{"level":"warn","ts":"2026-06-12T03:07:13.73873Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-12T03:07:13.738956Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162: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-06-12T03:07:13.739039Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-12T03:07:13.739058Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-06-12T03:07:13.739095Z","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-06-12T03:07:13.739881Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-06-12T03:07:13.739991Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162: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-06-12T03:07:13.744605Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.371037ms"} {"level":"info","ts":"2026-06-12T03:07:13.754027Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-06-12T03:07:13.754128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-06-12T03:07:13.754156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-06-12T03:07:13.754171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-12T03:07:13.754181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-06-12T03:07:13.754228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-06-12T03:07:13.781022Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-12T03:07:13.784012Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-12T03:07:13.785459Z","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-06-12T03:07:13.788345Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-12T03:07:13.788505Z","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-06-12T03:07:13.788595Z","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-06-12T03:07:13.788624Z","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-06-12T03:07:13.788894Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-12T03:07:13.791011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-06-12T03:07:13.791166Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-06-12T03:07:13.792369Z","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-06-12T03:07:13.792518Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-06-12T03:07:13.79254Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-06-12T03:07:13.793291Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-12T03:07:13.793327Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-12T03:07:14.054544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-06-12T03:07:14.054682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-06-12T03:07:14.054712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-06-12T03:07:14.054735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-06-12T03:07:14.055119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-06-12T03:07:14.055152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-06-12T03:07:14.055168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-06-12T03:07:14.056852Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-12T03:07:14.056919Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-12T03:07:14.057012Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-12T03:07:14.057385Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T03:07:14.057779Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-12T03:07:14.057814Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-12T03:07:14.059691Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T03:07:14.05981Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T03:07:14.059844Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T03:07:14.061845Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-12T03:07:14.062024Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"warn","ts":"2026-06-12T03:07:38.216973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.414705ms","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-06-12T03:07:38.217056Z","caller":"traceutil/trace.go:171","msg":"trace[1861737894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:389; }","duration":"195.538488ms","start":"2026-06-12T03:07:38.021504Z","end":"2026-06-12T03:07:38.217042Z","steps":["trace[1861737894] 'range keys from in-memory index tree' (duration: 195.319101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:38.21716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.979193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-12T03:07:38.217275Z","caller":"traceutil/trace.go:171","msg":"trace[2004182764] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:389; }","duration":"141.168589ms","start":"2026-06-12T03:07:38.076078Z","end":"2026-06-12T03:07:38.217247Z","steps":["trace[2004182764] 'range keys from in-memory index tree' (duration: 140.769107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:43.168731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.777884ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-12T03:07:46.377119Z","caller":"traceutil/trace.go:171","msg":"trace[1256172440] linearizableReadLoop","detail":"{readStateIndex:453; appliedIndex:452; }","duration":"113.697509ms","start":"2026-06-12T03:07:46.263391Z","end":"2026-06-12T03:07:46.377089Z","steps":["trace[1256172440] 'read index received' (duration: 113.501753ms)","trace[1256172440] 'applied index is now lower than readState.Index' (duration: 194.646µs)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:07:46.377314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.885063ms","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-06-12T03:07:46.377356Z","caller":"traceutil/trace.go:171","msg":"trace[362558903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:436; }","duration":"114.023948ms","start":"2026-06-12T03:07:46.263319Z","end":"2026-06-12T03:07:46.377343Z","steps":["trace[362558903] 'agreement among raft nodes before linearized reading' (duration: 113.879884ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:07:46.377356Z","caller":"traceutil/trace.go:171","msg":"trace[1558849645] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"118.367038ms","start":"2026-06-12T03:07:46.258947Z","end":"2026-06-12T03:07:46.377314Z","steps":["trace[1558849645] 'process raft request' (duration: 117.998588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:53.758161Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388179135,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-12T03:07:54.068751Z","caller":"traceutil/trace.go:171","msg":"trace[1410435716] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"833.632419ms","start":"2026-06-12T03:07:53.235041Z","end":"2026-06-12T03:07:54.068674Z","steps":["trace[1410435716] 'process raft request' (duration: 832.707745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.06955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.235013Z","time spent":"833.848665ms","remote":"127.0.0.1:38948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:07:54.076326Z","caller":"traceutil/trace.go:171","msg":"trace[1658758779] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:569; }","duration":"818.856116ms","start":"2026-06-12T03:07:53.257448Z","end":"2026-06-12T03:07:54.076304Z","steps":["trace[1658758779] 'read index received' (duration: 810.618535ms)","trace[1658758779] 'applied index is now lower than readState.Index' (duration: 8.236731ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:07:54.076431Z","caller":"traceutil/trace.go:171","msg":"trace[18235933] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"751.946208ms","start":"2026-06-12T03:07:53.324454Z","end":"2026-06-12T03:07:54.076401Z","steps":["trace[18235933] 'process raft request' (duration: 751.694572ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.076521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.0464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:07:54.076556Z","caller":"traceutil/trace.go:171","msg":"trace[339896739] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:551; }","duration":"819.137163ms","start":"2026-06-12T03:07:53.257406Z","end":"2026-06-12T03:07:54.076543Z","steps":["trace[339896739] 'agreement among raft nodes before linearized reading' (duration: 819.057431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.076579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.257382Z","time spent":"819.190703ms","remote":"127.0.0.1:43254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-06-12T03:07:54.076844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.324409Z","time spent":"752.097402ms","remote":"127.0.0.1:38948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:07:54.076887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.40654ms","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-06-12T03:07:54.076933Z","caller":"traceutil/trace.go:171","msg":"trace[2025399947] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:551; }","duration":"783.455881ms","start":"2026-06-12T03:07:53.293447Z","end":"2026-06-12T03:07:54.076903Z","steps":["trace[2025399947] 'agreement among raft nodes before linearized reading' (duration: 783.422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.076953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.293441Z","time spent":"783.506873ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-06-12T03:07:54.077024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.534139ms","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-06-12T03:07:54.077083Z","caller":"traceutil/trace.go:171","msg":"trace[1026406050] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:551; }","duration":"801.631971ms","start":"2026-06-12T03:07:53.275438Z","end":"2026-06-12T03:07:54.07707Z","steps":["trace[1026406050] 'agreement among raft nodes before linearized reading' (duration: 801.528528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.07711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.275421Z","time spent":"801.681952ms","remote":"127.0.0.1:43262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:07:54.077135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.327846ms","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-06-12T03:07:54.077163Z","caller":"traceutil/trace.go:171","msg":"trace[1730762433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:551; }","duration":"750.373728ms","start":"2026-06-12T03:07:53.326782Z","end":"2026-06-12T03:07:54.077156Z","steps":["trace[1730762433] 'agreement among raft nodes before linearized reading' (duration: 750.274395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.077182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.326769Z","time spent":"750.409398ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-12T03:07:54.077293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.866322ms","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-06-12T03:07:54.077322Z","caller":"traceutil/trace.go:171","msg":"trace[1043878246] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:551; }","duration":"783.932584ms","start":"2026-06-12T03:07:53.293381Z","end":"2026-06-12T03:07:54.077314Z","steps":["trace[1043878246] 'agreement among raft nodes before linearized reading' (duration: 783.884903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.077342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.293363Z","time spent":"783.973724ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:07:54.077296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.713858ms","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-06-12T03:07:54.07744Z","caller":"traceutil/trace.go:171","msg":"trace[1808358662] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:551; }","duration":"783.906763ms","start":"2026-06-12T03:07:53.293525Z","end":"2026-06-12T03:07:54.077432Z","steps":["trace[1808358662] 'agreement among raft nodes before linearized reading' (duration: 783.746989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.077479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.293501Z","time spent":"783.963084ms","remote":"127.0.0.1:43262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-06-12T03:07:54.077555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.096013ms","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-06-12T03:07:54.077597Z","caller":"traceutil/trace.go:171","msg":"trace[2002088625] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:551; }","duration":"802.159664ms","start":"2026-06-12T03:07:53.275415Z","end":"2026-06-12T03:07:54.077575Z","steps":["trace[2002088625] 'agreement among raft nodes before linearized reading' (duration: 802.117893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.077619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.275394Z","time spent":"802.218865ms","remote":"127.0.0.1:43262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-06-12T03:07:54.077716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.150768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:07:54.077737Z","caller":"traceutil/trace.go:171","msg":"trace[837039284] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:551; }","duration":"820.21913ms","start":"2026-06-12T03:07:53.257511Z","end":"2026-06-12T03:07:54.07773Z","steps":["trace[837039284] 'agreement among raft nodes before linearized reading' (duration: 819.334807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.078206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.257485Z","time spent":"820.709483ms","remote":"127.0.0.1:43254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:08:00.768325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.966379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-12T03:08:00.768434Z","caller":"traceutil/trace.go:171","msg":"trace[1986941264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"638.138923ms","start":"2026-06-12T03:08:00.130273Z","end":"2026-06-12T03:08:00.768412Z","steps":["trace[1986941264] 'range keys from in-memory index tree' (duration: 637.701632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:00.768479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:00.130241Z","time spent":"638.228986ms","remote":"127.0.0.1:39176","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-06-12T03:08:00.768447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.43197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:00.768589Z","caller":"traceutil/trace.go:171","msg":"trace[1427879850] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:598; }","duration":"722.645915ms","start":"2026-06-12T03:08:00.045912Z","end":"2026-06-12T03:08:00.768558Z","steps":["trace[1427879850] 'range keys from in-memory index tree' (duration: 722.354718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:00.768676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:00.045902Z","time spent":"722.758687ms","remote":"127.0.0.1:39032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-06-12T03:08:00.769953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.136393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:08:00.770169Z","caller":"traceutil/trace.go:171","msg":"trace[1448298812] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"391.514543ms","start":"2026-06-12T03:08:00.378604Z","end":"2026-06-12T03:08:00.770118Z","steps":["trace[1448298812] 'read index received' (duration: 206.821733ms)","trace[1448298812] 'applied index is now lower than readState.Index' (duration: 184.69059ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:00.770252Z","caller":"traceutil/trace.go:171","msg":"trace[471676472] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"605.574931ms","start":"2026-06-12T03:08:00.164632Z","end":"2026-06-12T03:08:00.770207Z","steps":["trace[471676472] 'process raft request' (duration: 420.789399ms)","trace[471676472] 'compare' (duration: 182.898937ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:08:00.770416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:00.164601Z","time spent":"605.728924ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:00.770512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.911253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-stsxl\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-12T03:08:00.770543Z","caller":"traceutil/trace.go:171","msg":"trace[753267650] range","detail":"{range_begin:/registry/pods/kube-system/cilium-stsxl; range_end:; response_count:1; response_revision:599; }","duration":"392.015235ms","start":"2026-06-12T03:08:00.378519Z","end":"2026-06-12T03:08:00.770534Z","steps":["trace[753267650] 'agreement among raft nodes before linearized reading' (duration: 391.831111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:00.770595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:00.378484Z","time spent":"392.074146ms","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-stsxl\" "} {"level":"warn","ts":"2026-06-12T03:08:00.770899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.875852ms","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-06-12T03:08:00.770951Z","caller":"traceutil/trace.go:171","msg":"trace[839786427] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"162.029055ms","start":"2026-06-12T03:08:00.608906Z","end":"2026-06-12T03:08:00.770935Z","steps":["trace[839786427] 'agreement among raft nodes before linearized reading' (duration: 161.82506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:00.770992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.180599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-12T03:08:00.771127Z","caller":"traceutil/trace.go:171","msg":"trace[899573702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"271.399455ms","start":"2026-06-12T03:08:00.499701Z","end":"2026-06-12T03:08:00.7711Z","steps":["trace[899573702] 'agreement among raft nodes before linearized reading' (duration: 271.048826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:00.771393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.825513ms","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-06-12T03:08:00.771444Z","caller":"traceutil/trace.go:171","msg":"trace[114805204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"300.911445ms","start":"2026-06-12T03:08:00.470518Z","end":"2026-06-12T03:08:00.771429Z","steps":["trace[114805204] 'agreement among raft nodes before linearized reading' (duration: 300.191897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:00.771476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:00.470496Z","time spent":"300.970847ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-12T03:08:01.017237Z","caller":"traceutil/trace.go:171","msg":"trace[828734544] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"244.677801ms","start":"2026-06-12T03:08:00.772527Z","end":"2026-06-12T03:08:01.017204Z","steps":["trace[828734544] 'process raft request' (duration: 244.546588ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:01.054616Z","caller":"traceutil/trace.go:171","msg":"trace[1952788331] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"281.356614ms","start":"2026-06-12T03:08:00.773232Z","end":"2026-06-12T03:08:01.054589Z","steps":["trace[1952788331] 'process raft request' (duration: 281.155399ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:01.055018Z","caller":"traceutil/trace.go:171","msg":"trace[539282129] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"276.410964ms","start":"2026-06-12T03:08:00.778554Z","end":"2026-06-12T03:08:01.054965Z","steps":["trace[539282129] 'process raft request' (duration: 275.987445ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:01.055076Z","caller":"traceutil/trace.go:171","msg":"trace[1131357548] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"276.374903ms","start":"2026-06-12T03:08:00.778673Z","end":"2026-06-12T03:08:01.055048Z","steps":["trace[1131357548] 'process raft request' (duration: 276.21475ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:01.055273Z","caller":"traceutil/trace.go:171","msg":"trace[897645020] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"276.502258ms","start":"2026-06-12T03:08:00.778746Z","end":"2026-06-12T03:08:01.055248Z","steps":["trace[897645020] 'process raft request' (duration: 276.254041ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:01.055326Z","caller":"traceutil/trace.go:171","msg":"trace[1846785641] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"266.678112ms","start":"2026-06-12T03:08:00.788634Z","end":"2026-06-12T03:08:01.055312Z","steps":["trace[1846785641] 'process raft request' (duration: 266.521517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:01.652305Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388179258,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T03:08:01.895048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.037959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:08:01.895533Z","caller":"traceutil/trace.go:171","msg":"trace[1129509316] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:626; }","duration":"743.540702ms","start":"2026-06-12T03:08:01.151973Z","end":"2026-06-12T03:08:01.895514Z","steps":["trace[1129509316] 'read index received' (duration: 522.96965ms)","trace[1129509316] 'applied index is now lower than readState.Index' (duration: 220.569742ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:08:01.895709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.698895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:01.895772Z","caller":"traceutil/trace.go:171","msg":"trace[344470645] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"743.835758ms","start":"2026-06-12T03:08:01.151923Z","end":"2026-06-12T03:08:01.895759Z","steps":["trace[344470645] 'agreement among raft nodes before linearized reading' (duration: 743.693175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:01.895848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:01.151896Z","time spent":"743.94178ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-12T03:08:01.895856Z","caller":"traceutil/trace.go:171","msg":"trace[588090919] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"872.341828ms","start":"2026-06-12T03:08:01.023493Z","end":"2026-06-12T03:08:01.895835Z","steps":["trace[588090919] 'process raft request' (duration: 651.435259ms)","trace[588090919] 'compare' (duration: 219.68251ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:01.895934Z","caller":"traceutil/trace.go:171","msg":"trace[415051436] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"870.184067ms","start":"2026-06-12T03:08:01.025715Z","end":"2026-06-12T03:08:01.8959Z","steps":["trace[415051436] 'process raft request' (duration: 869.749717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:01.896001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:01.023454Z","time spent":"872.482131ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:01.895851Z","caller":"traceutil/trace.go:171","msg":"trace[1902180240] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"870.884994ms","start":"2026-06-12T03:08:01.024948Z","end":"2026-06-12T03:08:01.895833Z","steps":["trace[1902180240] 'process raft request' (duration: 870.455974ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:01.896165Z","caller":"traceutil/trace.go:171","msg":"trace[1564796173] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"872.530142ms","start":"2026-06-12T03:08:01.023622Z","end":"2026-06-12T03:08:01.896152Z","steps":["trace[1564796173] 'process raft request' (duration: 871.653471ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:01.896172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:01.024915Z","time spent":"871.184931ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:01.896175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:01.025701Z","time spent":"870.32683ms","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:01.896258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:01.023608Z","time spent":"872.602545ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:03.561244Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388179270,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T03:08:04.061904Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388179270,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T03:08:04.094745Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.255436345s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-12T03:08:04.843957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.78828ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-12T03:08:04.844702Z","caller":"traceutil/trace.go:171","msg":"trace[1253329894] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"1.784283104s","start":"2026-06-12T03:08:03.06038Z","end":"2026-06-12T03:08:04.844663Z","steps":["trace[1253329894] 'read index received' (duration: 1.034634633s)","trace[1253329894] 'applied index is now lower than readState.Index' (duration: 749.646291ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:08:04.84499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.784588611s","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-06-12T03:08:04.84499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.784587081s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-12T03:08:04.845035Z","caller":"traceutil/trace.go:171","msg":"trace[211128664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"1.784679873s","start":"2026-06-12T03:08:03.060344Z","end":"2026-06-12T03:08:04.845024Z","steps":["trace[211128664] 'agreement among raft nodes before linearized reading' (duration: 1.784464428s)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:04.845043Z","caller":"traceutil/trace.go:171","msg":"trace[153224691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"1.784686253s","start":"2026-06-12T03:08:03.060344Z","end":"2026-06-12T03:08:04.84503Z","steps":["trace[153224691] 'agreement among raft nodes before linearized reading' (duration: 1.784503679s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:04.84508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:03.060321Z","time spent":"1.784750685s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T03:08:04.845081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:03.060321Z","time spent":"1.784750775s","remote":"127.0.0.1:39176","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-06-12T03:08:04.845279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.784868687s","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-06-12T03:08:04.845385Z","caller":"traceutil/trace.go:171","msg":"trace[1583759396] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"1.7849931s","start":"2026-06-12T03:08:03.06036Z","end":"2026-06-12T03:08:04.845353Z","steps":["trace[1583759396] 'agreement among raft nodes before linearized reading' (duration: 1.784661913s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:04.845459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:03.060299Z","time spent":"1.785148574s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-12T03:08:04.845601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694691583s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:04.845652Z","caller":"traceutil/trace.go:171","msg":"trace[225154706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"1.694803166s","start":"2026-06-12T03:08:03.150835Z","end":"2026-06-12T03:08:04.845638Z","steps":["trace[225154706] 'agreement among raft nodes before linearized reading' (duration: 1.694690123s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:04.845687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:03.150801Z","time spent":"1.694879628s","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T03:08:04.845793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.784734615s","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-06-12T03:08:04.845927Z","caller":"traceutil/trace.go:171","msg":"trace[871667115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"1.785036772s","start":"2026-06-12T03:08:03.060867Z","end":"2026-06-12T03:08:04.845904Z","steps":["trace[871667115] 'agreement among raft nodes before linearized reading' (duration: 1.784143461s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:04.846065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:03.060858Z","time spent":"1.785160694s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-12T03:08:05.025292Z","caller":"traceutil/trace.go:171","msg":"trace[1615307247] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"174.821878ms","start":"2026-06-12T03:08:04.850428Z","end":"2026-06-12T03:08:05.02525Z","steps":["trace[1615307247] 'process raft request' (duration: 174.604793ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:05.043387Z","caller":"traceutil/trace.go:171","msg":"trace[36223199] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"192.913052ms","start":"2026-06-12T03:08:04.850444Z","end":"2026-06-12T03:08:05.043357Z","steps":["trace[36223199] 'process raft request' (duration: 192.676057ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:05.043733Z","caller":"traceutil/trace.go:171","msg":"trace[1337401326] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"192.181175ms","start":"2026-06-12T03:08:04.851498Z","end":"2026-06-12T03:08:05.043679Z","steps":["trace[1337401326] 'process raft request' (duration: 191.811256ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:05.043898Z","caller":"traceutil/trace.go:171","msg":"trace[1532746679] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:631; }","duration":"189.453252ms","start":"2026-06-12T03:08:04.854418Z","end":"2026-06-12T03:08:05.043871Z","steps":["trace[1532746679] 'read index received' (duration: 170.56554ms)","trace[1532746679] 'applied index is now lower than readState.Index' (duration: 18.886762ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:05.043957Z","caller":"traceutil/trace.go:171","msg":"trace[368995414] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"191.889498ms","start":"2026-06-12T03:08:04.852025Z","end":"2026-06-12T03:08:05.043915Z","steps":["trace[368995414] 'process raft request' (duration: 191.719854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:05.044022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.578495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:05.044053Z","caller":"traceutil/trace.go:171","msg":"trace[1264973630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"189.659206ms","start":"2026-06-12T03:08:04.854386Z","end":"2026-06-12T03:08:05.044045Z","steps":["trace[1264973630] 'agreement among raft nodes before linearized reading' (duration: 189.585734ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:07.880119Z","caller":"traceutil/trace.go:171","msg":"trace[1062991224] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"170.151093ms","start":"2026-06-12T03:08:07.70992Z","end":"2026-06-12T03:08:07.880071Z","steps":["trace[1062991224] 'process raft request' (duration: 169.846466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:17.824718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.346723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-12T03:08:17.824819Z","caller":"traceutil/trace.go:171","msg":"trace[848134167] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:746; }","duration":"302.507197ms","start":"2026-06-12T03:08:17.522294Z","end":"2026-06-12T03:08:17.824801Z","steps":["trace[848134167] 'range keys from in-memory index tree' (duration: 302.162159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:17.824859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:17.522257Z","time spent":"302.593609ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"warn","ts":"2026-06-12T03:08:20.81959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.7978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7fmcf\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-12T03:08:20.819679Z","caller":"traceutil/trace.go:171","msg":"trace[1728407778] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7fmcf; range_end:; response_count:1; response_revision:760; }","duration":"315.938353ms","start":"2026-06-12T03:08:20.503719Z","end":"2026-06-12T03:08:20.819658Z","steps":["trace[1728407778] 'range keys from in-memory index tree' (duration: 315.601506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:20.819714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:20.503684Z","time spent":"316.022114ms","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7fmcf\" "} {"level":"info","ts":"2026-06-12T03:08:21.513566Z","caller":"traceutil/trace.go:171","msg":"trace[472190761] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"804.970861ms","start":"2026-06-12T03:08:20.708567Z","end":"2026-06-12T03:08:21.513538Z","steps":["trace[472190761] 'process raft request' (duration: 804.805927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:21.513811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:20.708541Z","time spent":"805.123644ms","remote":"127.0.0.1:39080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:22.096594Z","caller":"traceutil/trace.go:171","msg":"trace[19224296] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"1.268220396s","start":"2026-06-12T03:08:20.828342Z","end":"2026-06-12T03:08:22.096563Z","steps":["trace[19224296] 'process raft request' (duration: 1.267995431s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:22.096788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:20.828313Z","time spent":"1.268367129s","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:22.096894Z","caller":"traceutil/trace.go:171","msg":"trace[1944365980] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:788; }","duration":"980.347523ms","start":"2026-06-12T03:08:21.1165Z","end":"2026-06-12T03:08:22.096848Z","steps":["trace[1944365980] 'read index received' (duration: 396.988011ms)","trace[1944365980] 'applied index is now lower than readState.Index' (duration: 583.357202ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:22.097067Z","caller":"traceutil/trace.go:171","msg":"trace[882231110] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"894.987654ms","start":"2026-06-12T03:08:21.202057Z","end":"2026-06-12T03:08:22.097045Z","steps":["trace[882231110] 'process raft request' (duration: 894.448794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:22.09723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.717109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-12T03:08:22.09729Z","caller":"traceutil/trace.go:171","msg":"trace[1494828754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:763; }","duration":"980.849542ms","start":"2026-06-12T03:08:21.116425Z","end":"2026-06-12T03:08:22.097275Z","steps":["trace[1494828754] 'agreement among raft nodes before linearized reading' (duration: 980.627117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:22.0974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:21.116398Z","time spent":"980.988765ms","remote":"127.0.0.1:39176","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-06-12T03:08:22.097591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:21.202023Z","time spent":"895.188218ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:22.097821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.163751ms","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-06-12T03:08:22.097875Z","caller":"traceutil/trace.go:171","msg":"trace[771226800] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:763; }","duration":"879.271784ms","start":"2026-06-12T03:08:21.218589Z","end":"2026-06-12T03:08:22.097861Z","steps":["trace[771226800] 'agreement among raft nodes before linearized reading' (duration: 879.183312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:22.097916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:21.218564Z","time spent":"879.342337ms","remote":"127.0.0.1:39080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:08:22.097949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.651256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:22.098032Z","caller":"traceutil/trace.go:171","msg":"trace[1475668471] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"948.757989ms","start":"2026-06-12T03:08:21.149254Z","end":"2026-06-12T03:08:22.098012Z","steps":["trace[1475668471] 'agreement among raft nodes before linearized reading' (duration: 948.630135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:22.098078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:21.149234Z","time spent":"948.83581ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T03:08:22.098061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.344435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-12T03:08:22.098125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.971693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-12T03:08:22.098165Z","caller":"traceutil/trace.go:171","msg":"trace[1746041110] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:763; }","duration":"722.062264ms","start":"2026-06-12T03:08:21.376093Z","end":"2026-06-12T03:08:22.098155Z","steps":["trace[1746041110] 'agreement among raft nodes before linearized reading' (duration: 721.958662ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:22.098158Z","caller":"traceutil/trace.go:171","msg":"trace[1493803819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:763; }","duration":"971.61529ms","start":"2026-06-12T03:08:21.126521Z","end":"2026-06-12T03:08:22.098137Z","steps":["trace[1493803819] 'agreement among raft nodes before linearized reading' (duration: 971.262672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:22.098197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:21.376043Z","time spent":"722.148366ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-12T03:08:22.098212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:21.1265Z","time spent":"971.702121ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-12T03:08:22.098603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.190229ms","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-06-12T03:08:22.098649Z","caller":"traceutil/trace.go:171","msg":"trace[94679465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:763; }","duration":"976.275131ms","start":"2026-06-12T03:08:21.122362Z","end":"2026-06-12T03:08:22.098637Z","steps":["trace[94679465] 'agreement among raft nodes before linearized reading' (duration: 976.093278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:22.098682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:21.122336Z","time spent":"976.338783ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T03:08:22.100565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.430024ms","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-06-12T03:08:22.100634Z","caller":"traceutil/trace.go:171","msg":"trace[1958322753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:763; }","duration":"977.527066ms","start":"2026-06-12T03:08:21.123082Z","end":"2026-06-12T03:08:22.100609Z","steps":["trace[1958322753] 'agreement among raft nodes before linearized reading' (duration: 974.864434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:22.10067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:21.123072Z","time spent":"977.589958ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-12T03:08:52.723302Z","caller":"traceutil/trace.go:171","msg":"trace[749937299] linearizableReadLoop","detail":"{readStateIndex:1201; appliedIndex:1200; }","duration":"404.741822ms","start":"2026-06-12T03:08:52.318534Z","end":"2026-06-12T03:08:52.723276Z","steps":["trace[749937299] 'read index received' (duration: 404.422087ms)","trace[749937299] 'applied index is now lower than readState.Index' (duration: 318.585µs)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:52.723362Z","caller":"traceutil/trace.go:171","msg":"trace[595401149] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"412.818418ms","start":"2026-06-12T03:08:52.310505Z","end":"2026-06-12T03:08:52.723323Z","steps":["trace[595401149] 'process raft request' (duration: 412.579135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:52.723702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.066147ms","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-06-12T03:08:52.723703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.679351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-12T03:08:52.723827Z","caller":"traceutil/trace.go:171","msg":"trace[645257129] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1166; }","duration":"395.858714ms","start":"2026-06-12T03:08:52.327951Z","end":"2026-06-12T03:08:52.723809Z","steps":["trace[645257129] 'agreement among raft nodes before linearized reading' (duration: 395.54807ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:52.723813Z","caller":"traceutil/trace.go:171","msg":"trace[729791301] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1166; }","duration":"405.235209ms","start":"2026-06-12T03:08:52.318514Z","end":"2026-06-12T03:08:52.72375Z","steps":["trace[729791301] 'agreement among raft nodes before linearized reading' (duration: 404.869264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:52.723926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.318507Z","time spent":"405.401612ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-12T03:08:52.723896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.551172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-12T03:08:52.72392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.804611ms","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-06-12T03:08:52.724041Z","caller":"traceutil/trace.go:171","msg":"trace[1987610530] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1166; }","duration":"392.711394ms","start":"2026-06-12T03:08:52.3313Z","end":"2026-06-12T03:08:52.724012Z","steps":["trace[1987610530] 'agreement among raft nodes before linearized reading' (duration: 392.42006ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:52.72408Z","caller":"traceutil/trace.go:171","msg":"trace[546420420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1166; }","duration":"391.985953ms","start":"2026-06-12T03:08:52.332075Z","end":"2026-06-12T03:08:52.724061Z","steps":["trace[546420420] 'agreement among raft nodes before linearized reading' (duration: 391.639898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:52.724116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.331221Z","time spent":"392.881797ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T03:08:52.724135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.332063Z","time spent":"392.056535ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-12T03:08:52.723922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.327929Z","time spent":"395.976736ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-12T03:08:52.724231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.310456Z","time spent":"413.208464ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:53.314988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.650561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:08:53.315126Z","caller":"traceutil/trace.go:171","msg":"trace[2117971188] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"586.123644ms","start":"2026-06-12T03:08:52.728976Z","end":"2026-06-12T03:08:53.3151Z","steps":["trace[2117971188] 'process raft request' (duration: 475.201378ms)","trace[2117971188] 'compare' (duration: 110.289276ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:08:53.315204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.728946Z","time spent":"586.221715ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:53.466215Z","caller":"traceutil/trace.go:171","msg":"trace[1138306537] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"736.071502ms","start":"2026-06-12T03:08:52.730109Z","end":"2026-06-12T03:08:53.46618Z","steps":["trace[1138306537] 'process raft request' (duration: 735.9319ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:53.466299Z","caller":"traceutil/trace.go:171","msg":"trace[717684197] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"736.099772ms","start":"2026-06-12T03:08:52.73018Z","end":"2026-06-12T03:08:53.46628Z","steps":["trace[717684197] 'process raft request' (duration: 735.90201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:53.466678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.730097Z","time spent":"736.372137ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:53.466726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.730172Z","time spent":"736.418538ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:53.46622Z","caller":"traceutil/trace.go:171","msg":"trace[133393679] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"736.754873ms","start":"2026-06-12T03:08:52.729398Z","end":"2026-06-12T03:08:53.466153Z","steps":["trace[133393679] 'process raft request' (duration: 736.454718ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:53.466906Z","caller":"traceutil/trace.go:171","msg":"trace[610291071] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"712.074489ms","start":"2026-06-12T03:08:52.754815Z","end":"2026-06-12T03:08:53.466889Z","steps":["trace[610291071] 'process raft request' (duration: 711.302957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:53.467042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.754799Z","time spent":"712.1581ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:53.467108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.729368Z","time spent":"737.525055ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:53.471173Z","caller":"traceutil/trace.go:171","msg":"trace[1989410387] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"422.18514ms","start":"2026-06-12T03:08:53.048962Z","end":"2026-06-12T03:08:53.471147Z","steps":["trace[1989410387] 'process raft request' (duration: 421.984727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:53.471274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.477931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:08:53.471303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:53.048933Z","time spent":"422.301922ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:53.471318Z","caller":"traceutil/trace.go:171","msg":"trace[519325542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1172; }","duration":"319.578383ms","start":"2026-06-12T03:08:53.151728Z","end":"2026-06-12T03:08:53.471307Z","steps":["trace[519325542] 'agreement among raft nodes before linearized reading' (duration: 319.502812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:53.471357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:53.151699Z","time spent":"319.650233ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-12T03:08:53.471172Z","caller":"traceutil/trace.go:171","msg":"trace[474674094] linearizableReadLoop","detail":"{readStateIndex:1208; appliedIndex:1201; }","duration":"319.306438ms","start":"2026-06-12T03:08:53.151807Z","end":"2026-06-12T03:08:53.471114Z","steps":["trace[474674094] 'read index received' (duration: 52.38439ms)","trace[474674094] 'applied index is now lower than readState.Index' (duration: 266.920348ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:09:11.585253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.777095ms","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-06-12T03:09:11.585357Z","caller":"traceutil/trace.go:171","msg":"trace[179558830] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1311; }","duration":"173.916388ms","start":"2026-06-12T03:09:11.411416Z","end":"2026-06-12T03:09:11.585332Z","steps":["trace[179558830] 'range keys from in-memory index tree' (duration: 173.576053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:11.585396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.907754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T03:09:11.585499Z","caller":"traceutil/trace.go:171","msg":"trace[2085340136] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1311; }","duration":"199.088537ms","start":"2026-06-12T03:09:11.38639Z","end":"2026-06-12T03:09:11.585478Z","steps":["trace[2085340136] 'count revisions from in-memory index tree' (duration: 198.709821ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:19.148722Z","caller":"traceutil/trace.go:171","msg":"trace[639723153] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"287.717133ms","start":"2026-06-12T03:09:18.860973Z","end":"2026-06-12T03:09:19.14869Z","steps":["trace[639723153] 'process raft request' (duration: 287.522971ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:20.090551Z","caller":"traceutil/trace.go:171","msg":"trace[1911256784] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"451.041293ms","start":"2026-06-12T03:09:19.639478Z","end":"2026-06-12T03:09:20.090519Z","steps":["trace[1911256784] 'process raft request' (duration: 444.535537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:20.090695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:19.639464Z","time spent":"451.166444ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:09:20.091518Z","caller":"traceutil/trace.go:171","msg":"trace[1635913050] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"451.975666ms","start":"2026-06-12T03:09:19.639515Z","end":"2026-06-12T03:09:20.09149Z","steps":["trace[1635913050] 'process raft request' (duration: 451.834814ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:20.091684Z","caller":"traceutil/trace.go:171","msg":"trace[984051939] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"451.864974ms","start":"2026-06-12T03:09:19.639802Z","end":"2026-06-12T03:09:20.091667Z","steps":["trace[984051939] 'process raft request' (duration: 451.647701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:20.091971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:19.639791Z","time spent":"452.152477ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:09:20.091678Z","caller":"traceutil/trace.go:171","msg":"trace[928151692] linearizableReadLoop","detail":"{readStateIndex:1487; appliedIndex:1484; }","duration":"450.302984ms","start":"2026-06-12T03:09:19.641342Z","end":"2026-06-12T03:09:20.091645Z","steps":["trace[928151692] 'read index received' (duration: 442.688143ms)","trace[928151692] 'applied index is now lower than readState.Index' (duration: 7.613521ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:09:20.091813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:19.639498Z","time spent":"452.101527ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:09:20.091879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.529307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-12T03:09:20.09217Z","caller":"traceutil/trace.go:171","msg":"trace[1580723485] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1442; }","duration":"450.84048ms","start":"2026-06-12T03:09:19.641322Z","end":"2026-06-12T03:09:20.092162Z","steps":["trace[1580723485] 'agreement among raft nodes before linearized reading' (duration: 450.407195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:20.0922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:19.641315Z","time spent":"450.876551ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-12T03:09:31.816066Z","caller":"traceutil/trace.go:171","msg":"trace[482820268] transaction","detail":"{read_only:false; response_revision:1669; number_of_response:1; }","duration":"184.520318ms","start":"2026-06-12T03:09:31.631505Z","end":"2026-06-12T03:09:31.816025Z","steps":["trace[482820268] 'process raft request' (duration: 184.312475ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:31.820116Z","caller":"traceutil/trace.go:171","msg":"trace[1503573231] transaction","detail":"{read_only:false; response_revision:1670; number_of_response:1; }","duration":"159.578876ms","start":"2026-06-12T03:09:31.660513Z","end":"2026-06-12T03:09:31.820092Z","steps":["trace[1503573231] 'process raft request' (duration: 159.410663ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:38.470189Z","caller":"traceutil/trace.go:171","msg":"trace[2058230417] transaction","detail":"{read_only:false; response_revision:1753; number_of_response:1; }","duration":"232.988814ms","start":"2026-06-12T03:09:38.237169Z","end":"2026-06-12T03:09:38.470158Z","steps":["trace[2058230417] 'process raft request' (duration: 232.799722ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:38.47236Z","caller":"traceutil/trace.go:171","msg":"trace[1880394716] linearizableReadLoop","detail":"{readStateIndex:1826; appliedIndex:1823; }","duration":"180.450798ms","start":"2026-06-12T03:09:38.291868Z","end":"2026-06-12T03:09:38.472318Z","steps":["trace[1880394716] 'read index received' (duration: 178.070919ms)","trace[1880394716] 'applied index is now lower than readState.Index' (duration: 2.378219ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:09:38.472471Z","caller":"traceutil/trace.go:171","msg":"trace[427328745] transaction","detail":"{read_only:false; response_revision:1755; number_of_response:1; }","duration":"234.863708ms","start":"2026-06-12T03:09:38.237576Z","end":"2026-06-12T03:09:38.47244Z","steps":["trace[427328745] 'process raft request' (duration: 234.621356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:38.472529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.63627ms","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-06-12T03:09:38.472593Z","caller":"traceutil/trace.go:171","msg":"trace[2106210687] 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:1755; }","duration":"180.755932ms","start":"2026-06-12T03:09:38.291822Z","end":"2026-06-12T03:09:38.472578Z","steps":["trace[2106210687] 'agreement among raft nodes before linearized reading' (duration: 180.645831ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:38.472443Z","caller":"traceutil/trace.go:171","msg":"trace[2080199096] transaction","detail":"{read_only:false; response_revision:1754; number_of_response:1; }","duration":"234.915239ms","start":"2026-06-12T03:09:38.23746Z","end":"2026-06-12T03:09:38.472375Z","steps":["trace[2080199096] 'process raft request' (duration: 234.457002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:38.472802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.05345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:09:38.472833Z","caller":"traceutil/trace.go:171","msg":"trace[2031068684] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1755; }","duration":"160.116391ms","start":"2026-06-12T03:09:38.312709Z","end":"2026-06-12T03:09:38.472826Z","steps":["trace[2031068684] 'agreement among raft nodes before linearized reading' (duration: 160.03923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:38.472938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.056665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:09:38.472957Z","caller":"traceutil/trace.go:171","msg":"trace[735766430] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1755; }","duration":"101.092635ms","start":"2026-06-12T03:09:38.37186Z","end":"2026-06-12T03:09:38.472952Z","steps":["trace[735766430] 'agreement among raft nodes before linearized reading' (duration: 101.061915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:38.473044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.340638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:09:38.473061Z","caller":"traceutil/trace.go:171","msg":"trace[549267182] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1755; }","duration":"101.383958ms","start":"2026-06-12T03:09:38.371674Z","end":"2026-06-12T03:09:38.473058Z","steps":["trace[549267182] 'agreement among raft nodes before linearized reading' (duration: 101.355088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:38.473192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.084195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:09:38.473212Z","caller":"traceutil/trace.go:171","msg":"trace[779393762] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1755; }","duration":"129.113165ms","start":"2026-06-12T03:09:38.344094Z","end":"2026-06-12T03:09:38.473207Z","steps":["trace[779393762] 'agreement among raft nodes before linearized reading' (duration: 129.081015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:38.473298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.213346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:09:38.473316Z","caller":"traceutil/trace.go:171","msg":"trace[358314066] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1755; }","duration":"129.244796ms","start":"2026-06-12T03:09:38.344067Z","end":"2026-06-12T03:09:38.473312Z","steps":["trace[358314066] 'agreement among raft nodes before linearized reading' (duration: 129.217336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:38.47338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.541356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:09:38.473396Z","caller":"traceutil/trace.go:171","msg":"trace[1588023592] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1755; }","duration":"160.602266ms","start":"2026-06-12T03:09:38.31279Z","end":"2026-06-12T03:09:38.473393Z","steps":["trace[1588023592] 'agreement among raft nodes before linearized reading' (duration: 160.575816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:45.772135Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388181723,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-12T03:09:46.01205Z","caller":"traceutil/trace.go:171","msg":"trace[1959378148] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"786.870706ms","start":"2026-06-12T03:09:45.225157Z","end":"2026-06-12T03:09:46.012028Z","steps":["trace[1959378148] 'process raft request' (duration: 786.705485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.012217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:45.22513Z","time spent":"786.996508ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:09:46.728861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.138777Z","time spent":"590.07499ms","remote":"127.0.0.1:47028","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-12T03:09:46.729283Z","caller":"traceutil/trace.go:171","msg":"trace[1532540561] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"1.228278627s","start":"2026-06-12T03:09:45.50098Z","end":"2026-06-12T03:09:46.729259Z","steps":["trace[1532540561] 'process raft request' (duration: 1.137154836s)","trace[1532540561] 'compare' (duration: 90.453082ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:09:46.729413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:45.500953Z","time spent":"1.228396658s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:09:46.729641Z","caller":"traceutil/trace.go:171","msg":"trace[1474151095] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"1.105303586s","start":"2026-06-12T03:09:45.624314Z","end":"2026-06-12T03:09:46.729617Z","steps":["trace[1474151095] 'process raft request' (duration: 1.104900752s)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:46.729684Z","caller":"traceutil/trace.go:171","msg":"trace[1652752505] linearizableReadLoop","detail":"{readStateIndex:1928; appliedIndex:1925; }","duration":"1.457663231s","start":"2026-06-12T03:09:45.272012Z","end":"2026-06-12T03:09:46.729675Z","steps":["trace[1652752505] 'read index received' (duration: 739.840353ms)","trace[1652752505] 'applied index is now lower than readState.Index' (duration: 717.821668ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:09:46.729771Z","caller":"traceutil/trace.go:171","msg":"trace[225118860] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"790.8803ms","start":"2026-06-12T03:09:45.938884Z","end":"2026-06-12T03:09:46.729765Z","steps":["trace[225118860] 'process raft request' (duration: 790.657658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.729816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:45.93886Z","time spent":"790.929981ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:09:46.730157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099397228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fbea67a5-d997-4593-a0f9-01045d6e4240\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-12T03:09:46.730233Z","caller":"traceutil/trace.go:171","msg":"trace[447197672] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fbea67a5-d997-4593-a0f9-01045d6e4240; range_end:; response_count:1; response_revision:1857; }","duration":"1.099480949s","start":"2026-06-12T03:09:45.630733Z","end":"2026-06-12T03:09:46.730214Z","steps":["trace[447197672] 'agreement among raft nodes before linearized reading' (duration: 1.099259866s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.730212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.40296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-12T03:09:46.730671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.458661653s","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-06-12T03:09:46.730717Z","caller":"traceutil/trace.go:171","msg":"trace[971588737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1857; }","duration":"1.458748914s","start":"2026-06-12T03:09:45.271959Z","end":"2026-06-12T03:09:46.730708Z","steps":["trace[971588737] 'agreement among raft nodes before linearized reading' (duration: 1.457933144s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.730737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:45.271935Z","time spent":"1.458797585s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-12T03:09:46.730718Z","caller":"traceutil/trace.go:171","msg":"trace[1634976956] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1857; }","duration":"467.965555ms","start":"2026-06-12T03:09:46.262729Z","end":"2026-06-12T03:09:46.730695Z","steps":["trace[1634976956] 'agreement among raft nodes before linearized reading' (duration: 467.277518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.730786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.262708Z","time spent":"468.062456ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-12T03:09:46.730396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:45.624263Z","time spent":"1.105442428s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:09:46.730494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.541406ms","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-06-12T03:09:46.730997Z","caller":"traceutil/trace.go:171","msg":"trace[26241364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1857; }","duration":"224.055461ms","start":"2026-06-12T03:09:46.506926Z","end":"2026-06-12T03:09:46.730982Z","steps":["trace[26241364] 'agreement among raft nodes before linearized reading' (duration: 223.517896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.730497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:45.630711Z","time spent":"1.099728662s","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fbea67a5-d997-4593-a0f9-01045d6e4240\" "} {"level":"warn","ts":"2026-06-12T03:09:46.730523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.79239ms","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-06-12T03:09:46.73116Z","caller":"traceutil/trace.go:171","msg":"trace[1085496359] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1857; }","duration":"225.429148ms","start":"2026-06-12T03:09:46.505676Z","end":"2026-06-12T03:09:46.731105Z","steps":["trace[1085496359] 'agreement among raft nodes before linearized reading' (duration: 224.673419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.730557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.787154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fbea67a5-d997-4593-a0f9-01045d6e4240\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-12T03:09:46.73133Z","caller":"traceutil/trace.go:171","msg":"trace[554563999] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fbea67a5-d997-4593-a0f9-01045d6e4240; range_end:; response_count:1; response_revision:1857; }","duration":"749.599153ms","start":"2026-06-12T03:09:45.981719Z","end":"2026-06-12T03:09:46.731319Z","steps":["trace[554563999] 'agreement among raft nodes before linearized reading' (duration: 748.799664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.730609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.308224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-12T03:09:46.731427Z","caller":"traceutil/trace.go:171","msg":"trace[1635082145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1857; }","duration":"225.149964ms","start":"2026-06-12T03:09:46.506264Z","end":"2026-06-12T03:09:46.731414Z","steps":["trace[1635082145] 'agreement among raft nodes before linearized reading' (duration: 223.9852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.731377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:45.981696Z","time spent":"749.659244ms","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fbea67a5-d997-4593-a0f9-01045d6e4240\" "} {"level":"warn","ts":"2026-06-12T03:09:46.730593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.92203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:09:46.731678Z","caller":"traceutil/trace.go:171","msg":"trace[503022457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1857; }","duration":"581.046783ms","start":"2026-06-12T03:09:46.150621Z","end":"2026-06-12T03:09:46.731668Z","steps":["trace[503022457] 'agreement among raft nodes before linearized reading' (duration: 579.93016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.731715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.150609Z","time spent":"581.092903ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T03:09:46.730595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.868486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-12T03:09:46.731904Z","caller":"traceutil/trace.go:171","msg":"trace[1068512249] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1857; }","duration":"654.156402ms","start":"2026-06-12T03:09:46.077679Z","end":"2026-06-12T03:09:46.731836Z","steps":["trace[1068512249] 'agreement among raft nodes before linearized reading' (duration: 652.813416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:46.732011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.077663Z","time spent":"654.336854ms","remote":"127.0.0.1:36868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-12T03:09:47.931943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.632217ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:09:47.932584Z","caller":"traceutil/trace.go:171","msg":"trace[132227451] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"1.195298645s","start":"2026-06-12T03:09:46.737263Z","end":"2026-06-12T03:09:47.932562Z","steps":["trace[132227451] 'process raft request' (duration: 334.497085ms)","trace[132227451] 'compare' (duration: 858.659375ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:09:47.93265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.737221Z","time spent":"1.195398926s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:09:47.93318Z","caller":"traceutil/trace.go:171","msg":"trace[1081800055] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"1.195803281s","start":"2026-06-12T03:09:46.737366Z","end":"2026-06-12T03:09:47.933169Z","steps":["trace[1081800055] 'process raft request' (duration: 1.195350396s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:47.933229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.73736Z","time spent":"1.195845302s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:09:47.933374Z","caller":"traceutil/trace.go:171","msg":"trace[1098600853] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"1.196268347s","start":"2026-06-12T03:09:46.737095Z","end":"2026-06-12T03:09:47.933364Z","steps":["trace[1098600853] 'process raft request' (duration: 1.19570266s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:47.933422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.737075Z","time spent":"1.196320997s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:09:47.933735Z","caller":"traceutil/trace.go:171","msg":"trace[1286653216] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"1.195541809s","start":"2026-06-12T03:09:46.738184Z","end":"2026-06-12T03:09:47.933726Z","steps":["trace[1286653216] 'process raft request' (duration: 1.194957012s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:47.933794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.738177Z","time spent":"1.195593479s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:09:47.934061Z","caller":"traceutil/trace.go:171","msg":"trace[1496219439] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"895.866619ms","start":"2026-06-12T03:09:47.038124Z","end":"2026-06-12T03:09:47.933991Z","steps":["trace[1496219439] 'process raft request' (duration: 895.636087ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:09:47.934072Z","caller":"traceutil/trace.go:171","msg":"trace[1194009318] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1930; }","duration":"1.132048742s","start":"2026-06-12T03:09:46.802013Z","end":"2026-06-12T03:09:47.934061Z","steps":["trace[1194009318] 'read index received' (duration: 269.758596ms)","trace[1194009318] 'applied index is now lower than readState.Index' (duration: 862.288836ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:09:47.933925Z","caller":"traceutil/trace.go:171","msg":"trace[118087894] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"1.19400918s","start":"2026-06-12T03:09:46.739851Z","end":"2026-06-12T03:09:47.93386Z","steps":["trace[118087894] 'process raft request' (duration: 1.193649096s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:47.934175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.132151254s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:09:47.934198Z","caller":"traceutil/trace.go:171","msg":"trace[730511805] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1864; }","duration":"1.132217185s","start":"2026-06-12T03:09:46.801974Z","end":"2026-06-12T03:09:47.934191Z","steps":["trace[730511805] 'agreement among raft nodes before linearized reading' (duration: 1.132150924s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:47.934221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.80196Z","time spent":"1.132255335s","remote":"127.0.0.1:46624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:09:47.934369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.67128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-12T03:09:47.934396Z","caller":"traceutil/trace.go:171","msg":"trace[831201573] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:1864; }","duration":"407.745781ms","start":"2026-06-12T03:09:47.526642Z","end":"2026-06-12T03:09:47.934388Z","steps":["trace[831201573] 'agreement among raft nodes before linearized reading' (duration: 407.65383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:47.934415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:47.526621Z","time spent":"407.789901ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"warn","ts":"2026-06-12T03:09:47.934419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.543156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-12T03:09:47.934441Z","caller":"traceutil/trace.go:171","msg":"trace[122183392] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1864; }","duration":"194.588696ms","start":"2026-06-12T03:09:47.739844Z","end":"2026-06-12T03:09:47.934433Z","steps":["trace[122183392] 'agreement among raft nodes before linearized reading' (duration: 194.520736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:47.934533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.669542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fbea67a5-d997-4593-a0f9-01045d6e4240\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-06-12T03:09:47.934553Z","caller":"traceutil/trace.go:171","msg":"trace[389090632] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fbea67a5-d997-4593-a0f9-01045d6e4240; range_end:; response_count:1; response_revision:1864; }","duration":"197.732113ms","start":"2026-06-12T03:09:47.736815Z","end":"2026-06-12T03:09:47.934547Z","steps":["trace[389090632] 'agreement among raft nodes before linearized reading' (duration: 197.695872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:09:47.93412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:47.038099Z","time spent":"895.988421ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:09:47.938226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:09:46.739841Z","time spent":"1.194344535s","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:18.053851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.14861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:10:18.053957Z","caller":"traceutil/trace.go:171","msg":"trace[1182727046] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"483.301421ms","start":"2026-06-12T03:10:17.570637Z","end":"2026-06-12T03:10:18.053939Z","steps":["trace[1182727046] 'process raft request' (duration: 233.979659ms)","trace[1182727046] 'compare' (duration: 248.801706ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:10:18.054018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:17.570623Z","time spent":"483.366401ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:24.371973Z","caller":"traceutil/trace.go:171","msg":"trace[46333505] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"319.619102ms","start":"2026-06-12T03:10:24.052334Z","end":"2026-06-12T03:10:24.371953Z","steps":["trace[46333505] 'process raft request' (duration: 319.477571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:24.372107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.052308Z","time spent":"319.727543ms","remote":"127.0.0.1:39080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:24.372481Z","caller":"traceutil/trace.go:171","msg":"trace[1227598978] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2195; }","duration":"313.017494ms","start":"2026-06-12T03:10:24.059417Z","end":"2026-06-12T03:10:24.372434Z","steps":["trace[1227598978] 'read index received' (duration: 312.996564ms)","trace[1227598978] 'applied index is now lower than readState.Index' (duration: 17.64µs)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:10:24.372671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.254136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-06-12T03:10:24.372753Z","caller":"traceutil/trace.go:171","msg":"trace[1389674969] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2115; }","duration":"313.404568ms","start":"2026-06-12T03:10:24.05933Z","end":"2026-06-12T03:10:24.372735Z","steps":["trace[1389674969] 'agreement among raft nodes before linearized reading' (duration: 313.211026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:24.372797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.059307Z","time spent":"313.482378ms","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12408,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-12T03:10:24.740113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.233699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-06-12T03:10:24.740663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.815452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-12T03:10:24.740717Z","caller":"traceutil/trace.go:171","msg":"trace[1537792597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2116; }","duration":"553.927433ms","start":"2026-06-12T03:10:24.186776Z","end":"2026-06-12T03:10:24.740704Z","steps":["trace[1537792597] 'agreement among raft nodes before linearized reading' (duration: 553.741921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:24.740714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.484057ms","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":"warn","ts":"2026-06-12T03:10:24.740793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.268739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-12T03:10:24.740805Z","caller":"traceutil/trace.go:171","msg":"trace[1574347696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2116; }","duration":"551.634619ms","start":"2026-06-12T03:10:24.189153Z","end":"2026-06-12T03:10:24.740787Z","steps":["trace[1574347696] 'agreement among raft nodes before linearized reading' (duration: 551.380276ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:24.740844Z","caller":"traceutil/trace.go:171","msg":"trace[934486477] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2116; }","duration":"538.33993ms","start":"2026-06-12T03:10:24.202489Z","end":"2026-06-12T03:10:24.740829Z","steps":["trace[934486477] 'agreement among raft nodes before linearized reading' (duration: 538.202519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:24.740856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.189131Z","time spent":"551.717109ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-12T03:10:24.740854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.186745Z","time spent":"554.094834ms","remote":"127.0.0.1:39176","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-06-12T03:10:24.740879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.202474Z","time spent":"538.397211ms","remote":"127.0.0.1:36868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-12T03:10:24.740678Z","caller":"traceutil/trace.go:171","msg":"trace[1236805490] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"616.343476ms","start":"2026-06-12T03:10:24.124261Z","end":"2026-06-12T03:10:24.740604Z","steps":["trace[1236805490] 'process raft request' (duration: 404.48515ms)","trace[1236805490] 'compare' (duration: 211.076477ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:10:24.740268Z","caller":"traceutil/trace.go:171","msg":"trace[998673119] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2195; }","duration":"367.562513ms","start":"2026-06-12T03:10:24.372663Z","end":"2026-06-12T03:10:24.740226Z","steps":["trace[998673119] 'read index received' (duration: 156.119712ms)","trace[998673119] 'applied index is now lower than readState.Index' (duration: 211.441151ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:10:24.740661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.351326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-12T03:10:24.741093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.632806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:10:24.741076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.124238Z","time spent":"616.76007ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:24.741123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.867967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b836b7746270a8\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-12T03:10:24.741122Z","caller":"traceutil/trace.go:171","msg":"trace[77672950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2116; }","duration":"589.705557ms","start":"2026-06-12T03:10:24.151406Z","end":"2026-06-12T03:10:24.741111Z","steps":["trace[77672950] 'agreement among raft nodes before linearized reading' (duration: 589.659737ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:24.741126Z","caller":"traceutil/trace.go:171","msg":"trace[1498357551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2116; }","duration":"551.79593ms","start":"2026-06-12T03:10:24.189281Z","end":"2026-06-12T03:10:24.741076Z","steps":["trace[1498357551] 'agreement among raft nodes before linearized reading' (duration: 551.214813ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:24.741152Z","caller":"traceutil/trace.go:171","msg":"trace[995224949] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b836b7746270a8; range_end:; response_count:1; response_revision:2116; }","duration":"542.939508ms","start":"2026-06-12T03:10:24.198204Z","end":"2026-06-12T03:10:24.741144Z","steps":["trace[995224949] 'agreement among raft nodes before linearized reading' (duration: 542.844027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:24.741158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.151381Z","time spent":"589.769737ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T03:10:24.741152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.457779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-12T03:10:24.74118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.198176Z","time spent":"542.998399ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":868,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b836b7746270a8\" "} {"level":"info","ts":"2026-06-12T03:10:24.741209Z","caller":"traceutil/trace.go:171","msg":"trace[513087950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2116; }","duration":"576.60377ms","start":"2026-06-12T03:10:24.164591Z","end":"2026-06-12T03:10:24.741194Z","steps":["trace[513087950] 'agreement among raft nodes before linearized reading' (duration: 576.342197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:24.741225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.189272Z","time spent":"551.903661ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-12T03:10:24.741261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.164553Z","time spent":"576.685961ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T03:10:24.741377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.176849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-12T03:10:24.741465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.701608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:10:24.741507Z","caller":"traceutil/trace.go:171","msg":"trace[1004597919] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2116; }","duration":"352.788979ms","start":"2026-06-12T03:10:24.388707Z","end":"2026-06-12T03:10:24.741496Z","steps":["trace[1004597919] 'agreement among raft nodes before linearized reading' (duration: 352.726388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:24.74154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.388687Z","time spent":"352.84695ms","remote":"127.0.0.1:39350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-12T03:10:24.741783Z","caller":"traceutil/trace.go:171","msg":"trace[988647568] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2116; }","duration":"605.267749ms","start":"2026-06-12T03:10:24.136139Z","end":"2026-06-12T03:10:24.741407Z","steps":["trace[988647568] 'agreement among raft nodes before linearized reading' (duration: 605.193478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:24.741858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.136114Z","time spent":"605.723874ms","remote":"127.0.0.1:39262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:10:25.241164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.877482ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-12T03:10:25.24129Z","caller":"traceutil/trace.go:171","msg":"trace[1982591764] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2196; }","duration":"495.85767ms","start":"2026-06-12T03:10:24.745414Z","end":"2026-06-12T03:10:25.241272Z","steps":["trace[1982591764] 'read index received' (duration: 234.865476ms)","trace[1982591764] 'applied index is now lower than readState.Index' (duration: 260.990604ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:10:25.241305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.744287Z","time spent":"497.011282ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-12T03:10:25.241969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.518167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:10:25.242096Z","caller":"traceutil/trace.go:171","msg":"trace[356378763] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2116; }","duration":"496.672478ms","start":"2026-06-12T03:10:24.745392Z","end":"2026-06-12T03:10:25.242065Z","steps":["trace[356378763] 'agreement among raft nodes before linearized reading' (duration: 495.93979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.242205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.745382Z","time spent":"496.8086ms","remote":"127.0.0.1:39094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-12T03:10:25.267351Z","caller":"traceutil/trace.go:171","msg":"trace[1090275695] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"519.574857ms","start":"2026-06-12T03:10:24.747752Z","end":"2026-06-12T03:10:25.267327Z","steps":["trace[1090275695] 'process raft request' (duration: 519.324264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.267504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.747731Z","time spent":"519.694908ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:25.267748Z","caller":"traceutil/trace.go:171","msg":"trace[1775695986] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"519.86486ms","start":"2026-06-12T03:10:24.747871Z","end":"2026-06-12T03:10:25.267736Z","steps":["trace[1775695986] 'process raft request' (duration: 519.394995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.267815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.747857Z","time spent":"519.92506ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:25.268078Z","caller":"traceutil/trace.go:171","msg":"trace[951196622] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"520.139123ms","start":"2026-06-12T03:10:24.747913Z","end":"2026-06-12T03:10:25.268052Z","steps":["trace[951196622] 'process raft request' (duration: 519.696959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.268145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.747885Z","time spent":"520.225053ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:25.268201Z","caller":"traceutil/trace.go:171","msg":"trace[362986013] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"520.146662ms","start":"2026-06-12T03:10:24.748036Z","end":"2026-06-12T03:10:25.268183Z","steps":["trace[362986013] 'process raft request' (duration: 519.93898ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:25.268296Z","caller":"traceutil/trace.go:171","msg":"trace[293254935] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"394.517659ms","start":"2026-06-12T03:10:24.873752Z","end":"2026-06-12T03:10:25.26827Z","steps":["trace[293254935] 'process raft request' (duration: 394.266037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.26839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.748025Z","time spent":"520.232834ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:25.268454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.873725Z","time spent":"394.638921ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:25.268621Z","caller":"traceutil/trace.go:171","msg":"trace[575113529] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"378.31186ms","start":"2026-06-12T03:10:24.890288Z","end":"2026-06-12T03:10:25.2686Z","steps":["trace[575113529] 'process raft request' (duration: 377.892465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.268704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.890245Z","time spent":"378.415552ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:25.269272Z","caller":"traceutil/trace.go:171","msg":"trace[982187042] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"358.805175ms","start":"2026-06-12T03:10:24.91043Z","end":"2026-06-12T03:10:25.269235Z","steps":["trace[982187042] 'process raft request' (duration: 357.805955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.269412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.196194ms","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-06-12T03:10:25.269479Z","caller":"traceutil/trace.go:171","msg":"trace[1870848746] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2123; }","duration":"323.297945ms","start":"2026-06-12T03:10:24.946167Z","end":"2026-06-12T03:10:25.269465Z","steps":["trace[1870848746] 'agreement among raft nodes before linearized reading' (duration: 323.077082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.269515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.946156Z","time spent":"323.354485ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T03:10:25.269465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.285711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:10:25.270318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.910401Z","time spent":"358.928226ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:25.270557Z","caller":"traceutil/trace.go:171","msg":"trace[1271348163] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2123; }","duration":"362.489304ms","start":"2026-06-12T03:10:24.907118Z","end":"2026-06-12T03:10:25.269608Z","steps":["trace[1271348163] 'agreement among raft nodes before linearized reading' (duration: 362.285672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:25.270676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:24.907102Z","time spent":"363.515666ms","remote":"127.0.0.1:44466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:10:25.830357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.310796ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:10:25.831209Z","caller":"traceutil/trace.go:171","msg":"trace[224594697] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"558.005162ms","start":"2026-06-12T03:10:25.273161Z","end":"2026-06-12T03:10:25.831166Z","steps":["trace[224594697] 'process raft request' (duration: 343.757847ms)","trace[224594697] 'compare' (duration: 213.103194ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:10:25.831365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:25.273144Z","time spent":"558.136964ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:26.655362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388182325,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-12T03:10:26.768275Z","caller":"traceutil/trace.go:171","msg":"trace[1524074944] linearizableReadLoop","detail":"{readStateIndex:2207; appliedIndex:2206; }","duration":"613.434655ms","start":"2026-06-12T03:10:26.154773Z","end":"2026-06-12T03:10:26.768207Z","steps":["trace[1524074944] 'read index received' (duration: 558.15351ms)","trace[1524074944] 'applied index is now lower than readState.Index' (duration: 55.279975ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:10:26.768348Z","caller":"traceutil/trace.go:171","msg":"trace[514438718] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"756.958049ms","start":"2026-06-12T03:10:26.011347Z","end":"2026-06-12T03:10:26.768305Z","steps":["trace[514438718] 'process raft request' (duration: 701.603133ms)","trace[514438718] 'compare' (duration: 55.147984ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:10:26.768395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.604137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:10:26.768437Z","caller":"traceutil/trace.go:171","msg":"trace[1510047925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2126; }","duration":"613.693378ms","start":"2026-06-12T03:10:26.154731Z","end":"2026-06-12T03:10:26.768425Z","steps":["trace[1510047925] 'agreement among raft nodes before linearized reading' (duration: 613.613547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:26.768475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:26.154711Z","time spent":"613.756888ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T03:10:26.768617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:26.01132Z","time spent":"757.111651ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:27.602713Z","caller":"traceutil/trace.go:171","msg":"trace[778124984] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2208; }","duration":"328.198619ms","start":"2026-06-12T03:10:27.274492Z","end":"2026-06-12T03:10:27.60269Z","steps":["trace[778124984] 'read index received' (duration: 328.095468ms)","trace[778124984] 'applied index is now lower than readState.Index' (duration: 102.281µs)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:10:27.602775Z","caller":"traceutil/trace.go:171","msg":"trace[752892286] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"328.385071ms","start":"2026-06-12T03:10:27.274343Z","end":"2026-06-12T03:10:27.602728Z","steps":["trace[752892286] 'process raft request' (duration: 328.21187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:27.603344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.817896ms","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-06-12T03:10:27.603476Z","caller":"traceutil/trace.go:171","msg":"trace[695622856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2128; }","duration":"328.997337ms","start":"2026-06-12T03:10:27.274453Z","end":"2026-06-12T03:10:27.603451Z","steps":["trace[695622856] 'agreement among raft nodes before linearized reading' (duration: 328.359311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:27.603544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.274444Z","time spent":"329.089208ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-12T03:10:27.60376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.274313Z","time spent":"329.118878ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:28.103774Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388182341,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T03:10:28.603907Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388182341,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T03:10:28.664798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.740883ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:10:28.664894Z","caller":"traceutil/trace.go:171","msg":"trace[2053017884] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2128; }","duration":"405.852284ms","start":"2026-06-12T03:10:28.259028Z","end":"2026-06-12T03:10:28.66488Z","steps":["trace[2053017884] 'range keys from in-memory index tree' (duration: 405.725703ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:29.001425Z","caller":"traceutil/trace.go:171","msg":"trace[644815965] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"1.726600157s","start":"2026-06-12T03:10:27.274805Z","end":"2026-06-12T03:10:29.001406Z","steps":["trace[644815965] 'process raft request' (duration: 1.726438685s)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:29.001427Z","caller":"traceutil/trace.go:171","msg":"trace[774519977] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"1.725651478s","start":"2026-06-12T03:10:27.275752Z","end":"2026-06-12T03:10:29.001403Z","steps":["trace[774519977] 'process raft request' (duration: 1.725530967s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.00157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.275743Z","time spent":"1.725752759s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:29.001588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.27479Z","time spent":"1.726688439s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:29.001425Z","caller":"traceutil/trace.go:171","msg":"trace[1627979778] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"1.726790781s","start":"2026-06-12T03:10:27.274587Z","end":"2026-06-12T03:10:29.001377Z","steps":["trace[1627979778] 'process raft request' (duration: 1.726509828s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.001759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.274577Z","time spent":"1.727155064s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:29.001771Z","caller":"traceutil/trace.go:171","msg":"trace[147942875] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"1.724130101s","start":"2026-06-12T03:10:27.277624Z","end":"2026-06-12T03:10:29.001754Z","steps":["trace[147942875] 'process raft request' (duration: 1.72395652s)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:29.001793Z","caller":"traceutil/trace.go:171","msg":"trace[265776297] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"1.72489724s","start":"2026-06-12T03:10:27.276864Z","end":"2026-06-12T03:10:29.001761Z","steps":["trace[265776297] 'process raft request' (duration: 1.724462916s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.001867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.277617Z","time spent":"1.724196412s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:29.001933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.276856Z","time spent":"1.725002701s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:29.061433Z","caller":"traceutil/trace.go:171","msg":"trace[1842017200] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2209; }","duration":"1.458629102s","start":"2026-06-12T03:10:27.602786Z","end":"2026-06-12T03:10:29.061415Z","steps":["trace[1842017200] 'read index received' (duration: 1.398307928s)","trace[1842017200] 'applied index is now lower than readState.Index' (duration: 60.320304ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:10:29.061559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.498355375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:10:29.061551Z","caller":"traceutil/trace.go:171","msg":"trace[1373426547] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"271.594253ms","start":"2026-06-12T03:10:28.78988Z","end":"2026-06-12T03:10:29.061474Z","steps":["trace[1373426547] 'process raft request' (duration: 271.500733ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:29.061691Z","caller":"traceutil/trace.go:171","msg":"trace[963224581] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"1.453751142s","start":"2026-06-12T03:10:27.607931Z","end":"2026-06-12T03:10:29.061683Z","steps":["trace[963224581] 'process raft request' (duration: 1.453358419s)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:29.061634Z","caller":"traceutil/trace.go:171","msg":"trace[1102911915] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2135; }","duration":"1.498474817s","start":"2026-06-12T03:10:27.563147Z","end":"2026-06-12T03:10:29.061622Z","steps":["trace[1102911915] 'agreement among raft nodes before linearized reading' (duration: 1.498369706s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.061758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.607906Z","time spent":"1.453811423s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:29.061771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.373733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:10:29.061817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.563123Z","time spent":"1.498660508s","remote":"127.0.0.1:39790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"info","ts":"2026-06-12T03:10:29.061847Z","caller":"traceutil/trace.go:171","msg":"trace[641087807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2135; }","duration":"911.511674ms","start":"2026-06-12T03:10:28.150316Z","end":"2026-06-12T03:10:29.061827Z","steps":["trace[641087807] 'agreement among raft nodes before linearized reading' (duration: 911.361722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.06187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057511406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:10:29.061871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.863204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b836b7746270a8\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-06-12T03:10:29.061915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.532373749s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-12T03:10:29.061767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231796407s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:10:29.061939Z","caller":"traceutil/trace.go:171","msg":"trace[247449212] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b836b7746270a8; range_end:; response_count:1; response_revision:2135; }","duration":"156.011835ms","start":"2026-06-12T03:10:28.905908Z","end":"2026-06-12T03:10:29.06192Z","steps":["trace[247449212] 'agreement among raft nodes before linearized reading' (duration: 155.795623ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:29.061937Z","caller":"traceutil/trace.go:171","msg":"trace[1304614939] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2135; }","duration":"1.057603468s","start":"2026-06-12T03:10:28.004308Z","end":"2026-06-12T03:10:29.061911Z","steps":["trace[1304614939] 'agreement among raft nodes before linearized reading' (duration: 1.057519067s)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:29.061953Z","caller":"traceutil/trace.go:171","msg":"trace[816319961] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2135; }","duration":"1.232077079s","start":"2026-06-12T03:10:27.829863Z","end":"2026-06-12T03:10:29.061941Z","steps":["trace[816319961] 'agreement among raft nodes before linearized reading' (duration: 1.231766416s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.061989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.829845Z","time spent":"1.232134109s","remote":"127.0.0.1:44438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:10:29.061998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:28.004288Z","time spent":"1.057695388s","remote":"127.0.0.1:44390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:10:29.062079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215051753s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-12T03:10:29.062112Z","caller":"traceutil/trace.go:171","msg":"trace[1575675444] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2135; }","duration":"1.215103204s","start":"2026-06-12T03:10:27.846996Z","end":"2026-06-12T03:10:29.0621Z","steps":["trace[1575675444] 'agreement among raft nodes before linearized reading' (duration: 1.215011363s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.062142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.846982Z","time spent":"1.215153664s","remote":"127.0.0.1:36868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-12T03:10:29.062205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.083305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-12T03:10:29.062242Z","caller":"traceutil/trace.go:171","msg":"trace[1777241051] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2135; }","duration":"456.112306ms","start":"2026-06-12T03:10:28.606113Z","end":"2026-06-12T03:10:29.062226Z","steps":["trace[1777241051] 'agreement among raft nodes before linearized reading' (duration: 455.984625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.062231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19077906s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:10:29.062264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:28.606057Z","time spent":"456.201546ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-12T03:10:29.061912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:28.150264Z","time spent":"911.639425ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-12T03:10:29.062285Z","caller":"traceutil/trace.go:171","msg":"trace[2090951039] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2135; }","duration":"1.190866541s","start":"2026-06-12T03:10:27.871396Z","end":"2026-06-12T03:10:29.062262Z","steps":["trace[2090951039] 'agreement among raft nodes before linearized reading' (duration: 1.19079461s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.06232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.871385Z","time spent":"1.190926482s","remote":"127.0.0.1:39826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-06-12T03:10:29.061945Z","caller":"traceutil/trace.go:171","msg":"trace[1606808517] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:2135; }","duration":"1.532434799s","start":"2026-06-12T03:10:27.529503Z","end":"2026-06-12T03:10:29.061937Z","steps":["trace[1606808517] 'agreement among raft nodes before linearized reading' (duration: 1.532341178s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.062454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.226060236s","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-06-12T03:10:29.062482Z","caller":"traceutil/trace.go:171","msg":"trace[213680950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2135; }","duration":"1.226129617s","start":"2026-06-12T03:10:27.836344Z","end":"2026-06-12T03:10:29.062474Z","steps":["trace[213680950] 'agreement among raft nodes before linearized reading' (duration: 1.226040026s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.062508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.836316Z","time spent":"1.226186487s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T03:10:29.062481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:27.529482Z","time spent":"1.532980294s","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"info","ts":"2026-06-12T03:10:29.30163Z","caller":"traceutil/trace.go:171","msg":"trace[1307666078] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2216; }","duration":"237.420825ms","start":"2026-06-12T03:10:29.063966Z","end":"2026-06-12T03:10:29.301387Z","steps":["trace[1307666078] 'read index received' (duration: 195.996707ms)","trace[1307666078] 'applied index is now lower than readState.Index' (duration: 41.422588ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:10:29.30173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.746468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:10:29.301934Z","caller":"traceutil/trace.go:171","msg":"trace[1871639653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2135; }","duration":"238.595396ms","start":"2026-06-12T03:10:29.063324Z","end":"2026-06-12T03:10:29.30192Z","steps":["trace[1871639653] 'agreement among raft nodes before linearized reading' (duration: 238.343814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.802894Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388182351,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-12T03:10:29.967529Z","caller":"traceutil/trace.go:171","msg":"trace[50429503] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"902.756423ms","start":"2026-06-12T03:10:29.064731Z","end":"2026-06-12T03:10:29.967488Z","steps":["trace[50429503] 'process raft request' (duration: 902.479821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.967718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:29.064715Z","time spent":"902.900725ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:29.967732Z","caller":"traceutil/trace.go:171","msg":"trace[2001588422] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"900.194137ms","start":"2026-06-12T03:10:29.067514Z","end":"2026-06-12T03:10:29.967708Z","steps":["trace[2001588422] 'process raft request' (duration: 900.107657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.967885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:29.067506Z","time spent":"900.297798ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:29.967982Z","caller":"traceutil/trace.go:171","msg":"trace[111235283] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"900.827483ms","start":"2026-06-12T03:10:29.067139Z","end":"2026-06-12T03:10:29.967966Z","steps":["trace[111235283] 'process raft request' (duration: 900.249207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.968059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:29.067131Z","time spent":"900.886963ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:29.972747Z","caller":"traceutil/trace.go:171","msg":"trace[1456146685] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"670.29642ms","start":"2026-06-12T03:10:29.302435Z","end":"2026-06-12T03:10:29.972731Z","steps":["trace[1456146685] 'process raft request' (duration: 670.145408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.972838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:29.302417Z","time spent":"670.375932ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:29.973305Z","caller":"traceutil/trace.go:171","msg":"trace[178243798] linearizableReadLoop","detail":"{readStateIndex:2222; appliedIndex:2217; }","duration":"671.461752ms","start":"2026-06-12T03:10:29.301826Z","end":"2026-06-12T03:10:29.973288Z","steps":["trace[178243798] 'read index received' (duration: 665.43179ms)","trace[178243798] 'applied index is now lower than readState.Index' (duration: 6.028612ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:10:29.973516Z","caller":"traceutil/trace.go:171","msg":"trace[2035284813] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"362.362366ms","start":"2026-06-12T03:10:29.611143Z","end":"2026-06-12T03:10:29.973505Z","steps":["trace[2035284813] 'process raft request' (duration: 361.537327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.973586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:29.611115Z","time spent":"362.434087ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:10:29.973846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.575091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:10:29.973897Z","caller":"traceutil/trace.go:171","msg":"trace[1159620839] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2140; }","duration":"663.659512ms","start":"2026-06-12T03:10:29.310225Z","end":"2026-06-12T03:10:29.973884Z","steps":["trace[1159620839] 'agreement among raft nodes before linearized reading' (duration: 663.577911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.973911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.872283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-06-12T03:10:29.973935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:29.310208Z","time spent":"663.719283ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-12T03:10:29.973955Z","caller":"traceutil/trace.go:171","msg":"trace[579520945] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2140; }","duration":"281.013825ms","start":"2026-06-12T03:10:29.692928Z","end":"2026-06-12T03:10:29.973942Z","steps":["trace[579520945] 'agreement among raft nodes before linearized reading' (duration: 280.874963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.974212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.553491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T03:10:29.974269Z","caller":"traceutil/trace.go:171","msg":"trace[1457626510] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2140; }","duration":"751.645312ms","start":"2026-06-12T03:10:29.222608Z","end":"2026-06-12T03:10:29.974254Z","steps":["trace[1457626510] 'agreement among raft nodes before linearized reading' (duration: 751.097275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:29.974299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:29.222587Z","time spent":"751.703372ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-06-12T03:12:36.640502Z","caller":"traceutil/trace.go:171","msg":"trace[372427107] transaction","detail":"{read_only:false; response_revision:2916; number_of_response:1; }","duration":"164.222602ms","start":"2026-06-12T03:12:36.476243Z","end":"2026-06-12T03:12:36.640466Z","steps":["trace[372427107] 'process raft request' (duration: 163.999418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:37.577274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.190374ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:12:37.577357Z","caller":"traceutil/trace.go:171","msg":"trace[1302485803] linearizableReadLoop","detail":"{readStateIndex:3026; appliedIndex:3025; }","duration":"635.535376ms","start":"2026-06-12T03:12:36.941809Z","end":"2026-06-12T03:12:37.577344Z","steps":["trace[1302485803] 'read index received' (duration: 109.111088ms)","trace[1302485803] 'applied index is now lower than readState.Index' (duration: 526.423298ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:12:37.577548Z","caller":"traceutil/trace.go:171","msg":"trace[1979903102] transaction","detail":"{read_only:false; response_revision:2917; number_of_response:1; }","duration":"932.69874ms","start":"2026-06-12T03:12:36.644811Z","end":"2026-06-12T03:12:37.57751Z","steps":["trace[1979903102] 'process raft request' (duration: 406.203441ms)","trace[1979903102] 'compare' (duration: 526.106192ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:12:37.57765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.836611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b836d409310e83\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-06-12T03:12:37.57771Z","caller":"traceutil/trace.go:171","msg":"trace[1561265973] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b836d409310e83; range_end:; response_count:1; response_revision:2917; }","duration":"635.940644ms","start":"2026-06-12T03:12:36.941756Z","end":"2026-06-12T03:12:37.577697Z","steps":["trace[1561265973] 'agreement among raft nodes before linearized reading' (duration: 635.721049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:37.577748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:36.941735Z","time spent":"636.006744ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":803,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b836d409310e83\" "} {"level":"warn","ts":"2026-06-12T03:12:37.57827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:36.644794Z","time spent":"933.387465ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:12:37.620401Z","caller":"traceutil/trace.go:171","msg":"trace[518626938] transaction","detail":"{read_only:false; response_revision:2918; number_of_response:1; }","duration":"107.017792ms","start":"2026-06-12T03:12:37.513364Z","end":"2026-06-12T03:12:37.620382Z","steps":["trace[518626938] 'process raft request' (duration: 106.90464ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:12:37.989629Z","caller":"traceutil/trace.go:171","msg":"trace[612234549] transaction","detail":"{read_only:false; response_revision:2921; number_of_response:1; }","duration":"409.97365ms","start":"2026-06-12T03:12:37.579648Z","end":"2026-06-12T03:12:37.989621Z","steps":["trace[612234549] 'process raft request' (duration: 409.873598ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:12:37.98962Z","caller":"traceutil/trace.go:171","msg":"trace[940650715] linearizableReadLoop","detail":"{readStateIndex:3029; appliedIndex:3027; }","duration":"412.223326ms","start":"2026-06-12T03:12:37.577374Z","end":"2026-06-12T03:12:37.989598Z","steps":["trace[940650715] 'read index received' (duration: 43.093321ms)","trace[940650715] 'applied index is now lower than readState.Index' (duration: 369.126464ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:12:37.989843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.159213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-12T03:12:37.989856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.341937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:12:37.989888Z","caller":"traceutil/trace.go:171","msg":"trace[1007333248] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:2921; }","duration":"454.252215ms","start":"2026-06-12T03:12:37.535623Z","end":"2026-06-12T03:12:37.989875Z","steps":["trace[1007333248] 'agreement among raft nodes before linearized reading' (duration: 454.094242ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:12:37.989913Z","caller":"traceutil/trace.go:171","msg":"trace[530714515] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2921; }","duration":"901.45991ms","start":"2026-06-12T03:12:37.088436Z","end":"2026-06-12T03:12:37.989896Z","steps":["trace[530714515] 'agreement among raft nodes before linearized reading' (duration: 901.352758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:37.989966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:37.088414Z","time spent":"901.543571ms","remote":"127.0.0.1:39120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:12:37.990017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.688764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-06-12T03:12:37.989958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:37.579623Z","time spent":"410.048602ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:12:37.990053Z","caller":"traceutil/trace.go:171","msg":"trace[1799457634] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2921; }","duration":"340.764766ms","start":"2026-06-12T03:12:37.649281Z","end":"2026-06-12T03:12:37.990046Z","steps":["trace[1799457634] 'agreement among raft nodes before linearized reading' (duration: 340.672224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:37.990083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:37.64926Z","time spent":"340.817606ms","remote":"127.0.0.1:39094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-06-12T03:12:37.990132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.18126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:12:37.990154Z","caller":"traceutil/trace.go:171","msg":"trace[2016531785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2921; }","duration":"839.238731ms","start":"2026-06-12T03:12:37.150909Z","end":"2026-06-12T03:12:37.990148Z","steps":["trace[2016531785] 'agreement among raft nodes before linearized reading' (duration: 839.207661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:37.990168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:37.150888Z","time spent":"839.276563ms","remote":"127.0.0.1:38910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T03:12:37.990177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.128787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T03:12:37.99023Z","caller":"traceutil/trace.go:171","msg":"trace[607770561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2921; }","duration":"288.215808ms","start":"2026-06-12T03:12:37.702002Z","end":"2026-06-12T03:12:37.990218Z","steps":["trace[607770561] 'agreement among raft nodes before linearized reading' (duration: 288.022314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:37.989927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:37.535594Z","time spent":"454.324856ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"warn","ts":"2026-06-12T03:12:37.99034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.486662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-12T03:12:37.990359Z","caller":"traceutil/trace.go:171","msg":"trace[999591656] transaction","detail":"{read_only:false; response_revision:2920; number_of_response:1; }","duration":"474.233409ms","start":"2026-06-12T03:12:37.516098Z","end":"2026-06-12T03:12:37.990331Z","steps":["trace[999591656] 'process raft request' (duration: 473.341701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:37.990368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.430523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-12T03:12:37.990375Z","caller":"traceutil/trace.go:171","msg":"trace[568457420] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2921; }","duration":"290.562184ms","start":"2026-06-12T03:12:37.699805Z","end":"2026-06-12T03:12:37.990367Z","steps":["trace[568457420] 'agreement among raft nodes before linearized reading' (duration: 290.467832ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:12:37.990387Z","caller":"traceutil/trace.go:171","msg":"trace[41722923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2921; }","duration":"284.468444ms","start":"2026-06-12T03:12:37.705912Z","end":"2026-06-12T03:12:37.990381Z","steps":["trace[41722923] 'agreement among raft nodes before linearized reading' (duration: 284.421803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:37.990487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:37.51607Z","time spent":"474.311351ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:12:37.990496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.043461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-12T03:12:37.99052Z","caller":"traceutil/trace.go:171","msg":"trace[1110711237] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2921; }","duration":"299.066691ms","start":"2026-06-12T03:12:37.691447Z","end":"2026-06-12T03:12:37.990513Z","steps":["trace[1110711237] 'agreement among raft nodes before linearized reading' (duration: 298.99926ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:12:37.989503Z","caller":"traceutil/trace.go:171","msg":"trace[861575597] transaction","detail":"{read_only:false; response_revision:2919; number_of_response:1; }","duration":"475.988214ms","start":"2026-06-12T03:12:37.51349Z","end":"2026-06-12T03:12:37.989478Z","steps":["trace[861575597] 'process raft request' (duration: 455.219505ms)","trace[861575597] 'compare' (duration: 20.529664ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:12:37.990868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:12:37.513466Z","time spent":"477.366961ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:12:53.779067Z","caller":"traceutil/trace.go:171","msg":"trace[1165102836] linearizableReadLoop","detail":"{readStateIndex:3116; appliedIndex:3115; }","duration":"125.247382ms","start":"2026-06-12T03:12:53.65379Z","end":"2026-06-12T03:12:53.779038Z","steps":["trace[1165102836] 'read index received' (duration: 125.096868ms)","trace[1165102836] 'applied index is now lower than readState.Index' (duration: 149.104µs)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:12:53.779136Z","caller":"traceutil/trace.go:171","msg":"trace[287360736] transaction","detail":"{read_only:false; response_revision:3003; number_of_response:1; }","duration":"126.025696ms","start":"2026-06-12T03:12:53.653054Z","end":"2026-06-12T03:12:53.77908Z","steps":["trace[287360736] 'process raft request' (duration: 125.74612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:12:53.779598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.71189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1447"} {"level":"info","ts":"2026-06-12T03:12:53.779699Z","caller":"traceutil/trace.go:171","msg":"trace[1332764889] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:3003; }","duration":"125.910583ms","start":"2026-06-12T03:12:53.653768Z","end":"2026-06-12T03:12:53.779678Z","steps":["trace[1332764889] 'agreement among raft nodes before linearized reading' (duration: 125.380614ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:12:53.78033Z","caller":"traceutil/trace.go:171","msg":"trace[2016296513] transaction","detail":"{read_only:false; response_revision:3004; number_of_response:1; }","duration":"112.041035ms","start":"2026-06-12T03:12:53.668266Z","end":"2026-06-12T03:12:53.780307Z","steps":["trace[2016296513] 'process raft request' (duration: 111.756159ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:15:40.791143Z","caller":"traceutil/trace.go:171","msg":"trace[728054401] transaction","detail":"{read_only:false; response_revision:4037; number_of_response:1; }","duration":"101.833233ms","start":"2026-06-12T03:15:40.689285Z","end":"2026-06-12T03:15:40.791119Z","steps":["trace[728054401] 'process raft request' (duration: 96.846028ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:26.811009Z","caller":"traceutil/trace.go:171","msg":"trace[434931739] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"101.232411ms","start":"2026-06-12T03:16:26.709759Z","end":"2026-06-12T03:16:26.810991Z","steps":["trace[434931739] 'process raft request' (duration: 97.392294ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:31.178724Z","caller":"traceutil/trace.go:171","msg":"trace[1069732400] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"140.833294ms","start":"2026-06-12T03:16:31.037818Z","end":"2026-06-12T03:16:31.178651Z","steps":["trace[1069732400] 'process raft request' (duration: 140.393248ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:31.178982Z","caller":"traceutil/trace.go:171","msg":"trace[2066187010] linearizableReadLoop","detail":"{readStateIndex:4954; appliedIndex:4953; }","duration":"116.904058ms","start":"2026-06-12T03:16:31.061924Z","end":"2026-06-12T03:16:31.178828Z","steps":["trace[2066187010] 'read index received' (duration: 116.24954ms)","trace[2066187010] 'applied index is now lower than readState.Index' (duration: 336.874µs)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:16:31.179054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.10572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-12T03:16:31.17916Z","caller":"traceutil/trace.go:171","msg":"trace[2064427142] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4772; }","duration":"117.273692ms","start":"2026-06-12T03:16:31.06186Z","end":"2026-06-12T03:16:31.179134Z","steps":["trace[2064427142] 'agreement among raft nodes before linearized reading' (duration: 116.950688ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:33.306581Z","caller":"traceutil/trace.go:171","msg":"trace[1436505690] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"109.943961ms","start":"2026-06-12T03:16:33.196611Z","end":"2026-06-12T03:16:33.306555Z","steps":["trace[1436505690] 'process raft request' (duration: 109.764119ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:35.595882Z","caller":"traceutil/trace.go:171","msg":"trace[981505122] linearizableReadLoop","detail":"{readStateIndex:5056; appliedIndex:5055; }","duration":"234.557266ms","start":"2026-06-12T03:16:35.361282Z","end":"2026-06-12T03:16:35.595839Z","steps":["trace[981505122] 'read index received' (duration: 227.50667ms)","trace[981505122] 'applied index is now lower than readState.Index' (duration: 7.048556ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:16:35.595935Z","caller":"traceutil/trace.go:171","msg":"trace[476387529] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"267.845244ms","start":"2026-06-12T03:16:35.328053Z","end":"2026-06-12T03:16:35.595898Z","steps":["trace[476387529] 'process raft request' (duration: 260.719047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:35.59631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.457117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-12T03:16:35.596395Z","caller":"traceutil/trace.go:171","msg":"trace[1633845110] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4870; }","duration":"275.56881ms","start":"2026-06-12T03:16:35.320807Z","end":"2026-06-12T03:16:35.596376Z","steps":["trace[1633845110] 'agreement among raft nodes before linearized reading' (duration: 275.279716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:35.596405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.220049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-06-12T03:16:35.596505Z","caller":"traceutil/trace.go:171","msg":"trace[532221528] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4870; }","duration":"277.35705ms","start":"2026-06-12T03:16:35.319093Z","end":"2026-06-12T03:16:35.59645Z","steps":["trace[532221528] 'agreement among raft nodes before linearized reading' (duration: 276.996846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:35.596507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.096572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-12T03:16:35.596572Z","caller":"traceutil/trace.go:171","msg":"trace[1343712653] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4870; }","duration":"257.211123ms","start":"2026-06-12T03:16:35.339345Z","end":"2026-06-12T03:16:35.596556Z","steps":["trace[1343712653] 'agreement among raft nodes before linearized reading' (duration: 257.00235ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:35.607111Z","caller":"traceutil/trace.go:171","msg":"trace[1128391006] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"241.37934ms","start":"2026-06-12T03:16:35.36571Z","end":"2026-06-12T03:16:35.607089Z","steps":["trace[1128391006] 'process raft request' (duration: 241.214658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:35.610243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.341621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T03:16:35.610387Z","caller":"traceutil/trace.go:171","msg":"trace[240458888] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:4873; }","duration":"118.518883ms","start":"2026-06-12T03:16:35.491848Z","end":"2026-06-12T03:16:35.610367Z","steps":["trace[240458888] 'agreement among raft nodes before linearized reading' (duration: 118.2629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:35.6106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.704711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-12T03:16:35.610645Z","caller":"traceutil/trace.go:171","msg":"trace[1369802438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4873; }","duration":"174.806893ms","start":"2026-06-12T03:16:35.435827Z","end":"2026-06-12T03:16:35.610633Z","steps":["trace[1369802438] 'agreement among raft nodes before linearized reading' (duration: 174.662611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:35.61088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.910418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T03:16:35.610912Z","caller":"traceutil/trace.go:171","msg":"trace[1285551493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4873; }","duration":"163.000899ms","start":"2026-06-12T03:16:35.4479Z","end":"2026-06-12T03:16:35.610901Z","steps":["trace[1285551493] 'agreement among raft nodes before linearized reading' (duration: 162.871347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:35.61139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.38772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-12T03:16:35.611422Z","caller":"traceutil/trace.go:171","msg":"trace[1261314386] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4873; }","duration":"166.479611ms","start":"2026-06-12T03:16:35.444934Z","end":"2026-06-12T03:16:35.611414Z","steps":["trace[1261314386] 'agreement among raft nodes before linearized reading' (duration: 166.39835ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:41.458082Z","caller":"traceutil/trace.go:171","msg":"trace[553287591] transaction","detail":"{read_only:false; response_revision:4984; number_of_response:1; }","duration":"104.97031ms","start":"2026-06-12T03:16:41.353072Z","end":"2026-06-12T03:16:41.458042Z","steps":["trace[553287591] 'process raft request' (duration: 68.189551ms)","trace[553287591] 'compare' (duration: 36.605987ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:16:42.326049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.566254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:16:42.326166Z","caller":"traceutil/trace.go:171","msg":"trace[279286685] linearizableReadLoop","detail":"{readStateIndex:5172; appliedIndex:5171; }","duration":"691.371262ms","start":"2026-06-12T03:16:41.634778Z","end":"2026-06-12T03:16:42.326149Z","steps":["trace[279286685] 'read index received' (duration: 76.630945ms)","trace[279286685] 'applied index is now lower than readState.Index' (duration: 614.739137ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:16:42.32644Z","caller":"traceutil/trace.go:171","msg":"trace[1778265154] transaction","detail":"{read_only:false; response_revision:4985; number_of_response:1; }","duration":"694.202387ms","start":"2026-06-12T03:16:41.632224Z","end":"2026-06-12T03:16:42.326426Z","steps":["trace[1778265154] 'process raft request' (duration: 79.151267ms)","trace[1778265154] 'compare' (duration: 613.947566ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:16:42.32651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:41.63219Z","time spent":"694.281507ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:16:42.326816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.037809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-12T03:16:42.326873Z","caller":"traceutil/trace.go:171","msg":"trace[204733533] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4985; }","duration":"692.148011ms","start":"2026-06-12T03:16:41.634714Z","end":"2026-06-12T03:16:42.326862Z","steps":["trace[204733533] 'agreement among raft nodes before linearized reading' (duration: 691.993019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:42.326904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:41.634684Z","time spent":"692.212041ms","remote":"127.0.0.1:39176","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-06-12T03:16:42.368204Z","caller":"traceutil/trace.go:171","msg":"trace[418918902] transaction","detail":"{read_only:false; response_revision:4986; number_of_response:1; }","duration":"233.037321ms","start":"2026-06-12T03:16:42.135125Z","end":"2026-06-12T03:16:42.368162Z","steps":["trace[418918902] 'process raft request' (duration: 232.858319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:42.368307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.833416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-12T03:16:42.368302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.670575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:16:42.368376Z","caller":"traceutil/trace.go:171","msg":"trace[1529123387] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4986; }","duration":"677.959448ms","start":"2026-06-12T03:16:41.690385Z","end":"2026-06-12T03:16:42.368344Z","steps":["trace[1529123387] 'agreement among raft nodes before linearized reading' (duration: 677.779616ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:42.368397Z","caller":"traceutil/trace.go:171","msg":"trace[446345264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4986; }","duration":"218.845487ms","start":"2026-06-12T03:16:42.149539Z","end":"2026-06-12T03:16:42.368384Z","steps":["trace[446345264] 'agreement among raft nodes before linearized reading' (duration: 218.651915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:42.368405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:41.690362Z","time spent":"678.034368ms","remote":"127.0.0.1:36840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:16:42.368409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.848328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-12T03:16:42.368463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.461903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T03:16:42.3685Z","caller":"traceutil/trace.go:171","msg":"trace[474108638] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4986; }","duration":"733.03481ms","start":"2026-06-12T03:16:41.635445Z","end":"2026-06-12T03:16:42.36848Z","steps":["trace[474108638] 'agreement among raft nodes before linearized reading' (duration: 732.700496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:42.368544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:41.635423Z","time spent":"733.114431ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-12T03:16:42.368562Z","caller":"traceutil/trace.go:171","msg":"trace[2109723436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4986; }","duration":"705.603845ms","start":"2026-06-12T03:16:41.662921Z","end":"2026-06-12T03:16:42.368525Z","steps":["trace[2109723436] 'agreement among raft nodes before linearized reading' (duration: 705.367102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:42.368611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:41.66283Z","time spent":"705.772237ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-12T03:16:42.368709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.137291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-232bf23e-f2c2-4328-b131-79ad26101eab\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-12T03:16:42.368739Z","caller":"traceutil/trace.go:171","msg":"trace[1805404942] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-232bf23e-f2c2-4328-b131-79ad26101eab; range_end:; response_count:1; response_revision:4986; }","duration":"233.209631ms","start":"2026-06-12T03:16:42.135523Z","end":"2026-06-12T03:16:42.368732Z","steps":["trace[1805404942] 'agreement among raft nodes before linearized reading' (duration: 233.07931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:42.368775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.319658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-12T03:16:42.368785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.56192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-12T03:16:42.3688Z","caller":"traceutil/trace.go:171","msg":"trace[324822982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4986; }","duration":"704.38906ms","start":"2026-06-12T03:16:41.664403Z","end":"2026-06-12T03:16:42.368792Z","steps":["trace[324822982] 'agreement among raft nodes before linearized reading' (duration: 704.304299ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:42.368816Z","caller":"traceutil/trace.go:171","msg":"trace[1067102361] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4986; }","duration":"717.61374ms","start":"2026-06-12T03:16:41.651192Z","end":"2026-06-12T03:16:42.368806Z","steps":["trace[1067102361] 'agreement among raft nodes before linearized reading' (duration: 717.518799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:42.368824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:41.664385Z","time spent":"704.4342ms","remote":"127.0.0.1:39176","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-06-12T03:16:42.368845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:41.651177Z","time spent":"717.661431ms","remote":"127.0.0.1:39176","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-06-12T03:16:42.482884Z","caller":"traceutil/trace.go:171","msg":"trace[1475608185] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"108.943858ms","start":"2026-06-12T03:16:42.37389Z","end":"2026-06-12T03:16:42.482833Z","steps":["trace[1475608185] 'process raft request' (duration: 108.864787ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:42.48295Z","caller":"traceutil/trace.go:171","msg":"trace[258708579] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"109.700148ms","start":"2026-06-12T03:16:42.373193Z","end":"2026-06-12T03:16:42.482893Z","steps":["trace[258708579] 'process raft request' (duration: 101.938593ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:42.483995Z","caller":"traceutil/trace.go:171","msg":"trace[2017013772] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"106.029041ms","start":"2026-06-12T03:16:42.377944Z","end":"2026-06-12T03:16:42.483973Z","steps":["trace[2017013772] 'process raft request' (duration: 105.958531ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:42.483991Z","caller":"traceutil/trace.go:171","msg":"trace[531474218] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"109.429233ms","start":"2026-06-12T03:16:42.374532Z","end":"2026-06-12T03:16:42.483961Z","steps":["trace[531474218] 'process raft request' (duration: 108.26007ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:42.484345Z","caller":"traceutil/trace.go:171","msg":"trace[1743240943] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"108.646845ms","start":"2026-06-12T03:16:42.375687Z","end":"2026-06-12T03:16:42.484334Z","steps":["trace[1743240943] 'process raft request' (duration: 108.100467ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:43.301498Z","caller":"traceutil/trace.go:171","msg":"trace[486169892] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"344.843699ms","start":"2026-06-12T03:16:42.956627Z","end":"2026-06-12T03:16:43.30147Z","steps":["trace[486169892] 'process raft request' (duration: 344.647477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:43.301695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:42.956597Z","time spent":"344.993652ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:16:43.440494Z","caller":"traceutil/trace.go:171","msg":"trace[48648631] linearizableReadLoop","detail":"{readStateIndex:5184; appliedIndex:5181; }","duration":"289.396595ms","start":"2026-06-12T03:16:43.15107Z","end":"2026-06-12T03:16:43.440467Z","steps":["trace[48648631] 'read index received' (duration: 150.191479ms)","trace[48648631] 'applied index is now lower than readState.Index' (duration: 139.203596ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:16:43.440644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.557917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:16:43.440716Z","caller":"traceutil/trace.go:171","msg":"trace[1573305178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4996; }","duration":"289.693268ms","start":"2026-06-12T03:16:43.15101Z","end":"2026-06-12T03:16:43.440703Z","steps":["trace[1573305178] 'agreement among raft nodes before linearized reading' (duration: 289.572846ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:43.440808Z","caller":"traceutil/trace.go:171","msg":"trace[226583108] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"474.719212ms","start":"2026-06-12T03:16:42.966057Z","end":"2026-06-12T03:16:43.440776Z","steps":["trace[226583108] 'process raft request' (duration: 444.301251ms)","trace[226583108] 'compare' (duration: 29.794153ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:16:43.440855Z","caller":"traceutil/trace.go:171","msg":"trace[1126184880] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"411.39137ms","start":"2026-06-12T03:16:43.02943Z","end":"2026-06-12T03:16:43.440822Z","steps":["trace[1126184880] 'process raft request' (duration: 410.925615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:43.44098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:42.966035Z","time spent":"474.866623ms","remote":"127.0.0.1:38968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":925,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:16:43.441087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:43.029391Z","time spent":"411.538652ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:16:43.724741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.421028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:16:43.724857Z","caller":"traceutil/trace.go:171","msg":"trace[153889960] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4997; }","duration":"162.651241ms","start":"2026-06-12T03:16:43.562169Z","end":"2026-06-12T03:16:43.72482Z","steps":["trace[153889960] 'count revisions from in-memory index tree' (duration: 162.290957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:43.725185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.815191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-232bf23e-f2c2-4328-b131-79ad26101eab\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-06-12T03:16:43.725301Z","caller":"traceutil/trace.go:171","msg":"trace[852290575] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-232bf23e-f2c2-4328-b131-79ad26101eab; range_end:; response_count:1; response_revision:4997; }","duration":"161.957663ms","start":"2026-06-12T03:16:43.563318Z","end":"2026-06-12T03:16:43.725275Z","steps":["trace[852290575] 'range keys from in-memory index tree' (duration: 161.306225ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:46.612912Z","caller":"traceutil/trace.go:171","msg":"trace[2060139034] linearizableReadLoop","detail":"{readStateIndex:5234; appliedIndex:5233; }","duration":"175.289819ms","start":"2026-06-12T03:16:46.437601Z","end":"2026-06-12T03:16:46.61289Z","steps":["trace[2060139034] 'read index received' (duration: 170.020046ms)","trace[2060139034] 'applied index is now lower than readState.Index' (duration: 5.268663ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:16:46.612968Z","caller":"traceutil/trace.go:171","msg":"trace[2141478168] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"264.090387ms","start":"2026-06-12T03:16:46.348831Z","end":"2026-06-12T03:16:46.612922Z","steps":["trace[2141478168] 'process raft request' (duration: 258.768833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:46.613632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.989958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-12T03:16:46.613776Z","caller":"traceutil/trace.go:171","msg":"trace[218633098] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5047; }","duration":"176.1572ms","start":"2026-06-12T03:16:46.437554Z","end":"2026-06-12T03:16:46.613711Z","steps":["trace[218633098] 'agreement among raft nodes before linearized reading' (duration: 175.470653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:46.614525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.391551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-12T03:16:46.614525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.354661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T03:16:46.614578Z","caller":"traceutil/trace.go:171","msg":"trace[1902193278] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5047; }","duration":"110.514223ms","start":"2026-06-12T03:16:46.504054Z","end":"2026-06-12T03:16:46.614568Z","steps":["trace[1902193278] 'agreement among raft nodes before linearized reading' (duration: 110.29916ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:46.614589Z","caller":"traceutil/trace.go:171","msg":"trace[307056985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5047; }","duration":"110.456272ms","start":"2026-06-12T03:16:46.50412Z","end":"2026-06-12T03:16:46.614576Z","steps":["trace[307056985] 'agreement among raft nodes before linearized reading' (duration: 110.212849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:46.61461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.669015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-12T03:16:46.614641Z","caller":"traceutil/trace.go:171","msg":"trace[889088581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5047; }","duration":"110.709155ms","start":"2026-06-12T03:16:46.503924Z","end":"2026-06-12T03:16:46.614633Z","steps":["trace[889088581] 'agreement among raft nodes before linearized reading' (duration: 110.626704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:46.614743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.165907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-12T03:16:46.614767Z","caller":"traceutil/trace.go:171","msg":"trace[72857999] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5047; }","duration":"114.200538ms","start":"2026-06-12T03:16:46.500559Z","end":"2026-06-12T03:16:46.61476Z","steps":["trace[72857999] 'agreement among raft nodes before linearized reading' (duration: 113.751082ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:52.192074Z","caller":"traceutil/trace.go:171","msg":"trace[2015793924] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"213.075416ms","start":"2026-06-12T03:16:51.978969Z","end":"2026-06-12T03:16:52.192044Z","steps":["trace[2015793924] 'process raft request' (duration: 212.355608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:57.824932Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745305388189652,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-12T03:16:58.315201Z","caller":"traceutil/trace.go:171","msg":"trace[368656179] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"991.328126ms","start":"2026-06-12T03:16:57.323836Z","end":"2026-06-12T03:16:58.315164Z","steps":["trace[368656179] 'process raft request' (duration: 988.173518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.31539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:57.3238Z","time spent":"991.48692ms","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:16:58.330908Z","caller":"traceutil/trace.go:171","msg":"trace[1226669731] transaction","detail":"{read_only:false; response_revision:5184; number_of_response:1; }","duration":"954.323592ms","start":"2026-06-12T03:16:57.376503Z","end":"2026-06-12T03:16:58.330827Z","steps":["trace[1226669731] 'process raft request' (duration: 954.107008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.331092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:57.376473Z","time spent":"954.529294ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:16:58.331135Z","caller":"traceutil/trace.go:171","msg":"trace[625710923] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"832.838357ms","start":"2026-06-12T03:16:57.498242Z","end":"2026-06-12T03:16:58.331081Z","steps":["trace[625710923] 'process raft request' (duration: 832.496754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.331274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:57.498208Z","time spent":"832.98724ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:16:58.331361Z","caller":"traceutil/trace.go:171","msg":"trace[1026495791] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"430.672015ms","start":"2026-06-12T03:16:57.900684Z","end":"2026-06-12T03:16:58.331356Z","steps":["trace[1026495791] 'process raft request' (duration: 430.078328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.331392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:57.900658Z","time spent":"430.712425ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:16:58.331559Z","caller":"traceutil/trace.go:171","msg":"trace[1826030457] linearizableReadLoop","detail":"{readStateIndex:5378; appliedIndex:5375; }","duration":"1.006678872s","start":"2026-06-12T03:16:57.324326Z","end":"2026-06-12T03:16:58.331005Z","steps":["trace[1826030457] 'read index received' (duration: 987.570991ms)","trace[1826030457] 'applied index is now lower than readState.Index' (duration: 19.107151ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:16:58.331635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.856822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:16:58.331654Z","caller":"traceutil/trace.go:171","msg":"trace[1098887157] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:5186; }","duration":"873.920453ms","start":"2026-06-12T03:16:57.457728Z","end":"2026-06-12T03:16:58.331648Z","steps":["trace[1098887157] 'agreement among raft nodes before linearized reading' (duration: 873.880422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.331675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:57.457693Z","time spent":"873.973623ms","remote":"127.0.0.1:39306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:16:58.331793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.897858ms","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-06-12T03:16:58.331815Z","caller":"traceutil/trace.go:171","msg":"trace[278266172] 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:5186; }","duration":"279.919619ms","start":"2026-06-12T03:16:58.051887Z","end":"2026-06-12T03:16:58.331806Z","steps":["trace[278266172] 'agreement among raft nodes before linearized reading' (duration: 279.880638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.33198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.711126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-12T03:16:58.331999Z","caller":"traceutil/trace.go:171","msg":"trace[749780349] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:5186; }","duration":"783.780586ms","start":"2026-06-12T03:16:57.548212Z","end":"2026-06-12T03:16:58.331993Z","steps":["trace[749780349] 'agreement among raft nodes before linearized reading' (duration: 783.698505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.332061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:57.548186Z","time spent":"783.825557ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"warn","ts":"2026-06-12T03:16:58.332303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007975547s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c65857d2-ceb5-46df-8eff-0b51e3fb2288\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-06-12T03:16:58.332336Z","caller":"traceutil/trace.go:171","msg":"trace[221801610] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c65857d2-ceb5-46df-8eff-0b51e3fb2288; range_end:; response_count:1; response_revision:5186; }","duration":"1.008036958s","start":"2026-06-12T03:16:57.324289Z","end":"2026-06-12T03:16:58.332326Z","steps":["trace[221801610] 'agreement among raft nodes before linearized reading' (duration: 1.007303618s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.332355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:57.324279Z","time spent":"1.008072038s","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1457,"request content":"key:\"/registry/persistentvolumes/pvc-c65857d2-ceb5-46df-8eff-0b51e3fb2288\" "} {"level":"warn","ts":"2026-06-12T03:16:58.685713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.942885ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-06-12T03:16:58.685809Z","caller":"traceutil/trace.go:171","msg":"trace[1843867874] linearizableReadLoop","detail":"{readStateIndex:5380; appliedIndex:5379; }","duration":"350.326446ms","start":"2026-06-12T03:16:58.335467Z","end":"2026-06-12T03:16:58.685794Z","steps":["trace[1843867874] 'read index received' (duration: 48.331081ms)","trace[1843867874] 'applied index is now lower than readState.Index' (duration: 301.993905ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:16:58.685837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.334324Z","time spent":"351.50443ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-12T03:16:58.686137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.65511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-12T03:16:58.686171Z","caller":"traceutil/trace.go:171","msg":"trace[610945146] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5186; }","duration":"350.747441ms","start":"2026-06-12T03:16:58.335413Z","end":"2026-06-12T03:16:58.686161Z","steps":["trace[610945146] 'agreement among raft nodes before linearized reading' (duration: 350.543769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.686228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.335391Z","time spent":"350.827502ms","remote":"127.0.0.1:39054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-12T03:16:58.757177Z","caller":"traceutil/trace.go:171","msg":"trace[335377730] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"412.194891ms","start":"2026-06-12T03:16:58.34495Z","end":"2026-06-12T03:16:58.757144Z","steps":["trace[335377730] 'process raft request' (duration: 411.960478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:58.757367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.344935Z","time spent":"412.329732ms","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17108,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:16:59.038729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.906618ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:16:59.038973Z","caller":"traceutil/trace.go:171","msg":"trace[557298916] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"385.359448ms","start":"2026-06-12T03:16:58.653591Z","end":"2026-06-12T03:16:59.03895Z","steps":["trace[557298916] 'process raft request' (duration: 228.136826ms)","trace[557298916] 'compare' (duration: 156.787827ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:16:59.03905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.653546Z","time spent":"385.468349ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:16:59.039292Z","caller":"traceutil/trace.go:171","msg":"trace[345362989] linearizableReadLoop","detail":"{readStateIndex:5382; appliedIndex:5380; }","duration":"353.374814ms","start":"2026-06-12T03:16:58.685899Z","end":"2026-06-12T03:16:59.039274Z","steps":["trace[345362989] 'read index received' (duration: 70.978805ms)","trace[345362989] 'applied index is now lower than readState.Index' (duration: 282.393579ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:16:59.039257Z","caller":"traceutil/trace.go:171","msg":"trace[1449486101] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"351.49736ms","start":"2026-06-12T03:16:58.687718Z","end":"2026-06-12T03:16:59.039215Z","steps":["trace[1449486101] 'process raft request' (duration: 351.173995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.039468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.663593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:16:59.039481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.687687Z","time spent":"351.670543ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:16:59.039508Z","caller":"traceutil/trace.go:171","msg":"trace[247980276] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:5190; }","duration":"646.753094ms","start":"2026-06-12T03:16:58.392742Z","end":"2026-06-12T03:16:59.039495Z","steps":["trace[247980276] 'agreement among raft nodes before linearized reading' (duration: 646.637513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.039542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.392717Z","time spent":"646.818125ms","remote":"127.0.0.1:44438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"warn","ts":"2026-06-12T03:16:59.039657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.609771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-12T03:16:59.03945Z","caller":"traceutil/trace.go:171","msg":"trace[1576492561] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"231.511867ms","start":"2026-06-12T03:16:58.807901Z","end":"2026-06-12T03:16:59.039413Z","steps":["trace[1576492561] 'process raft request' (duration: 231.333775ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:59.039768Z","caller":"traceutil/trace.go:171","msg":"trace[1850733232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5190; }","duration":"361.789364ms","start":"2026-06-12T03:16:58.677956Z","end":"2026-06-12T03:16:59.039746Z","steps":["trace[1850733232] 'agreement among raft nodes before linearized reading' (duration: 361.39325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.039758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.039171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-12T03:16:59.039828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.677927Z","time spent":"361.890425ms","remote":"127.0.0.1:39176","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-06-12T03:16:59.039836Z","caller":"traceutil/trace.go:171","msg":"trace[1399490692] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5190; }","duration":"354.168193ms","start":"2026-06-12T03:16:58.68565Z","end":"2026-06-12T03:16:59.039818Z","steps":["trace[1399490692] 'agreement among raft nodes before linearized reading' (duration: 354.007181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.039843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.656228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:16:59.039896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.685625Z","time spent":"354.252183ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-12T03:16:59.039978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.455658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T03:16:59.040022Z","caller":"traceutil/trace.go:171","msg":"trace[1103263501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5190; }","duration":"350.523458ms","start":"2026-06-12T03:16:58.689488Z","end":"2026-06-12T03:16:59.040012Z","steps":["trace[1103263501] 'agreement among raft nodes before linearized reading' (duration: 350.373066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.040022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.110646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-12T03:16:59.040061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.689476Z","time spent":"350.578128ms","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-12T03:16:59.039761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.057208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-12T03:16:59.040082Z","caller":"traceutil/trace.go:171","msg":"trace[786635765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5190; }","duration":"351.202037ms","start":"2026-06-12T03:16:58.688868Z","end":"2026-06-12T03:16:59.04007Z","steps":["trace[786635765] 'agreement among raft nodes before linearized reading' (duration: 351.065425ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:59.039908Z","caller":"traceutil/trace.go:171","msg":"trace[67250627] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:5190; }","duration":"285.787579ms","start":"2026-06-12T03:16:58.754102Z","end":"2026-06-12T03:16:59.039889Z","steps":["trace[67250627] 'agreement among raft nodes before linearized reading' (duration: 285.696118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.040122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.68886Z","time spent":"351.252147ms","remote":"127.0.0.1:39176","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":"info","ts":"2026-06-12T03:16:59.040117Z","caller":"traceutil/trace.go:171","msg":"trace[1330565012] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5190; }","duration":"352.481682ms","start":"2026-06-12T03:16:58.68762Z","end":"2026-06-12T03:16:59.040102Z","steps":["trace[1330565012] 'agreement among raft nodes before linearized reading' (duration: 351.944986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.040178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.687594Z","time spent":"352.570334ms","remote":"127.0.0.1:39176","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-06-12T03:16:59.040268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.67249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-232bf23e-f2c2-4328-b131-79ad26101eab\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-12T03:16:59.040327Z","caller":"traceutil/trace.go:171","msg":"trace[297541925] range","detail":"{range_begin:/registry/persistentvolumes/pvc-232bf23e-f2c2-4328-b131-79ad26101eab; range_end:; response_count:1; response_revision:5190; }","duration":"350.75021ms","start":"2026-06-12T03:16:58.689561Z","end":"2026-06-12T03:16:59.040311Z","steps":["trace[297541925] 'agreement among raft nodes before linearized reading' (duration: 350.555038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.040368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:16:58.689547Z","time spent":"350.813391ms","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1344,"request content":"key:\"/registry/persistentvolumes/pvc-232bf23e-f2c2-4328-b131-79ad26101eab\" "} {"level":"info","ts":"2026-06-12T03:16:59.237818Z","caller":"traceutil/trace.go:171","msg":"trace[304031879] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"191.947928ms","start":"2026-06-12T03:16:59.045816Z","end":"2026-06-12T03:16:59.237763Z","steps":["trace[304031879] 'process raft request' (duration: 191.587904ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:59.237535Z","caller":"traceutil/trace.go:171","msg":"trace[1887123310] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"191.510573ms","start":"2026-06-12T03:16:59.045801Z","end":"2026-06-12T03:16:59.237312Z","steps":["trace[1887123310] 'process raft request' (duration: 112.487623ms)","trace[1887123310] 'compare' (duration: 78.604495ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:16:59.237971Z","caller":"traceutil/trace.go:171","msg":"trace[156694683] transaction","detail":"{read_only:false; response_revision:5194; number_of_response:1; }","duration":"192.01969ms","start":"2026-06-12T03:16:59.045927Z","end":"2026-06-12T03:16:59.237947Z","steps":["trace[156694683] 'process raft request' (duration: 191.565994ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:59.237996Z","caller":"traceutil/trace.go:171","msg":"trace[702276277] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"191.95787ms","start":"2026-06-12T03:16:59.046017Z","end":"2026-06-12T03:16:59.237975Z","steps":["trace[702276277] 'process raft request' (duration: 191.756806ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:16:59.237873Z","caller":"traceutil/trace.go:171","msg":"trace[1455037486] linearizableReadLoop","detail":"{readStateIndex:5389; appliedIndex:5385; }","duration":"162.17284ms","start":"2026-06-12T03:16:59.075666Z","end":"2026-06-12T03:16:59.237839Z","steps":["trace[1455037486] 'read index received' (duration: 82.615364ms)","trace[1455037486] 'applied index is now lower than readState.Index' (duration: 79.555986ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:16:59.238343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.777996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T03:16:59.238414Z","caller":"traceutil/trace.go:171","msg":"trace[981718740] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:5195; }","duration":"191.896238ms","start":"2026-06-12T03:16:59.046494Z","end":"2026-06-12T03:16:59.23839Z","steps":["trace[981718740] 'agreement among raft nodes before linearized reading' (duration: 191.724106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.24024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.785888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-12T03:16:59.240333Z","caller":"traceutil/trace.go:171","msg":"trace[2094874601] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5195; }","duration":"162.921809ms","start":"2026-06-12T03:16:59.0774Z","end":"2026-06-12T03:16:59.240321Z","steps":["trace[2094874601] 'agreement among raft nodes before linearized reading' (duration: 162.489994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:16:59.537689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.382392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-12T03:16:59.537843Z","caller":"traceutil/trace.go:171","msg":"trace[904952494] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5195; }","duration":"186.578915ms","start":"2026-06-12T03:16:59.351207Z","end":"2026-06-12T03:16:59.537786Z","steps":["trace[904952494] 'range keys from in-memory index tree' (duration: 186.138778ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:17:14.534279Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2800} {"level":"info","ts":"2026-06-12T03:17:14.619852Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2800,"took":"83.345403ms","hash":2825443454,"current-db-size-bytes":52228096,"current-db-size":"52 MB","current-db-size-in-use-bytes":27463680,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-12T03:17:14.619962Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2825443454,"revision":2800,"compact-revision":-1} {"level":"warn","ts":"2026-06-12T03:17:44.710201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.82289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:17:44.710363Z","caller":"traceutil/trace.go:171","msg":"trace[1947347286] transaction","detail":"{read_only:false; response_revision:5560; number_of_response:1; }","duration":"158.345591ms","start":"2026-06-12T03:17:44.551991Z","end":"2026-06-12T03:17:44.710337Z","steps":["trace[1947347286] 'process raft request' (duration: 45.226899ms)","trace[1947347286] 'compare' (duration: 112.633867ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:17:53.78396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.322808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:17:53.784151Z","caller":"traceutil/trace.go:171","msg":"trace[721436152] transaction","detail":"{read_only:false; response_revision:5634; number_of_response:1; }","duration":"165.803179ms","start":"2026-06-12T03:17:53.618328Z","end":"2026-06-12T03:17:53.784132Z","steps":["trace[721436152] 'process raft request' (duration: 165.744659ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:17:53.784367Z","caller":"traceutil/trace.go:171","msg":"trace[294008393] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"167.414558ms","start":"2026-06-12T03:17:53.616908Z","end":"2026-06-12T03:17:53.784323Z","steps":["trace[294008393] 'process raft request' (duration: 65.619914ms)","trace[294008393] 'compare' (duration: 101.197467ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:17:56.875704Z","caller":"traceutil/trace.go:171","msg":"trace[1846950378] transaction","detail":"{read_only:false; response_revision:5651; number_of_response:1; }","duration":"128.765426ms","start":"2026-06-12T03:17:56.746903Z","end":"2026-06-12T03:17:56.875669Z","steps":["trace[1846950378] 'process raft request' (duration: 128.551664ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:17:56.887194Z","caller":"traceutil/trace.go:171","msg":"trace[969435699] linearizableReadLoop","detail":"{readStateIndex:5860; appliedIndex:5858; }","duration":"129.09984ms","start":"2026-06-12T03:17:56.758058Z","end":"2026-06-12T03:17:56.887158Z","steps":["trace[969435699] 'read index received' (duration: 117.398574ms)","trace[969435699] 'applied index is now lower than readState.Index' (duration: 11.700246ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:17:56.887357Z","caller":"traceutil/trace.go:171","msg":"trace[1788835176] transaction","detail":"{read_only:false; response_revision:5652; number_of_response:1; }","duration":"132.767873ms","start":"2026-06-12T03:17:56.754558Z","end":"2026-06-12T03:17:56.887326Z","steps":["trace[1788835176] 'process raft request' (duration: 132.44508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:17:56.887593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.348112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-12T03:17:56.887644Z","caller":"traceutil/trace.go:171","msg":"trace[1929382309] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5652; }","duration":"129.626396ms","start":"2026-06-12T03:17:56.758005Z","end":"2026-06-12T03:17:56.887632Z","steps":["trace[1929382309] 'agreement among raft nodes before linearized reading' (duration: 129.275432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:20:43.149806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.048976ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-12T03:22:14.540101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5285} {"level":"info","ts":"2026-06-12T03:22:14.673386Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5285,"took":"131.486566ms","hash":3191229372,"current-db-size-bytes":52228096,"current-db-size":"52 MB","current-db-size-in-use-bytes":18702336,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-06-12T03:22:14.673467Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3191229372,"revision":5285,"compact-revision":2800}