{"level":"warn","ts":"2026-05-05T17:28:43.573956Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T17:28:43.57405Z","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-05-05T17:28:43.574207Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T17:28:43.574221Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-05-05T17:28:43.574238Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-05T17:28:43.574864Z","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-05-05T17:28:43.574948Z","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-05-05T17:28:43.579261Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.106082ms"} {"level":"info","ts":"2026-05-05T17:28:43.585349Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-05-05T17:28:43.58545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T17:28:43.585481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-05-05T17:28:43.585508Z","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-05-05T17:28:43.585519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-05-05T17:28:43.585578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-05-05T17:28:43.591994Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T17:28:43.593544Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T17:28:43.596024Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-05T17:28:43.598364Z","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-05-05T17:28:43.598895Z","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-05-05T17:28:43.59904Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T17:28:43.599308Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T17:28:43.599336Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T17:28:43.601489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-05-05T17:28:43.601877Z","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-05-05T17:28:43.603683Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-05T17:28:43.603895Z","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-05-05T17:28:43.603933Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T17:28:43.604515Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-05-05T17:28:43.604535Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-05-05T17:28:43.986755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T17:28:43.986847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T17:28:43.986868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-05-05T17:28:43.986883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-05-05T17:28:43.98689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-05-05T17:28:43.986902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-05-05T17:28:43.986915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-05-05T17:28:43.987701Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T17:28:43.989994Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T17:28:43.989983Z","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-05-05T17:28:43.990057Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T17:28:43.990336Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T17:28:43.990378Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T17:28:43.991394Z","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-05-05T17:28:43.991558Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T17:28:43.991602Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T17:28:43.991964Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T17:28:43.992813Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"warn","ts":"2026-05-05T17:28:46.827303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.661287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-05T17:28:46.827435Z","caller":"traceutil/trace.go:171","msg":"trace[333604966] transaction","detail":"{read_only:false; response_revision:110; number_of_response:1; }","duration":"237.115766ms","start":"2026-05-05T17:28:46.5903Z","end":"2026-05-05T17:28:46.827415Z","steps":["trace[333604966] 'process raft request' (duration: 110.804641ms)","trace[333604966] 'compare' (duration: 125.505087ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:28:53.577206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.440101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-05T17:28:53.57729Z","caller":"traceutil/trace.go:171","msg":"trace[756406558] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:299; }","duration":"140.606409ms","start":"2026-05-05T17:28:53.436665Z","end":"2026-05-05T17:28:53.577272Z","steps":["trace[756406558] 'range keys from in-memory index tree' (duration: 140.325178ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:28:54.990088Z","caller":"traceutil/trace.go:171","msg":"trace[1203605910] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"144.129361ms","start":"2026-05-05T17:28:54.845939Z","end":"2026-05-05T17:28:54.990068Z","steps":["trace[1203605910] 'process raft request' (duration: 144.004677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:28:55.208582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.395016ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:28:55.20907Z","caller":"traceutil/trace.go:171","msg":"trace[625984353] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"130.649412ms","start":"2026-05-05T17:28:55.078347Z","end":"2026-05-05T17:28:55.208996Z","steps":["trace[625984353] 'process raft request' (duration: 20.770246ms)","trace[625984353] 'compare' (duration: 109.24247ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:28:55.20913Z","caller":"traceutil/trace.go:171","msg":"trace[1677166035] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"129.368388ms","start":"2026-05-05T17:28:55.079727Z","end":"2026-05-05T17:28:55.209095Z","steps":["trace[1677166035] 'process raft request' (duration: 129.00429ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:28:55.209279Z","caller":"traceutil/trace.go:171","msg":"trace[812343886] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"129.169887ms","start":"2026-05-05T17:28:55.079674Z","end":"2026-05-05T17:28:55.208844Z","steps":["trace[812343886] 'process raft request' (duration: 129.013561ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:28:55.209618Z","caller":"traceutil/trace.go:171","msg":"trace[1143516969] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"126.675326ms","start":"2026-05-05T17:28:55.08273Z","end":"2026-05-05T17:28:55.209405Z","steps":["trace[1143516969] 'process raft request' (duration: 126.097006ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:28:55.399724Z","caller":"traceutil/trace.go:171","msg":"trace[1321107194] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"110.428104ms","start":"2026-05-05T17:28:55.289274Z","end":"2026-05-05T17:28:55.399702Z","steps":["trace[1321107194] 'process raft request' (duration: 69.487736ms)","trace[1321107194] 'compare' (duration: 40.86216ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:28:55.715655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.318285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:28:55.715881Z","caller":"traceutil/trace.go:171","msg":"trace[1871503249] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:363; }","duration":"117.393104ms","start":"2026-05-05T17:28:55.598448Z","end":"2026-05-05T17:28:55.715841Z","steps":["trace[1871503249] 'read index received' (duration: 38.924µs)","trace[1871503249] 'applied index is now lower than readState.Index' (duration: 117.261441ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:28:55.716Z","caller":"traceutil/trace.go:171","msg":"trace[1690813614] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"173.270615ms","start":"2026-05-05T17:28:55.542688Z","end":"2026-05-05T17:28:55.715959Z","steps":["trace[1690813614] 'process raft request' (duration: 49.27033ms)","trace[1690813614] 'compare' (duration: 122.898969ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:28:55.716906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.437803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T17:28:55.717021Z","caller":"traceutil/trace.go:171","msg":"trace[1906781342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:352; }","duration":"118.586458ms","start":"2026-05-05T17:28:55.598399Z","end":"2026-05-05T17:28:55.716985Z","steps":["trace[1906781342] 'agreement among raft nodes before linearized reading' (duration: 117.83458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:28:55.786855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.06134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:28:55.786935Z","caller":"traceutil/trace.go:171","msg":"trace[786016039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:353; }","duration":"187.187533ms","start":"2026-05-05T17:28:55.599729Z","end":"2026-05-05T17:28:55.786916Z","steps":["trace[786016039] 'agreement among raft nodes before linearized reading' (duration: 187.045618ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:28:55.787024Z","caller":"traceutil/trace.go:171","msg":"trace[1901471905] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"145.667754ms","start":"2026-05-05T17:28:55.64133Z","end":"2026-05-05T17:28:55.786997Z","steps":["trace[1901471905] 'process raft request' (duration: 145.279624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:28:55.787103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.187843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-05T17:28:55.787199Z","caller":"traceutil/trace.go:171","msg":"trace[1280422023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:353; }","duration":"187.365382ms","start":"2026-05-05T17:28:55.599817Z","end":"2026-05-05T17:28:55.787183Z","steps":["trace[1280422023] 'agreement among raft nodes before linearized reading' (duration: 187.178962ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:28:55.873824Z","caller":"traceutil/trace.go:171","msg":"trace[85432833] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"150.720824ms","start":"2026-05-05T17:28:55.723077Z","end":"2026-05-05T17:28:55.873798Z","steps":["trace[85432833] 'process raft request' (duration: 119.922409ms)","trace[85432833] 'compare' (duration: 30.615486ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:29:15.857883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.155231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:29:15.858276Z","caller":"traceutil/trace.go:171","msg":"trace[1855585183] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"639.428951ms","start":"2026-05-05T17:29:15.218831Z","end":"2026-05-05T17:29:15.858259Z","steps":["trace[1855585183] 'process raft request' (duration: 639.199647ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:15.858633Z","caller":"traceutil/trace.go:171","msg":"trace[1419690983] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"633.900914ms","start":"2026-05-05T17:29:15.224684Z","end":"2026-05-05T17:29:15.858585Z","steps":["trace[1419690983] 'process raft request' (duration: 633.528991ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:15.858849Z","caller":"traceutil/trace.go:171","msg":"trace[631792410] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"697.125585ms","start":"2026-05-05T17:29:15.161477Z","end":"2026-05-05T17:29:15.858602Z","steps":["trace[631792410] 'process raft request' (duration: 354.030674ms)","trace[631792410] 'compare' (duration: 341.65148ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:29:15.85896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:15.224655Z","time spent":"634.185192ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T17:29:15.859067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:15.161447Z","time spent":"697.492118ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:29:15.85836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:15.218797Z","time spent":"639.525537ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:29:16.251879Z","caller":"traceutil/trace.go:171","msg":"trace[836309206] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"116.500549ms","start":"2026-05-05T17:29:16.135312Z","end":"2026-05-05T17:29:16.251812Z","steps":["trace[836309206] 'read index received' (duration: 44.051566ms)","trace[836309206] 'applied index is now lower than readState.Index' (duration: 72.447973ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:29:16.252132Z","caller":"traceutil/trace.go:171","msg":"trace[588529290] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"203.457647ms","start":"2026-05-05T17:29:16.04866Z","end":"2026-05-05T17:29:16.252118Z","steps":["trace[588529290] 'process raft request' (duration: 130.868726ms)","trace[588529290] 'compare' (duration: 71.647644ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:29:16.252287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.962396ms","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-05-05T17:29:16.252309Z","caller":"traceutil/trace.go:171","msg":"trace[1796867076] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:543; }","duration":"117.03183ms","start":"2026-05-05T17:29:16.13527Z","end":"2026-05-05T17:29:16.252302Z","steps":["trace[1796867076] 'agreement among raft nodes before linearized reading' (duration: 116.962256ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:16.847702Z","caller":"traceutil/trace.go:171","msg":"trace[935713461] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"104.885788ms","start":"2026-05-05T17:29:16.742786Z","end":"2026-05-05T17:29:16.847672Z","steps":["trace[935713461] 'process raft request' (duration: 104.193816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:17.823188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.900151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:17.823289Z","caller":"traceutil/trace.go:171","msg":"trace[1831885981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"136.050659ms","start":"2026-05-05T17:29:17.687219Z","end":"2026-05-05T17:29:17.82327Z","steps":["trace[1831885981] 'range keys from in-memory index tree' (duration: 135.822596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:17.823891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.547681ms","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-05-05T17:29:17.82405Z","caller":"traceutil/trace.go:171","msg":"trace[197576127] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:556; }","duration":"443.801976ms","start":"2026-05-05T17:29:17.380226Z","end":"2026-05-05T17:29:17.824028Z","steps":["trace[197576127] 'range keys from in-memory index tree' (duration: 442.793436ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:17.824096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:17.380205Z","time spent":"443.88188ms","remote":"127.0.0.1:58604","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-05-05T17:29:17.824216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.51247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-05-05T17:29:17.824263Z","caller":"traceutil/trace.go:171","msg":"trace[1492809217] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:556; }","duration":"795.602345ms","start":"2026-05-05T17:29:17.028647Z","end":"2026-05-05T17:29:17.824249Z","steps":["trace[1492809217] 'range keys from in-memory index tree' (duration: 795.155449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:17.824296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:17.028626Z","time spent":"795.660859ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":570127,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-05-05T17:29:22.62288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:22.298474Z","time spent":"324.369441ms","remote":"127.0.0.1:44510","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-05T17:29:22.704019Z","caller":"traceutil/trace.go:171","msg":"trace[155808366] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"483.483118ms","start":"2026-05-05T17:29:22.220496Z","end":"2026-05-05T17:29:22.70398Z","steps":["trace[155808366] 'process raft request' (duration: 483.246716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:22.704467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:22.220458Z","time spent":"483.90184ms","remote":"127.0.0.1:58764","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-05-05T17:29:23.092663Z","caller":"traceutil/trace.go:171","msg":"trace[201822599] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"796.081528ms","start":"2026-05-05T17:29:22.296524Z","end":"2026-05-05T17:29:23.092606Z","steps":["trace[201822599] 'process raft request' (duration: 795.328399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:23.092911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:22.296481Z","time spent":"796.295268ms","remote":"127.0.0.1:58660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:29:24.684058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00028784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-05T17:29:24.684133Z","caller":"traceutil/trace.go:171","msg":"trace[166492444] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000435618s","start":"2026-05-05T17:29:22.683681Z","end":"2026-05-05T17:29:24.684117Z","steps":["trace[166492444] 'agreement among raft nodes before linearized reading' (duration: 2.000337353s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.684177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:22.683661Z","time spent":"2.000507371s","remote":"127.0.0.1:58576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/05 17:29:24 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-05T17:29:24.756497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.663934667s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-05T17:29:24.756568Z","caller":"traceutil/trace.go:171","msg":"trace[2044182934] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"2.437977622s","start":"2026-05-05T17:29:22.318578Z","end":"2026-05-05T17:29:24.756555Z","steps":["trace[2044182934] 'read index received' (duration: 385.8201ms)","trace[2044182934] 'applied index is now lower than readState.Index' (duration: 2.052156342s)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:29:24.756712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.438131939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-05T17:29:24.756744Z","caller":"traceutil/trace.go:171","msg":"trace[1319345274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"2.438211884s","start":"2026-05-05T17:29:22.318525Z","end":"2026-05-05T17:29:24.756737Z","steps":["trace[1319345274] 'agreement among raft nodes before linearized reading' (duration: 2.438101518s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.756769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:22.318505Z","time spent":"2.438258126s","remote":"127.0.0.1:58830","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-05-05T17:29:24.834961Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.675015224s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:29:24.835414Z","caller":"traceutil/trace.go:171","msg":"trace[400073922] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.675623725s","start":"2026-05-05T17:29:23.159768Z","end":"2026-05-05T17:29:24.835391Z","steps":["trace[400073922] 'process raft request' (duration: 1.675422855s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.835558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:23.159728Z","time spent":"1.675778062s","remote":"127.0.0.1:58914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T17:29:24.893053Z","caller":"traceutil/trace.go:171","msg":"trace[1753257546] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"136.402451ms","start":"2026-05-05T17:29:24.756631Z","end":"2026-05-05T17:29:24.893033Z","steps":["trace[1753257546] 'read index received' (duration: 78.60619ms)","trace[1753257546] 'applied index is now lower than readState.Index' (duration: 57.795491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:29:24.893164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.545294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.893237Z","caller":"traceutil/trace.go:171","msg":"trace[595778067] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:587; }","duration":"417.65947ms","start":"2026-05-05T17:29:24.475558Z","end":"2026-05-05T17:29:24.893218Z","steps":["trace[595778067] 'agreement among raft nodes before linearized reading' (duration: 417.493562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.893292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.475548Z","time spent":"417.733223ms","remote":"127.0.0.1:43372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:29:24.893336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.085083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.893384Z","caller":"traceutil/trace.go:171","msg":"trace[1519866894] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"430.142836ms","start":"2026-05-05T17:29:24.463232Z","end":"2026-05-05T17:29:24.893375Z","steps":["trace[1519866894] 'agreement among raft nodes before linearized reading' (duration: 430.066932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.893434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.463227Z","time spent":"430.197838ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:29:24.893427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.949001ms","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-05-05T17:29:24.893502Z","caller":"traceutil/trace.go:171","msg":"trace[820013774] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"777.105829ms","start":"2026-05-05T17:29:24.116383Z","end":"2026-05-05T17:29:24.893489Z","steps":["trace[820013774] 'agreement among raft nodes before linearized reading' (duration: 776.962641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.893577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.116358Z","time spent":"777.203293ms","remote":"127.0.0.1:43328","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":"info","ts":"2026-05-05T17:29:24.89359Z","caller":"traceutil/trace.go:171","msg":"trace[856493893] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"206.646234ms","start":"2026-05-05T17:29:24.686923Z","end":"2026-05-05T17:29:24.89357Z","steps":["trace[856493893] 'process raft request' (duration: 186.455827ms)","trace[856493893] 'compare' (duration: 19.450309ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:29:24.893774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.377294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.893806Z","caller":"traceutil/trace.go:171","msg":"trace[1422900347] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"609.441478ms","start":"2026-05-05T17:29:24.284357Z","end":"2026-05-05T17:29:24.893799Z","steps":["trace[1422900347] 'agreement among raft nodes before linearized reading' (duration: 609.385465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.893827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.284345Z","time spent":"609.476109ms","remote":"127.0.0.1:43342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:29:24.893877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.523103ms","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":"warn","ts":"2026-05-05T17:29:24.893943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.99207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.893999Z","caller":"traceutil/trace.go:171","msg":"trace[221410643] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:587; }","duration":"842.056923ms","start":"2026-05-05T17:29:24.051923Z","end":"2026-05-05T17:29:24.89398Z","steps":["trace[221410643] 'agreement among raft nodes before linearized reading' (duration: 841.98249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.894015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.167348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.051914Z","time spent":"842.123567ms","remote":"127.0.0.1:43312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-05-05T17:29:24.894059Z","caller":"traceutil/trace.go:171","msg":"trace[1317001670] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:587; }","duration":"250.247382ms","start":"2026-05-05T17:29:24.643797Z","end":"2026-05-05T17:29:24.894045Z","steps":["trace[1317001670] 'agreement among raft nodes before linearized reading' (duration: 250.178778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.894132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.055904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.302051ms","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":"warn","ts":"2026-05-05T17:29:24.894256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.78996ms","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-05-05T17:29:24.8943Z","caller":"traceutil/trace.go:171","msg":"trace[114459184] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"484.355263ms","start":"2026-05-05T17:29:24.409937Z","end":"2026-05-05T17:29:24.894293Z","steps":["trace[114459184] 'agreement among raft nodes before linearized reading' (duration: 484.315691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.8943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.093943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.89432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.409916Z","time spent":"484.398965ms","remote":"127.0.0.1:43348","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":"info","ts":"2026-05-05T17:29:24.894336Z","caller":"traceutil/trace.go:171","msg":"trace[1222005246] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"740.866314ms","start":"2026-05-05T17:29:24.153437Z","end":"2026-05-05T17:29:24.894303Z","steps":["trace[1222005246] 'agreement among raft nodes before linearized reading' (duration: 740.79897ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.89434Z","caller":"traceutil/trace.go:171","msg":"trace[368814422] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"340.167187ms","start":"2026-05-05T17:29:24.55416Z","end":"2026-05-05T17:29:24.894327Z","steps":["trace[368814422] 'agreement among raft nodes before linearized reading' (duration: 340.115174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.894372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.15343Z","time spent":"740.931468ms","remote":"127.0.0.1:43334","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-05-05T17:29:24.89442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.223749ms","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-05-05T17:29:24.89446Z","caller":"traceutil/trace.go:171","msg":"trace[652395629] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"340.298793ms","start":"2026-05-05T17:29:24.554154Z","end":"2026-05-05T17:29:24.894453Z","steps":["trace[652395629] 'agreement among raft nodes before linearized reading' (duration: 340.243651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.894497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.554135Z","time spent":"340.350446ms","remote":"127.0.0.1:43384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:29:24.894544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.604752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.894585Z","caller":"traceutil/trace.go:171","msg":"trace[518184944] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:587; }","duration":"843.691186ms","start":"2026-05-05T17:29:24.050881Z","end":"2026-05-05T17:29:24.894573Z","steps":["trace[518184944] 'agreement among raft nodes before linearized reading' (duration: 843.641134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.894654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.050855Z","time spent":"843.758799ms","remote":"127.0.0.1:43312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:29:24.893852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.9776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.668418ms","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-05-05T17:29:24.894732Z","caller":"traceutil/trace.go:171","msg":"trace[1077588929] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"369.732832ms","start":"2026-05-05T17:29:24.524987Z","end":"2026-05-05T17:29:24.89472Z","steps":["trace[1077588929] 'agreement among raft nodes before linearized reading' (duration: 369.661408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.894778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.524983Z","time spent":"369.783854ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T17:29:24.894872Z","caller":"traceutil/trace.go:171","msg":"trace[1111379395] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"230.032654ms","start":"2026-05-05T17:29:24.66483Z","end":"2026-05-05T17:29:24.894863Z","steps":["trace[1111379395] 'agreement among raft nodes before linearized reading' (duration: 228.974611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.894943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.963443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.89498Z","caller":"traceutil/trace.go:171","msg":"trace[840612812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"370.037367ms","start":"2026-05-05T17:29:24.524933Z","end":"2026-05-05T17:29:24.89497Z","steps":["trace[840612812] 'agreement among raft nodes before linearized reading' (duration: 369.984184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.895016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.52491Z","time spent":"370.09635ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:29:24.895141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.288482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.895174Z","caller":"traceutil/trace.go:171","msg":"trace[503922762] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:587; }","duration":"419.334354ms","start":"2026-05-05T17:29:24.475831Z","end":"2026-05-05T17:29:24.895165Z","steps":["trace[503922762] 'agreement among raft nodes before linearized reading' (duration: 419.288082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.895202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.475824Z","time spent":"419.369856ms","remote":"127.0.0.1:43372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:29:24.893243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.701342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.895335Z","caller":"traceutil/trace.go:171","msg":"trace[1649902420] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:587; }","duration":"419.870731ms","start":"2026-05-05T17:29:24.475454Z","end":"2026-05-05T17:29:24.895325Z","steps":["trace[1649902420] 'agreement among raft nodes before linearized reading' (duration: 417.691271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.895374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.475445Z","time spent":"419.919144ms","remote":"127.0.0.1:43372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:29:24.895128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.866774ms","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-05-05T17:29:24.895582Z","caller":"traceutil/trace.go:171","msg":"trace[835932048] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"742.391462ms","start":"2026-05-05T17:29:24.153178Z","end":"2026-05-05T17:29:24.89557Z","steps":["trace[835932048] 'agreement among raft nodes before linearized reading' (duration: 741.430902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.894496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.457025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.895662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.568464881s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:29:24.895935Z","caller":"traceutil/trace.go:171","msg":"trace[1386010662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"2.568772017s","start":"2026-05-05T17:29:22.327154Z","end":"2026-05-05T17:29:24.895926Z","steps":["trace[1386010662] 'agreement among raft nodes before linearized reading' (duration: 2.568479742s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.895991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:22.327132Z","time spent":"2.568850841s","remote":"127.0.0.1:58830","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-05-05T17:29:24.896146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.998538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.896196Z","caller":"traceutil/trace.go:171","msg":"trace[584206512] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:587; }","duration":"872.079811ms","start":"2026-05-05T17:29:24.024108Z","end":"2026-05-05T17:29:24.896188Z","steps":["trace[584206512] 'agreement among raft nodes before linearized reading' (duration: 872.015428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.896221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.024088Z","time spent":"872.125163ms","remote":"127.0.0.1:43296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:29:24.896391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.277031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.89642Z","caller":"traceutil/trace.go:171","msg":"trace[2102348988] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:587; }","duration":"872.336384ms","start":"2026-05-05T17:29:24.024077Z","end":"2026-05-05T17:29:24.896413Z","steps":["trace[2102348988] 'agreement among raft nodes before linearized reading' (duration: 872.292472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.89644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.024059Z","time spent":"872.374996ms","remote":"127.0.0.1:43296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:29:24.896585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.564279456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T17:29:24.896611Z","caller":"traceutil/trace.go:171","msg":"trace[2063163730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"2.564325578s","start":"2026-05-05T17:29:22.332279Z","end":"2026-05-05T17:29:24.896605Z","steps":["trace[2063163730] 'agreement among raft nodes before linearized reading' (duration: 2.564273666s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.896629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:22.332271Z","time spent":"2.56435336s","remote":"127.0.0.1:58830","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-05-05T17:29:24.893953Z","caller":"traceutil/trace.go:171","msg":"trace[1135240419] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"609.571115ms","start":"2026-05-05T17:29:24.28434Z","end":"2026-05-05T17:29:24.893911Z","steps":["trace[1135240419] 'agreement among raft nodes before linearized reading' (duration: 609.4751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.896779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.28427Z","time spent":"612.499853ms","remote":"127.0.0.1:43342","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":"info","ts":"2026-05-05T17:29:24.896753Z","caller":"traceutil/trace.go:171","msg":"trace[1855149474] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"823.702009ms","start":"2026-05-05T17:29:24.073038Z","end":"2026-05-05T17:29:24.89674Z","steps":["trace[1855149474] 'agreement among raft nodes before linearized reading' (duration: 820.861094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.073024Z","time spent":"823.979333ms","remote":"127.0.0.1:43316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:29:24.897123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.881466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897163Z","caller":"traceutil/trace.go:171","msg":"trace[1009924576] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"232.277018ms","start":"2026-05-05T17:29:24.664875Z","end":"2026-05-05T17:29:24.897152Z","steps":["trace[1009924576] 'agreement among raft nodes before linearized reading' (duration: 228.810622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.598212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897265Z","caller":"traceutil/trace.go:171","msg":"trace[1870225229] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"136.385039ms","start":"2026-05-05T17:29:24.760871Z","end":"2026-05-05T17:29:24.897256Z","steps":["trace[1870225229] 'process raft request' (duration: 132.095621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.180232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.897323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.337353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897353Z","caller":"traceutil/trace.go:171","msg":"trace[289954874] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:587; }","duration":"144.401857ms","start":"2026-05-05T17:29:24.752943Z","end":"2026-05-05T17:29:24.897345Z","steps":["trace[289954874] 'agreement among raft nodes before linearized reading' (duration: 144.353534ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.897348Z","caller":"traceutil/trace.go:171","msg":"trace[339144633] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"173.226234ms","start":"2026-05-05T17:29:24.724115Z","end":"2026-05-05T17:29:24.897341Z","steps":["trace[339144633] 'agreement among raft nodes before linearized reading' (duration: 173.155821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.537263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897273Z","caller":"traceutil/trace.go:171","msg":"trace[2091685444] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"172.672436ms","start":"2026-05-05T17:29:24.724587Z","end":"2026-05-05T17:29:24.89726Z","steps":["trace[2091685444] 'agreement among raft nodes before linearized reading' (duration: 172.511278ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.897488Z","caller":"traceutil/trace.go:171","msg":"trace[1548199339] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:587; }","duration":"144.642849ms","start":"2026-05-05T17:29:24.752832Z","end":"2026-05-05T17:29:24.897475Z","steps":["trace[1548199339] 'agreement among raft nodes before linearized reading' (duration: 144.492222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.895533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.854043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897536Z","caller":"traceutil/trace.go:171","msg":"trace[1975211680] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:587; }","duration":"253.003962ms","start":"2026-05-05T17:29:24.644521Z","end":"2026-05-05T17:29:24.897525Z","steps":["trace[1975211680] 'agreement among raft nodes before linearized reading' (duration: 249.382898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.603813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.441941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897599Z","caller":"traceutil/trace.go:171","msg":"trace[1921597863] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"173.646555ms","start":"2026-05-05T17:29:24.723946Z","end":"2026-05-05T17:29:24.897593Z","steps":["trace[1921597863] 'agreement among raft nodes before linearized reading' (duration: 173.605903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.187579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897658Z","caller":"traceutil/trace.go:171","msg":"trace[2070040654] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:587; }","duration":"102.245912ms","start":"2026-05-05T17:29:24.795404Z","end":"2026-05-05T17:29:24.89765Z","steps":["trace[2070040654] 'agreement among raft nodes before linearized reading' (duration: 102.192089ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.897643Z","caller":"traceutil/trace.go:171","msg":"trace[1691161357] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"434.922499ms","start":"2026-05-05T17:29:24.462683Z","end":"2026-05-05T17:29:24.897605Z","steps":["trace[1691161357] 'agreement among raft nodes before linearized reading' (duration: 431.436161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.626677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.897707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.462678Z","time spent":"435.014343ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:29:24.895771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.280049ms","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-05-05T17:29:24.89773Z","caller":"traceutil/trace.go:171","msg":"trace[1334562779] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"199.67991ms","start":"2026-05-05T17:29:24.698042Z","end":"2026-05-05T17:29:24.897722Z","steps":["trace[1334562779] 'agreement among raft nodes before linearized reading' (duration: 199.634377ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.897746Z","caller":"traceutil/trace.go:171","msg":"trace[1991076409] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"781.297311ms","start":"2026-05-05T17:29:24.116437Z","end":"2026-05-05T17:29:24.897735Z","steps":["trace[1991076409] 'agreement among raft nodes before linearized reading' (duration: 779.29764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.89776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.140488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897783Z","caller":"traceutil/trace.go:171","msg":"trace[1285529552] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:587; }","duration":"103.19031ms","start":"2026-05-05T17:29:24.794585Z","end":"2026-05-05T17:29:24.897775Z","steps":["trace[1285529552] 'agreement among raft nodes before linearized reading' (duration: 103.158419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.116408Z","time spent":"781.364265ms","remote":"127.0.0.1:43328","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-05-05T17:29:24.89785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.800666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.897856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.71758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.897878Z","caller":"traceutil/trace.go:171","msg":"trace[733628015] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"199.860428ms","start":"2026-05-05T17:29:24.698011Z","end":"2026-05-05T17:29:24.897872Z","steps":["trace[733628015] 'agreement among raft nodes before linearized reading' (duration: 199.816466ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.897912Z","caller":"traceutil/trace.go:171","msg":"trace[1731979896] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"824.788984ms","start":"2026-05-05T17:29:24.073088Z","end":"2026-05-05T17:29:24.897877Z","steps":["trace[1731979896] 'agreement among raft nodes before linearized reading' (duration: 824.7106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.208903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.89395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.909264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.273514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-05T17:29:24.894179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.510615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.313991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.139663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.607981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.583138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.895663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.153156Z","time spent":"742.491518ms","remote":"127.0.0.1:43334","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-05-05T17:29:24.893799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.529692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.89693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.354648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.897954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.07308Z","time spent":"824.862978ms","remote":"127.0.0.1:43316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T17:29:24.898019Z","caller":"traceutil/trace.go:171","msg":"trace[2102249909] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:587; }","duration":"103.475815ms","start":"2026-05-05T17:29:24.794536Z","end":"2026-05-05T17:29:24.898012Z","steps":["trace[2102249909] 'agreement among raft nodes before linearized reading' (duration: 102.370819ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.895666Z","caller":"traceutil/trace.go:171","msg":"trace[1234579388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:587; }","duration":"844.709579ms","start":"2026-05-05T17:29:24.050942Z","end":"2026-05-05T17:29:24.895651Z","steps":["trace[1234579388] 'agreement among raft nodes before linearized reading' (duration: 843.470395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.898096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.050914Z","time spent":"847.166983ms","remote":"127.0.0.1:43312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:29:24.898131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.957753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:24.898157Z","caller":"traceutil/trace.go:171","msg":"trace[1217862946] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"233.002424ms","start":"2026-05-05T17:29:24.665149Z","end":"2026-05-05T17:29:24.898151Z","steps":["trace[1217862946] 'agreement among raft nodes before linearized reading' (duration: 232.960882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.897965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.822886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.897133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.924362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:29:24.894378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.55414Z","time spent":"340.22953ms","remote":"127.0.0.1:43384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T17:29:24.898282Z","caller":"traceutil/trace.go:171","msg":"trace[25191063] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"824.51066ms","start":"2026-05-05T17:29:24.07376Z","end":"2026-05-05T17:29:24.898271Z","steps":["trace[25191063] 'agreement among raft nodes before linearized reading' (duration: 823.790134ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.898385Z","caller":"traceutil/trace.go:171","msg":"trace[2102799050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"687.604785ms","start":"2026-05-05T17:29:24.210776Z","end":"2026-05-05T17:29:24.89838Z","steps":["trace[2102799050] 'agreement among raft nodes before linearized reading' (duration: 683.20389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.898438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.21074Z","time spent":"687.689989ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T17:29:24.898415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.07371Z","time spent":"824.69093ms","remote":"127.0.0.1:43316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-05T17:29:24.898564Z","caller":"traceutil/trace.go:171","msg":"trace[88294382] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"435.933791ms","start":"2026-05-05T17:29:24.462623Z","end":"2026-05-05T17:29:24.898556Z","steps":["trace[88294382] 'agreement among raft nodes before linearized reading' (duration: 431.541747ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.898589Z","caller":"traceutil/trace.go:171","msg":"trace[13039710] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"744.996085ms","start":"2026-05-05T17:29:24.153585Z","end":"2026-05-05T17:29:24.898581Z","steps":["trace[13039710] 'agreement among raft nodes before linearized reading' (duration: 740.58357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.898598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.462602Z","time spent":"435.986543ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:29:24.898615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.153579Z","time spent":"745.027376ms","remote":"127.0.0.1:43328","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:500 "} {"level":"info","ts":"2026-05-05T17:29:24.89865Z","caller":"traceutil/trace.go:171","msg":"trace[16026674] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"487.769339ms","start":"2026-05-05T17:29:24.410866Z","end":"2026-05-05T17:29:24.898635Z","steps":["trace[16026674] 'agreement among raft nodes before linearized reading' (duration: 483.324192ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.898677Z","caller":"traceutil/trace.go:171","msg":"trace[1418064961] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"488.645402ms","start":"2026-05-05T17:29:24.410021Z","end":"2026-05-05T17:29:24.898667Z","steps":["trace[1418064961] 'agreement among raft nodes before linearized reading' (duration: 484.191745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.898713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.409968Z","time spent":"488.733867ms","remote":"127.0.0.1:43348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:29:24.898713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.410857Z","time spent":"487.838352ms","remote":"127.0.0.1:43342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"info","ts":"2026-05-05T17:29:24.898756Z","caller":"traceutil/trace.go:171","msg":"trace[1538649647] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:587; }","duration":"145.546325ms","start":"2026-05-05T17:29:24.753199Z","end":"2026-05-05T17:29:24.898745Z","steps":["trace[1538649647] 'agreement among raft nodes before linearized reading' (duration: 143.910672ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.89831Z","caller":"traceutil/trace.go:171","msg":"trace[991135489] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"343.655765ms","start":"2026-05-05T17:29:24.554644Z","end":"2026-05-05T17:29:24.8983Z","steps":["trace[991135489] 'agreement among raft nodes before linearized reading' (duration: 339.580178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.898882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.554636Z","time spent":"344.235475ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-05-05T17:29:24.898353Z","caller":"traceutil/trace.go:171","msg":"trace[176730880] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"207.596323ms","start":"2026-05-05T17:29:24.690749Z","end":"2026-05-05T17:29:24.898346Z","steps":["trace[176730880] 'agreement among raft nodes before linearized reading' (duration: 207.199772ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.89837Z","caller":"traceutil/trace.go:171","msg":"trace[1492581655] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:587; }","duration":"254.33723ms","start":"2026-05-05T17:29:24.644028Z","end":"2026-05-05T17:29:24.898365Z","steps":["trace[1492581655] 'agreement among raft nodes before linearized reading' (duration: 249.891643ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:24.898372Z","caller":"traceutil/trace.go:171","msg":"trace[267345737] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:587; }","duration":"874.177938ms","start":"2026-05-05T17:29:24.024187Z","end":"2026-05-05T17:29:24.898365Z","steps":["trace[267345737] 'agreement among raft nodes before linearized reading' (duration: 869.539162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:24.899128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:24.024159Z","time spent":"874.955948ms","remote":"127.0.0.1:43296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"info","ts":"2026-05-05T17:29:25.453821Z","caller":"traceutil/trace.go:171","msg":"trace[269641614] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"278.019215ms","start":"2026-05-05T17:29:25.175772Z","end":"2026-05-05T17:29:25.453792Z","steps":["trace[269641614] 'process raft request' (duration: 277.810675ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:25.476353Z","caller":"traceutil/trace.go:171","msg":"trace[1823242820] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"171.017821ms","start":"2026-05-05T17:29:25.305309Z","end":"2026-05-05T17:29:25.476327Z","steps":["trace[1823242820] 'process raft request' (duration: 170.486254ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:25.476916Z","caller":"traceutil/trace.go:171","msg":"trace[543555198] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"287.432875ms","start":"2026-05-05T17:29:25.188877Z","end":"2026-05-05T17:29:25.47631Z","steps":["trace[543555198] 'process raft request' (duration: 286.33721ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:28.568769Z","caller":"traceutil/trace.go:171","msg":"trace[1213072463] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"357.183146ms","start":"2026-05-05T17:29:28.21156Z","end":"2026-05-05T17:29:28.568743Z","steps":["trace[1213072463] 'process raft request' (duration: 356.337776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:28.568914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:28.211526Z","time spent":"357.315342ms","remote":"127.0.0.1:58764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18052,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:29:28.568666Z","caller":"traceutil/trace.go:171","msg":"trace[775973381] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"272.300379ms","start":"2026-05-05T17:29:28.296346Z","end":"2026-05-05T17:29:28.568646Z","steps":["trace[775973381] 'read index received' (duration: 271.519152ms)","trace[775973381] 'applied index is now lower than readState.Index' (duration: 780.307µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:29:28.568878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.517909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:28.569093Z","caller":"traceutil/trace.go:171","msg":"trace[1118805574] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:653; }","duration":"272.761249ms","start":"2026-05-05T17:29:28.29631Z","end":"2026-05-05T17:29:28.569071Z","steps":["trace[1118805574] 'agreement among raft nodes before linearized reading' (duration: 272.518798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:28.831921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.871733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-05T17:29:28.831949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.881291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-05-05T17:29:28.832022Z","caller":"traceutil/trace.go:171","msg":"trace[1014135927] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:653; }","duration":"122.00508ms","start":"2026-05-05T17:29:28.709999Z","end":"2026-05-05T17:29:28.832004Z","steps":["trace[1014135927] 'range keys from in-memory index tree' (duration: 121.656883ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:28.832034Z","caller":"traceutil/trace.go:171","msg":"trace[1062243816] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:653; }","duration":"135.019797ms","start":"2026-05-05T17:29:28.696993Z","end":"2026-05-05T17:29:28.832013Z","steps":["trace[1062243816] 'range keys from in-memory index tree' (duration: 134.669469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:29.147979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.782322ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:29:29.148186Z","caller":"traceutil/trace.go:171","msg":"trace[1793470775] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"226.024857ms","start":"2026-05-05T17:29:28.922143Z","end":"2026-05-05T17:29:29.148168Z","steps":["trace[1793470775] 'process raft request' (duration: 225.932762ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:29.148205Z","caller":"traceutil/trace.go:171","msg":"trace[1237729530] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"225.894381ms","start":"2026-05-05T17:29:28.922298Z","end":"2026-05-05T17:29:29.148193Z","steps":["trace[1237729530] 'process raft request' (duration: 225.824147ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:29.148258Z","caller":"traceutil/trace.go:171","msg":"trace[1911014] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"226.303431ms","start":"2026-05-05T17:29:28.92183Z","end":"2026-05-05T17:29:29.148134Z","steps":["trace[1911014] 'process raft request' (duration: 52.276907ms)","trace[1911014] 'compare' (duration: 173.635455ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:29:29.148569Z","caller":"traceutil/trace.go:171","msg":"trace[1781263460] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:679; }","duration":"166.23384ms","start":"2026-05-05T17:29:28.982327Z","end":"2026-05-05T17:29:29.14856Z","steps":["trace[1781263460] 'read index received' (duration: 125.122293ms)","trace[1781263460] 'applied index is now lower than readState.Index' (duration: 41.110687ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:29:29.148636Z","caller":"traceutil/trace.go:171","msg":"trace[1123536789] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"226.157333ms","start":"2026-05-05T17:29:28.922473Z","end":"2026-05-05T17:29:29.148631Z","steps":["trace[1123536789] 'process raft request' (duration: 225.680332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:29.14872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.399717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:29.148739Z","caller":"traceutil/trace.go:171","msg":"trace[1844627015] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"166.45928ms","start":"2026-05-05T17:29:28.982273Z","end":"2026-05-05T17:29:29.148732Z","steps":["trace[1844627015] 'agreement among raft nodes before linearized reading' (duration: 166.423228ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:29.346721Z","caller":"traceutil/trace.go:171","msg":"trace[1863742262] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:683; }","duration":"130.026245ms","start":"2026-05-05T17:29:29.216665Z","end":"2026-05-05T17:29:29.346691Z","steps":["trace[1863742262] 'read index received' (duration: 70.239956ms)","trace[1863742262] 'applied index is now lower than readState.Index' (duration: 59.784879ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:29:29.346782Z","caller":"traceutil/trace.go:171","msg":"trace[495907858] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"165.098387ms","start":"2026-05-05T17:29:29.181623Z","end":"2026-05-05T17:29:29.346721Z","steps":["trace[495907858] 'process raft request' (duration: 105.391792ms)","trace[495907858] 'compare' (duration: 59.529377ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:29:29.346947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.267406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gh2lh\" ","response":"range_response_count:1 size:18067"} {"level":"info","ts":"2026-05-05T17:29:29.346984Z","caller":"traceutil/trace.go:171","msg":"trace[607916951] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gh2lh; range_end:; response_count:1; response_revision:660; }","duration":"130.35234ms","start":"2026-05-05T17:29:29.216624Z","end":"2026-05-05T17:29:29.346976Z","steps":["trace[607916951] 'agreement among raft nodes before linearized reading' (duration: 130.177772ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:29:43.046685Z","caller":"traceutil/trace.go:171","msg":"trace[543804171] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:780; }","duration":"361.221472ms","start":"2026-05-05T17:29:42.685427Z","end":"2026-05-05T17:29:43.046649Z","steps":["trace[543804171] 'read index received' (duration: 361.045876ms)","trace[543804171] 'applied index is now lower than readState.Index' (duration: 173.606µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:29:43.046776Z","caller":"traceutil/trace.go:171","msg":"trace[137571660] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"691.654528ms","start":"2026-05-05T17:29:42.355061Z","end":"2026-05-05T17:29:43.046716Z","steps":["trace[137571660] 'process raft request' (duration: 691.351278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:43.046961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.44135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:29:43.047053Z","caller":"traceutil/trace.go:171","msg":"trace[1147430723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"361.673548ms","start":"2026-05-05T17:29:42.685357Z","end":"2026-05-05T17:29:43.047031Z","steps":["trace[1147430723] 'agreement among raft nodes before linearized reading' (duration: 361.43469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:29:43.04712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:42.685327Z","time spent":"361.777622ms","remote":"127.0.0.1:58570","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-05-05T17:29:43.047288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:29:42.355035Z","time spent":"692.148005ms","remote":"127.0.0.1:58818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:30:01.129372Z","caller":"traceutil/trace.go:171","msg":"trace[581712511] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"119.920288ms","start":"2026-05-05T17:30:01.009392Z","end":"2026-05-05T17:30:01.129313Z","steps":["trace[581712511] 'process raft request' (duration: 119.6181ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:01.12954Z","caller":"traceutil/trace.go:171","msg":"trace[607763940] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"112.136664ms","start":"2026-05-05T17:30:01.017369Z","end":"2026-05-05T17:30:01.129506Z","steps":["trace[607763940] 'process raft request' (duration: 111.890218ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:01.129539Z","caller":"traceutil/trace.go:171","msg":"trace[1345647501] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"118.779269ms","start":"2026-05-05T17:30:01.010706Z","end":"2026-05-05T17:30:01.129485Z","steps":["trace[1345647501] 'process raft request' (duration: 118.479171ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:01.129807Z","caller":"traceutil/trace.go:171","msg":"trace[482716857] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"112.253577ms","start":"2026-05-05T17:30:01.017517Z","end":"2026-05-05T17:30:01.129771Z","steps":["trace[482716857] 'process raft request' (duration: 111.804485ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:01.12995Z","caller":"traceutil/trace.go:171","msg":"trace[57940411] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"107.033249ms","start":"2026-05-05T17:30:01.022903Z","end":"2026-05-05T17:30:01.129936Z","steps":["trace[57940411] 'process raft request' (duration: 106.515526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:30:13.900249Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744478121576980,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T17:30:14.13003Z","caller":"traceutil/trace.go:171","msg":"trace[1348257105] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"869.39502ms","start":"2026-05-05T17:30:13.260595Z","end":"2026-05-05T17:30:14.12999Z","steps":["trace[1348257105] 'process raft request' (duration: 869.145985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:30:14.130227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:30:13.260553Z","time spent":"869.563434ms","remote":"127.0.0.1:58830","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-05-05T17:30:14.134059Z","caller":"traceutil/trace.go:171","msg":"trace[1564705323] linearizableReadLoop","detail":"{readStateIndex:1200; appliedIndex:1198; }","duration":"734.186762ms","start":"2026-05-05T17:30:13.399857Z","end":"2026-05-05T17:30:14.134043Z","steps":["trace[1564705323] 'read index received' (duration: 729.869354ms)","trace[1564705323] 'applied index is now lower than readState.Index' (duration: 4.316118ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:30:14.134222Z","caller":"traceutil/trace.go:171","msg":"trace[379670449] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"241.470416ms","start":"2026-05-05T17:30:13.892704Z","end":"2026-05-05T17:30:14.134174Z","steps":["trace[379670449] 'process raft request' (duration: 241.232061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:30:14.134365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.18919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-05T17:30:14.134275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.420687ms","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-05-05T17:30:14.134433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.027954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:30:14.134459Z","caller":"traceutil/trace.go:171","msg":"trace[352777482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1163; }","duration":"450.082695ms","start":"2026-05-05T17:30:13.684368Z","end":"2026-05-05T17:30:14.13445Z","steps":["trace[352777482] 'agreement among raft nodes before linearized reading' (duration: 450.046124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:30:14.13446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.885353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:30:14.134551Z","caller":"traceutil/trace.go:171","msg":"trace[1626354238] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1163; }","duration":"733.004056ms","start":"2026-05-05T17:30:13.40152Z","end":"2026-05-05T17:30:14.134524Z","steps":["trace[1626354238] 'agreement among raft nodes before linearized reading' (duration: 732.707429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:30:14.134572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.564352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-05T17:30:14.134482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:30:13.684354Z","time spent":"450.123976ms","remote":"127.0.0.1:58570","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-05-05T17:30:14.134599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:30:13.40151Z","time spent":"733.079557ms","remote":"127.0.0.1:58830","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-05-05T17:30:14.134518Z","caller":"traceutil/trace.go:171","msg":"trace[836496934] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1163; }","duration":"734.657862ms","start":"2026-05-05T17:30:13.399793Z","end":"2026-05-05T17:30:14.134451Z","steps":["trace[836496934] 'agreement among raft nodes before linearized reading' (duration: 734.356586ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:14.134655Z","caller":"traceutil/trace.go:171","msg":"trace[916414356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1163; }","duration":"644.674774ms","start":"2026-05-05T17:30:13.489941Z","end":"2026-05-05T17:30:14.134615Z","steps":["trace[916414356] 'agreement among raft nodes before linearized reading' (duration: 644.49292ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:14.134399Z","caller":"traceutil/trace.go:171","msg":"trace[7179339] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1163; }","duration":"498.222561ms","start":"2026-05-05T17:30:13.636167Z","end":"2026-05-05T17:30:14.13439Z","steps":["trace[7179339] 'agreement among raft nodes before linearized reading' (duration: 498.137709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:30:14.134702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:30:13.489912Z","time spent":"644.780127ms","remote":"127.0.0.1:58830","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-05-05T17:30:14.134742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:30:13.399766Z","time spent":"734.912198ms","remote":"127.0.0.1:58830","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-05-05T17:30:14.134759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.282181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T17:30:14.134808Z","caller":"traceutil/trace.go:171","msg":"trace[1156904364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1163; }","duration":"646.436345ms","start":"2026-05-05T17:30:13.488359Z","end":"2026-05-05T17:30:14.134795Z","steps":["trace[1156904364] 'agreement among raft nodes before linearized reading' (duration: 646.095617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:30:14.134792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:30:13.636086Z","time spent":"498.646771ms","remote":"127.0.0.1:58780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":50,"response size":29,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:30:14.134835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:30:13.488329Z","time spent":"646.500536ms","remote":"127.0.0.1:58830","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-05-05T17:30:28.268927Z","caller":"traceutil/trace.go:171","msg":"trace[1469567305] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"114.177493ms","start":"2026-05-05T17:30:28.154714Z","end":"2026-05-05T17:30:28.268891Z","steps":["trace[1469567305] 'process raft request' (duration: 94.842708ms)","trace[1469567305] 'compare' (duration: 19.11612ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:30:36.558076Z","caller":"traceutil/trace.go:171","msg":"trace[1362624264] linearizableReadLoop","detail":"{readStateIndex:1463; appliedIndex:1462; }","duration":"154.131658ms","start":"2026-05-05T17:30:36.40391Z","end":"2026-05-05T17:30:36.558041Z","steps":["trace[1362624264] 'read index received' (duration: 126.861413ms)","trace[1362624264] 'applied index is now lower than readState.Index' (duration: 27.268965ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:30:36.558482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.547265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-05T17:30:36.55861Z","caller":"traceutil/trace.go:171","msg":"trace[94614204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1418; }","duration":"154.704508ms","start":"2026-05-05T17:30:36.403863Z","end":"2026-05-05T17:30:36.558567Z","steps":["trace[94614204] 'agreement among raft nodes before linearized reading' (duration: 154.397653ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:36.558615Z","caller":"traceutil/trace.go:171","msg":"trace[638781911] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"162.760571ms","start":"2026-05-05T17:30:36.395816Z","end":"2026-05-05T17:30:36.558577Z","steps":["trace[638781911] 'process raft request' (duration: 135.047768ms)","trace[638781911] 'compare' (duration: 26.943127ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:30:36.558613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.618948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:30:36.558837Z","caller":"traceutil/trace.go:171","msg":"trace[965025026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1418; }","duration":"153.803562ms","start":"2026-05-05T17:30:36.404889Z","end":"2026-05-05T17:30:36.558693Z","steps":["trace[965025026] 'agreement among raft nodes before linearized reading' (duration: 153.477546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:30:36.558846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.06857ms","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-05-05T17:30:36.558932Z","caller":"traceutil/trace.go:171","msg":"trace[1765882480] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1418; }","duration":"151.190363ms","start":"2026-05-05T17:30:36.407722Z","end":"2026-05-05T17:30:36.558912Z","steps":["trace[1765882480] 'agreement among raft nodes before linearized reading' (duration: 150.871287ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:50.77372Z","caller":"traceutil/trace.go:171","msg":"trace[776337938] transaction","detail":"{read_only:false; response_revision:1660; number_of_response:1; }","duration":"114.006423ms","start":"2026-05-05T17:30:50.659636Z","end":"2026-05-05T17:30:50.773642Z","steps":["trace[776337938] 'process raft request' (duration: 113.799929ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:50.784336Z","caller":"traceutil/trace.go:171","msg":"trace[1885056301] transaction","detail":"{read_only:false; response_revision:1661; number_of_response:1; }","duration":"122.603734ms","start":"2026-05-05T17:30:50.661675Z","end":"2026-05-05T17:30:50.784279Z","steps":["trace[1885056301] 'process raft request' (duration: 122.33229ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:50.784597Z","caller":"traceutil/trace.go:171","msg":"trace[63632339] transaction","detail":"{read_only:false; response_revision:1662; number_of_response:1; }","duration":"122.716756ms","start":"2026-05-05T17:30:50.661847Z","end":"2026-05-05T17:30:50.784564Z","steps":["trace[63632339] 'process raft request' (duration: 122.305969ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:50.784848Z","caller":"traceutil/trace.go:171","msg":"trace[1049222694] transaction","detail":"{read_only:false; response_revision:1663; number_of_response:1; }","duration":"122.783777ms","start":"2026-05-05T17:30:50.662053Z","end":"2026-05-05T17:30:50.784837Z","steps":["trace[1049222694] 'process raft request' (duration: 122.146076ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:30:57.336769Z","caller":"traceutil/trace.go:171","msg":"trace[590958849] transaction","detail":"{read_only:false; response_revision:1745; number_of_response:1; }","duration":"176.128724ms","start":"2026-05-05T17:30:57.16058Z","end":"2026-05-05T17:30:57.336709Z","steps":["trace[590958849] 'process raft request' (duration: 175.930088ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:05.052204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.796498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5f12728-114b-4d03-a549-d88520e2f76d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-05T17:31:05.052275Z","caller":"traceutil/trace.go:171","msg":"trace[1722693424] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f5f12728-114b-4d03-a549-d88520e2f76d; range_end:; response_count:1; response_revision:1855; }","duration":"280.940152ms","start":"2026-05-05T17:31:04.771322Z","end":"2026-05-05T17:31:05.052262Z","steps":["trace[1722693424] 'range keys from in-memory index tree' (duration: 280.589432ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:05.3018Z","caller":"traceutil/trace.go:171","msg":"trace[1468133769] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"377.0392ms","start":"2026-05-05T17:31:04.924648Z","end":"2026-05-05T17:31:05.301687Z","steps":["trace[1468133769] 'read index received' (duration: 376.885866ms)","trace[1468133769] 'applied index is now lower than readState.Index' (duration: 151.834µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:05.301846Z","caller":"traceutil/trace.go:171","msg":"trace[741459967] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"459.443889ms","start":"2026-05-05T17:31:04.842371Z","end":"2026-05-05T17:31:05.301815Z","steps":["trace[741459967] 'process raft request' (duration: 459.13877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:05.302104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.402311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:31:05.302218Z","caller":"traceutil/trace.go:171","msg":"trace[1381419246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1856; }","duration":"377.631498ms","start":"2026-05-05T17:31:04.924573Z","end":"2026-05-05T17:31:05.302205Z","steps":["trace[1381419246] 'agreement among raft nodes before linearized reading' (duration: 377.329119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:05.302328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:04.842334Z","time spent":"459.793108ms","remote":"127.0.0.1:58830","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-05-05T17:31:05.302315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:04.924543Z","time spent":"377.759741ms","remote":"127.0.0.1:58830","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-05-05T17:31:05.39652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.588563ms","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-05-05T17:31:05.396604Z","caller":"traceutil/trace.go:171","msg":"trace[939112284] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1858; }","duration":"423.756527ms","start":"2026-05-05T17:31:04.97283Z","end":"2026-05-05T17:31:05.396587Z","steps":["trace[939112284] 'agreement among raft nodes before linearized reading' (duration: 423.479819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:05.396648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:04.972795Z","time spent":"423.842989ms","remote":"127.0.0.1:58830","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-05-05T17:31:05.396918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.85841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T17:31:05.397056Z","caller":"traceutil/trace.go:171","msg":"trace[396686880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1858; }","duration":"472.153228ms","start":"2026-05-05T17:31:04.924878Z","end":"2026-05-05T17:31:05.397031Z","steps":["trace[396686880] 'agreement among raft nodes before linearized reading' (duration: 471.627314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:05.397136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:04.924852Z","time spent":"472.271022ms","remote":"127.0.0.1:58830","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-05-05T17:31:05.397182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.878885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-05T17:31:05.397244Z","caller":"traceutil/trace.go:171","msg":"trace[1276005086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1858; }","duration":"452.981909ms","start":"2026-05-05T17:31:04.94424Z","end":"2026-05-05T17:31:05.397222Z","steps":["trace[1276005086] 'agreement among raft nodes before linearized reading' (duration: 452.799564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:05.397294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:04.944212Z","time spent":"453.073151ms","remote":"127.0.0.1:58830","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-05-05T17:31:05.396942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.352404ms","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-05-05T17:31:05.397382Z","caller":"traceutil/trace.go:171","msg":"trace[264751941] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"335.751933ms","start":"2026-05-05T17:31:05.060443Z","end":"2026-05-05T17:31:05.396195Z","steps":["trace[264751941] 'process raft request' (duration: 302.197216ms)","trace[264751941] 'compare' (duration: 33.317031ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:05.397485Z","caller":"traceutil/trace.go:171","msg":"trace[426470687] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1858; }","duration":"451.94176ms","start":"2026-05-05T17:31:04.945532Z","end":"2026-05-05T17:31:05.397474Z","steps":["trace[426470687] 'agreement among raft nodes before linearized reading' (duration: 451.25098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:05.39752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:04.945519Z","time spent":"451.991261ms","remote":"127.0.0.1:58830","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-05-05T17:31:05.39766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:05.060422Z","time spent":"337.09226ms","remote":"127.0.0.1:58764","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-05-05T17:31:06.903952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744478121578376,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:31:06.954497Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.169574819s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:31:06.955328Z","caller":"traceutil/trace.go:171","msg":"trace[783819498] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"1.170538606s","start":"2026-05-05T17:31:05.784754Z","end":"2026-05-05T17:31:06.955292Z","steps":["trace[783819498] 'process raft request' (duration: 1.170264498s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:06.955888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:05.784719Z","time spent":"1.17104494s","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:31:07.257765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.275921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:31:07.258231Z","caller":"traceutil/trace.go:171","msg":"trace[97263283] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"968.854004ms","start":"2026-05-05T17:31:06.289341Z","end":"2026-05-05T17:31:07.258195Z","steps":["trace[97263283] 'process raft request' (duration: 832.027318ms)","trace[97263283] 'compare' (duration: 136.110346ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:07.258322Z","caller":"traceutil/trace.go:171","msg":"trace[1251706489] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1936; }","duration":"855.174077ms","start":"2026-05-05T17:31:06.403102Z","end":"2026-05-05T17:31:07.258276Z","steps":["trace[1251706489] 'read index received' (duration: 551.870037ms)","trace[1251706489] 'applied index is now lower than readState.Index' (duration: 303.30145ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:31:07.258415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:06.289308Z","time spent":"969.000208ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:31:07.258438Z","caller":"traceutil/trace.go:171","msg":"trace[1515325626] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"805.620701ms","start":"2026-05-05T17:31:06.452742Z","end":"2026-05-05T17:31:07.258363Z","steps":["trace[1515325626] 'process raft request' (duration: 805.299351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:07.258635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.514906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5f12728-114b-4d03-a549-d88520e2f76d\" ","response":"range_response_count:1 size:3747"} {"level":"warn","ts":"2026-05-05T17:31:07.258721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.288442ms","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":"warn","ts":"2026-05-05T17:31:07.258721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.803524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T17:31:07.258736Z","caller":"traceutil/trace.go:171","msg":"trace[342429372] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f5f12728-114b-4d03-a549-d88520e2f76d; range_end:; response_count:1; response_revision:1866; }","duration":"855.661261ms","start":"2026-05-05T17:31:06.40305Z","end":"2026-05-05T17:31:07.258711Z","steps":["trace[342429372] 'agreement among raft nodes before linearized reading' (duration: 855.391414ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:07.258762Z","caller":"traceutil/trace.go:171","msg":"trace[1132318795] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1866; }","duration":"567.378274ms","start":"2026-05-05T17:31:06.691374Z","end":"2026-05-05T17:31:07.258752Z","steps":["trace[1132318795] 'agreement among raft nodes before linearized reading' (duration: 567.191139ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:07.258775Z","caller":"traceutil/trace.go:171","msg":"trace[2026092105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1866; }","duration":"716.927358ms","start":"2026-05-05T17:31:06.541832Z","end":"2026-05-05T17:31:07.258759Z","steps":["trace[2026092105] 'agreement among raft nodes before linearized reading' (duration: 716.66787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:07.258791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:06.691345Z","time spent":"567.440966ms","remote":"127.0.0.1:56252","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-05-05T17:31:07.258773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:06.452716Z","time spent":"805.911309ms","remote":"127.0.0.1:58830","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-05-05T17:31:07.258805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:06.403033Z","time spent":"855.756403ms","remote":"127.0.0.1:58764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5f12728-114b-4d03-a549-d88520e2f76d\" "} {"level":"warn","ts":"2026-05-05T17:31:07.258828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:06.541798Z","time spent":"717.02057ms","remote":"127.0.0.1:58830","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-05-05T17:31:07.258805Z","caller":"traceutil/trace.go:171","msg":"trace[1160237695] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"904.99955ms","start":"2026-05-05T17:31:06.353098Z","end":"2026-05-05T17:31:07.258098Z","steps":["trace[1160237695] 'process raft request' (duration: 904.807035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:07.259113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:06.353063Z","time spent":"905.903936ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:31:13.505482Z","caller":"traceutil/trace.go:171","msg":"trace[1294040180] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"219.668281ms","start":"2026-05-05T17:31:13.285784Z","end":"2026-05-05T17:31:13.505452Z","steps":["trace[1294040180] 'process raft request' (duration: 147.325374ms)","trace[1294040180] 'compare' (duration: 72.146952ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:13.505757Z","caller":"traceutil/trace.go:171","msg":"trace[1995924779] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"219.859656ms","start":"2026-05-05T17:31:13.285863Z","end":"2026-05-05T17:31:13.505723Z","steps":["trace[1995924779] 'process raft request' (duration: 219.539738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:13.506001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.594695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T17:31:13.506094Z","caller":"traceutil/trace.go:171","msg":"trace[574898602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1930; }","duration":"217.730449ms","start":"2026-05-05T17:31:13.288344Z","end":"2026-05-05T17:31:13.506075Z","steps":["trace[574898602] 'agreement among raft nodes before linearized reading' (duration: 217.449312ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:13.506729Z","caller":"traceutil/trace.go:171","msg":"trace[952661558] linearizableReadLoop","detail":"{readStateIndex:2006; appliedIndex:2003; }","duration":"217.37065ms","start":"2026-05-05T17:31:13.288376Z","end":"2026-05-05T17:31:13.505747Z","steps":["trace[952661558] 'read index received' (duration: 23.418313ms)","trace[952661558] 'applied index is now lower than readState.Index' (duration: 193.879265ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:31:13.507049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.98862ms","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-05-05T17:31:13.507101Z","caller":"traceutil/trace.go:171","msg":"trace[1119700522] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1930; }","duration":"205.059592ms","start":"2026-05-05T17:31:13.30202Z","end":"2026-05-05T17:31:13.50708Z","steps":["trace[1119700522] 'agreement among raft nodes before linearized reading' (duration: 204.903938ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:13.744873Z","caller":"traceutil/trace.go:171","msg":"trace[262501722] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"231.2953ms","start":"2026-05-05T17:31:13.513547Z","end":"2026-05-05T17:31:13.744843Z","steps":["trace[262501722] 'process raft request' (duration: 231.202068ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:13.74489Z","caller":"traceutil/trace.go:171","msg":"trace[575188136] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"231.599799ms","start":"2026-05-05T17:31:13.513238Z","end":"2026-05-05T17:31:13.744838Z","steps":["trace[575188136] 'process raft request' (duration: 231.228269ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:13.745231Z","caller":"traceutil/trace.go:171","msg":"trace[1144062787] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"231.611339ms","start":"2026-05-05T17:31:13.513594Z","end":"2026-05-05T17:31:13.745206Z","steps":["trace[1144062787] 'process raft request' (duration: 231.202168ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:13.745589Z","caller":"traceutil/trace.go:171","msg":"trace[581076178] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"231.3343ms","start":"2026-05-05T17:31:13.514238Z","end":"2026-05-05T17:31:13.745572Z","steps":["trace[581076178] 'process raft request' (duration: 230.863878ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:17.626593Z","caller":"traceutil/trace.go:171","msg":"trace[658283128] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"107.14047ms","start":"2026-05-05T17:31:17.519431Z","end":"2026-05-05T17:31:17.626571Z","steps":["trace[658283128] 'process raft request' (duration: 107.003717ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:18.94653Z","caller":"traceutil/trace.go:171","msg":"trace[1634147377] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"595.448499ms","start":"2026-05-05T17:31:18.351043Z","end":"2026-05-05T17:31:18.946491Z","steps":["trace[1634147377] 'process raft request' (duration: 595.224464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:18.946793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:18.351021Z","time spent":"595.644634ms","remote":"127.0.0.1:58830","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-05-05T17:31:18.946995Z","caller":"traceutil/trace.go:171","msg":"trace[1764834298] linearizableReadLoop","detail":"{readStateIndex:2038; appliedIndex:2038; }","duration":"316.28569ms","start":"2026-05-05T17:31:18.630698Z","end":"2026-05-05T17:31:18.946984Z","steps":["trace[1764834298] 'read index received' (duration: 316.2779ms)","trace[1764834298] 'applied index is now lower than readState.Index' (duration: 6.99µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:31:18.947097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.386712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:31:18.94716Z","caller":"traceutil/trace.go:171","msg":"trace[805106931] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1961; }","duration":"316.489516ms","start":"2026-05-05T17:31:18.630647Z","end":"2026-05-05T17:31:18.947136Z","steps":["trace[805106931] 'agreement among raft nodes before linearized reading' (duration: 316.395663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:18.94721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:18.63062Z","time spent":"316.579427ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:31:18.948592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.586782ms","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-05-05T17:31:18.948656Z","caller":"traceutil/trace.go:171","msg":"trace[417458933] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1961; }","duration":"310.719636ms","start":"2026-05-05T17:31:18.637921Z","end":"2026-05-05T17:31:18.948641Z","steps":["trace[417458933] 'agreement among raft nodes before linearized reading' (duration: 310.47006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:18.948691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:18.63791Z","time spent":"310.772147ms","remote":"127.0.0.1:56252","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-05-05T17:31:18.949064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.88207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:31:18.949107Z","caller":"traceutil/trace.go:171","msg":"trace[1806084849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1961; }","duration":"264.986882ms","start":"2026-05-05T17:31:18.684109Z","end":"2026-05-05T17:31:18.949096Z","steps":["trace[1806084849] 'agreement among raft nodes before linearized reading' (duration: 264.92886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:18.949527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.225917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-05T17:31:18.949748Z","caller":"traceutil/trace.go:171","msg":"trace[835687415] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1961; }","duration":"275.3569ms","start":"2026-05-05T17:31:18.674247Z","end":"2026-05-05T17:31:18.949604Z","steps":["trace[835687415] 'agreement among raft nodes before linearized reading' (duration: 275.087383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:34.304089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.21185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:31:34.30427Z","caller":"traceutil/trace.go:171","msg":"trace[1562649797] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"334.8107ms","start":"2026-05-05T17:31:33.969422Z","end":"2026-05-05T17:31:34.304232Z","steps":["trace[1562649797] 'process raft request' (duration: 196.301022ms)","trace[1562649797] 'compare' (duration: 138.067567ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:34.304241Z","caller":"traceutil/trace.go:171","msg":"trace[1984219561] linearizableReadLoop","detail":"{readStateIndex:2147; appliedIndex:2146; }","duration":"151.438546ms","start":"2026-05-05T17:31:34.152776Z","end":"2026-05-05T17:31:34.304215Z","steps":["trace[1984219561] 'read index received' (duration: 12.867127ms)","trace[1984219561] 'applied index is now lower than readState.Index' (duration: 138.569789ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:31:34.304498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:33.969383Z","time spent":"334.979004ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:31:34.308825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.018846ms","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-05-05T17:31:34.309119Z","caller":"traceutil/trace.go:171","msg":"trace[874594984] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2067; }","duration":"156.377655ms","start":"2026-05-05T17:31:34.152717Z","end":"2026-05-05T17:31:34.309095Z","steps":["trace[874594984] 'agreement among raft nodes before linearized reading' (duration: 151.715943ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:41.366214Z","caller":"traceutil/trace.go:171","msg":"trace[1816518335] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"206.318996ms","start":"2026-05-05T17:31:41.15986Z","end":"2026-05-05T17:31:41.366179Z","steps":["trace[1816518335] 'process raft request' (duration: 206.076801ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:42.196498Z","caller":"traceutil/trace.go:171","msg":"trace[1788754975] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"383.781175ms","start":"2026-05-05T17:31:41.812682Z","end":"2026-05-05T17:31:42.196464Z","steps":["trace[1788754975] 'process raft request' (duration: 383.54552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.1967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:41.812655Z","time spent":"383.936149ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:31:42.208127Z","caller":"traceutil/trace.go:171","msg":"trace[1080667674] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"392.935366ms","start":"2026-05-05T17:31:41.815152Z","end":"2026-05-05T17:31:42.208088Z","steps":["trace[1080667674] 'process raft request' (duration: 392.603829ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:42.208275Z","caller":"traceutil/trace.go:171","msg":"trace[1645831323] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2182; }","duration":"382.195039ms","start":"2026-05-05T17:31:41.826055Z","end":"2026-05-05T17:31:42.20825Z","steps":["trace[1645831323] 'read index received' (duration: 370.1314ms)","trace[1645831323] 'applied index is now lower than readState.Index' (duration: 12.062249ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:31:42.20836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:41.815137Z","time spent":"393.112601ms","remote":"127.0.0.1:58830","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-05-05T17:31:42.208389Z","caller":"traceutil/trace.go:171","msg":"trace[178955940] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"188.008885ms","start":"2026-05-05T17:31:42.020339Z","end":"2026-05-05T17:31:42.208348Z","steps":["trace[178955940] 'process raft request' (duration: 187.645506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.208505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.7962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-05T17:31:42.208545Z","caller":"traceutil/trace.go:171","msg":"trace[1354719013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2104; }","duration":"245.892452ms","start":"2026-05-05T17:31:41.96264Z","end":"2026-05-05T17:31:42.208533Z","steps":["trace[1354719013] 'agreement among raft nodes before linearized reading' (duration: 245.749639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.208608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.824342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:31:42.208646Z","caller":"traceutil/trace.go:171","msg":"trace[742177389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2104; }","duration":"242.871612ms","start":"2026-05-05T17:31:41.965765Z","end":"2026-05-05T17:31:42.208637Z","steps":["trace[742177389] 'agreement among raft nodes before linearized reading' (duration: 242.729489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.208674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.373261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T17:31:42.208725Z","caller":"traceutil/trace.go:171","msg":"trace[1132562131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2104; }","duration":"245.441712ms","start":"2026-05-05T17:31:41.963269Z","end":"2026-05-05T17:31:42.208711Z","steps":["trace[1132562131] 'agreement among raft nodes before linearized reading' (duration: 245.270848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.20879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.647569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T17:31:42.208911Z","caller":"traceutil/trace.go:171","msg":"trace[573933070] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2104; }","duration":"382.880054ms","start":"2026-05-05T17:31:41.826009Z","end":"2026-05-05T17:31:42.208889Z","steps":["trace[573933070] 'agreement among raft nodes before linearized reading' (duration: 382.372183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.208831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.060807ms","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-05-05T17:31:42.209007Z","caller":"traceutil/trace.go:171","msg":"trace[1636378281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2104; }","duration":"246.261961ms","start":"2026-05-05T17:31:41.96273Z","end":"2026-05-05T17:31:42.208992Z","steps":["trace[1636378281] 'agreement among raft nodes before linearized reading' (duration: 245.993684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.208984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:41.825993Z","time spent":"382.979146ms","remote":"127.0.0.1:58830","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-05-05T17:31:42.60828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.948054ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:31:42.609289Z","caller":"traceutil/trace.go:171","msg":"trace[652827905] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"394.376741ms","start":"2026-05-05T17:31:42.214888Z","end":"2026-05-05T17:31:42.609265Z","steps":["trace[652827905] 'process raft request' (duration: 201.324041ms)","trace[652827905] 'compare' (duration: 191.783971ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:42.609328Z","caller":"traceutil/trace.go:171","msg":"trace[519620374] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"394.097695ms","start":"2026-05-05T17:31:42.215209Z","end":"2026-05-05T17:31:42.609307Z","steps":["trace[519620374] 'process raft request' (duration: 393.805309ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:42.6094Z","caller":"traceutil/trace.go:171","msg":"trace[1197917185] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"393.902231ms","start":"2026-05-05T17:31:42.215386Z","end":"2026-05-05T17:31:42.609289Z","steps":["trace[1197917185] 'process raft request' (duration: 393.659055ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:42.609382Z","caller":"traceutil/trace.go:171","msg":"trace[1083454698] linearizableReadLoop","detail":"{readStateIndex:2190; appliedIndex:2186; }","duration":"234.658009ms","start":"2026-05-05T17:31:42.374628Z","end":"2026-05-05T17:31:42.609286Z","steps":["trace[1083454698] 'read index received' (duration: 41.514747ms)","trace[1083454698] 'applied index is now lower than readState.Index' (duration: 193.137392ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:42.609351Z","caller":"traceutil/trace.go:171","msg":"trace[1176595865] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"394.098145ms","start":"2026-05-05T17:31:42.21519Z","end":"2026-05-05T17:31:42.609289Z","steps":["trace[1176595865] 'process raft request' (duration: 393.214224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.609529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:42.215164Z","time spent":"394.32268ms","remote":"127.0.0.1:58830","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-05-05T17:31:42.6096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:42.215181Z","time spent":"394.235078ms","remote":"127.0.0.1:58830","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-05-05T17:31:42.609529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:42.215133Z","time spent":"394.307309ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:31:42.609688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.043098ms","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-05-05T17:31:42.609794Z","caller":"traceutil/trace.go:171","msg":"trace[2006196550] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2109; }","duration":"235.202272ms","start":"2026-05-05T17:31:42.374565Z","end":"2026-05-05T17:31:42.609767Z","steps":["trace[2006196550] 'agreement among raft nodes before linearized reading' (duration: 234.905565ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:42.611052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:42.214866Z","time spent":"394.470753ms","remote":"127.0.0.1:58830","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-05-05T17:31:42.613713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.477394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:31:42.613774Z","caller":"traceutil/trace.go:171","msg":"trace[311863192] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2109; }","duration":"181.613626ms","start":"2026-05-05T17:31:42.432146Z","end":"2026-05-05T17:31:42.61376Z","steps":["trace[311863192] 'agreement among raft nodes before linearized reading' (duration: 181.507014ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:43.044896Z","caller":"traceutil/trace.go:171","msg":"trace[429646289] linearizableReadLoop","detail":"{readStateIndex:2192; appliedIndex:2191; }","duration":"360.549268ms","start":"2026-05-05T17:31:42.684318Z","end":"2026-05-05T17:31:43.044868Z","steps":["trace[429646289] 'read index received' (duration: 360.387024ms)","trace[429646289] 'applied index is now lower than readState.Index' (duration: 160.494µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:43.045059Z","caller":"traceutil/trace.go:171","msg":"trace[1383756693] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"392.904444ms","start":"2026-05-05T17:31:42.652096Z","end":"2026-05-05T17:31:43.045Z","steps":["trace[1383756693] 'process raft request' (duration: 392.553586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:43.045327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:42.652081Z","time spent":"393.127748ms","remote":"127.0.0.1:58640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:31:43.045121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.777913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:31:43.045721Z","caller":"traceutil/trace.go:171","msg":"trace[272298235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2110; }","duration":"361.447268ms","start":"2026-05-05T17:31:42.68426Z","end":"2026-05-05T17:31:43.045707Z","steps":["trace[272298235] 'agreement among raft nodes before linearized reading' (duration: 360.775723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:43.045765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:42.684237Z","time spent":"361.51653ms","remote":"127.0.0.1:58570","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-05-05T17:31:43.064144Z","caller":"traceutil/trace.go:171","msg":"trace[730227717] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"217.21975ms","start":"2026-05-05T17:31:42.846897Z","end":"2026-05-05T17:31:43.064116Z","steps":["trace[730227717] 'process raft request' (duration: 216.740669ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:43.771638Z","caller":"traceutil/trace.go:171","msg":"trace[615000364] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"398.768115ms","start":"2026-05-05T17:31:43.372834Z","end":"2026-05-05T17:31:43.771602Z","steps":["trace[615000364] 'process raft request' (duration: 398.55333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:43.772013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:43.372803Z","time spent":"398.928579ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:31:44.521971Z","caller":"traceutil/trace.go:171","msg":"trace[364649378] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2194; }","duration":"904.110073ms","start":"2026-05-05T17:31:43.617835Z","end":"2026-05-05T17:31:44.521946Z","steps":["trace[364649378] 'read index received' (duration: 154.773822ms)","trace[364649378] 'applied index is now lower than readState.Index' (duration: 749.335381ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:31:44.522071Z","caller":"traceutil/trace.go:171","msg":"trace[1252502687] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"1.008174802s","start":"2026-05-05T17:31:43.513887Z","end":"2026-05-05T17:31:44.522062Z","steps":["trace[1252502687] 'process raft request' (duration: 1.007881265s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:44.522182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:43.513853Z","time spent":"1.008239054s","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:31:44.522396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.541835ms","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-05-05T17:31:44.522507Z","caller":"traceutil/trace.go:171","msg":"trace[1633624440] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2113; }","duration":"904.697408ms","start":"2026-05-05T17:31:43.617773Z","end":"2026-05-05T17:31:44.522471Z","steps":["trace[1633624440] 'agreement among raft nodes before linearized reading' (duration: 904.457183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:44.522553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:43.617755Z","time spent":"904.78819ms","remote":"127.0.0.1:56252","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-05-05T17:31:44.691081Z","caller":"traceutil/trace.go:171","msg":"trace[1119433505] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"487.004603ms","start":"2026-05-05T17:31:44.20405Z","end":"2026-05-05T17:31:44.691055Z","steps":["trace[1119433505] 'process raft request' (duration: 436.742834ms)","trace[1119433505] 'compare' (duration: 49.920431ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:31:44.69123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:44.204007Z","time spent":"487.141056ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:31:44.691304Z","caller":"traceutil/trace.go:171","msg":"trace[11074845] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2195; }","duration":"169.23711ms","start":"2026-05-05T17:31:44.522035Z","end":"2026-05-05T17:31:44.691272Z","steps":["trace[11074845] 'read index received' (duration: 118.680414ms)","trace[11074845] 'applied index is now lower than readState.Index' (duration: 50.555336ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:31:44.691632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.644542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T17:31:44.69167Z","caller":"traceutil/trace.go:171","msg":"trace[89256456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2115; }","duration":"443.685843ms","start":"2026-05-05T17:31:44.247975Z","end":"2026-05-05T17:31:44.691661Z","steps":["trace[89256456] 'agreement among raft nodes before linearized reading' (duration: 443.5526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:44.691692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:44.247904Z","time spent":"443.782644ms","remote":"127.0.0.1:58830","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-05-05T17:31:44.6918Z","caller":"traceutil/trace.go:171","msg":"trace[547951895] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"475.846607ms","start":"2026-05-05T17:31:44.215943Z","end":"2026-05-05T17:31:44.69179Z","steps":["trace[547951895] 'process raft request' (duration: 475.07667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:44.691849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:44.215887Z","time spent":"475.93612ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:31:45.337685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.337312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:31:45.338155Z","caller":"traceutil/trace.go:171","msg":"trace[13485223] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"638.775941ms","start":"2026-05-05T17:31:44.69935Z","end":"2026-05-05T17:31:45.338126Z","steps":["trace[13485223] 'process raft request' (duration: 638.71306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:45.338275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:44.699308Z","time spent":"638.913685ms","remote":"127.0.0.1:58830","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-05-05T17:31:45.33858Z","caller":"traceutil/trace.go:171","msg":"trace[1817089330] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"639.459096ms","start":"2026-05-05T17:31:44.699103Z","end":"2026-05-05T17:31:45.338562Z","steps":["trace[1817089330] 'process raft request' (duration: 638.850062ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:45.338606Z","caller":"traceutil/trace.go:171","msg":"trace[705901384] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"640.106342ms","start":"2026-05-05T17:31:44.698449Z","end":"2026-05-05T17:31:45.338555Z","steps":["trace[705901384] 'process raft request' (duration: 639.417737ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:31:45.338721Z","caller":"traceutil/trace.go:171","msg":"trace[436074747] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"639.551168ms","start":"2026-05-05T17:31:44.699157Z","end":"2026-05-05T17:31:45.338708Z","steps":["trace[436074747] 'process raft request' (duration: 638.847103ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:45.338809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:44.699128Z","time spent":"639.639251ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:31:45.339016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:44.698423Z","time spent":"640.332796ms","remote":"127.0.0.1:58830","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-05-05T17:31:45.338667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:44.699092Z","time spent":"639.531258ms","remote":"127.0.0.1:58830","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-05-05T17:31:45.33971Z","caller":"traceutil/trace.go:171","msg":"trace[1279292177] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"642.305191ms","start":"2026-05-05T17:31:44.697343Z","end":"2026-05-05T17:31:45.339648Z","steps":["trace[1279292177] 'process raft request' (duration: 428.863103ms)","trace[1279292177] 'compare' (duration: 210.676705ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:31:45.339954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:44.697327Z","time spent":"642.499505ms","remote":"127.0.0.1:58830","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-05-05T17:31:46.032696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.805972ms","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-05-05T17:31:46.032897Z","caller":"traceutil/trace.go:171","msg":"trace[1309262377] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2120; }","duration":"502.020047ms","start":"2026-05-05T17:31:45.530854Z","end":"2026-05-05T17:31:46.032874Z","steps":["trace[1309262377] 'range keys from in-memory index tree' (duration: 501.598737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:46.032986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:45.530778Z","time spent":"502.196521ms","remote":"127.0.0.1:56252","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-05-05T17:31:46.032756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.575646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:31:46.033207Z","caller":"traceutil/trace.go:171","msg":"trace[869023941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2120; }","duration":"350.090988ms","start":"2026-05-05T17:31:45.683107Z","end":"2026-05-05T17:31:46.033198Z","steps":["trace[869023941] 'range keys from in-memory index tree' (duration: 349.503935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:31:46.033249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:31:45.683089Z","time spent":"350.151309ms","remote":"127.0.0.1:58570","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-05-05T17:31:46.034105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.937627ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:31:46.034336Z","caller":"traceutil/trace.go:171","msg":"trace[658825411] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"249.469527ms","start":"2026-05-05T17:31:45.784847Z","end":"2026-05-05T17:31:46.034317Z","steps":["trace[658825411] 'process raft request' (duration: 126.216613ms)","trace[658825411] 'compare' (duration: 121.74118ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:33:16.182189Z","caller":"traceutil/trace.go:171","msg":"trace[673277085] transaction","detail":"{read_only:false; response_revision:2641; number_of_response:1; }","duration":"282.563196ms","start":"2026-05-05T17:33:15.899591Z","end":"2026-05-05T17:33:16.182154Z","steps":["trace[673277085] 'process raft request' (duration: 282.389172ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:16.190187Z","caller":"traceutil/trace.go:171","msg":"trace[1186679886] transaction","detail":"{read_only:false; response_revision:2643; number_of_response:1; }","duration":"288.535795ms","start":"2026-05-05T17:33:15.901619Z","end":"2026-05-05T17:33:16.190155Z","steps":["trace[1186679886] 'process raft request' (duration: 288.457594ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:16.190794Z","caller":"traceutil/trace.go:171","msg":"trace[953670556] transaction","detail":"{read_only:false; response_revision:2642; number_of_response:1; }","duration":"290.382448ms","start":"2026-05-05T17:33:15.900401Z","end":"2026-05-05T17:33:16.190783Z","steps":["trace[953670556] 'process raft request' (duration: 289.544463ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:25.204204Z","caller":"traceutil/trace.go:171","msg":"trace[1008100050] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"275.158838ms","start":"2026-05-05T17:33:24.929018Z","end":"2026-05-05T17:33:25.204177Z","steps":["trace[1008100050] 'process raft request' (duration: 275.010025ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:25.571789Z","caller":"traceutil/trace.go:171","msg":"trace[1059592654] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"475.786286ms","start":"2026-05-05T17:33:25.095976Z","end":"2026-05-05T17:33:25.571762Z","steps":["trace[1059592654] 'process raft request' (duration: 473.978053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:25.571966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:33:25.095947Z","time spent":"475.926149ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:33:25.571991Z","caller":"traceutil/trace.go:171","msg":"trace[28406688] linearizableReadLoop","detail":"{readStateIndex:2854; appliedIndex:2852; }","duration":"193.45882ms","start":"2026-05-05T17:33:25.378476Z","end":"2026-05-05T17:33:25.571935Z","steps":["trace[28406688] 'read index received' (duration: 191.480054ms)","trace[28406688] 'applied index is now lower than readState.Index' (duration: 1.975206ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:33:25.572187Z","caller":"traceutil/trace.go:171","msg":"trace[2049804334] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"470.931438ms","start":"2026-05-05T17:33:25.101236Z","end":"2026-05-05T17:33:25.572167Z","steps":["trace[2049804334] 'process raft request' (duration: 470.403798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:25.572274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.482109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:33:25.572318Z","caller":"traceutil/trace.go:171","msg":"trace[1191580631] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2749; }","duration":"162.54438ms","start":"2026-05-05T17:33:25.409758Z","end":"2026-05-05T17:33:25.572302Z","steps":["trace[1191580631] 'agreement among raft nodes before linearized reading' (duration: 162.476539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:25.572337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.868502ms","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":"warn","ts":"2026-05-05T17:33:25.572335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.832816ms","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":"warn","ts":"2026-05-05T17:33:25.572349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:33:25.101223Z","time spent":"471.014689ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:33:25.572394Z","caller":"traceutil/trace.go:171","msg":"trace[1350456572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2749; }","duration":"133.978594ms","start":"2026-05-05T17:33:25.4384Z","end":"2026-05-05T17:33:25.572379Z","steps":["trace[1350456572] 'agreement among raft nodes before linearized reading' (duration: 133.858451ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:25.572413Z","caller":"traceutil/trace.go:171","msg":"trace[1327816547] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2749; }","duration":"193.962059ms","start":"2026-05-05T17:33:25.378429Z","end":"2026-05-05T17:33:25.572391Z","steps":["trace[1327816547] 'agreement among raft nodes before linearized reading' (duration: 193.813936ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:51.851269Z","caller":"traceutil/trace.go:171","msg":"trace[244773517] transaction","detail":"{read_only:false; response_revision:2895; number_of_response:1; }","duration":"166.631925ms","start":"2026-05-05T17:33:51.684605Z","end":"2026-05-05T17:33:51.851237Z","steps":["trace[244773517] 'process raft request' (duration: 158.051673ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:51.869538Z","caller":"traceutil/trace.go:171","msg":"trace[775292373] transaction","detail":"{read_only:false; response_revision:2896; number_of_response:1; }","duration":"160.59393ms","start":"2026-05-05T17:33:51.708924Z","end":"2026-05-05T17:33:51.869518Z","steps":["trace[775292373] 'process raft request' (duration: 160.482838ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:57.599598Z","caller":"traceutil/trace.go:171","msg":"trace[491251706] linearizableReadLoop","detail":"{readStateIndex:3035; appliedIndex:3034; }","duration":"201.72555ms","start":"2026-05-05T17:33:57.397854Z","end":"2026-05-05T17:33:57.599579Z","steps":["trace[491251706] 'read index received' (duration: 201.554097ms)","trace[491251706] 'applied index is now lower than readState.Index' (duration: 170.693µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:33:57.599732Z","caller":"traceutil/trace.go:171","msg":"trace[31243787] transaction","detail":"{read_only:false; response_revision:2924; number_of_response:1; }","duration":"216.623063ms","start":"2026-05-05T17:33:57.383055Z","end":"2026-05-05T17:33:57.599678Z","steps":["trace[31243787] 'process raft request' (duration: 216.402929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:57.599798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.927114ms","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-05-05T17:33:57.600032Z","caller":"traceutil/trace.go:171","msg":"trace[1120771811] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:2924; }","duration":"202.230649ms","start":"2026-05-05T17:33:57.397792Z","end":"2026-05-05T17:33:57.600022Z","steps":["trace[1120771811] 'agreement among raft nodes before linearized reading' (duration: 201.859083ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:57.918072Z","caller":"traceutil/trace.go:171","msg":"trace[848563577] linearizableReadLoop","detail":"{readStateIndex:3037; appliedIndex:3035; }","duration":"136.046245ms","start":"2026-05-05T17:33:57.782005Z","end":"2026-05-05T17:33:57.918051Z","steps":["trace[848563577] 'read index received' (duration: 90.654947ms)","trace[848563577] 'applied index is now lower than readState.Index' (duration: 45.390628ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:33:57.918105Z","caller":"traceutil/trace.go:171","msg":"trace[1277705604] transaction","detail":"{read_only:false; response_revision:2925; number_of_response:1; }","duration":"206.913773ms","start":"2026-05-05T17:33:57.711154Z","end":"2026-05-05T17:33:57.918067Z","steps":["trace[1277705604] 'process raft request' (duration: 206.799511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:57.918232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.220968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18acbbc75958490d\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-05-05T17:33:57.918268Z","caller":"traceutil/trace.go:171","msg":"trace[1556497820] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18acbbc75958490d; range_end:; response_count:1; response_revision:2925; }","duration":"136.33997ms","start":"2026-05-05T17:33:57.781918Z","end":"2026-05-05T17:33:57.918258Z","steps":["trace[1556497820] 'agreement among raft nodes before linearized reading' (duration: 136.214508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:57.918207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:33:57.601382Z","time spent":"316.820727ms","remote":"127.0.0.1:58604","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-05T17:33:58.381077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.586021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T17:33:58.381197Z","caller":"traceutil/trace.go:171","msg":"trace[1627799216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2928; }","duration":"257.764395ms","start":"2026-05-05T17:33:58.123407Z","end":"2026-05-05T17:33:58.381171Z","steps":["trace[1627799216] 'range keys from in-memory index tree' (duration: 257.306936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:58.381763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.777359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:33:58.38181Z","caller":"traceutil/trace.go:171","msg":"trace[1763181991] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2928; }","duration":"259.867621ms","start":"2026-05-05T17:33:58.121931Z","end":"2026-05-05T17:33:58.381799Z","steps":["trace[1763181991] 'range keys from in-memory index tree' (duration: 259.655337ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:58.384266Z","caller":"traceutil/trace.go:171","msg":"trace[1624869747] transaction","detail":"{read_only:false; response_revision:2929; number_of_response:1; }","duration":"142.867503ms","start":"2026-05-05T17:33:58.241377Z","end":"2026-05-05T17:33:58.384244Z","steps":["trace[1624869747] 'process raft request' (duration: 142.744301ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:58.773148Z","caller":"traceutil/trace.go:171","msg":"trace[278405086] linearizableReadLoop","detail":"{readStateIndex:3043; appliedIndex:3041; }","duration":"355.078347ms","start":"2026-05-05T17:33:58.41805Z","end":"2026-05-05T17:33:58.773128Z","steps":["trace[278405086] 'read index received' (duration: 306.37572ms)","trace[278405086] 'applied index is now lower than readState.Index' (duration: 48.701927ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:33:58.773878Z","caller":"traceutil/trace.go:171","msg":"trace[168286918] transaction","detail":"{read_only:false; response_revision:2932; number_of_response:1; }","duration":"151.604986ms","start":"2026-05-05T17:33:58.622259Z","end":"2026-05-05T17:33:58.773864Z","steps":["trace[168286918] 'process raft request' (duration: 150.843893ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:58.774077Z","caller":"traceutil/trace.go:171","msg":"trace[1153832133] transaction","detail":"{read_only:false; response_revision:2930; number_of_response:1; }","duration":"387.261392ms","start":"2026-05-05T17:33:58.386799Z","end":"2026-05-05T17:33:58.77406Z","steps":["trace[1153832133] 'process raft request' (duration: 337.602199ms)","trace[1153832133] 'compare' (duration: 48.485393ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:33:58.774262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.962767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-05T17:33:58.77431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.607367ms","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-05-05T17:33:58.774391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.329118ms","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-05-05T17:33:58.774415Z","caller":"traceutil/trace.go:171","msg":"trace[95536974] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2932; }","duration":"279.779591ms","start":"2026-05-05T17:33:58.494615Z","end":"2026-05-05T17:33:58.774395Z","steps":["trace[95536974] 'agreement among raft nodes before linearized reading' (duration: 279.530936ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:33:58.774446Z","caller":"traceutil/trace.go:171","msg":"trace[563562071] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2932; }","duration":"356.426639ms","start":"2026-05-05T17:33:58.418006Z","end":"2026-05-05T17:33:58.774433Z","steps":["trace[563562071] 'agreement among raft nodes before linearized reading' (duration: 356.299057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:58.774487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:33:58.417993Z","time spent":"356.484411ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T17:33:58.774382Z","caller":"traceutil/trace.go:171","msg":"trace[832818857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2932; }","duration":"350.145939ms","start":"2026-05-05T17:33:58.424216Z","end":"2026-05-05T17:33:58.774362Z","steps":["trace[832818857] 'agreement among raft nodes before linearized reading' (duration: 349.766842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:58.774605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.87451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:33:58.774647Z","caller":"traceutil/trace.go:171","msg":"trace[928918177] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2932; }","duration":"222.956452ms","start":"2026-05-05T17:33:58.551679Z","end":"2026-05-05T17:33:58.774635Z","steps":["trace[928918177] 'agreement among raft nodes before linearized reading' (duration: 222.85959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:58.774615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:33:58.424194Z","time spent":"350.406464ms","remote":"127.0.0.1:58830","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":"info","ts":"2026-05-05T17:33:58.775147Z","caller":"traceutil/trace.go:171","msg":"trace[1831355317] transaction","detail":"{read_only:false; response_revision:2931; number_of_response:1; }","duration":"387.615029ms","start":"2026-05-05T17:33:58.387513Z","end":"2026-05-05T17:33:58.775128Z","steps":["trace[1831355317] 'process raft request' (duration: 385.557843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:58.775263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:33:58.387506Z","time spent":"387.67959ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:33:58.774503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:33:58.386782Z","time spent":"387.335913ms","remote":"127.0.0.1:58830","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-05-05T17:33:58.775733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.664675ms","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-05-05T17:33:58.775764Z","caller":"traceutil/trace.go:171","msg":"trace[1586831578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2932; }","duration":"347.718667ms","start":"2026-05-05T17:33:58.428038Z","end":"2026-05-05T17:33:58.775756Z","steps":["trace[1586831578] 'agreement among raft nodes before linearized reading' (duration: 347.636766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:33:58.775788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:33:58.428026Z","time spent":"347.756807ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-05T17:34:03.919287Z","caller":"traceutil/trace.go:171","msg":"trace[1912009809] linearizableReadLoop","detail":"{readStateIndex:3069; appliedIndex:3068; }","duration":"235.146153ms","start":"2026-05-05T17:34:03.684107Z","end":"2026-05-05T17:34:03.919253Z","steps":["trace[1912009809] 'read index received' (duration: 234.584194ms)","trace[1912009809] 'applied index is now lower than readState.Index' (duration: 560.419µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:34:03.919393Z","caller":"traceutil/trace.go:171","msg":"trace[565785699] transaction","detail":"{read_only:false; response_revision:2956; number_of_response:1; }","duration":"299.37548ms","start":"2026-05-05T17:34:03.619922Z","end":"2026-05-05T17:34:03.919298Z","steps":["trace[565785699] 'process raft request' (duration: 298.78714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:34:03.9196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.470288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:34:03.919689Z","caller":"traceutil/trace.go:171","msg":"trace[225311275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2956; }","duration":"235.612221ms","start":"2026-05-05T17:34:03.684056Z","end":"2026-05-05T17:34:03.919668Z","steps":["trace[225311275] 'agreement among raft nodes before linearized reading' (duration: 235.345417ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:34:23.072233Z","caller":"traceutil/trace.go:171","msg":"trace[1927838345] transaction","detail":"{read_only:false; response_revision:3058; number_of_response:1; }","duration":"114.738432ms","start":"2026-05-05T17:34:22.957448Z","end":"2026-05-05T17:34:23.072187Z","steps":["trace[1927838345] 'process raft request' (duration: 114.365636ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:35:46.497161Z","caller":"traceutil/trace.go:171","msg":"trace[900314219] transaction","detail":"{read_only:false; response_revision:3502; number_of_response:1; }","duration":"119.809741ms","start":"2026-05-05T17:35:46.377315Z","end":"2026-05-05T17:35:46.497125Z","steps":["trace[900314219] 'process raft request' (duration: 78.570151ms)","trace[900314219] 'compare' (duration: 41.120767ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:35:46.5235Z","caller":"traceutil/trace.go:171","msg":"trace[1475099750] transaction","detail":"{read_only:false; response_revision:3503; number_of_response:1; }","duration":"102.499973ms","start":"2026-05-05T17:35:46.420946Z","end":"2026-05-05T17:35:46.523446Z","steps":["trace[1475099750] 'process raft request' (duration: 102.40139ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:35:46.523523Z","caller":"traceutil/trace.go:171","msg":"trace[7434363] transaction","detail":"{read_only:false; number_of_response:1; response_revision:3502; }","duration":"131.942161ms","start":"2026-05-05T17:35:46.391547Z","end":"2026-05-05T17:35:46.523489Z","steps":["trace[7434363] 'process raft request' (duration: 131.680454ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:35:59.551277Z","caller":"traceutil/trace.go:171","msg":"trace[32231749] transaction","detail":"{read_only:false; response_revision:3644; number_of_response:1; }","duration":"117.379401ms","start":"2026-05-05T17:35:59.433867Z","end":"2026-05-05T17:35:59.551247Z","steps":["trace[32231749] 'process raft request' (duration: 117.201067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:36:23.663985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.901331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:36:23.664103Z","caller":"traceutil/trace.go:171","msg":"trace[1424399802] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:3777; }","duration":"150.064125ms","start":"2026-05-05T17:36:23.514015Z","end":"2026-05-05T17:36:23.664079Z","steps":["trace[1424399802] 'count revisions from in-memory index tree' (duration: 149.821868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:36:23.664252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.892653ms","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-05-05T17:36:23.664345Z","caller":"traceutil/trace.go:171","msg":"trace[842437653] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:3777; }","duration":"110.083358ms","start":"2026-05-05T17:36:23.554241Z","end":"2026-05-05T17:36:23.664325Z","steps":["trace[842437653] 'count revisions from in-memory index tree' (duration: 109.76488ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:36.543223Z","caller":"traceutil/trace.go:171","msg":"trace[2116490581] transaction","detail":"{read_only:false; response_revision:4589; number_of_response:1; }","duration":"113.773875ms","start":"2026-05-05T17:37:36.429117Z","end":"2026-05-05T17:37:36.542891Z","steps":["trace[2116490581] 'process raft request' (duration: 113.612761ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:39.136932Z","caller":"traceutil/trace.go:171","msg":"trace[1015863160] transaction","detail":"{read_only:false; response_revision:4621; number_of_response:1; }","duration":"152.257548ms","start":"2026-05-05T17:37:38.984643Z","end":"2026-05-05T17:37:39.136901Z","steps":["trace[1015863160] 'process raft request' (duration: 148.518314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:42.509664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.740679ms","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-05-05T17:37:42.509646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.133317ms","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-05-05T17:37:42.509758Z","caller":"traceutil/trace.go:171","msg":"trace[1385088496] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4740; }","duration":"150.885722ms","start":"2026-05-05T17:37:42.358851Z","end":"2026-05-05T17:37:42.509737Z","steps":["trace[1385088496] 'range keys from in-memory index tree' (duration: 150.549646ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:42.509782Z","caller":"traceutil/trace.go:171","msg":"trace[1908053712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4740; }","duration":"159.340212ms","start":"2026-05-05T17:37:42.350422Z","end":"2026-05-05T17:37:42.509762Z","steps":["trace[1908053712] 'range keys from in-memory index tree' (duration: 158.887652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:42.509671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.155411ms","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-05-05T17:37:42.510638Z","caller":"traceutil/trace.go:171","msg":"trace[699357636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4740; }","duration":"170.162654ms","start":"2026-05-05T17:37:42.340451Z","end":"2026-05-05T17:37:42.510613Z","steps":["trace[699357636] 'range keys from in-memory index tree' (duration: 168.906466ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:45.440081Z","caller":"traceutil/trace.go:171","msg":"trace[1658455235] linearizableReadLoop","detail":"{readStateIndex:4996; appliedIndex:4995; }","duration":"227.615167ms","start":"2026-05-05T17:37:45.21244Z","end":"2026-05-05T17:37:45.440055Z","steps":["trace[1658455235] 'read index received' (duration: 221.366957ms)","trace[1658455235] 'applied index is now lower than readState.Index' (duration: 6.24665ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:37:45.440362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.877993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:37:45.440442Z","caller":"traceutil/trace.go:171","msg":"trace[89316606] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4809; }","duration":"227.998896ms","start":"2026-05-05T17:37:45.212424Z","end":"2026-05-05T17:37:45.440423Z","steps":["trace[89316606] 'agreement among raft nodes before linearized reading' (duration: 227.846533ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:45.440705Z","caller":"traceutil/trace.go:171","msg":"trace[1927029765] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"230.201294ms","start":"2026-05-05T17:37:45.210488Z","end":"2026-05-05T17:37:45.44069Z","steps":["trace[1927029765] 'process raft request' (duration: 223.386803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:45.440743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.164939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-df3c3294-f82c-4e41-bdf1-8320428b22f9\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-05-05T17:37:45.441047Z","caller":"traceutil/trace.go:171","msg":"trace[1737512583] range","detail":"{range_begin:/registry/persistentvolumes/pvc-df3c3294-f82c-4e41-bdf1-8320428b22f9; range_end:; response_count:1; response_revision:4809; }","duration":"228.473285ms","start":"2026-05-05T17:37:45.212555Z","end":"2026-05-05T17:37:45.441028Z","steps":["trace[1737512583] 'agreement among raft nodes before linearized reading' (duration: 228.081917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:45.441606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.964381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-05-05T17:37:45.441655Z","caller":"traceutil/trace.go:171","msg":"trace[1636720455] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4809; }","duration":"147.034232ms","start":"2026-05-05T17:37:45.29461Z","end":"2026-05-05T17:37:45.441644Z","steps":["trace[1636720455] 'agreement among raft nodes before linearized reading' (duration: 146.918119ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:46.388751Z","caller":"traceutil/trace.go:171","msg":"trace[567218832] linearizableReadLoop","detail":"{readStateIndex:5012; appliedIndex:5011; }","duration":"223.014767ms","start":"2026-05-05T17:37:46.165712Z","end":"2026-05-05T17:37:46.388727Z","steps":["trace[567218832] 'read index received' (duration: 221.002423ms)","trace[567218832] 'applied index is now lower than readState.Index' (duration: 2.011374ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:37:46.388801Z","caller":"traceutil/trace.go:171","msg":"trace[1849008902] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"281.726872ms","start":"2026-05-05T17:37:46.107054Z","end":"2026-05-05T17:37:46.388781Z","steps":["trace[1849008902] 'process raft request' (duration: 279.645936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:46.389003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.269632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T17:37:46.389045Z","caller":"traceutil/trace.go:171","msg":"trace[1520024833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4825; }","duration":"223.384215ms","start":"2026-05-05T17:37:46.165651Z","end":"2026-05-05T17:37:46.389035Z","steps":["trace[1520024833] 'agreement among raft nodes before linearized reading' (duration: 223.19661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:46.38909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.914119ms","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-05-05T17:37:46.389119Z","caller":"traceutil/trace.go:171","msg":"trace[752278711] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4825; }","duration":"103.993402ms","start":"2026-05-05T17:37:46.285119Z","end":"2026-05-05T17:37:46.389113Z","steps":["trace[752278711] 'agreement among raft nodes before linearized reading' (duration: 103.890559ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:52.196074Z","caller":"traceutil/trace.go:171","msg":"trace[604278514] linearizableReadLoop","detail":"{readStateIndex:5116; appliedIndex:5115; }","duration":"318.069849ms","start":"2026-05-05T17:37:51.877978Z","end":"2026-05-05T17:37:52.196047Z","steps":["trace[604278514] 'read index received' (duration: 317.842404ms)","trace[604278514] 'applied index is now lower than readState.Index' (duration: 226.445µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:37:52.196194Z","caller":"traceutil/trace.go:171","msg":"trace[1452269210] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"337.990809ms","start":"2026-05-05T17:37:51.858177Z","end":"2026-05-05T17:37:52.196167Z","steps":["trace[1452269210] 'process raft request' (duration: 337.705182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:52.196329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:37:51.858148Z","time spent":"338.106191ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:37:52.196337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.335675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eec5d362-a343-4db9-ab9a-da5cc7336354\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-05-05T17:37:52.196358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.275304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-5787b6bf64-rz9sm.18acbc0246e00e46\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-05-05T17:37:52.196403Z","caller":"traceutil/trace.go:171","msg":"trace[1481394748] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eec5d362-a343-4db9-ab9a-da5cc7336354; range_end:; response_count:1; response_revision:4928; }","duration":"318.415667ms","start":"2026-05-05T17:37:51.877973Z","end":"2026-05-05T17:37:52.196389Z","steps":["trace[1481394748] 'agreement among raft nodes before linearized reading' (duration: 318.227702ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:52.196427Z","caller":"traceutil/trace.go:171","msg":"trace[860387017] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-5787b6bf64-rz9sm.18acbc0246e00e46; range_end:; response_count:1; response_revision:4928; }","duration":"318.378847ms","start":"2026-05-05T17:37:51.878035Z","end":"2026-05-05T17:37:52.196414Z","steps":["trace[860387017] 'agreement among raft nodes before linearized reading' (duration: 318.162041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:52.196481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:37:51.878029Z","time spent":"318.440108ms","remote":"127.0.0.1:58640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":920,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-5787b6bf64-rz9sm.18acbc0246e00e46\" "} {"level":"warn","ts":"2026-05-05T17:37:52.196487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.078712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-05T17:37:52.196434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:37:51.877959Z","time spent":"318.468438ms","remote":"127.0.0.1:58764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eec5d362-a343-4db9-ab9a-da5cc7336354\" "} {"level":"info","ts":"2026-05-05T17:37:52.196546Z","caller":"traceutil/trace.go:171","msg":"trace[2143010340] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:4928; }","duration":"295.183904ms","start":"2026-05-05T17:37:51.901347Z","end":"2026-05-05T17:37:52.196531Z","steps":["trace[2143010340] 'agreement among raft nodes before linearized reading' (duration: 295.084182ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:52.412961Z","caller":"traceutil/trace.go:171","msg":"trace[1940987325] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"213.795975ms","start":"2026-05-05T17:37:52.19913Z","end":"2026-05-05T17:37:52.412926Z","steps":["trace[1940987325] 'process raft request' (duration: 158.652138ms)","trace[1940987325] 'compare' (duration: 55.053955ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:37:52.443892Z","caller":"traceutil/trace.go:171","msg":"trace[727470693] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"239.696898ms","start":"2026-05-05T17:37:52.204173Z","end":"2026-05-05T17:37:52.44387Z","steps":["trace[727470693] 'process raft request' (duration: 239.576555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:37:52.993657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.571773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-5787b6bf64-rz9sm.18acbc0246e00e46\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-05-05T17:37:52.993747Z","caller":"traceutil/trace.go:171","msg":"trace[2089364918] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-5787b6bf64-rz9sm.18acbc0246e00e46; range_end:; response_count:1; response_revision:4936; }","duration":"112.724716ms","start":"2026-05-05T17:37:52.880997Z","end":"2026-05-05T17:37:52.993722Z","steps":["trace[2089364918] 'range keys from in-memory index tree' (duration: 112.385389ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:53.143258Z","caller":"traceutil/trace.go:171","msg":"trace[1679727412] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"146.926127ms","start":"2026-05-05T17:37:52.996301Z","end":"2026-05-05T17:37:53.143227Z","steps":["trace[1679727412] 'process raft request' (duration: 146.757542ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:37:56.186972Z","caller":"traceutil/trace.go:171","msg":"trace[2055012402] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"262.130535ms","start":"2026-05-05T17:37:55.924817Z","end":"2026-05-05T17:37:56.186948Z","steps":["trace[2055012402] 'process raft request' (duration: 261.86557ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:02.534825Z","caller":"traceutil/trace.go:171","msg":"trace[1618323484] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"296.360757ms","start":"2026-05-05T17:38:02.238445Z","end":"2026-05-05T17:38:02.534806Z","steps":["trace[1618323484] 'process raft request' (duration: 293.622957ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:07.287574Z","caller":"traceutil/trace.go:171","msg":"trace[1119597762] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"113.254454ms","start":"2026-05-05T17:38:07.174284Z","end":"2026-05-05T17:38:07.287538Z","steps":["trace[1119597762] 'process raft request' (duration: 112.985567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.457733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.853372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:38:08.458054Z","caller":"traceutil/trace.go:171","msg":"trace[685739651] transaction","detail":"{read_only:false; response_revision:5121; number_of_response:1; }","duration":"1.137995883s","start":"2026-05-05T17:38:07.320033Z","end":"2026-05-05T17:38:08.458029Z","steps":["trace[685739651] 'process raft request' (duration: 451.765323ms)","trace[685739651] 'compare' (duration: 685.540966ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:38:08.458187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:38:07.320008Z","time spent":"1.138133456s","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:38:08.481014Z","caller":"traceutil/trace.go:171","msg":"trace[1772565239] linearizableReadLoop","detail":"{readStateIndex:5318; appliedIndex:5315; }","duration":"1.066908524s","start":"2026-05-05T17:38:07.414087Z","end":"2026-05-05T17:38:08.480996Z","steps":["trace[1772565239] 'read index received' (duration: 357.707896ms)","trace[1772565239] 'applied index is now lower than readState.Index' (duration: 709.199698ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:38:08.481075Z","caller":"traceutil/trace.go:171","msg":"trace[1032998616] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"1.160991701s","start":"2026-05-05T17:38:07.320059Z","end":"2026-05-05T17:38:08.481051Z","steps":["trace[1032998616] 'process raft request' (duration: 1.160790707s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.482098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:38:07.320042Z","time spent":"1.162012684s","remote":"127.0.0.1:58830","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-05-05T17:38:08.481297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0671959s","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-05-05T17:38:08.482295Z","caller":"traceutil/trace.go:171","msg":"trace[241679897] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:5123; }","duration":"1.068207082s","start":"2026-05-05T17:38:07.414043Z","end":"2026-05-05T17:38:08.48225Z","steps":["trace[241679897] 'agreement among raft nodes before linearized reading' (duration: 1.067100818s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.482363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:38:07.414026Z","time spent":"1.068324184s","remote":"127.0.0.1:58604","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-05-05T17:38:08.481372Z","caller":"traceutil/trace.go:171","msg":"trace[739396640] transaction","detail":"{read_only:false; response_revision:5123; number_of_response:1; }","duration":"1.140339514s","start":"2026-05-05T17:38:07.341017Z","end":"2026-05-05T17:38:08.481357Z","steps":["trace[739396640] 'process raft request' (duration: 1.139939235s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.482652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:38:07.340991Z","time spent":"1.141622172s","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:38:08.481562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.949347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:38:08.482826Z","caller":"traceutil/trace.go:171","msg":"trace[1424861587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5123; }","duration":"780.251875ms","start":"2026-05-05T17:38:07.702564Z","end":"2026-05-05T17:38:08.482816Z","steps":["trace[1424861587] 'agreement among raft nodes before linearized reading' (duration: 778.967688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.482915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:38:07.702542Z","time spent":"780.325757ms","remote":"127.0.0.1:58570","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-05-05T17:38:08.481696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.851627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13878"} {"level":"info","ts":"2026-05-05T17:38:08.483087Z","caller":"traceutil/trace.go:171","msg":"trace[202008632] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5123; }","duration":"461.278238ms","start":"2026-05-05T17:38:08.0218Z","end":"2026-05-05T17:38:08.483078Z","steps":["trace[202008632] 'agreement among raft nodes before linearized reading' (duration: 459.811126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.483134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:38:08.02178Z","time spent":"461.34446ms","remote":"127.0.0.1:58764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":13900,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-05T17:38:08.481717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.090249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-05T17:38:08.483373Z","caller":"traceutil/trace.go:171","msg":"trace[464484986] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5123; }","duration":"379.791816ms","start":"2026-05-05T17:38:08.103569Z","end":"2026-05-05T17:38:08.483361Z","steps":["trace[464484986] 'agreement among raft nodes before linearized reading' (duration: 377.999897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.483421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:38:08.103555Z","time spent":"379.856087ms","remote":"127.0.0.1:58724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-05T17:38:08.481779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.532809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:38:08.483639Z","caller":"traceutil/trace.go:171","msg":"trace[252210214] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:5123; }","duration":"184.43159ms","start":"2026-05-05T17:38:08.299188Z","end":"2026-05-05T17:38:08.483619Z","steps":["trace[252210214] 'agreement among raft nodes before linearized reading' (duration: 182.569789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.482006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.753276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T17:38:08.483909Z","caller":"traceutil/trace.go:171","msg":"trace[1069001178] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5123; }","duration":"498.691408ms","start":"2026-05-05T17:38:07.985203Z","end":"2026-05-05T17:38:08.483895Z","steps":["trace[1069001178] 'agreement among raft nodes before linearized reading' (duration: 496.517531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.484017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:38:07.985179Z","time spent":"498.820661ms","remote":"127.0.0.1:58640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":510,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-05-05T17:38:08.602841Z","caller":"traceutil/trace.go:171","msg":"trace[1838598321] linearizableReadLoop","detail":"{readStateIndex:5321; appliedIndex:5320; }","duration":"107.138177ms","start":"2026-05-05T17:38:08.495677Z","end":"2026-05-05T17:38:08.602816Z","steps":["trace[1838598321] 'read index received' (duration: 100.882632ms)","trace[1838598321] 'applied index is now lower than readState.Index' (duration: 6.254275ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:38:08.602924Z","caller":"traceutil/trace.go:171","msg":"trace[178202732] transaction","detail":"{read_only:false; response_revision:5125; number_of_response:1; }","duration":"108.145148ms","start":"2026-05-05T17:38:08.494739Z","end":"2026-05-05T17:38:08.602884Z","steps":["trace[178202732] 'process raft request' (duration: 101.809902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.603195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.494255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T17:38:08.603242Z","caller":"traceutil/trace.go:171","msg":"trace[1255710270] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:5125; }","duration":"107.570157ms","start":"2026-05-05T17:38:08.495659Z","end":"2026-05-05T17:38:08.603229Z","steps":["trace[1255710270] 'agreement among raft nodes before linearized reading' (duration: 107.23894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.610126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.971466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-eec5d362-a343-4db9-ab9a-da5cc7336354\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-05-05T17:38:08.610171Z","caller":"traceutil/trace.go:171","msg":"trace[1914407452] range","detail":"{range_begin:/registry/persistentvolumes/pvc-eec5d362-a343-4db9-ab9a-da5cc7336354; range_end:; response_count:1; response_revision:5126; }","duration":"114.028157ms","start":"2026-05-05T17:38:08.496133Z","end":"2026-05-05T17:38:08.610161Z","steps":["trace[1914407452] 'agreement among raft nodes before linearized reading' (duration: 113.945415ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:08.867516Z","caller":"traceutil/trace.go:171","msg":"trace[2015828973] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"190.47622ms","start":"2026-05-05T17:38:08.676972Z","end":"2026-05-05T17:38:08.867449Z","steps":["trace[2015828973] 'process raft request' (duration: 190.117941ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:08.867529Z","caller":"traceutil/trace.go:171","msg":"trace[363341772] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"190.44717ms","start":"2026-05-05T17:38:08.677049Z","end":"2026-05-05T17:38:08.867496Z","steps":["trace[363341772] 'process raft request' (duration: 190.277546ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:08.867749Z","caller":"traceutil/trace.go:171","msg":"trace[584038486] transaction","detail":"{read_only:false; response_revision:5132; number_of_response:1; }","duration":"190.44233ms","start":"2026-05-05T17:38:08.677275Z","end":"2026-05-05T17:38:08.867717Z","steps":["trace[584038486] 'process raft request' (duration: 190.116183ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:08.867864Z","caller":"traceutil/trace.go:171","msg":"trace[1994221206] transaction","detail":"{read_only:false; response_revision:5133; number_of_response:1; }","duration":"189.322166ms","start":"2026-05-05T17:38:08.678514Z","end":"2026-05-05T17:38:08.867836Z","steps":["trace[1994221206] 'process raft request' (duration: 188.934388ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:08.867954Z","caller":"traceutil/trace.go:171","msg":"trace[1219544291] transaction","detail":"{read_only:false; response_revision:5134; number_of_response:1; }","duration":"175.65061ms","start":"2026-05-05T17:38:08.69229Z","end":"2026-05-05T17:38:08.86794Z","steps":["trace[1219544291] 'process raft request' (duration: 175.239302ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:08.868237Z","caller":"traceutil/trace.go:171","msg":"trace[882739777] linearizableReadLoop","detail":"{readStateIndex:5330; appliedIndex:5325; }","duration":"112.036814ms","start":"2026-05-05T17:38:08.755548Z","end":"2026-05-05T17:38:08.867585Z","steps":["trace[882739777] 'read index received' (duration: 111.4384ms)","trace[882739777] 'applied index is now lower than readState.Index' (duration: 597.224µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:38:08.868227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.658237ms","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-05-05T17:38:08.868474Z","caller":"traceutil/trace.go:171","msg":"trace[1450802251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5134; }","duration":"112.934843ms","start":"2026-05-05T17:38:08.755504Z","end":"2026-05-05T17:38:08.868439Z","steps":["trace[1450802251] 'agreement among raft nodes before linearized reading' (duration: 112.569015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.868582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.75865ms","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-05-05T17:38:08.869569Z","caller":"traceutil/trace.go:171","msg":"trace[1080388588] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5134; }","duration":"113.782791ms","start":"2026-05-05T17:38:08.755771Z","end":"2026-05-05T17:38:08.869554Z","steps":["trace[1080388588] 'agreement among raft nodes before linearized reading' (duration: 112.672797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:08.86872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.289414ms","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-05-05T17:38:08.870174Z","caller":"traceutil/trace.go:171","msg":"trace[2026447974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5134; }","duration":"110.784287ms","start":"2026-05-05T17:38:08.759376Z","end":"2026-05-05T17:38:08.87016Z","steps":["trace[2026447974] 'agreement among raft nodes before linearized reading' (duration: 109.195182ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:09.193208Z","caller":"traceutil/trace.go:171","msg":"trace[1126285834] linearizableReadLoop","detail":"{readStateIndex:5334; appliedIndex:5333; }","duration":"218.551573ms","start":"2026-05-05T17:38:08.974637Z","end":"2026-05-05T17:38:09.193188Z","steps":["trace[1126285834] 'read index received' (duration: 218.442571ms)","trace[1126285834] 'applied index is now lower than readState.Index' (duration: 108.172µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:38:09.19343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.774888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:38:09.193513Z","caller":"traceutil/trace.go:171","msg":"trace[1988970393] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"236.228135ms","start":"2026-05-05T17:38:08.957086Z","end":"2026-05-05T17:38:09.193314Z","steps":["trace[1988970393] 'process raft request' (duration: 235.947249ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:09.19411Z","caller":"traceutil/trace.go:171","msg":"trace[1683583503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5138; }","duration":"219.491843ms","start":"2026-05-05T17:38:08.974599Z","end":"2026-05-05T17:38:09.194091Z","steps":["trace[1683583503] 'agreement among raft nodes before linearized reading' (duration: 218.771937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:38:42.855853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.086924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:38:42.855934Z","caller":"traceutil/trace.go:171","msg":"trace[2123519073] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:5428; }","duration":"127.231067ms","start":"2026-05-05T17:38:42.728682Z","end":"2026-05-05T17:38:42.855913Z","steps":["trace[2123519073] 'count revisions from in-memory index tree' (duration: 126.992782ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:42.856179Z","caller":"traceutil/trace.go:171","msg":"trace[703118659] linearizableReadLoop","detail":"{readStateIndex:5634; appliedIndex:5633; }","duration":"117.182327ms","start":"2026-05-05T17:38:42.738979Z","end":"2026-05-05T17:38:42.856162Z","steps":["trace[703118659] 'read index received' (duration: 113.161253ms)","trace[703118659] 'applied index is now lower than readState.Index' (duration: 4.019914ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:38:42.856269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.30055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:38:42.856291Z","caller":"traceutil/trace.go:171","msg":"trace[201934461] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:5429; }","duration":"117.383912ms","start":"2026-05-05T17:38:42.7389Z","end":"2026-05-05T17:38:42.856284Z","steps":["trace[201934461] 'agreement among raft nodes before linearized reading' (duration: 117.34363ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:42.856271Z","caller":"traceutil/trace.go:171","msg":"trace[461565053] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"122.014938ms","start":"2026-05-05T17:38:42.73421Z","end":"2026-05-05T17:38:42.856225Z","steps":["trace[461565053] 'process raft request' (duration: 117.953984ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:44.162089Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2855} {"level":"info","ts":"2026-05-05T17:38:44.262161Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2855,"took":"98.930803ms","hash":682042827,"current-db-size-bytes":52854784,"current-db-size":"53 MB","current-db-size-in-use-bytes":28053504,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-05T17:38:44.26222Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":682042827,"revision":2855,"compact-revision":-1} {"level":"info","ts":"2026-05-05T17:38:44.777193Z","caller":"traceutil/trace.go:171","msg":"trace[1820152332] transaction","detail":"{read_only:false; response_revision:5437; number_of_response:1; }","duration":"187.877917ms","start":"2026-05-05T17:38:44.589294Z","end":"2026-05-05T17:38:44.777172Z","steps":["trace[1820152332] 'process raft request' (duration: 187.731344ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:44.786065Z","caller":"traceutil/trace.go:171","msg":"trace[1767095115] transaction","detail":"{read_only:false; response_revision:5438; number_of_response:1; }","duration":"187.425908ms","start":"2026-05-05T17:38:44.598619Z","end":"2026-05-05T17:38:44.786045Z","steps":["trace[1767095115] 'process raft request' (duration: 187.097572ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:38:44.786161Z","caller":"traceutil/trace.go:171","msg":"trace[1773019537] transaction","detail":"{read_only:false; response_revision:5439; number_of_response:1; }","duration":"171.288381ms","start":"2026-05-05T17:38:44.614851Z","end":"2026-05-05T17:38:44.786139Z","steps":["trace[1773019537] 'process raft request' (duration: 171.080927ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:39:49.301845Z","caller":"traceutil/trace.go:171","msg":"trace[852063035] transaction","detail":"{read_only:false; response_revision:5910; number_of_response:1; }","duration":"103.266224ms","start":"2026-05-05T17:39:49.19854Z","end":"2026-05-05T17:39:49.301806Z","steps":["trace[852063035] 'process raft request' (duration: 49.981214ms)","trace[852063035] 'compare' (duration: 53.103376ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:39:55.277947Z","caller":"traceutil/trace.go:171","msg":"trace[1441832189] transaction","detail":"{read_only:false; response_revision:5939; number_of_response:1; }","duration":"160.257738ms","start":"2026-05-05T17:39:55.117659Z","end":"2026-05-05T17:39:55.277917Z","steps":["trace[1441832189] 'process raft request' (duration: 160.170406ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:39:55.278357Z","caller":"traceutil/trace.go:171","msg":"trace[609666123] transaction","detail":"{read_only:false; response_revision:5938; number_of_response:1; }","duration":"161.160566ms","start":"2026-05-05T17:39:55.117166Z","end":"2026-05-05T17:39:55.278327Z","steps":["trace[609666123] 'process raft request' (duration: 95.193407ms)","trace[609666123] 'compare' (duration: 65.286585ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:39:55.30626Z","caller":"traceutil/trace.go:171","msg":"trace[1994130387] transaction","detail":"{read_only:false; response_revision:5940; number_of_response:1; }","duration":"160.633814ms","start":"2026-05-05T17:39:55.145611Z","end":"2026-05-05T17:39:55.306245Z","steps":["trace[1994130387] 'process raft request' (duration: 160.556683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:42:17.606691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.12847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-05-05T17:42:17.60678Z","caller":"traceutil/trace.go:171","msg":"trace[1448146099] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:6916; }","duration":"112.262853ms","start":"2026-05-05T17:42:17.494498Z","end":"2026-05-05T17:42:17.606761Z","steps":["trace[1448146099] 'range keys from in-memory index tree' (duration: 111.964658ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:42:17.997497Z","caller":"traceutil/trace.go:171","msg":"trace[694438742] transaction","detail":"{read_only:false; response_revision:6919; number_of_response:1; }","duration":"103.982676ms","start":"2026-05-05T17:42:17.893485Z","end":"2026-05-05T17:42:17.997467Z","steps":["trace[694438742] 'process raft request' (duration: 103.832353ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:43:44.16881Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5436} {"level":"info","ts":"2026-05-05T17:43:44.27718Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5436,"took":"106.841872ms","hash":1709251170,"current-db-size-bytes":52854784,"current-db-size":"53 MB","current-db-size-in-use-bytes":18665472,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-05-05T17:43:44.277371Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1709251170,"revision":5436,"compact-revision":2855}