{"level":"warn","ts":"2026-04-20T01:58:22.276038Z","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-20T01:58:22.276141Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-20T01:58:22.276224Z","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-20T01:58:22.276234Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-04-20T01:58:22.276255Z","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-20T01:58:22.277116Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-04-20T01:58:22.277205Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-20T01:58:22.283159Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.680131ms"} {"level":"info","ts":"2026-04-20T01:58:22.297625Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-04-20T01:58:22.297724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T01:58:22.297746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-04-20T01:58:22.297761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T01:58:22.29778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-04-20T01:58:22.297822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-04-20T01:58:22.308351Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T01:58:22.310986Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T01:58:22.313562Z","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-20T01:58:22.319054Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T01:58:22.320743Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T01:58:22.321341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-04-20T01:58:22.321558Z","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-20T01:58:22.321793Z","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-20T01:58:22.321842Z","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-20T01:58:22.322112Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-04-20T01:58:22.324911Z","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-20T01:58:22.324932Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-04-20T01:58:22.324962Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-04-20T01:58:22.325241Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T01:58:22.325331Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T01:58:23.098575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T01:58:23.09866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T01:58:23.098692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-04-20T01:58:23.098706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-04-20T01:58:23.098712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-04-20T01:58:23.098723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-04-20T01:58:23.098734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-04-20T01:58:23.100165Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T01:58:23.100207Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T01:58:23.100214Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T01:58:23.100439Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T01:58:23.101526Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T01:58:23.10156Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T01:58:23.104382Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T01:58:23.104542Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T01:58:23.104611Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T01:58:23.105077Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T01:58:23.105552Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-04-20T01:58:53.215641Z","caller":"traceutil/trace.go:171","msg":"trace[44839727] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"123.775223ms","start":"2026-04-20T01:58:53.091838Z","end":"2026-04-20T01:58:53.215614Z","steps":["trace[44839727] 'process raft request' (duration: 120.31047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:58:58.213891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.058161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sr86c\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T01:58:58.213997Z","caller":"traceutil/trace.go:171","msg":"trace[482135820] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sr86c; range_end:; response_count:1; response_revision:611; }","duration":"131.210732ms","start":"2026-04-20T01:58:58.082766Z","end":"2026-04-20T01:58:58.213977Z","steps":["trace[482135820] 'range keys from in-memory index tree' (duration: 130.899369ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:58:58.238435Z","caller":"traceutil/trace.go:171","msg":"trace[553602144] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"145.168869ms","start":"2026-04-20T01:58:58.093208Z","end":"2026-04-20T01:58:58.238377Z","steps":["trace[553602144] 'process raft request' (duration: 144.332823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:58:58.771045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.673782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T01:58:58.77134Z","caller":"traceutil/trace.go:171","msg":"trace[2097890997] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"323.676526ms","start":"2026-04-20T01:58:58.447645Z","end":"2026-04-20T01:58:58.771322Z","steps":["trace[2097890997] 'process raft request' (duration: 323.603516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:58:58.771434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:58.447619Z","time spent":"323.774577ms","remote":"127.0.0.1:44830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:58:58.771514Z","caller":"traceutil/trace.go:171","msg":"trace[1873622907] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"461.76059ms","start":"2026-04-20T01:58:58.309717Z","end":"2026-04-20T01:58:58.771477Z","steps":["trace[1873622907] 'process raft request' (duration: 461.451719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:58:58.771667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:58.309697Z","time spent":"461.901581ms","remote":"127.0.0.1:45186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:58:58.771777Z","caller":"traceutil/trace.go:171","msg":"trace[1341267270] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"505.192213ms","start":"2026-04-20T01:58:58.266315Z","end":"2026-04-20T01:58:58.771507Z","steps":["trace[1341267270] 'process raft request' (duration: 115.272062ms)","trace[1341267270] 'compare' (duration: 388.518281ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:58:58.771853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:58.266292Z","time spent":"505.522644ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:58:58.771886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.693117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T01:58:58.77204Z","caller":"traceutil/trace.go:171","msg":"trace[2003773605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"446.890348ms","start":"2026-04-20T01:58:58.325121Z","end":"2026-04-20T01:58:58.772012Z","steps":["trace[2003773605] 'agreement among raft nodes before linearized reading' (duration: 446.570606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:58:58.772128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:58.325101Z","time spent":"447.007408ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T01:58:58.772238Z","caller":"traceutil/trace.go:171","msg":"trace[1226824247] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"446.322134ms","start":"2026-04-20T01:58:58.325165Z","end":"2026-04-20T01:58:58.771488Z","steps":["trace[1226824247] 'read index received' (duration: 56.453064ms)","trace[1226824247] 'applied index is now lower than readState.Index' (duration: 389.86447ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:58:58.773303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.165256ms","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-20T01:58:58.773451Z","caller":"traceutil/trace.go:171","msg":"trace[2072763272] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"242.361508ms","start":"2026-04-20T01:58:58.531067Z","end":"2026-04-20T01:58:58.773429Z","steps":["trace[2072763272] 'agreement among raft nodes before linearized reading' (duration: 241.729543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:14.071763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.074603ms","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-20T01:59:14.071796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.609979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:14.071973Z","caller":"traceutil/trace.go:171","msg":"trace[1374098431] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:771; }","duration":"153.246384ms","start":"2026-04-20T01:59:13.918608Z","end":"2026-04-20T01:59:14.071854Z","steps":["trace[1374098431] 'range keys from in-memory index tree' (duration: 152.821641ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:14.072073Z","caller":"traceutil/trace.go:171","msg":"trace[927203437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:771; }","duration":"164.915621ms","start":"2026-04-20T01:59:13.907123Z","end":"2026-04-20T01:59:14.072038Z","steps":["trace[927203437] 'range keys from in-memory index tree' (duration: 164.523699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:26.411673Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.230610034s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-20T01:59:26.430116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:25.180936Z","time spent":"1.249174689s","remote":"127.0.0.1:44708","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-20T01:59:26.43702Z","caller":"traceutil/trace.go:171","msg":"trace[200666941] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:950; }","duration":"429.712123ms","start":"2026-04-20T01:59:26.007283Z","end":"2026-04-20T01:59:26.436995Z","steps":["trace[200666941] 'read index received' (duration: 404.684588ms)","trace[200666941] 'applied index is now lower than readState.Index' (duration: 25.026455ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:26.437082Z","caller":"traceutil/trace.go:171","msg":"trace[1432540947] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"852.429018ms","start":"2026-04-20T01:59:25.584627Z","end":"2026-04-20T01:59:26.437056Z","steps":["trace[1432540947] 'process raft request' (duration: 852.106451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:26.437201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:25.5846Z","time spent":"852.538394ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:26.437232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.928965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:26.437275Z","caller":"traceutil/trace.go:171","msg":"trace[2094615463] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"852.301531ms","start":"2026-04-20T01:59:25.584943Z","end":"2026-04-20T01:59:26.437245Z","steps":["trace[2094615463] 'process raft request' (duration: 851.983035ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:26.437297Z","caller":"traceutil/trace.go:171","msg":"trace[446741959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:924; }","duration":"430.02795ms","start":"2026-04-20T01:59:26.007254Z","end":"2026-04-20T01:59:26.437281Z","steps":["trace[446741959] 'agreement among raft nodes before linearized reading' (duration: 429.884833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:26.437347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:26.007237Z","time spent":"430.099754ms","remote":"127.0.0.1:44630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T01:59:26.437409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:25.584936Z","time spent":"852.395326ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:26.43886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.235956ms","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-20T01:59:26.438895Z","caller":"traceutil/trace.go:171","msg":"trace[780421059] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:925; }","duration":"247.300129ms","start":"2026-04-20T01:59:26.191587Z","end":"2026-04-20T01:59:26.438887Z","steps":["trace[780421059] 'agreement among raft nodes before linearized reading' (duration: 247.176893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:26.439191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.809375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T01:59:26.439218Z","caller":"traceutil/trace.go:171","msg":"trace[1242706077] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:925; }","duration":"110.870548ms","start":"2026-04-20T01:59:26.328339Z","end":"2026-04-20T01:59:26.43921Z","steps":["trace[1242706077] 'agreement among raft nodes before linearized reading' (duration: 110.800345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.348732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.384051589s","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-20T01:59:30.348797Z","caller":"traceutil/trace.go:171","msg":"trace[1774328645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:938; }","duration":"3.384155084s","start":"2026-04-20T01:59:26.964629Z","end":"2026-04-20T01:59:30.348784Z","steps":["trace[1774328645] 'range keys from in-memory index tree' (duration: 3.383922642s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.349026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:26.964612Z","time spent":"3.384405306s","remote":"127.0.0.1:44932","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-20T01:59:30.349174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.381015483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T01:59:30.349207Z","caller":"traceutil/trace.go:171","msg":"trace[174921668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:938; }","duration":"3.381052975s","start":"2026-04-20T01:59:26.968139Z","end":"2026-04-20T01:59:30.349192Z","steps":["trace[174921668] 'range keys from in-memory index tree' (duration: 3.380958571s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.34922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:26.968132Z","time spent":"3.381084647s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T01:59:30.349273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.381059796s","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-20T01:59:30.349309Z","caller":"traceutil/trace.go:171","msg":"trace[1203685140] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:938; }","duration":"3.381116289s","start":"2026-04-20T01:59:26.968182Z","end":"2026-04-20T01:59:30.349298Z","steps":["trace[1203685140] 'range keys from in-memory index tree' (duration: 3.380979171s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.349336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:26.968171Z","time spent":"3.38115814s","remote":"127.0.0.1:44932","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-20T01:59:30.349827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.854849ms","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-20T01:59:30.349875Z","caller":"traceutil/trace.go:171","msg":"trace[1841131998] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:938; }","duration":"497.903281ms","start":"2026-04-20T01:59:29.851964Z","end":"2026-04-20T01:59:30.349867Z","steps":["trace[1841131998] 'range keys from in-memory index tree' (duration: 497.847888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.353112Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987003803,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T01:59:30.35401Z","caller":"traceutil/trace.go:171","msg":"trace[1008375322] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"502.265724ms","start":"2026-04-20T01:59:29.851733Z","end":"2026-04-20T01:59:30.353999Z","steps":["trace[1008375322] 'process raft request' (duration: 502.19011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.354078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:29.851713Z","time spent":"502.319846ms","remote":"127.0.0.1:44932","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-20T01:59:30.358586Z","caller":"traceutil/trace.go:171","msg":"trace[1187990815] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:968; }","duration":"506.446785ms","start":"2026-04-20T01:59:29.852107Z","end":"2026-04-20T01:59:30.358553Z","steps":["trace[1187990815] 'read index received' (duration: 501.808271ms)","trace[1187990815] 'applied index is now lower than readState.Index' (duration: 4.637744ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:30.35875Z","caller":"traceutil/trace.go:171","msg":"trace[880376918] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"499.425742ms","start":"2026-04-20T01:59:29.859312Z","end":"2026-04-20T01:59:30.358737Z","steps":["trace[880376918] 'process raft request' (duration: 499.208251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.358841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.730268ms","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-20T01:59:30.358875Z","caller":"traceutil/trace.go:171","msg":"trace[760615693] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:941; }","duration":"506.781322ms","start":"2026-04-20T01:59:29.852085Z","end":"2026-04-20T01:59:30.358867Z","steps":["trace[760615693] 'agreement among raft nodes before linearized reading' (duration: 506.688346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.358899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:29.852078Z","time spent":"506.815204ms","remote":"127.0.0.1:44932","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-20T01:59:30.358844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:29.859302Z","time spent":"499.474944ms","remote":"127.0.0.1:44830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:30.359174Z","caller":"traceutil/trace.go:171","msg":"trace[648738003] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"505.150263ms","start":"2026-04-20T01:59:29.854012Z","end":"2026-04-20T01:59:30.359162Z","steps":["trace[648738003] 'process raft request' (duration: 504.393326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.359233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:29.854Z","time spent":"505.207765ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:30.364792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.666197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:30.364855Z","caller":"traceutil/trace.go:171","msg":"trace[1198241187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:944; }","duration":"512.745442ms","start":"2026-04-20T01:59:29.852097Z","end":"2026-04-20T01:59:30.364842Z","steps":["trace[1198241187] 'agreement among raft nodes before linearized reading' (duration: 512.647417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.364877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:29.852091Z","time spent":"512.780973ms","remote":"127.0.0.1:44630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T01:59:30.365113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.727988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T01:59:30.365133Z","caller":"traceutil/trace.go:171","msg":"trace[1673349510] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:944; }","duration":"163.76857ms","start":"2026-04-20T01:59:30.20136Z","end":"2026-04-20T01:59:30.365128Z","steps":["trace[1673349510] 'agreement among raft nodes before linearized reading' (duration: 163.737209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.365213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.103801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-mm4r7\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-04-20T01:59:30.365228Z","caller":"traceutil/trace.go:171","msg":"trace[1375392998] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-mm4r7; range_end:; response_count:1; response_revision:944; }","duration":"511.145613ms","start":"2026-04-20T01:59:29.854079Z","end":"2026-04-20T01:59:30.365224Z","steps":["trace[1375392998] 'agreement among raft nodes before linearized reading' (duration: 511.08497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.36524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:29.854064Z","time spent":"511.172535ms","remote":"127.0.0.1:44840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5095,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-mm4r7\" "} {"level":"warn","ts":"2026-04-20T01:59:30.365337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.175432ms","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-20T01:59:30.365353Z","caller":"traceutil/trace.go:171","msg":"trace[1555192210] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:944; }","duration":"513.206183ms","start":"2026-04-20T01:59:29.852143Z","end":"2026-04-20T01:59:30.365349Z","steps":["trace[1555192210] 'agreement among raft nodes before linearized reading' (duration: 513.165411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.365368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:29.852139Z","time spent":"513.225565ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:00:06.478426Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987004663,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T02:00:06.496538Z","caller":"traceutil/trace.go:171","msg":"trace[1733268076] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"789.460603ms","start":"2026-04-20T02:00:05.707058Z","end":"2026-04-20T02:00:06.496518Z","steps":["trace[1733268076] 'process raft request' (duration: 782.297393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:06.49666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:05.707026Z","time spent":"789.573986ms","remote":"127.0.0.1:44736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105451,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:00:06.497102Z","caller":"traceutil/trace.go:171","msg":"trace[1728397745] linearizableReadLoop","detail":"{readStateIndex:1449; appliedIndex:1447; }","duration":"682.01136ms","start":"2026-04-20T02:00:05.815063Z","end":"2026-04-20T02:00:06.497075Z","steps":["trace[1728397745] 'read index received' (duration: 674.257842ms)","trace[1728397745] 'applied index is now lower than readState.Index' (duration: 7.752638ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:06.497305Z","caller":"traceutil/trace.go:171","msg":"trace[38968661] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"752.922198ms","start":"2026-04-20T02:00:05.74437Z","end":"2026-04-20T02:00:06.497292Z","steps":["trace[38968661] 'process raft request' (duration: 752.617407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:06.49739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:05.744335Z","time spent":"753.004861ms","remote":"127.0.0.1:35960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2381,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T02:00:06.497613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.540518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:00:06.497648Z","caller":"traceutil/trace.go:171","msg":"trace[1271111745] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1408; }","duration":"682.580099ms","start":"2026-04-20T02:00:05.815058Z","end":"2026-04-20T02:00:06.497638Z","steps":["trace[1271111745] 'agreement among raft nodes before linearized reading' (duration: 682.494256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:06.497691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:05.815009Z","time spent":"682.671881ms","remote":"127.0.0.1:45046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:00:06.497937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.437786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:06.497979Z","caller":"traceutil/trace.go:171","msg":"trace[992245391] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1409; }","duration":"587.523959ms","start":"2026-04-20T02:00:05.910444Z","end":"2026-04-20T02:00:06.497968Z","steps":["trace[992245391] 'agreement among raft nodes before linearized reading' (duration: 587.444746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:06.498006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:05.910429Z","time spent":"587.573071ms","remote":"127.0.0.1:44630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T02:00:09.057338Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987004704,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:00:09.558509Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987004704,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:00:09.59003Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.0502064s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:00:09.590521Z","caller":"traceutil/trace.go:171","msg":"trace[666245613] linearizableReadLoop","detail":"{readStateIndex:1471; appliedIndex:1470; }","duration":"1.033426213s","start":"2026-04-20T02:00:08.557076Z","end":"2026-04-20T02:00:09.590502Z","steps":["trace[666245613] 'read index received' (duration: 1.033154125s)","trace[666245613] 'applied index is now lower than readState.Index' (duration: 271.238µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:09.590789Z","caller":"traceutil/trace.go:171","msg":"trace[316464057] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"1.051068076s","start":"2026-04-20T02:00:08.539713Z","end":"2026-04-20T02:00:09.590781Z","steps":["trace[316464057] 'process raft request' (duration: 1.050615113s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.590867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:08.539691Z","time spent":"1.051123607s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:00:09.591051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033972179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:00:09.591079Z","caller":"traceutil/trace.go:171","msg":"trace[52588840] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1429; }","duration":"1.03400284s","start":"2026-04-20T02:00:08.557068Z","end":"2026-04-20T02:00:09.591071Z","steps":["trace[52588840] 'agreement among raft nodes before linearized reading' (duration: 1.033927378s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.591103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:08.557008Z","time spent":"1.034088343s","remote":"127.0.0.1:45008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":21,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:00:09.591333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003033348s","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-20T02:00:09.591356Z","caller":"traceutil/trace.go:171","msg":"trace[983544459] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1429; }","duration":"1.00309646s","start":"2026-04-20T02:00:08.588253Z","end":"2026-04-20T02:00:09.59135Z","steps":["trace[983544459] 'agreement among raft nodes before linearized reading' (duration: 1.002982546s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.591377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:08.588236Z","time spent":"1.003136702s","remote":"127.0.0.1:44932","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-20T02:00:09.591354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.523131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:09.591429Z","caller":"traceutil/trace.go:171","msg":"trace[465654129] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1429; }","duration":"305.651505ms","start":"2026-04-20T02:00:09.285758Z","end":"2026-04-20T02:00:09.59141Z","steps":["trace[465654129] 'agreement among raft nodes before linearized reading' (duration: 305.49875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.591488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:09.285745Z","time spent":"305.731537ms","remote":"127.0.0.1:44882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:00:09.591532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.033284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T02:00:09.591568Z","caller":"traceutil/trace.go:171","msg":"trace[563862075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1429; }","duration":"986.090396ms","start":"2026-04-20T02:00:08.605469Z","end":"2026-04-20T02:00:09.59156Z","steps":["trace[563862075] 'agreement among raft nodes before linearized reading' (duration: 986.000494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.591587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:08.60546Z","time spent":"986.122877ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:00:09.591571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.007854ms","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-20T02:00:09.59166Z","caller":"traceutil/trace.go:171","msg":"trace[773284011] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1429; }","duration":"986.128178ms","start":"2026-04-20T02:00:08.605512Z","end":"2026-04-20T02:00:09.59164Z","steps":["trace[773284011] 'agreement among raft nodes before linearized reading' (duration: 985.88ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.591708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:08.605503Z","time spent":"986.19677ms","remote":"127.0.0.1:44932","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-20T02:00:09.59173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.523384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T02:00:09.591761Z","caller":"traceutil/trace.go:171","msg":"trace[1275370157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1429; }","duration":"997.554075ms","start":"2026-04-20T02:00:08.594199Z","end":"2026-04-20T02:00:09.591753Z","steps":["trace[1275370157] 'agreement among raft nodes before linearized reading' (duration: 997.477143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.591786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:08.594166Z","time spent":"997.613857ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T02:00:09.591827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.60477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:09.591864Z","caller":"traceutil/trace.go:171","msg":"trace[2233002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1429; }","duration":"123.667752ms","start":"2026-04-20T02:00:09.468184Z","end":"2026-04-20T02:00:09.591851Z","steps":["trace[2233002] 'agreement among raft nodes before linearized reading' (duration: 123.616431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.591893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003051698s","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-20T02:00:09.59192Z","caller":"traceutil/trace.go:171","msg":"trace[923473876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1429; }","duration":"1.003097369s","start":"2026-04-20T02:00:08.588815Z","end":"2026-04-20T02:00:09.591912Z","steps":["trace[923473876] 'agreement among raft nodes before linearized reading' (duration: 1.003025617s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.591946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:08.588808Z","time spent":"1.003132791s","remote":"127.0.0.1:44932","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-20T02:00:09.592081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.874264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-20T02:00:09.592131Z","caller":"traceutil/trace.go:171","msg":"trace[1303101268] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1429; }","duration":"316.956147ms","start":"2026-04-20T02:00:09.27516Z","end":"2026-04-20T02:00:09.592116Z","steps":["trace[1303101268] 'agreement among raft nodes before linearized reading' (duration: 316.837043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.592161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:09.275144Z","time spent":"317.010428ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":580,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-20T02:00:09.592395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.626039ms","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-20T02:00:09.592436Z","caller":"traceutil/trace.go:171","msg":"trace[419979682] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1429; }","duration":"478.711311ms","start":"2026-04-20T02:00:09.113713Z","end":"2026-04-20T02:00:09.592425Z","steps":["trace[419979682] 'agreement among raft nodes before linearized reading' (duration: 478.638949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:09.592462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:09.113691Z","time spent":"478.763703ms","remote":"127.0.0.1:44736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":15,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-04-20T02:00:11.735329Z","caller":"traceutil/trace.go:171","msg":"trace[871546176] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"101.196519ms","start":"2026-04-20T02:00:11.634108Z","end":"2026-04-20T02:00:11.735304Z","steps":["trace[871546176] 'process raft request' (duration: 93.565878ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:11.735736Z","caller":"traceutil/trace.go:171","msg":"trace[1421928720] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"101.483798ms","start":"2026-04-20T02:00:11.634225Z","end":"2026-04-20T02:00:11.735709Z","steps":["trace[1421928720] 'process raft request' (duration: 101.333124ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:11.735972Z","caller":"traceutil/trace.go:171","msg":"trace[1935621044] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"101.395236ms","start":"2026-04-20T02:00:11.634567Z","end":"2026-04-20T02:00:11.735962Z","steps":["trace[1935621044] 'process raft request' (duration: 101.101536ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:11.73575Z","caller":"traceutil/trace.go:171","msg":"trace[2000833956] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"101.5561ms","start":"2026-04-20T02:00:11.634166Z","end":"2026-04-20T02:00:11.735722Z","steps":["trace[2000833956] 'process raft request' (duration: 101.098086ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:30.304123Z","caller":"traceutil/trace.go:171","msg":"trace[1823948877] linearizableReadLoop","detail":"{readStateIndex:1812; appliedIndex:1811; }","duration":"447.702684ms","start":"2026-04-20T02:00:29.856396Z","end":"2026-04-20T02:00:30.304099Z","steps":["trace[1823948877] 'read index received' (duration: 447.479188ms)","trace[1823948877] 'applied index is now lower than readState.Index' (duration: 222.616µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:30.304229Z","caller":"traceutil/trace.go:171","msg":"trace[177852037] transaction","detail":"{read_only:false; response_revision:1743; number_of_response:1; }","duration":"539.742094ms","start":"2026-04-20T02:00:29.764431Z","end":"2026-04-20T02:00:30.304173Z","steps":["trace[177852037] 'process raft request' (duration: 539.519748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:30.30437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.167265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-20T02:00:30.304381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:29.7644Z","time spent":"539.899247ms","remote":"127.0.0.1:44932","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-20T02:00:30.304381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.979661ms","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-20T02:00:30.304422Z","caller":"traceutil/trace.go:171","msg":"trace[1521529683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1743; }","duration":"444.282128ms","start":"2026-04-20T02:00:29.860128Z","end":"2026-04-20T02:00:30.30441Z","steps":["trace[1521529683] 'agreement among raft nodes before linearized reading' (duration: 444.106293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:30.304443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.677166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:30.304453Z","caller":"traceutil/trace.go:171","msg":"trace[1824720950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1743; }","duration":"448.078274ms","start":"2026-04-20T02:00:29.856349Z","end":"2026-04-20T02:00:30.304427Z","steps":["trace[1824720950] 'agreement among raft nodes before linearized reading' (duration: 447.882109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:30.304465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:29.860085Z","time spent":"444.371ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:00:30.30449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:29.856328Z","time spent":"448.154165ms","remote":"127.0.0.1:44932","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":"info","ts":"2026-04-20T02:00:30.304489Z","caller":"traceutil/trace.go:171","msg":"trace[406480417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1743; }","duration":"393.726987ms","start":"2026-04-20T02:00:29.910745Z","end":"2026-04-20T02:00:30.304472Z","steps":["trace[406480417] 'agreement among raft nodes before linearized reading' (duration: 393.680176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:30.30451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.312788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-20T02:00:30.304369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.418137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:00:30.304533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:29.910736Z","time spent":"393.787848ms","remote":"127.0.0.1:44630","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-20T02:00:30.304587Z","caller":"traceutil/trace.go:171","msg":"trace[1415589074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1743; }","duration":"398.697893ms","start":"2026-04-20T02:00:29.905878Z","end":"2026-04-20T02:00:30.304576Z","steps":["trace[1415589074] 'agreement among raft nodes before linearized reading' (duration: 398.409465ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:30.304584Z","caller":"traceutil/trace.go:171","msg":"trace[2031717706] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1743; }","duration":"444.41648ms","start":"2026-04-20T02:00:29.860149Z","end":"2026-04-20T02:00:30.304566Z","steps":["trace[2031717706] 'agreement among raft nodes before linearized reading' (duration: 444.216805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:30.304614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:29.905861Z","time spent":"398.747094ms","remote":"127.0.0.1:44634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T02:00:30.304626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:29.860138Z","time spent":"444.477862ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-20T02:00:30.30464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.834769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-20T02:00:30.304527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.68098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T02:00:30.304688Z","caller":"traceutil/trace.go:171","msg":"trace[71135480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1743; }","duration":"411.90982ms","start":"2026-04-20T02:00:29.892763Z","end":"2026-04-20T02:00:30.304672Z","steps":["trace[71135480] 'agreement among raft nodes before linearized reading' (duration: 411.801347ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:30.304696Z","caller":"traceutil/trace.go:171","msg":"trace[446812877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1743; }","duration":"430.887955ms","start":"2026-04-20T02:00:29.873792Z","end":"2026-04-20T02:00:30.30468Z","steps":["trace[446812877] 'agreement among raft nodes before linearized reading' (duration: 430.566027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:30.304732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:29.892741Z","time spent":"411.980012ms","remote":"127.0.0.1:44932","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-20T02:00:30.304736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:29.873772Z","time spent":"430.953016ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T02:00:36.044632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.807838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:36.044866Z","caller":"traceutil/trace.go:171","msg":"trace[755211166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1806; }","duration":"101.067053ms","start":"2026-04-20T02:00:35.943779Z","end":"2026-04-20T02:00:36.044846Z","steps":["trace[755211166] 'agreement among raft nodes before linearized reading' (duration: 100.151022ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:36.222407Z","caller":"traceutil/trace.go:171","msg":"trace[1994711637] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"100.055526ms","start":"2026-04-20T02:00:36.12233Z","end":"2026-04-20T02:00:36.222385Z","steps":["trace[1994711637] 'process raft request' (duration: 99.094753ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:36.399963Z","caller":"traceutil/trace.go:171","msg":"trace[1018749067] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"100.859026ms","start":"2026-04-20T02:00:36.299034Z","end":"2026-04-20T02:00:36.399893Z","steps":["trace[1018749067] 'process raft request' (duration: 100.672641ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:36.400361Z","caller":"traceutil/trace.go:171","msg":"trace[475350922] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"100.075817ms","start":"2026-04-20T02:00:36.300259Z","end":"2026-04-20T02:00:36.400335Z","steps":["trace[475350922] 'process raft request' (duration: 99.684288ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:36.560111Z","caller":"traceutil/trace.go:171","msg":"trace[713389011] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1894; }","duration":"125.966517ms","start":"2026-04-20T02:00:36.434121Z","end":"2026-04-20T02:00:36.560087Z","steps":["trace[713389011] 'read index received' (duration: 50.578231ms)","trace[713389011] 'applied index is now lower than readState.Index' (duration: 75.387286ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:36.560122Z","caller":"traceutil/trace.go:171","msg":"trace[1790340683] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"126.029139ms","start":"2026-04-20T02:00:36.43406Z","end":"2026-04-20T02:00:36.560089Z","steps":["trace[1790340683] 'process raft request' (duration: 97.551507ms)","trace[1790340683] 'compare' (duration: 28.207385ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:36.560317Z","caller":"traceutil/trace.go:171","msg":"trace[528953213] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"126.230034ms","start":"2026-04-20T02:00:36.43406Z","end":"2026-04-20T02:00:36.56029Z","steps":["trace[528953213] 'process raft request' (duration: 125.921546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:36.560415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.271745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:36.561466Z","caller":"traceutil/trace.go:171","msg":"trace[758423342] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:1832; }","duration":"127.36204ms","start":"2026-04-20T02:00:36.434085Z","end":"2026-04-20T02:00:36.561447Z","steps":["trace[758423342] 'agreement among raft nodes before linearized reading' (duration: 126.239233ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:38.640482Z","caller":"traceutil/trace.go:171","msg":"trace[1283483610] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"145.270019ms","start":"2026-04-20T02:00:38.495189Z","end":"2026-04-20T02:00:38.640459Z","steps":["trace[1283483610] 'process raft request' (duration: 145.138636ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:38.768417Z","caller":"traceutil/trace.go:171","msg":"trace[1535323129] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"273.062207ms","start":"2026-04-20T02:00:38.495325Z","end":"2026-04-20T02:00:38.768387Z","steps":["trace[1535323129] 'process raft request' (duration: 216.70355ms)","trace[1535323129] 'compare' (duration: 56.183873ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:38.768826Z","caller":"traceutil/trace.go:171","msg":"trace[640780019] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"272.346501ms","start":"2026-04-20T02:00:38.496466Z","end":"2026-04-20T02:00:38.768812Z","steps":["trace[640780019] 'process raft request' (duration: 272.133266ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:38.76889Z","caller":"traceutil/trace.go:171","msg":"trace[259496566] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1929; }","duration":"145.049903ms","start":"2026-04-20T02:00:38.623822Z","end":"2026-04-20T02:00:38.768872Z","steps":["trace[259496566] 'read index received' (duration: 16.485148ms)","trace[259496566] 'applied index is now lower than readState.Index' (duration: 128.563725ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:38.768924Z","caller":"traceutil/trace.go:171","msg":"trace[1300536619] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"271.90134ms","start":"2026-04-20T02:00:38.497013Z","end":"2026-04-20T02:00:38.768914Z","steps":["trace[1300536619] 'process raft request' (duration: 271.733096ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:38.768913Z","caller":"traceutil/trace.go:171","msg":"trace[1502576466] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"272.420432ms","start":"2026-04-20T02:00:38.496329Z","end":"2026-04-20T02:00:38.76875Z","steps":["trace[1502576466] 'process raft request' (duration: 272.012213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:38.769115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.265718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-30289e4e-a2f6-4023-b30e-28d947ffcdef\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-20T02:00:38.769214Z","caller":"traceutil/trace.go:171","msg":"trace[1794217838] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-30289e4e-a2f6-4023-b30e-28d947ffcdef; range_end:; response_count:1; response_revision:1864; }","duration":"145.385202ms","start":"2026-04-20T02:00:38.62379Z","end":"2026-04-20T02:00:38.769175Z","steps":["trace[1794217838] 'agreement among raft nodes before linearized reading' (duration: 145.151616ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:38.769636Z","caller":"traceutil/trace.go:171","msg":"trace[1781526531] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"272.089954ms","start":"2026-04-20T02:00:38.496696Z","end":"2026-04-20T02:00:38.768786Z","steps":["trace[1781526531] 'process raft request' (duration: 272.015392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:01:13.473269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.552108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:01:13.473447Z","caller":"traceutil/trace.go:171","msg":"trace[1830361005] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"268.262666ms","start":"2026-04-20T02:01:13.205176Z","end":"2026-04-20T02:01:13.473439Z","steps":["trace[1830361005] 'process raft request' (duration: 268.186525ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:01:13.47343Z","caller":"traceutil/trace.go:171","msg":"trace[48349880] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"404.058324ms","start":"2026-04-20T02:01:13.069329Z","end":"2026-04-20T02:01:13.473387Z","steps":["trace[48349880] 'process raft request' (duration: 138.305123ms)","trace[48349880] 'compare' (duration: 265.045159ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:01:13.473562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:13.069304Z","time spent":"404.205517ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:01:13.473543Z","caller":"traceutil/trace.go:171","msg":"trace[1704732088] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2179; }","duration":"339.700754ms","start":"2026-04-20T02:01:13.133803Z","end":"2026-04-20T02:01:13.473504Z","steps":["trace[1704732088] 'read index received' (duration: 73.911532ms)","trace[1704732088] 'applied index is now lower than readState.Index' (duration: 265.785781ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:01:13.474114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.285275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-20T02:01:13.474165Z","caller":"traceutil/trace.go:171","msg":"trace[571587037] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2102; }","duration":"340.391796ms","start":"2026-04-20T02:01:13.133756Z","end":"2026-04-20T02:01:13.474148Z","steps":["trace[571587037] 'agreement among raft nodes before linearized reading' (duration: 339.918168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:01:13.474205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:13.133736Z","time spent":"340.460198ms","remote":"127.0.0.1:54086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-20T02:01:13.527997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.04056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:01:13.528077Z","caller":"traceutil/trace.go:171","msg":"trace[319508876] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2103; }","duration":"274.190914ms","start":"2026-04-20T02:01:13.253871Z","end":"2026-04-20T02:01:13.528062Z","steps":["trace[319508876] 'agreement among raft nodes before linearized reading' (duration: 274.01866ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:01:13.528302Z","caller":"traceutil/trace.go:171","msg":"trace[2015834] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"145.169107ms","start":"2026-04-20T02:01:13.383121Z","end":"2026-04-20T02:01:13.52829Z","steps":["trace[2015834] 'process raft request' (duration: 144.629187ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:50.862127Z","caller":"traceutil/trace.go:171","msg":"trace[1571257788] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"123.447511ms","start":"2026-04-20T02:02:50.738659Z","end":"2026-04-20T02:02:50.862107Z","steps":["trace[1571257788] 'process raft request' (duration: 123.337889ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:54.650368Z","caller":"traceutil/trace.go:171","msg":"trace[629306464] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"136.930246ms","start":"2026-04-20T02:06:54.513409Z","end":"2026-04-20T02:06:54.650339Z","steps":["trace[629306464] 'process raft request' (duration: 136.768542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:55.027398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.04407ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:06:55.027567Z","caller":"traceutil/trace.go:171","msg":"trace[1950511476] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"170.987637ms","start":"2026-04-20T02:06:54.85656Z","end":"2026-04-20T02:06:55.027548Z","steps":["trace[1950511476] 'process raft request' (duration: 38.708271ms)","trace[1950511476] 'compare' (duration: 131.880837ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:55.027872Z","caller":"traceutil/trace.go:171","msg":"trace[1433806207] linearizableReadLoop","detail":"{readStateIndex:4951; appliedIndex:4948; }","duration":"147.924189ms","start":"2026-04-20T02:06:54.879922Z","end":"2026-04-20T02:06:55.027846Z","steps":["trace[1433806207] 'read index received' (duration: 15.354297ms)","trace[1433806207] 'applied index is now lower than readState.Index' (duration: 132.568572ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:55.02791Z","caller":"traceutil/trace.go:171","msg":"trace[1654998041] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"170.974486ms","start":"2026-04-20T02:06:54.856911Z","end":"2026-04-20T02:06:55.027886Z","steps":["trace[1654998041] 'process raft request' (duration: 170.827043ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:55.027896Z","caller":"traceutil/trace.go:171","msg":"trace[745572681] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"171.192461ms","start":"2026-04-20T02:06:54.856659Z","end":"2026-04-20T02:06:55.027851Z","steps":["trace[745572681] 'process raft request' (duration: 170.839202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:55.028025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.106593ms","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-20T02:06:55.028058Z","caller":"traceutil/trace.go:171","msg":"trace[1200032652] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4774; }","duration":"148.162704ms","start":"2026-04-20T02:06:54.879886Z","end":"2026-04-20T02:06:55.028048Z","steps":["trace[1200032652] 'agreement among raft nodes before linearized reading' (duration: 148.049941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:55.028077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.742452ms","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-20T02:06:55.028134Z","caller":"traceutil/trace.go:171","msg":"trace[337048360] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:4774; }","duration":"146.824824ms","start":"2026-04-20T02:06:54.881289Z","end":"2026-04-20T02:06:55.028114Z","steps":["trace[337048360] 'agreement among raft nodes before linearized reading' (duration: 146.724361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:55.028395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.486325ms","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-20T02:06:55.028459Z","caller":"traceutil/trace.go:171","msg":"trace[1648287910] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4774; }","duration":"121.628678ms","start":"2026-04-20T02:06:54.906817Z","end":"2026-04-20T02:06:55.028446Z","steps":["trace[1648287910] 'agreement among raft nodes before linearized reading' (duration: 121.315071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:55.02858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.812205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-20T02:06:55.02863Z","caller":"traceutil/trace.go:171","msg":"trace[1547134200] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4774; }","duration":"140.878877ms","start":"2026-04-20T02:06:54.887737Z","end":"2026-04-20T02:06:55.028616Z","steps":["trace[1547134200] 'agreement among raft nodes before linearized reading' (duration: 140.703873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:55.028648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.127148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:55.028679Z","caller":"traceutil/trace.go:171","msg":"trace[16118039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4774; }","duration":"121.176098ms","start":"2026-04-20T02:06:54.907492Z","end":"2026-04-20T02:06:55.028669Z","steps":["trace[16118039] 'agreement among raft nodes before linearized reading' (duration: 121.124487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:07.729598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.90046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:07:07.729771Z","caller":"traceutil/trace.go:171","msg":"trace[468231501] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"323.799762ms","start":"2026-04-20T02:07:07.405944Z","end":"2026-04-20T02:07:07.729743Z","steps":["trace[468231501] 'process raft request' (duration: 65.583264ms)","trace[468231501] 'compare' (duration: 257.617144ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:07:07.72987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:07.405914Z","time spent":"323.902265ms","remote":"127.0.0.1:44932","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-20T02:07:07.731378Z","caller":"traceutil/trace.go:171","msg":"trace[900429698] linearizableReadLoop","detail":"{readStateIndex:5125; appliedIndex:5124; }","duration":"120.592892ms","start":"2026-04-20T02:07:07.610757Z","end":"2026-04-20T02:07:07.73135Z","steps":["trace[900429698] 'read index received' (duration: 120.243874ms)","trace[900429698] 'applied index is now lower than readState.Index' (duration: 347.168µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:07:07.731427Z","caller":"traceutil/trace.go:171","msg":"trace[1927336027] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"238.76175ms","start":"2026-04-20T02:07:07.492634Z","end":"2026-04-20T02:07:07.731396Z","steps":["trace[1927336027] 'process raft request' (duration: 238.469973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:07.731566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.809002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:07:07.731642Z","caller":"traceutil/trace.go:171","msg":"trace[551522300] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:4943; }","duration":"114.862733ms","start":"2026-04-20T02:07:07.616737Z","end":"2026-04-20T02:07:07.7316Z","steps":["trace[551522300] 'agreement among raft nodes before linearized reading' (duration: 114.767321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:07.731846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.019902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-04-20T02:07:07.731955Z","caller":"traceutil/trace.go:171","msg":"trace[1983268325] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4943; }","duration":"121.240297ms","start":"2026-04-20T02:07:07.610695Z","end":"2026-04-20T02:07:07.731935Z","steps":["trace[1983268325] 'agreement among raft nodes before linearized reading' (duration: 120.787397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:07.732063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.012343ms","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-20T02:07:07.733536Z","caller":"traceutil/trace.go:171","msg":"trace[460050458] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4943; }","duration":"102.104946ms","start":"2026-04-20T02:07:07.630016Z","end":"2026-04-20T02:07:07.732121Z","steps":["trace[460050458] 'agreement among raft nodes before linearized reading' (duration: 101.871611ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:08:23.127833Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2895} {"level":"info","ts":"2026-04-20T02:08:23.200795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2895,"took":"71.071627ms","hash":1593139289,"current-db-size-bytes":54255616,"current-db-size":"54 MB","current-db-size-in-use-bytes":29425664,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T02:08:23.200869Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1593139289,"revision":2895,"compact-revision":-1} {"level":"info","ts":"2026-04-20T02:13:23.141157Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5568} {"level":"info","ts":"2026-04-20T02:13:23.301188Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5568,"took":"158.060415ms","hash":3766700403,"current-db-size-bytes":54255616,"current-db-size":"54 MB","current-db-size-in-use-bytes":18440192,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-20T02:13:23.301258Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3766700403,"revision":5568,"compact-revision":2895} {"level":"info","ts":"2026-04-20T02:14:15.769379Z","caller":"traceutil/trace.go:171","msg":"trace[312426505] transaction","detail":"{read_only:false; response_revision:7686; number_of_response:1; }","duration":"101.537391ms","start":"2026-04-20T02:14:15.66781Z","end":"2026-04-20T02:14:15.769348Z","steps":["trace[312426505] 'process raft request' (duration: 101.429988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:47.89224Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987022655,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:14:48.393349Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987022655,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:14:48.893521Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987022655,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:14:49.393824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987022655,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:14:49.504361Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.168410476s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:14:49.505076Z","caller":"traceutil/trace.go:171","msg":"trace[1760430318] transaction","detail":"{read_only:false; response_revision:7842; number_of_response:1; }","duration":"2.169133996s","start":"2026-04-20T02:14:47.33587Z","end":"2026-04-20T02:14:49.505004Z","steps":["trace[1760430318] 'process raft request' (duration: 2.168891879s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.505306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.335848Z","time spent":"2.169308401s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:14:49.554274Z","caller":"traceutil/trace.go:171","msg":"trace[1139609233] linearizableReadLoop","detail":"{readStateIndex:8130; appliedIndex:8127; }","duration":"2.162980241s","start":"2026-04-20T02:14:47.391271Z","end":"2026-04-20T02:14:49.554251Z","steps":["trace[1139609233] 'read index received' (duration: 2.113416427s)","trace[1139609233] 'applied index is now lower than readState.Index' (duration: 49.562194ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:14:49.554509Z","caller":"traceutil/trace.go:171","msg":"trace[1671900705] transaction","detail":"{read_only:false; response_revision:7844; number_of_response:1; }","duration":"257.672244ms","start":"2026-04-20T02:14:49.296782Z","end":"2026-04-20T02:14:49.554454Z","steps":["trace[1671900705] 'process raft request' (duration: 257.268863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.554692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.139708877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-public/default\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-04-20T02:14:49.554773Z","caller":"traceutil/trace.go:171","msg":"trace[879013555] range","detail":"{range_begin:/registry/serviceaccounts/kube-public/default; range_end:; response_count:1; response_revision:7844; }","duration":"2.139800049s","start":"2026-04-20T02:14:47.414955Z","end":"2026-04-20T02:14:49.554755Z","steps":["trace[879013555] 'agreement among raft nodes before linearized reading' (duration: 2.139593003s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:14:49.55419Z","caller":"traceutil/trace.go:171","msg":"trace[65001134] transaction","detail":"{read_only:false; response_revision:7843; number_of_response:1; }","duration":"1.913769432s","start":"2026-04-20T02:14:47.640353Z","end":"2026-04-20T02:14:49.554123Z","steps":["trace[65001134] 'process raft request' (duration: 1.913525015s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.554824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.414904Z","time spent":"2.139911923s","remote":"127.0.0.1:44868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":202,"request content":"key:\"/registry/serviceaccounts/kube-public/default\" "} {"level":"warn","ts":"2026-04-20T02:14:49.554934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.647051789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:14:49.554974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.640301Z","time spent":"1.914550375s","remote":"127.0.0.1:44932","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-20T02:14:49.55505Z","caller":"traceutil/trace.go:171","msg":"trace[2021888975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7844; }","duration":"1.647197223s","start":"2026-04-20T02:14:47.907811Z","end":"2026-04-20T02:14:49.555008Z","steps":["trace[2021888975] 'agreement among raft nodes before linearized reading' (duration: 1.646992558s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.555102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.748803591s","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-20T02:14:49.555117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.907791Z","time spent":"1.647316286s","remote":"127.0.0.1:44630","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-20T02:14:49.555141Z","caller":"traceutil/trace.go:171","msg":"trace[261508868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7844; }","duration":"1.748865663s","start":"2026-04-20T02:14:47.806263Z","end":"2026-04-20T02:14:49.555129Z","steps":["trace[261508868] 'agreement among raft nodes before linearized reading' (duration: 1.74876346s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.55518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.806246Z","time spent":"1.748927224s","remote":"127.0.0.1:44932","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-20T02:14:49.555258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.021207741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:14:49.555326Z","caller":"traceutil/trace.go:171","msg":"trace[2127539355] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:7844; }","duration":"2.021348005s","start":"2026-04-20T02:14:47.533961Z","end":"2026-04-20T02:14:49.555309Z","steps":["trace[2127539355] 'agreement among raft nodes before linearized reading' (duration: 2.021205361s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.555368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.53394Z","time spent":"2.021417988s","remote":"127.0.0.1:44982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:14:49.555481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.819358306s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-20T02:14:49.555529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.164250757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-04-20T02:14:49.555586Z","caller":"traceutil/trace.go:171","msg":"trace[438403685] range","detail":"{range_begin:/registry/roles/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:7844; }","duration":"2.16432714s","start":"2026-04-20T02:14:47.391241Z","end":"2026-04-20T02:14:49.555568Z","steps":["trace[438403685] 'agreement among raft nodes before linearized reading' (duration: 2.164230497s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.555621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.595154053s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-04-20T02:14:49.555625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.391227Z","time spent":"2.164390552s","remote":"127.0.0.1:45008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":732,"request content":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" "} {"level":"info","ts":"2026-04-20T02:14:49.555645Z","caller":"traceutil/trace.go:171","msg":"trace[1000197722] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7844; }","duration":"1.595204914s","start":"2026-04-20T02:14:47.960431Z","end":"2026-04-20T02:14:49.555636Z","steps":["trace[1000197722] 'agreement among raft nodes before linearized reading' (duration: 1.595139102s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:14:49.555544Z","caller":"traceutil/trace.go:171","msg":"trace[1235011447] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7844; }","duration":"1.819454489s","start":"2026-04-20T02:14:47.736074Z","end":"2026-04-20T02:14:49.555528Z","steps":["trace[1235011447] 'agreement among raft nodes before linearized reading' (duration: 1.819232652s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.555673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.960412Z","time spent":"1.595254886s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-20T02:14:49.555668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.54791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:14:49.555699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.736054Z","time spent":"1.819633763s","remote":"127.0.0.1:44932","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":"info","ts":"2026-04-20T02:14:49.555714Z","caller":"traceutil/trace.go:171","msg":"trace[1816893904] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:7844; }","duration":"153.641074ms","start":"2026-04-20T02:14:49.40206Z","end":"2026-04-20T02:14:49.555701Z","steps":["trace[1816893904] 'agreement among raft nodes before linearized reading' (duration: 153.561321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.555505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.078041482s","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-20T02:14:49.555812Z","caller":"traceutil/trace.go:171","msg":"trace[94904999] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7844; }","duration":"2.078397323s","start":"2026-04-20T02:14:47.477397Z","end":"2026-04-20T02:14:49.555795Z","steps":["trace[94904999] 'agreement among raft nodes before linearized reading' (duration: 2.077843736s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.555911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.477376Z","time spent":"2.078506127s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T02:14:49.555908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.813748061s","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-20T02:14:49.556164Z","caller":"traceutil/trace.go:171","msg":"trace[2071048774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7844; }","duration":"1.814190794s","start":"2026-04-20T02:14:47.741948Z","end":"2026-04-20T02:14:49.556139Z","steps":["trace[2071048774] 'agreement among raft nodes before linearized reading' (duration: 1.813273247s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.556254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.741939Z","time spent":"1.814301568s","remote":"127.0.0.1:44932","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":"warn","ts":"2026-04-20T02:14:49.555815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.61781917s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-20T02:14:49.556424Z","caller":"traceutil/trace.go:171","msg":"trace[1587892499] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:7844; }","duration":"1.618473659s","start":"2026-04-20T02:14:47.937937Z","end":"2026-04-20T02:14:49.556411Z","steps":["trace[1587892499] 'agreement among raft nodes before linearized reading' (duration: 1.617348705s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.556522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.937917Z","time spent":"1.618591253s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-20T02:14:49.556709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.5920264s","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-20T02:14:49.55679Z","caller":"traceutil/trace.go:171","msg":"trace[2065342097] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7844; }","duration":"1.592129074s","start":"2026-04-20T02:14:47.964653Z","end":"2026-04-20T02:14:49.556783Z","steps":["trace[2065342097] 'agreement among raft nodes before linearized reading' (duration: 1.590604969s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:49.556812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:47.964644Z","time spent":"1.592162915s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:14:51.2281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:50.76939Z","time spent":"458.700626ms","remote":"127.0.0.1:37830","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-20T02:14:51.230521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.651209533s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:14:51.230722Z","caller":"traceutil/trace.go:171","msg":"trace[856701287] transaction","detail":"{read_only:false; response_revision:7845; number_of_response:1; }","duration":"1.669528281s","start":"2026-04-20T02:14:49.561169Z","end":"2026-04-20T02:14:51.230698Z","steps":["trace[856701287] 'process raft request' (duration: 18.018199ms)","trace[856701287] 'compare' (duration: 1.648458673s)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:14:51.230873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.561142Z","time spent":"1.669686855s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:14:51.231634Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.652584634s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:14:51.232025Z","caller":"traceutil/trace.go:171","msg":"trace[1865867971] transaction","detail":"{read_only:false; response_revision:7846; number_of_response:1; }","duration":"1.670613683s","start":"2026-04-20T02:14:49.561394Z","end":"2026-04-20T02:14:51.232008Z","steps":["trace[1865867971] 'process raft request' (duration: 1.670422188s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.232391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.561371Z","time spent":"1.670968763s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:14:51.232619Z","caller":"traceutil/trace.go:171","msg":"trace[671131047] transaction","detail":"{read_only:false; response_revision:7847; number_of_response:1; }","duration":"1.671055615s","start":"2026-04-20T02:14:49.561532Z","end":"2026-04-20T02:14:51.232588Z","steps":["trace[671131047] 'process raft request' (duration: 1.670388416s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.232951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.561524Z","time spent":"1.671187989s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:14:51.232989Z","caller":"traceutil/trace.go:171","msg":"trace[676515520] transaction","detail":"{read_only:false; response_revision:7848; number_of_response:1; }","duration":"1.671313592s","start":"2026-04-20T02:14:49.56165Z","end":"2026-04-20T02:14:51.232964Z","steps":["trace[676515520] 'process raft request' (duration: 1.670854629s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.23342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.561633Z","time spent":"1.671733865s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:14:51.233646Z","caller":"traceutil/trace.go:171","msg":"trace[368325189] transaction","detail":"{read_only:false; response_revision:7849; number_of_response:1; }","duration":"1.671323883s","start":"2026-04-20T02:14:49.562289Z","end":"2026-04-20T02:14:51.233613Z","steps":["trace[368325189] 'process raft request' (duration: 1.670368735s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.234008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.562263Z","time spent":"1.671533688s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:14:51.234015Z","caller":"traceutil/trace.go:171","msg":"trace[2022510448] linearizableReadLoop","detail":"{readStateIndex:8133; appliedIndex:8130; }","duration":"1.672343763s","start":"2026-04-20T02:14:49.561653Z","end":"2026-04-20T02:14:51.233996Z","steps":["trace[2022510448] 'read index received' (duration: 17.294857ms)","trace[2022510448] 'applied index is now lower than readState.Index' (duration: 1.655047776s)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:14:51.234152Z","caller":"traceutil/trace.go:171","msg":"trace[1976378168] transaction","detail":"{read_only:false; response_revision:7851; number_of_response:1; }","duration":"1.66988861s","start":"2026-04-20T02:14:49.564228Z","end":"2026-04-20T02:14:51.234116Z","steps":["trace[1976378168] 'process raft request' (duration: 1.669614622s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.234277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.564201Z","time spent":"1.669978233s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:14:51.234568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.667845732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:14:51.234642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.957458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:14:51.234614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.569392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T02:14:51.234717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.38642475s","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-20T02:14:51.234723Z","caller":"traceutil/trace.go:171","msg":"trace[700169222] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:7851; }","duration":"624.726916ms","start":"2026-04-20T02:14:50.609978Z","end":"2026-04-20T02:14:51.234704Z","steps":["trace[700169222] 'agreement among raft nodes before linearized reading' (duration: 624.534521ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:14:51.234813Z","caller":"traceutil/trace.go:171","msg":"trace[1731668557] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7851; }","duration":"1.386550844s","start":"2026-04-20T02:14:49.848246Z","end":"2026-04-20T02:14:51.234797Z","steps":["trace[1731668557] 'agreement among raft nodes before linearized reading' (duration: 1.38642371s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:14:51.234691Z","caller":"traceutil/trace.go:171","msg":"trace[518824222] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:7851; }","duration":"879.01903ms","start":"2026-04-20T02:14:50.355654Z","end":"2026-04-20T02:14:51.234673Z","steps":["trace[518824222] 'agreement among raft nodes before linearized reading' (duration: 878.965689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.235016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:50.355643Z","time spent":"879.35983ms","remote":"127.0.0.1:35830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:14:51.235106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.848221Z","time spent":"1.386708659s","remote":"127.0.0.1:53990","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-20T02:14:51.235142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.597604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:14:51.235209Z","caller":"traceutil/trace.go:171","msg":"trace[1986205510] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:7851; }","duration":"926.704056ms","start":"2026-04-20T02:14:50.30849Z","end":"2026-04-20T02:14:51.235194Z","steps":["trace[1986205510] 'agreement among raft nodes before linearized reading' (duration: 926.607574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.235262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:50.308466Z","time spent":"926.785019ms","remote":"127.0.0.1:35972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:14:51.234421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.672764555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:709"} {"level":"warn","ts":"2026-04-20T02:14:51.235462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.633805823s","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-20T02:14:51.235482Z","caller":"traceutil/trace.go:171","msg":"trace[1517252468] range","detail":"{range_begin:/registry/roles/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:7851; }","duration":"1.673877737s","start":"2026-04-20T02:14:49.561585Z","end":"2026-04-20T02:14:51.235462Z","steps":["trace[1517252468] 'agreement among raft nodes before linearized reading' (duration: 1.672784266s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:14:51.235503Z","caller":"traceutil/trace.go:171","msg":"trace[665983630] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7851; }","duration":"1.633897945s","start":"2026-04-20T02:14:49.601594Z","end":"2026-04-20T02:14:51.235492Z","steps":["trace[665983630] 'agreement among raft nodes before linearized reading' (duration: 1.63373882s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.235546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.60157Z","time spent":"1.633968237s","remote":"127.0.0.1:44840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-20T02:14:51.235533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.561549Z","time spent":"1.67396923s","remote":"127.0.0.1:45008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":732,"request content":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" "} {"level":"warn","ts":"2026-04-20T02:14:51.234846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:50.609955Z","time spent":"624.879721ms","remote":"127.0.0.1:45034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":72,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:14:51.23459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.182332189s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:14:51.235856Z","caller":"traceutil/trace.go:171","msg":"trace[1738178854] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:7851; }","duration":"1.183630547s","start":"2026-04-20T02:14:50.052211Z","end":"2026-04-20T02:14:51.235842Z","steps":["trace[1738178854] 'agreement among raft nodes before linearized reading' (duration: 1.182294399s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:14:51.234641Z","caller":"traceutil/trace.go:171","msg":"trace[768553888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7851; }","duration":"1.667951495s","start":"2026-04-20T02:14:49.566674Z","end":"2026-04-20T02:14:51.234625Z","steps":["trace[768553888] 'agreement among raft nodes before linearized reading' (duration: 1.667842912s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.236135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:50.052194Z","time spent":"1.183789771s","remote":"127.0.0.1:35888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:14:51.23623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.673795265s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-public/default\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-04-20T02:14:51.236267Z","caller":"traceutil/trace.go:171","msg":"trace[1161037072] range","detail":"{range_begin:/registry/serviceaccounts/kube-public/default; range_end:; response_count:1; response_revision:7851; }","duration":"1.673863397s","start":"2026-04-20T02:14:49.562395Z","end":"2026-04-20T02:14:51.236258Z","steps":["trace[1161037072] 'agreement among raft nodes before linearized reading' (duration: 1.673160217s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.236803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.562383Z","time spent":"1.674409474s","remote":"127.0.0.1:44868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":202,"request content":"key:\"/registry/serviceaccounts/kube-public/default\" "} {"level":"info","ts":"2026-04-20T02:14:51.236941Z","caller":"traceutil/trace.go:171","msg":"trace[120110068] transaction","detail":"{read_only:false; response_revision:7850; number_of_response:1; }","duration":"1.674543687s","start":"2026-04-20T02:14:49.562372Z","end":"2026-04-20T02:14:51.236916Z","steps":["trace[120110068] 'process raft request' (duration: 1.670343434s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:51.237065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.562352Z","time spent":"1.674641801s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:14:51.23764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:49.56666Z","time spent":"1.669383866s","remote":"127.0.0.1:44630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T02:14:52.062356Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987022690,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:14:52.563311Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987022690,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:14:53.063674Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201719987022690,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:14:53.295847Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.785489467s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:14:53.296229Z","caller":"traceutil/trace.go:171","msg":"trace[429250329] transaction","detail":"{read_only:false; response_revision:7852; number_of_response:1; }","duration":"1.786004192s","start":"2026-04-20T02:14:51.510204Z","end":"2026-04-20T02:14:53.296208Z","steps":["trace[429250329] 'process raft request' (duration: 1.785816017s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:53.29637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:51.510169Z","time spent":"1.786131136s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:14:53.302358Z","caller":"traceutil/trace.go:171","msg":"trace[1674685271] transaction","detail":"{read_only:false; response_revision:7853; number_of_response:1; }","duration":"1.740576093s","start":"2026-04-20T02:14:51.561754Z","end":"2026-04-20T02:14:53.30233Z","steps":["trace[1674685271] 'process raft request' (duration: 1.740373777s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:53.303142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:51.561741Z","time spent":"1.741332905s","remote":"127.0.0.1:44932","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-20T02:14:53.328912Z","caller":"traceutil/trace.go:171","msg":"trace[626384794] linearizableReadLoop","detail":"{readStateIndex:8140; appliedIndex:8137; }","duration":"1.767666483s","start":"2026-04-20T02:14:51.561221Z","end":"2026-04-20T02:14:53.328888Z","steps":["trace[626384794] 'read index received' (duration: 1.734873208s)","trace[626384794] 'applied index is now lower than readState.Index' (duration: 32.792205ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:14:53.329206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.767967022s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubelet-config\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-04-20T02:14:53.329246Z","caller":"traceutil/trace.go:171","msg":"trace[1007264280] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubelet-config; range_end:; response_count:1; response_revision:7853; }","duration":"1.768049434s","start":"2026-04-20T02:14:51.561186Z","end":"2026-04-20T02:14:53.329235Z","steps":["trace[1007264280] 'agreement among raft nodes before linearized reading' (duration: 1.76790384s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:53.329281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:51.561164Z","time spent":"1.768107136s","remote":"127.0.0.1:45010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":561,"request content":"key:\"/registry/rolebindings/kube-system/kubeadm:kubelet-config\" "} {"level":"warn","ts":"2026-04-20T02:14:53.329808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.734893876s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-20T02:14:53.330013Z","caller":"traceutil/trace.go:171","msg":"trace[1033434659] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:7854; }","duration":"1.735133642s","start":"2026-04-20T02:14:51.594859Z","end":"2026-04-20T02:14:53.329993Z","steps":["trace[1033434659] 'agreement among raft nodes before linearized reading' (duration: 1.73473782s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:53.330204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:51.594842Z","time spent":"1.735341688s","remote":"127.0.0.1:45010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":506,"request content":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" "} {"level":"warn","ts":"2026-04-20T02:14:53.329922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.497167157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T02:14:53.329863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.665813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:14:53.331204Z","caller":"traceutil/trace.go:171","msg":"trace[1641271869] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7854; }","duration":"423.039202ms","start":"2026-04-20T02:14:52.908149Z","end":"2026-04-20T02:14:53.331189Z","steps":["trace[1641271869] 'agreement among raft nodes before linearized reading' (duration: 421.688063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:53.331292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:52.908129Z","time spent":"423.148935ms","remote":"127.0.0.1:44630","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-20T02:14:53.330867Z","caller":"traceutil/trace.go:171","msg":"trace[771921084] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:7854; }","duration":"1.498141495s","start":"2026-04-20T02:14:51.832704Z","end":"2026-04-20T02:14:53.330845Z","steps":["trace[771921084] 'agreement among raft nodes before linearized reading' (duration: 1.497173807s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:14:53.331845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:14:51.832683Z","time spent":"1.499145553s","remote":"127.0.0.1:35836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":26,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-04-20T02:14:55.518315Z","caller":"traceutil/trace.go:171","msg":"trace[128994949] transaction","detail":"{read_only:false; response_revision:7869; number_of_response:1; }","duration":"105.475844ms","start":"2026-04-20T02:14:55.412812Z","end":"2026-04-20T02:14:55.518288Z","steps":["trace[128994949] 'process raft request' (duration: 86.533494ms)","trace[128994949] 'compare' (duration: 18.789416ms)"],"step_count":2}