{"level":"warn","ts":"2026-05-15T13:42:18.572711Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-15T13:42:18.572847Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.237:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.237:2380","--initial-cluster=instance=https://199.19.213.237:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.237:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.237: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-05-15T13:42:18.572945Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-15T13:42:18.572958Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.237:2380"]} {"level":"info","ts":"2026-05-15T13:42:18.572979Z","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-05-15T13:42:18.573811Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"]} {"level":"info","ts":"2026-05-15T13:42:18.573902Z","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.19.213.237:2380"],"listen-peer-urls":["https://199.19.213.237:2380"],"advertise-client-urls":["https://199.19.213.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.237: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-05-15T13:42:18.578172Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.991477ms"} {"level":"info","ts":"2026-05-15T13:42:18.584036Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c51d7a9ea5537d6e","cluster-id":"bea7a5ea8f053dc3"} {"level":"info","ts":"2026-05-15T13:42:18.584133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=()"} {"level":"info","ts":"2026-05-15T13:42:18.584162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became follower at term 0"} {"level":"info","ts":"2026-05-15T13:42:18.584183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c51d7a9ea5537d6e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-15T13:42:18.584196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became follower at term 1"} {"level":"info","ts":"2026-05-15T13:42:18.584243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=(14203643621593546094)"} {"level":"warn","ts":"2026-05-15T13:42:18.59342Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-15T13:42:18.596183Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-15T13:42:18.597587Z","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-05-15T13:42:18.600104Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c51d7a9ea5537d6e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-15T13:42:18.604355Z","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-05-15T13:42:18.604413Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c51d7a9ea5537d6e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-15T13:42:18.604654Z","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-05-15T13:42:18.60468Z","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-05-15T13:42:18.608146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=(14203643621593546094)"} {"level":"info","ts":"2026-05-15T13:42:18.608435Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bea7a5ea8f053dc3","local-member-id":"c51d7a9ea5537d6e","added-peer-id":"c51d7a9ea5537d6e","added-peer-peer-urls":["https://199.19.213.237:2380"]} {"level":"info","ts":"2026-05-15T13:42:18.608687Z","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-05-15T13:42:18.608968Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.237:2380"} {"level":"info","ts":"2026-05-15T13:42:18.608989Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.237:2380"} {"level":"info","ts":"2026-05-15T13:42:18.611513Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c51d7a9ea5537d6e","initial-advertise-peer-urls":["https://199.19.213.237:2380"],"listen-peer-urls":["https://199.19.213.237:2380"],"advertise-client-urls":["https://199.19.213.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-15T13:42:18.61162Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-15T13:42:19.585344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e is starting a new election at term 1"} {"level":"info","ts":"2026-05-15T13:42:19.585413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became pre-candidate at term 1"} {"level":"info","ts":"2026-05-15T13:42:19.585447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e received MsgPreVoteResp from c51d7a9ea5537d6e at term 1"} {"level":"info","ts":"2026-05-15T13:42:19.585481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became candidate at term 2"} {"level":"info","ts":"2026-05-15T13:42:19.585494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e received MsgVoteResp from c51d7a9ea5537d6e at term 2"} {"level":"info","ts":"2026-05-15T13:42:19.585507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became leader at term 2"} {"level":"info","ts":"2026-05-15T13:42:19.585523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c51d7a9ea5537d6e elected leader c51d7a9ea5537d6e at term 2"} {"level":"info","ts":"2026-05-15T13:42:19.586655Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-15T13:42:19.586804Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c51d7a9ea5537d6e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.237:2379]}","request-path":"/0/members/c51d7a9ea5537d6e/attributes","cluster-id":"bea7a5ea8f053dc3","publish-timeout":"7s"} {"level":"info","ts":"2026-05-15T13:42:19.586959Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-15T13:42:19.587053Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-15T13:42:19.588428Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bea7a5ea8f053dc3","local-member-id":"c51d7a9ea5537d6e","cluster-version":"3.5"} {"level":"info","ts":"2026-05-15T13:42:19.58852Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-15T13:42:19.589358Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-15T13:42:19.589364Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-15T13:42:19.589457Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-15T13:42:19.5896Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-15T13:42:19.591224Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.237:2379"} {"level":"warn","ts":"2026-05-15T13:42:22.564211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.186115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-15T13:42:22.564299Z","caller":"traceutil/trace.go:171","msg":"trace[2036560616] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:75; }","duration":"547.382329ms","start":"2026-05-15T13:42:22.016898Z","end":"2026-05-15T13:42:22.564281Z","steps":["trace[2036560616] 'range keys from in-memory index tree' (duration: 547.130764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:42:22.564363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:42:22.016883Z","time spent":"547.466772ms","remote":"127.0.0.1:45968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"warn","ts":"2026-05-15T13:42:22.564463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.526253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-cluster-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-15T13:42:22.564463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.853318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-15T13:42:22.564582Z","caller":"traceutil/trace.go:171","msg":"trace[89380667] range","detail":"{range_begin:/registry/priorityclasses/system-cluster-critical; range_end:; response_count:0; response_revision:75; }","duration":"547.701547ms","start":"2026-05-15T13:42:22.016856Z","end":"2026-05-15T13:42:22.564558Z","steps":["trace[89380667] 'range keys from in-memory index tree' (duration: 547.341438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:42:22.56467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:42:22.01684Z","time spent":"547.817361ms","remote":"127.0.0.1:45976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-cluster-critical\" "} {"level":"info","ts":"2026-05-15T13:42:22.564731Z","caller":"traceutil/trace.go:171","msg":"trace[1663077456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:75; }","duration":"514.187926ms","start":"2026-05-15T13:42:22.050454Z","end":"2026-05-15T13:42:22.564642Z","steps":["trace[1663077456] 'range keys from in-memory index tree' (duration: 513.634323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:42:22.564888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:42:22.050426Z","time spent":"514.423632ms","remote":"127.0.0.1:45632","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-05-15T13:42:22.747174Z","caller":"traceutil/trace.go:171","msg":"trace[1802432367] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"135.443368ms","start":"2026-05-15T13:42:22.611654Z","end":"2026-05-15T13:42:22.747098Z","steps":["trace[1802432367] 'process raft request' (duration: 131.218604ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:42:23.479362Z","caller":"traceutil/trace.go:171","msg":"trace[1526731793] linearizableReadLoop","detail":"{readStateIndex:82; appliedIndex:81; }","duration":"428.803002ms","start":"2026-05-15T13:42:23.050533Z","end":"2026-05-15T13:42:23.479336Z","steps":["trace[1526731793] 'read index received' (duration: 428.565486ms)","trace[1526731793] 'applied index is now lower than readState.Index' (duration: 236.766µs)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:42:23.479491Z","caller":"traceutil/trace.go:171","msg":"trace[1047472809] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"724.536426ms","start":"2026-05-15T13:42:22.754916Z","end":"2026-05-15T13:42:23.479453Z","steps":["trace[1047472809] 'process raft request' (duration: 724.286171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:42:23.479647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.100009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-15T13:42:23.479676Z","caller":"traceutil/trace.go:171","msg":"trace[1848974262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:78; }","duration":"429.183181ms","start":"2026-05-15T13:42:23.050484Z","end":"2026-05-15T13:42:23.479667Z","steps":["trace[1848974262] 'agreement among raft nodes before linearized reading' (duration: 428.999546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:42:23.4797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:42:23.050465Z","time spent":"429.229292ms","remote":"127.0.0.1:45632","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-05-15T13:42:23.479791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.191893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-15T13:42:23.479829Z","caller":"traceutil/trace.go:171","msg":"trace[817267188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:78; }","duration":"387.260595ms","start":"2026-05-15T13:42:23.092557Z","end":"2026-05-15T13:42:23.479817Z","steps":["trace[817267188] 'agreement among raft nodes before linearized reading' (duration: 387.167293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:42:23.479856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:42:23.092541Z","time spent":"387.308096ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-15T13:42:23.479895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.435716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:430"} {"level":"info","ts":"2026-05-15T13:42:23.480029Z","caller":"traceutil/trace.go:171","msg":"trace[2128116342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:78; }","duration":"393.680452ms","start":"2026-05-15T13:42:23.086321Z","end":"2026-05-15T13:42:23.480002Z","steps":["trace[2128116342] 'agreement among raft nodes before linearized reading' (duration: 393.374475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:42:23.48007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:42:22.754883Z","time spent":"724.700411ms","remote":"127.0.0.1:45968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":634,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-15T13:42:23.480081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:42:23.086215Z","time spent":"393.855626ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-15T13:43:03.595146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.101862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:9149"} {"level":"info","ts":"2026-05-15T13:43:03.595312Z","caller":"traceutil/trace.go:171","msg":"trace[836921919] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:588; }","duration":"171.337317ms","start":"2026-05-15T13:43:03.423944Z","end":"2026-05-15T13:43:03.595282Z","steps":["trace[836921919] 'range keys from in-memory index tree' (duration: 170.823334ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:03.595308Z","caller":"traceutil/trace.go:171","msg":"trace[181480940] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"154.70125ms","start":"2026-05-15T13:43:03.440574Z","end":"2026-05-15T13:43:03.595276Z","steps":["trace[181480940] 'process raft request' (duration: 151.878401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:04.518488Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9038335413452332282,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-15T13:43:04.869299Z","caller":"traceutil/trace.go:171","msg":"trace[1116283543] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"900.613203ms","start":"2026-05-15T13:43:03.968634Z","end":"2026-05-15T13:43:04.869247Z","steps":["trace[1116283543] 'process raft request' (duration: 900.411387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:04.869494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:03.968584Z","time spent":"900.815387ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-15T13:43:04.917628Z","caller":"traceutil/trace.go:171","msg":"trace[856059881] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:624; }","duration":"899.171121ms","start":"2026-05-15T13:43:04.018423Z","end":"2026-05-15T13:43:04.917594Z","steps":["trace[856059881] 'read index received' (duration: 850.554115ms)","trace[856059881] 'applied index is now lower than readState.Index' (duration: 48.615946ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:43:04.917724Z","caller":"traceutil/trace.go:171","msg":"trace[1893121353] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"752.184782ms","start":"2026-05-15T13:43:04.165499Z","end":"2026-05-15T13:43:04.917684Z","steps":["trace[1893121353] 'process raft request' (duration: 751.872893ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:04.917785Z","caller":"traceutil/trace.go:171","msg":"trace[288889321] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"551.869763ms","start":"2026-05-15T13:43:04.365855Z","end":"2026-05-15T13:43:04.917724Z","steps":["trace[288889321] 'process raft request' (duration: 551.681589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:04.917936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:04.165456Z","time spent":"752.355135ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-15T13:43:04.917992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:04.365787Z","time spent":"552.115939ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-15T13:43:04.91825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.762687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:04.919146Z","caller":"traceutil/trace.go:171","msg":"trace[1250234658] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"899.988671ms","start":"2026-05-15T13:43:04.018377Z","end":"2026-05-15T13:43:04.918366Z","steps":["trace[1250234658] 'agreement among raft nodes before linearized reading' (duration: 899.375686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:04.919296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:04.018352Z","time spent":"900.885113ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-15T13:43:05.195979Z","caller":"traceutil/trace.go:171","msg":"trace[771705387] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"278.214215ms","start":"2026-05-15T13:43:04.917734Z","end":"2026-05-15T13:43:05.195948Z","steps":["trace[771705387] 'read index received' (duration: 277.861807ms)","trace[771705387] 'applied index is now lower than readState.Index' (duration: 351.268µs)"],"step_count":2} {"level":"warn","ts":"2026-05-15T13:43:05.1965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.818723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T13:43:05.196533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.037067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T13:43:05.19659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.151571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:05.196633Z","caller":"traceutil/trace.go:171","msg":"trace[1171517329] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:605; }","duration":"634.237922ms","start":"2026-05-15T13:43:04.562374Z","end":"2026-05-15T13:43:05.196612Z","steps":["trace[1171517329] 'agreement among raft nodes before linearized reading' (duration: 634.022087ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:05.196658Z","caller":"traceutil/trace.go:171","msg":"trace[196238084] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:605; }","duration":"234.238173ms","start":"2026-05-15T13:43:04.962384Z","end":"2026-05-15T13:43:05.196622Z","steps":["trace[196238084] 'agreement among raft nodes before linearized reading' (duration: 234.172091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:05.196704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080219416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-15T13:43:05.196717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:04.562349Z","time spent":"634.360765ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-05-15T13:43:05.19669Z","caller":"traceutil/trace.go:171","msg":"trace[572076028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"176.956676ms","start":"2026-05-15T13:43:05.019599Z","end":"2026-05-15T13:43:05.196556Z","steps":["trace[572076028] 'agreement among raft nodes before linearized reading' (duration: 176.851864ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:05.196845Z","caller":"traceutil/trace.go:171","msg":"trace[968780732] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"310.494623ms","start":"2026-05-15T13:43:04.886338Z","end":"2026-05-15T13:43:05.196832Z","steps":["trace[968780732] 'process raft request' (duration: 309.321575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:05.196481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.175106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.237\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-15T13:43:05.196954Z","caller":"traceutil/trace.go:171","msg":"trace[1497034774] range","detail":"{range_begin:/registry/masterleases/199.19.213.237; range_end:; response_count:1; response_revision:605; }","duration":"842.701009ms","start":"2026-05-15T13:43:04.354229Z","end":"2026-05-15T13:43:05.19693Z","steps":["trace[1497034774] 'agreement among raft nodes before linearized reading' (duration: 842.075653ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:05.196991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:04.354201Z","time spent":"842.778111ms","remote":"127.0.0.1:45678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.237\" "} {"level":"info","ts":"2026-05-15T13:43:05.196753Z","caller":"traceutil/trace.go:171","msg":"trace[829593543] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"1.08037035s","start":"2026-05-15T13:43:04.116371Z","end":"2026-05-15T13:43:05.196741Z","steps":["trace[829593543] 'agreement among raft nodes before linearized reading' (duration: 1.080199756s)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:05.197096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.876617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T13:43:05.197123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:04.116339Z","time spent":"1.080776741s","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-15T13:43:05.197143Z","caller":"traceutil/trace.go:171","msg":"trace[1154383238] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:605; }","duration":"435.626665ms","start":"2026-05-15T13:43:04.761499Z","end":"2026-05-15T13:43:05.197126Z","steps":["trace[1154383238] 'agreement among raft nodes before linearized reading' (duration: 434.865627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:05.197215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:04.761475Z","time spent":"435.727847ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-15T13:43:05.197292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:04.886284Z","time spent":"310.589265ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T13:43:05.196637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.226676ms","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-05-15T13:43:05.197421Z","caller":"traceutil/trace.go:171","msg":"trace[385409379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"270.112958ms","start":"2026-05-15T13:43:04.927255Z","end":"2026-05-15T13:43:05.197368Z","steps":["trace[385409379] 'agreement among raft nodes before linearized reading' (duration: 269.084483ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:05.334757Z","caller":"traceutil/trace.go:171","msg":"trace[1557587104] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"123.869451ms","start":"2026-05-15T13:43:05.210863Z","end":"2026-05-15T13:43:05.334733Z","steps":["trace[1557587104] 'process raft request' (duration: 122.988199ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:05.334905Z","caller":"traceutil/trace.go:171","msg":"trace[2089554255] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"123.901922ms","start":"2026-05-15T13:43:05.210996Z","end":"2026-05-15T13:43:05.334898Z","steps":["trace[2089554255] 'process raft request' (duration: 123.045881ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:05.334997Z","caller":"traceutil/trace.go:171","msg":"trace[1202229715] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"121.833492ms","start":"2026-05-15T13:43:05.213155Z","end":"2026-05-15T13:43:05.334989Z","steps":["trace[1202229715] 'process raft request' (duration: 120.92194ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:05.335185Z","caller":"traceutil/trace.go:171","msg":"trace[1010820649] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"103.152786ms","start":"2026-05-15T13:43:05.232023Z","end":"2026-05-15T13:43:05.335176Z","steps":["trace[1010820649] 'process raft request' (duration: 102.083901ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:10.196515Z","caller":"traceutil/trace.go:171","msg":"trace[115430279] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"167.707301ms","start":"2026-05-15T13:43:10.028772Z","end":"2026-05-15T13:43:10.196479Z","steps":["trace[115430279] 'process raft request' (duration: 167.141967ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:10.902369Z","caller":"traceutil/trace.go:171","msg":"trace[901834923] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"220.57452ms","start":"2026-05-15T13:43:10.68176Z","end":"2026-05-15T13:43:10.902334Z","steps":["trace[901834923] 'process raft request' (duration: 219.841643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:13.171258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.61728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:13.171384Z","caller":"traceutil/trace.go:171","msg":"trace[617413720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:669; }","duration":"150.010329ms","start":"2026-05-15T13:43:13.021352Z","end":"2026-05-15T13:43:13.171363Z","steps":["trace[617413720] 'range keys from in-memory index tree' (duration: 149.497586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:13.17145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.278285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-g6dg8\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-15T13:43:13.17156Z","caller":"traceutil/trace.go:171","msg":"trace[2019181] range","detail":"{range_begin:/registry/pods/kube-system/cilium-g6dg8; range_end:; response_count:1; response_revision:669; }","duration":"813.513671ms","start":"2026-05-15T13:43:12.358017Z","end":"2026-05-15T13:43:13.171531Z","steps":["trace[2019181] 'range keys from in-memory index tree' (duration: 812.924917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:13.171616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:12.357993Z","time spent":"813.611144ms","remote":"127.0.0.1:45822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-g6dg8\" "} {"level":"warn","ts":"2026-05-15T13:43:13.872227Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9038335413452332441,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-15T13:43:14.057591Z","caller":"traceutil/trace.go:171","msg":"trace[1034064541] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:694; }","duration":"686.082074ms","start":"2026-05-15T13:43:13.371471Z","end":"2026-05-15T13:43:14.057553Z","steps":["trace[1034064541] 'read index received' (duration: 685.698755ms)","trace[1034064541] 'applied index is now lower than readState.Index' (duration: 381.739µs)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:43:14.057722Z","caller":"traceutil/trace.go:171","msg":"trace[871836188] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"871.64852ms","start":"2026-05-15T13:43:13.186027Z","end":"2026-05-15T13:43:14.057675Z","steps":["trace[871836188] 'process raft request' (duration: 871.278852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:14.057936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:13.185993Z","time spent":"871.833943ms","remote":"127.0.0.1:45822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T13:43:14.057981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.477124ms","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-05-15T13:43:14.058015Z","caller":"traceutil/trace.go:171","msg":"trace[492716082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:670; }","duration":"686.543936ms","start":"2026-05-15T13:43:13.371462Z","end":"2026-05-15T13:43:14.058006Z","steps":["trace[492716082] 'agreement among raft nodes before linearized reading' (duration: 686.280329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:14.058052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:13.371389Z","time spent":"686.656027ms","remote":"127.0.0.1:45890","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-05-15T13:43:14.05821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.008253ms","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-05-15T13:43:14.058296Z","caller":"traceutil/trace.go:171","msg":"trace[1764221148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:670; }","duration":"242.125685ms","start":"2026-05-15T13:43:13.816139Z","end":"2026-05-15T13:43:14.058265Z","steps":["trace[1764221148] 'agreement among raft nodes before linearized reading' (duration: 241.87613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:14.05833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.964789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-15T13:43:14.058451Z","caller":"traceutil/trace.go:171","msg":"trace[1338319104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:670; }","duration":"230.134962ms","start":"2026-05-15T13:43:13.82829Z","end":"2026-05-15T13:43:14.058425Z","steps":["trace[1338319104] 'agreement among raft nodes before linearized reading' (duration: 229.845346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:14.058825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.11578ms","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-05-15T13:43:14.059073Z","caller":"traceutil/trace.go:171","msg":"trace[932741808] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:670; }","duration":"685.386957ms","start":"2026-05-15T13:43:13.373675Z","end":"2026-05-15T13:43:14.059062Z","steps":["trace[932741808] 'agreement among raft nodes before linearized reading' (duration: 684.398563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:14.0591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:13.373648Z","time spent":"685.442668ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-15T13:43:14.05909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.123349ms","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-05-15T13:43:14.059171Z","caller":"traceutil/trace.go:171","msg":"trace[1426033784] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:670; }","duration":"687.265431ms","start":"2026-05-15T13:43:13.371871Z","end":"2026-05-15T13:43:14.059136Z","steps":["trace[1426033784] 'agreement among raft nodes before linearized reading' (duration: 686.108244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:14.059224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:13.371838Z","time spent":"687.374114ms","remote":"127.0.0.1:45890","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":"info","ts":"2026-05-15T13:43:16.241124Z","caller":"traceutil/trace.go:171","msg":"trace[1751952772] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"153.898524ms","start":"2026-05-15T13:43:16.087198Z","end":"2026-05-15T13:43:16.241097Z","steps":["trace[1751952772] 'process raft request' (duration: 153.808132ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:16.241299Z","caller":"traceutil/trace.go:171","msg":"trace[1867859751] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"154.504958ms","start":"2026-05-15T13:43:16.08675Z","end":"2026-05-15T13:43:16.241255Z","steps":["trace[1867859751] 'process raft request' (duration: 130.509163ms)","trace[1867859751] 'compare' (duration: 23.591505ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:43:16.241444Z","caller":"traceutil/trace.go:171","msg":"trace[1402753631] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:710; }","duration":"120.062718ms","start":"2026-05-15T13:43:16.121346Z","end":"2026-05-15T13:43:16.241409Z","steps":["trace[1402753631] 'read index received' (duration: 54.348216ms)","trace[1402753631] 'applied index is now lower than readState.Index' (duration: 65.712682ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:43:16.241509Z","caller":"traceutil/trace.go:171","msg":"trace[1424592758] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"153.277248ms","start":"2026-05-15T13:43:16.088221Z","end":"2026-05-15T13:43:16.241498Z","steps":["trace[1424592758] 'process raft request' (duration: 152.831587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:16.241806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.426767ms","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-05-15T13:43:16.241847Z","caller":"traceutil/trace.go:171","msg":"trace[2074959479] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:688; }","duration":"120.52912ms","start":"2026-05-15T13:43:16.121304Z","end":"2026-05-15T13:43:16.241833Z","steps":["trace[2074959479] 'agreement among raft nodes before linearized reading' (duration: 120.229943ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:30.555112Z","caller":"traceutil/trace.go:171","msg":"trace[585510671] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:816; }","duration":"292.149725ms","start":"2026-05-15T13:43:30.262932Z","end":"2026-05-15T13:43:30.555082Z","steps":["trace[585510671] 'read index received' (duration: 292.016442ms)","trace[585510671] 'applied index is now lower than readState.Index' (duration: 132.143µs)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:43:30.55517Z","caller":"traceutil/trace.go:171","msg":"trace[1737137110] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"293.775665ms","start":"2026-05-15T13:43:30.261373Z","end":"2026-05-15T13:43:30.555149Z","steps":["trace[1737137110] 'process raft request' (duration: 293.54829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.555626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.638438ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:30.555779Z","caller":"traceutil/trace.go:171","msg":"trace[810983999] 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:786; }","duration":"292.839553ms","start":"2026-05-15T13:43:30.262878Z","end":"2026-05-15T13:43:30.555718Z","steps":["trace[810983999] 'agreement among raft nodes before linearized reading' (duration: 292.358421ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:30.867172Z","caller":"traceutil/trace.go:171","msg":"trace[1304079864] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"311.945619ms","start":"2026-05-15T13:43:30.55519Z","end":"2026-05-15T13:43:30.867136Z","steps":["trace[1304079864] 'read index received' (duration: 311.644701ms)","trace[1304079864] 'applied index is now lower than readState.Index' (duration: 299.168µs)"],"step_count":2} {"level":"warn","ts":"2026-05-15T13:43:30.867776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.3735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T13:43:30.867799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.960251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:30.86785Z","caller":"traceutil/trace.go:171","msg":"trace[461328221] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:787; }","duration":"563.564995ms","start":"2026-05-15T13:43:30.304264Z","end":"2026-05-15T13:43:30.867829Z","steps":["trace[461328221] 'agreement among raft nodes before linearized reading' (duration: 563.39793ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:30.867887Z","caller":"traceutil/trace.go:171","msg":"trace[572151897] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:787; }","duration":"545.066394ms","start":"2026-05-15T13:43:30.322783Z","end":"2026-05-15T13:43:30.86785Z","steps":["trace[572151897] 'agreement among raft nodes before linearized reading' (duration: 544.93268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.867909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.304225Z","time spent":"563.665987ms","remote":"127.0.0.1:38906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-15T13:43:30.867936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.322767Z","time spent":"545.154697ms","remote":"127.0.0.1:38918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-15T13:43:30.868022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.359297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:30.86812Z","caller":"traceutil/trace.go:171","msg":"trace[226794278] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:787; }","duration":"544.433779ms","start":"2026-05-15T13:43:30.323624Z","end":"2026-05-15T13:43:30.868058Z","steps":["trace[226794278] 'agreement among raft nodes before linearized reading' (duration: 544.346907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.868175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.323616Z","time spent":"544.543381ms","remote":"127.0.0.1:38906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-05-15T13:43:30.868357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.663824ms","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-05-15T13:43:30.868388Z","caller":"traceutil/trace.go:171","msg":"trace[903502270] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"366.747915ms","start":"2026-05-15T13:43:30.501607Z","end":"2026-05-15T13:43:30.868355Z","steps":["trace[903502270] 'process raft request' (duration: 365.33335ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:30.86842Z","caller":"traceutil/trace.go:171","msg":"trace[979732755] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:787; }","duration":"546.725535ms","start":"2026-05-15T13:43:30.321678Z","end":"2026-05-15T13:43:30.868403Z","steps":["trace[979732755] 'agreement among raft nodes before linearized reading' (duration: 546.51515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.86846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.321613Z","time spent":"546.837257ms","remote":"127.0.0.1:45890","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-05-15T13:43:30.868514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.501574Z","time spent":"366.850387ms","remote":"127.0.0.1:45868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T13:43:30.868374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.095998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:30.868644Z","caller":"traceutil/trace.go:171","msg":"trace[299549204] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:787; }","duration":"564.476798ms","start":"2026-05-15T13:43:30.304153Z","end":"2026-05-15T13:43:30.86863Z","steps":["trace[299549204] 'agreement among raft nodes before linearized reading' (duration: 564.16075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.868765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.69118ms","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-05-15T13:43:30.868821Z","caller":"traceutil/trace.go:171","msg":"trace[1542371755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:787; }","duration":"552.792643ms","start":"2026-05-15T13:43:30.316013Z","end":"2026-05-15T13:43:30.868806Z","steps":["trace[1542371755] 'agreement among raft nodes before linearized reading' (duration: 552.64877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.86893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.31598Z","time spent":"552.932136ms","remote":"127.0.0.1:45890","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-05-15T13:43:30.8692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.243963ms","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-05-15T13:43:30.86927Z","caller":"traceutil/trace.go:171","msg":"trace[417667048] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"553.322786ms","start":"2026-05-15T13:43:30.31592Z","end":"2026-05-15T13:43:30.869242Z","steps":["trace[417667048] 'agreement among raft nodes before linearized reading' (duration: 553.184182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.869321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.315901Z","time spent":"553.407758ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-15T13:43:30.869356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.455668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:30.869415Z","caller":"traceutil/trace.go:171","msg":"trace[1707688578] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:787; }","duration":"546.612022ms","start":"2026-05-15T13:43:30.322788Z","end":"2026-05-15T13:43:30.8694Z","steps":["trace[1707688578] 'agreement among raft nodes before linearized reading' (duration: 546.51481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.869469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.322758Z","time spent":"546.695474ms","remote":"127.0.0.1:38918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-15T13:43:30.869595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.456353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-15T13:43:30.869627Z","caller":"traceutil/trace.go:171","msg":"trace[2072466802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"554.509494ms","start":"2026-05-15T13:43:30.31511Z","end":"2026-05-15T13:43:30.869619Z","steps":["trace[2072466802] 'agreement among raft nodes before linearized reading' (duration: 554.403012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.869651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.315095Z","time spent":"554.549786ms","remote":"127.0.0.1:45890","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-05-15T13:43:30.869938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.772019ms","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-05-15T13:43:30.869993Z","caller":"traceutil/trace.go:171","msg":"trace[498537546] 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:787; }","duration":"606.860911ms","start":"2026-05-15T13:43:30.263122Z","end":"2026-05-15T13:43:30.869983Z","steps":["trace[498537546] 'agreement among raft nodes before linearized reading' (duration: 606.78489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.870028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.263099Z","time spent":"606.918492ms","remote":"127.0.0.1:38886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"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-05-15T13:43:30.870156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.484608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-15T13:43:30.870199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.447793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:30.87019Z","caller":"traceutil/trace.go:171","msg":"trace[351658079] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:787; }","duration":"211.56992ms","start":"2026-05-15T13:43:30.658612Z","end":"2026-05-15T13:43:30.870182Z","steps":["trace[351658079] 'agreement among raft nodes before linearized reading' (duration: 211.505678ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:43:30.870233Z","caller":"traceutil/trace.go:171","msg":"trace[1002816972] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:787; }","duration":"588.487744ms","start":"2026-05-15T13:43:30.281737Z","end":"2026-05-15T13:43:30.870225Z","steps":["trace[1002816972] 'agreement among raft nodes before linearized reading' (duration: 588.426543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.870264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.281633Z","time spent":"588.622377ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-15T13:43:30.87042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.105203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:30.870454Z","caller":"traceutil/trace.go:171","msg":"trace[849416801] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:787; }","duration":"590.212285ms","start":"2026-05-15T13:43:30.280233Z","end":"2026-05-15T13:43:30.870445Z","steps":["trace[849416801] 'agreement among raft nodes before linearized reading' (duration: 590.157424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.870445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.446205ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T13:43:30.870488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.28022Z","time spent":"590.257797ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-15T13:43:30.870499Z","caller":"traceutil/trace.go:171","msg":"trace[1359177284] 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:787; }","duration":"607.510536ms","start":"2026-05-15T13:43:30.262978Z","end":"2026-05-15T13:43:30.870489Z","steps":["trace[1359177284] 'agreement among raft nodes before linearized reading' (duration: 607.436134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.870565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.262973Z","time spent":"607.556877ms","remote":"127.0.0.1:38886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-15T13:43:30.870624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.611926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:43:30.870652Z","caller":"traceutil/trace.go:171","msg":"trace[611224639] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:787; }","duration":"590.677817ms","start":"2026-05-15T13:43:30.279966Z","end":"2026-05-15T13:43:30.870643Z","steps":["trace[611224639] 'agreement among raft nodes before linearized reading' (duration: 590.626594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:43:30.870689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.279941Z","time spent":"590.736918ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-15T13:43:30.872052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:43:30.304114Z","time spent":"564.630702ms","remote":"127.0.0.1:38906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-05-15T13:44:07.051192Z","caller":"traceutil/trace.go:171","msg":"trace[766024075] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"300.600761ms","start":"2026-05-15T13:44:06.750555Z","end":"2026-05-15T13:44:07.051156Z","steps":["trace[766024075] 'process raft request' (duration: 300.330615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:07.051384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:06.750527Z","time spent":"300.747055ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:44:07.31072Z","caller":"traceutil/trace.go:171","msg":"trace[1648235231] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1045; }","duration":"171.866842ms","start":"2026-05-15T13:44:07.138831Z","end":"2026-05-15T13:44:07.310698Z","steps":["trace[1648235231] 'read index received' (duration: 171.678237ms)","trace[1648235231] 'applied index is now lower than readState.Index' (duration: 187.885µs)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:44:07.311144Z","caller":"traceutil/trace.go:171","msg":"trace[1828345646] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"200.146271ms","start":"2026-05-15T13:44:07.110988Z","end":"2026-05-15T13:44:07.311134Z","steps":["trace[1828345646] 'process raft request' (duration: 199.588198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:07.311393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.337263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-15T13:44:07.311508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.660411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-15T13:44:07.311531Z","caller":"traceutil/trace.go:171","msg":"trace[529503553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1007; }","duration":"172.520717ms","start":"2026-05-15T13:44:07.138987Z","end":"2026-05-15T13:44:07.311508Z","steps":["trace[529503553] 'agreement among raft nodes before linearized reading' (duration: 172.18378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:07.311604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.459935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-15T13:44:07.311627Z","caller":"traceutil/trace.go:171","msg":"trace[1676446113] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1007; }","duration":"165.510726ms","start":"2026-05-15T13:44:07.146111Z","end":"2026-05-15T13:44:07.311622Z","steps":["trace[1676446113] 'agreement among raft nodes before linearized reading' (duration: 165.451415ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:44:07.31154Z","caller":"traceutil/trace.go:171","msg":"trace[284030501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1007; }","duration":"172.738743ms","start":"2026-05-15T13:44:07.138792Z","end":"2026-05-15T13:44:07.311531Z","steps":["trace[284030501] 'agreement among raft nodes before linearized reading' (duration: 172.572749ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:44:08.138105Z","caller":"traceutil/trace.go:171","msg":"trace[2011955814] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"821.381244ms","start":"2026-05-15T13:44:07.316698Z","end":"2026-05-15T13:44:08.138079Z","steps":["trace[2011955814] 'process raft request' (duration: 818.626846ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:08.138255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:07.316668Z","time spent":"821.506237ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:44:08.189326Z","caller":"traceutil/trace.go:171","msg":"trace[1881982769] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"871.122817ms","start":"2026-05-15T13:44:07.318178Z","end":"2026-05-15T13:44:08.189301Z","steps":["trace[1881982769] 'process raft request' (duration: 870.756037ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:44:08.189372Z","caller":"traceutil/trace.go:171","msg":"trace[452167988] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"460.707507ms","start":"2026-05-15T13:44:07.728625Z","end":"2026-05-15T13:44:08.189333Z","steps":["trace[452167988] 'process raft request' (duration: 460.617605ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:44:08.189508Z","caller":"traceutil/trace.go:171","msg":"trace[668906251] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1046; }","duration":"258.129596ms","start":"2026-05-15T13:44:07.931359Z","end":"2026-05-15T13:44:08.189488Z","steps":["trace[668906251] 'read index received' (duration: 204.020117ms)","trace[668906251] 'applied index is now lower than readState.Index' (duration: 54.108669ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T13:44:08.189544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:07.318151Z","time spent":"871.264559ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:44:08.18955Z","caller":"traceutil/trace.go:171","msg":"trace[249522160] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"433.075342ms","start":"2026-05-15T13:44:07.75644Z","end":"2026-05-15T13:44:08.189516Z","steps":["trace[249522160] 'process raft request' (duration: 432.863827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:08.189681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.30182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-15T13:44:08.189701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:07.756411Z","time spent":"433.204605ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:44:08.189711Z","caller":"traceutil/trace.go:171","msg":"trace[211387158] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1012; }","duration":"258.389922ms","start":"2026-05-15T13:44:07.931311Z","end":"2026-05-15T13:44:08.189701Z","steps":["trace[211387158] 'agreement among raft nodes before linearized reading' (duration: 258.256459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:08.189746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.04682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:44:08.189816Z","caller":"traceutil/trace.go:171","msg":"trace[1001717043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"166.158493ms","start":"2026-05-15T13:44:08.023638Z","end":"2026-05-15T13:44:08.189796Z","steps":["trace[1001717043] 'agreement among raft nodes before linearized reading' (duration: 166.04262ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:44:08.189257Z","caller":"traceutil/trace.go:171","msg":"trace[290668639] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"872.132142ms","start":"2026-05-15T13:44:07.317036Z","end":"2026-05-15T13:44:08.189168Z","steps":["trace[290668639] 'process raft request' (duration: 871.736232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:08.189951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:07.317011Z","time spent":"872.90282ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T13:44:08.1903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:07.728601Z","time spent":"460.84569ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:44:33.581552Z","caller":"traceutil/trace.go:171","msg":"trace[699940308] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1134; }","duration":"148.244211ms","start":"2026-05-15T13:44:33.433289Z","end":"2026-05-15T13:44:33.581533Z","steps":["trace[699940308] 'read index received' (duration: 148.025215ms)","trace[699940308] 'applied index is now lower than readState.Index' (duration: 218.216µs)"],"step_count":2} {"level":"warn","ts":"2026-05-15T13:44:33.581745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.457456ms","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-05-15T13:44:33.581777Z","caller":"traceutil/trace.go:171","msg":"trace[2070176290] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1091; }","duration":"148.742794ms","start":"2026-05-15T13:44:33.433025Z","end":"2026-05-15T13:44:33.581768Z","steps":["trace[2070176290] 'agreement among raft nodes before linearized reading' (duration: 148.59336ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:44:33.581749Z","caller":"traceutil/trace.go:171","msg":"trace[663321470] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"393.887557ms","start":"2026-05-15T13:44:33.187828Z","end":"2026-05-15T13:44:33.581716Z","steps":["trace[663321470] 'process raft request' (duration: 393.580859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:33.582055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:33.187803Z","time spent":"394.145013ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:44:34.161457Z","caller":"traceutil/trace.go:171","msg":"trace[270448527] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"576.102071ms","start":"2026-05-15T13:44:33.585331Z","end":"2026-05-15T13:44:34.161433Z","steps":["trace[270448527] 'process raft request' (duration: 524.832585ms)","trace[270448527] 'compare' (duration: 51.064231ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:44:34.161684Z","caller":"traceutil/trace.go:171","msg":"trace[1271403673] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"366.168741ms","start":"2026-05-15T13:44:33.795484Z","end":"2026-05-15T13:44:34.161653Z","steps":["trace[1271403673] 'process raft request' (duration: 365.876235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:34.161845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:33.795458Z","time spent":"366.304075ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T13:44:34.161891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:33.585313Z","time spent":"576.221284ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:44:50.260002Z","caller":"traceutil/trace.go:171","msg":"trace[388074681] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"569.500665ms","start":"2026-05-15T13:44:49.690463Z","end":"2026-05-15T13:44:50.259964Z","steps":["trace[388074681] 'process raft request' (duration: 569.291539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:50.260225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:49.690445Z","time spent":"569.67863ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:44:50.383736Z","caller":"traceutil/trace.go:171","msg":"trace[1617457037] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1244; }","duration":"363.131814ms","start":"2026-05-15T13:44:50.020576Z","end":"2026-05-15T13:44:50.383708Z","steps":["trace[1617457037] 'read index received' (duration: 239.161523ms)","trace[1617457037] 'applied index is now lower than readState.Index' (duration: 123.968591ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T13:44:50.383967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.36232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:44:50.384078Z","caller":"traceutil/trace.go:171","msg":"trace[1177181343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1196; }","duration":"363.540684ms","start":"2026-05-15T13:44:50.020515Z","end":"2026-05-15T13:44:50.384056Z","steps":["trace[1177181343] 'agreement among raft nodes before linearized reading' (duration: 363.288668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:50.384088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.387852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-15T13:44:50.384124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:44:50.020495Z","time spent":"363.621527ms","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-15T13:44:50.38416Z","caller":"traceutil/trace.go:171","msg":"trace[1259687767] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1196; }","duration":"275.530496ms","start":"2026-05-15T13:44:50.108614Z","end":"2026-05-15T13:44:50.384144Z","steps":["trace[1259687767] 'agreement among raft nodes before linearized reading' (duration: 275.361732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:50.384281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.626722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:44:50.384326Z","caller":"traceutil/trace.go:171","msg":"trace[1069419731] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1196; }","duration":"270.734765ms","start":"2026-05-15T13:44:50.11358Z","end":"2026-05-15T13:44:50.384315Z","steps":["trace[1069419731] 'agreement among raft nodes before linearized reading' (duration: 270.659213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:44:50.384483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.662202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-15T13:44:50.384669Z","caller":"traceutil/trace.go:171","msg":"trace[261525508] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1196; }","duration":"146.909627ms","start":"2026-05-15T13:44:50.237733Z","end":"2026-05-15T13:44:50.384643Z","steps":["trace[261525508] 'agreement among raft nodes before linearized reading' (duration: 146.480396ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:08.441063Z","caller":"traceutil/trace.go:171","msg":"trace[490552495] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1328; }","duration":"211.659293ms","start":"2026-05-15T13:45:08.229372Z","end":"2026-05-15T13:45:08.441031Z","steps":["trace[490552495] 'read index received' (duration: 211.432737ms)","trace[490552495] 'applied index is now lower than readState.Index' (duration: 225.506µs)"],"step_count":2} {"level":"warn","ts":"2026-05-15T13:45:08.441286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.886619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-15T13:45:08.441262Z","caller":"traceutil/trace.go:171","msg":"trace[1913396519] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"541.187514ms","start":"2026-05-15T13:45:07.90003Z","end":"2026-05-15T13:45:08.441217Z","steps":["trace[1913396519] 'process raft request' (duration: 540.774194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:08.441426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.048642ms","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-05-15T13:45:08.44147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:45:07.899979Z","time spent":"541.389791ms","remote":"127.0.0.1:45822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11375,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:45:08.44148Z","caller":"traceutil/trace.go:171","msg":"trace[1719820541] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1276; }","duration":"106.116374ms","start":"2026-05-15T13:45:08.33535Z","end":"2026-05-15T13:45:08.441466Z","steps":["trace[1719820541] 'agreement among raft nodes before linearized reading' (duration: 105.893649ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:08.441323Z","caller":"traceutil/trace.go:171","msg":"trace[1112077067] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1276; }","duration":"211.96333ms","start":"2026-05-15T13:45:08.22935Z","end":"2026-05-15T13:45:08.441313Z","steps":["trace[1112077067] 'agreement among raft nodes before linearized reading' (duration: 211.859847ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:08.727014Z","caller":"traceutil/trace.go:171","msg":"trace[10193400] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"278.603413ms","start":"2026-05-15T13:45:08.448371Z","end":"2026-05-15T13:45:08.726975Z","steps":["trace[10193400] 'process raft request' (duration: 263.701179ms)","trace[10193400] 'compare' (duration: 14.73493ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:45:08.779648Z","caller":"traceutil/trace.go:171","msg":"trace[650590850] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1329; }","duration":"296.835901ms","start":"2026-05-15T13:45:08.48278Z","end":"2026-05-15T13:45:08.779616Z","steps":["trace[650590850] 'read index received' (duration: 229.310575ms)","trace[650590850] 'applied index is now lower than readState.Index' (duration: 67.523956ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:45:08.780236Z","caller":"traceutil/trace.go:171","msg":"trace[364103606] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"323.921621ms","start":"2026-05-15T13:45:08.456167Z","end":"2026-05-15T13:45:08.780089Z","steps":["trace[364103606] 'process raft request' (duration: 323.190462ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:08.780353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.817635ms","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-05-15T13:45:08.780391Z","caller":"traceutil/trace.go:171","msg":"trace[382117184] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1282; }","duration":"252.926579ms","start":"2026-05-15T13:45:08.527454Z","end":"2026-05-15T13:45:08.780381Z","steps":["trace[382117184] 'agreement among raft nodes before linearized reading' (duration: 252.762055ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:08.780338Z","caller":"traceutil/trace.go:171","msg":"trace[958913451] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"330.456535ms","start":"2026-05-15T13:45:08.449726Z","end":"2026-05-15T13:45:08.780182Z","steps":["trace[958913451] 'process raft request' (duration: 329.534371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:08.780478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:45:08.456136Z","time spent":"324.216038ms","remote":"127.0.0.1:45812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T13:45:08.780473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.683042ms","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-05-15T13:45:08.780554Z","caller":"traceutil/trace.go:171","msg":"trace[874092714] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1282; }","duration":"297.822346ms","start":"2026-05-15T13:45:08.482717Z","end":"2026-05-15T13:45:08.780539Z","steps":["trace[874092714] 'agreement among raft nodes before linearized reading' (duration: 297.497968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:08.780614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.989793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-15T13:45:08.780639Z","caller":"traceutil/trace.go:171","msg":"trace[193339937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1282; }","duration":"126.014314ms","start":"2026-05-15T13:45:08.654617Z","end":"2026-05-15T13:45:08.780631Z","steps":["trace[193339937] 'agreement among raft nodes before linearized reading' (duration: 125.947262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:08.780684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:45:08.449712Z","time spent":"330.765402ms","remote":"127.0.0.1:45808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:45:08.780792Z","caller":"traceutil/trace.go:171","msg":"trace[310911869] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"269.251709ms","start":"2026-05-15T13:45:08.511531Z","end":"2026-05-15T13:45:08.780782Z","steps":["trace[310911869] 'process raft request' (duration: 268.037849ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:08.780884Z","caller":"traceutil/trace.go:171","msg":"trace[486146016] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"331.567063ms","start":"2026-05-15T13:45:08.449305Z","end":"2026-05-15T13:45:08.780872Z","steps":["trace[486146016] 'process raft request' (duration: 329.785018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:08.780963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:45:08.449275Z","time spent":"331.622794ms","remote":"127.0.0.1:45898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T13:45:08.780746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.536807ms","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-05-15T13:45:08.781205Z","caller":"traceutil/trace.go:171","msg":"trace[1822037339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1282; }","duration":"190.01649ms","start":"2026-05-15T13:45:08.591159Z","end":"2026-05-15T13:45:08.781175Z","steps":["trace[1822037339] 'agreement among raft nodes before linearized reading' (duration: 189.541007ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:08.781406Z","caller":"traceutil/trace.go:171","msg":"trace[1820617306] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"325.285855ms","start":"2026-05-15T13:45:08.456071Z","end":"2026-05-15T13:45:08.781356Z","steps":["trace[1820617306] 'process raft request' (duration: 323.242124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:08.781521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:45:08.456051Z","time spent":"325.421138ms","remote":"127.0.0.1:46072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T13:45:09.956121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.134174ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-15T13:45:10.839066Z","caller":"traceutil/trace.go:171","msg":"trace[1333235139] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"103.206771ms","start":"2026-05-15T13:45:10.735837Z","end":"2026-05-15T13:45:10.839044Z","steps":["trace[1333235139] 'process raft request' (duration: 103.044557ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:11.139584Z","caller":"traceutil/trace.go:171","msg":"trace[801119781] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1345; }","duration":"250.099919ms","start":"2026-05-15T13:45:10.889444Z","end":"2026-05-15T13:45:11.139544Z","steps":["trace[801119781] 'read index received' (duration: 249.78274ms)","trace[801119781] 'applied index is now lower than readState.Index' (duration: 315.419µs)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:45:11.139652Z","caller":"traceutil/trace.go:171","msg":"trace[1282479761] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"298.702079ms","start":"2026-05-15T13:45:10.840895Z","end":"2026-05-15T13:45:11.139597Z","steps":["trace[1282479761] 'process raft request' (duration: 298.347969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:11.140002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.521608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-15T13:45:11.140046Z","caller":"traceutil/trace.go:171","msg":"trace[539381225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1292; }","duration":"250.637021ms","start":"2026-05-15T13:45:10.889395Z","end":"2026-05-15T13:45:11.140032Z","steps":["trace[539381225] 'agreement among raft nodes before linearized reading' (duration: 250.399405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:11.175595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.966848ms","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-05-15T13:45:11.175717Z","caller":"traceutil/trace.go:171","msg":"trace[2021947378] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1293; }","duration":"286.158272ms","start":"2026-05-15T13:45:10.889528Z","end":"2026-05-15T13:45:11.175686Z","steps":["trace[2021947378] 'agreement among raft nodes before linearized reading' (duration: 285.766673ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:11.176269Z","caller":"traceutil/trace.go:171","msg":"trace[908781058] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"279.943147ms","start":"2026-05-15T13:45:10.896308Z","end":"2026-05-15T13:45:11.176251Z","steps":["trace[908781058] 'process raft request' (duration: 278.778198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:11.176707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.844379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-15T13:45:11.176766Z","caller":"traceutil/trace.go:171","msg":"trace[377706312] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1293; }","duration":"117.942991ms","start":"2026-05-15T13:45:11.058806Z","end":"2026-05-15T13:45:11.176749Z","steps":["trace[377706312] 'agreement among raft nodes before linearized reading' (duration: 117.844759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:11.177019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.011056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:45:11.177067Z","caller":"traceutil/trace.go:171","msg":"trace[338469281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1293; }","duration":"156.096779ms","start":"2026-05-15T13:45:11.020957Z","end":"2026-05-15T13:45:11.177054Z","steps":["trace[338469281] 'agreement among raft nodes before linearized reading' (duration: 156.025437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:11.177183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.813515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:45:11.177277Z","caller":"traceutil/trace.go:171","msg":"trace[753673508] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1293; }","duration":"240.956239ms","start":"2026-05-15T13:45:10.936296Z","end":"2026-05-15T13:45:11.177252Z","steps":["trace[753673508] 'agreement among raft nodes before linearized reading' (duration: 240.782034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:11.177622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.170428ms","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-05-15T13:45:11.177663Z","caller":"traceutil/trace.go:171","msg":"trace[1831562946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1293; }","duration":"285.25465ms","start":"2026-05-15T13:45:10.892399Z","end":"2026-05-15T13:45:11.177654Z","steps":["trace[1831562946] 'agreement among raft nodes before linearized reading' (duration: 285.083396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:11.413979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.819173ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-15T13:45:11.41418Z","caller":"traceutil/trace.go:171","msg":"trace[713537159] linearizableReadLoop","detail":"{readStateIndex:1349; appliedIndex:1347; }","duration":"235.448379ms","start":"2026-05-15T13:45:11.178713Z","end":"2026-05-15T13:45:11.414161Z","steps":["trace[713537159] 'read index received' (duration: 14.247617ms)","trace[713537159] 'applied index is now lower than readState.Index' (duration: 221.199402ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T13:45:11.414298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.576242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T13:45:11.414334Z","caller":"traceutil/trace.go:171","msg":"trace[2034525434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1295; }","duration":"235.639834ms","start":"2026-05-15T13:45:11.178685Z","end":"2026-05-15T13:45:11.414325Z","steps":["trace[2034525434] 'agreement among raft nodes before linearized reading' (duration: 235.534602ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:11.414443Z","caller":"traceutil/trace.go:171","msg":"trace[2086510878] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"266.303674ms","start":"2026-05-15T13:45:11.148111Z","end":"2026-05-15T13:45:11.414415Z","steps":["trace[2086510878] 'process raft request' (duration: 44.835666ms)","trace[2086510878] 'compare' (duration: 220.603117ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T13:45:11.414724Z","caller":"traceutil/trace.go:171","msg":"trace[1388343407] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"264.9107ms","start":"2026-05-15T13:45:11.14978Z","end":"2026-05-15T13:45:11.414691Z","steps":["trace[1388343407] 'process raft request' (duration: 264.304514ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:11.482182Z","caller":"traceutil/trace.go:171","msg":"trace[2016676859] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"298.4048ms","start":"2026-05-15T13:45:11.183752Z","end":"2026-05-15T13:45:11.482156Z","steps":["trace[2016676859] 'process raft request' (duration: 298.363799ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T13:45:11.482708Z","caller":"traceutil/trace.go:171","msg":"trace[1710539963] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"300.446041ms","start":"2026-05-15T13:45:11.182249Z","end":"2026-05-15T13:45:11.482695Z","steps":["trace[1710539963] 'process raft request' (duration: 299.56619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T13:45:11.482808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T13:45:11.182228Z","time spent":"300.508672ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T13:45:11.482952Z","caller":"traceutil/trace.go:171","msg":"trace[883508081] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"299.188849ms","start":"2026-05-15T13:45:11.183751Z","end":"2026-05-15T13:45:11.48294Z","steps":["trace[883508081] 'process raft request' (duration: 298.310087ms)"],"step_count":1}