{"level":"warn","ts":"2026-06-30T17:08:51.995242Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T17:08:51.995353Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-30T17:08:51.995443Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T17:08:51.995458Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-06-30T17:08:51.995476Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-30T17:08:51.996306Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-06-30T17:08:51.996404Z","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.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-30T17:08:51.999267Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.595685ms"} {"level":"info","ts":"2026-06-30T17:08:52.004861Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-06-30T17:08:52.004966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T17:08:52.005005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-06-30T17:08:52.005019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T17:08:52.005041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-06-30T17:08:52.00509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-06-30T17:08:52.012194Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T17:08:52.013657Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T17:08:52.01817Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-30T17:08:52.022408Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T17:08:52.022665Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T17:08:52.022747Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T17:08:52.022899Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T17:08:52.022928Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T17:08:52.023794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-06-30T17:08:52.02479Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-06-30T17:08:52.02792Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-30T17:08:52.028082Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-06-30T17:08:52.028158Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-06-30T17:08:52.028325Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T17:08:52.028363Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T17:08:52.106076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T17:08:52.10624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T17:08:52.106318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-06-30T17:08:52.106338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-06-30T17:08:52.106345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-06-30T17:08:52.10636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-06-30T17:08:52.106374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-06-30T17:08:52.107366Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:08:52.108387Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T17:08:52.108415Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:08:52.108467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:08:52.108738Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T17:08:52.10879Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T17:08:52.108993Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:08:52.109069Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:08:52.109095Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:08:52.11209Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-06-30T17:08:52.113381Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T17:08:53.953634Z","caller":"traceutil/trace.go:171","msg":"trace[1653207277] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"145.295587ms","start":"2026-06-30T17:08:53.808274Z","end":"2026-06-30T17:08:53.953569Z","steps":["trace[1653207277] 'process raft request' (duration: 130.207453ms)","trace[1653207277] 'compare' (duration: 14.836596ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:08:53.953747Z","caller":"traceutil/trace.go:171","msg":"trace[400679355] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"143.809118ms","start":"2026-06-30T17:08:53.809877Z","end":"2026-06-30T17:08:53.953686Z","steps":["trace[400679355] 'process raft request' (duration: 143.608122ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:53.953836Z","caller":"traceutil/trace.go:171","msg":"trace[1592906792] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"100.012584ms","start":"2026-06-30T17:08:53.853755Z","end":"2026-06-30T17:08:53.953768Z","steps":["trace[1592906792] 'process raft request' (duration: 99.88982ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:53.954055Z","caller":"traceutil/trace.go:171","msg":"trace[1888191517] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:14; }","duration":"106.27676ms","start":"2026-06-30T17:08:53.847739Z","end":"2026-06-30T17:08:53.954015Z","steps":["trace[1888191517] 'read index received' (duration: 90.886986ms)","trace[1888191517] 'applied index is now lower than readState.Index' (duration: 15.386464ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:08:53.953981Z","caller":"traceutil/trace.go:171","msg":"trace[773059577] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"100.068606ms","start":"2026-06-30T17:08:53.853817Z","end":"2026-06-30T17:08:53.953886Z","steps":["trace[773059577] 'process raft request' (duration: 99.873059ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:53.954239Z","caller":"traceutil/trace.go:171","msg":"trace[1234739753] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"145.901637ms","start":"2026-06-30T17:08:53.808327Z","end":"2026-06-30T17:08:53.954228Z","steps":["trace[1234739753] 'process raft request' (duration: 145.135992ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:53.954341Z","caller":"traceutil/trace.go:171","msg":"trace[1680076881] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"100.544151ms","start":"2026-06-30T17:08:53.853787Z","end":"2026-06-30T17:08:53.954331Z","steps":["trace[1680076881] 'process raft request' (duration: 99.88327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:08:53.954383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.996965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-06-30T17:08:53.954469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.352916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-06-30T17:08:53.954475Z","caller":"traceutil/trace.go:171","msg":"trace[1299324259] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"133.14195ms","start":"2026-06-30T17:08:53.821314Z","end":"2026-06-30T17:08:53.954456Z","steps":["trace[1299324259] 'agreement among raft nodes before linearized reading' (duration: 132.975664ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:53.954515Z","caller":"traceutil/trace.go:171","msg":"trace[1865570755] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"100.414298ms","start":"2026-06-30T17:08:53.854082Z","end":"2026-06-30T17:08:53.954496Z","steps":["trace[1865570755] 'agreement among raft nodes before linearized reading' (duration: 100.366356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:08:53.954373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.109876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:08:53.954608Z","caller":"traceutil/trace.go:171","msg":"trace[450161906] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"100.920164ms","start":"2026-06-30T17:08:53.853677Z","end":"2026-06-30T17:08:53.954597Z","steps":["trace[450161906] 'process raft request' (duration: 99.940162ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:53.954649Z","caller":"traceutil/trace.go:171","msg":"trace[258177721] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:19; }","duration":"103.429296ms","start":"2026-06-30T17:08:53.851204Z","end":"2026-06-30T17:08:53.954633Z","steps":["trace[258177721] 'agreement among raft nodes before linearized reading' (duration: 103.123646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:08:54.190922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.150933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-30T17:08:54.191264Z","caller":"traceutil/trace.go:171","msg":"trace[460494243] linearizableReadLoop","detail":"{readStateIndex:40; appliedIndex:32; }","duration":"150.874349ms","start":"2026-06-30T17:08:54.040371Z","end":"2026-06-30T17:08:54.191246Z","steps":["trace[460494243] 'read index received' (duration: 40.845167ms)","trace[460494243] 'applied index is now lower than readState.Index' (duration: 110.028222ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:08:54.191376Z","caller":"traceutil/trace.go:171","msg":"trace[680539893] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"156.69707ms","start":"2026-06-30T17:08:54.034552Z","end":"2026-06-30T17:08:54.191249Z","steps":["trace[680539893] 'process raft request' (duration: 46.607296ms)","trace[680539893] 'compare' (duration: 108.993278ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:08:54.191552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.018305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:08:54.191599Z","caller":"traceutil/trace.go:171","msg":"trace[1774247720] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:36; }","duration":"151.245031ms","start":"2026-06-30T17:08:54.040339Z","end":"2026-06-30T17:08:54.191584Z","steps":["trace[1774247720] 'agreement among raft nodes before linearized reading' (duration: 150.965362ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:54.191593Z","caller":"traceutil/trace.go:171","msg":"trace[1165002400] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"156.710211ms","start":"2026-06-30T17:08:54.034858Z","end":"2026-06-30T17:08:54.191568Z","steps":["trace[1165002400] 'process raft request' (duration: 156.247946ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:54.191652Z","caller":"traceutil/trace.go:171","msg":"trace[995737470] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"156.561177ms","start":"2026-06-30T17:08:54.035057Z","end":"2026-06-30T17:08:54.191618Z","steps":["trace[995737470] 'process raft request' (duration: 156.106432ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:54.191743Z","caller":"traceutil/trace.go:171","msg":"trace[2013669853] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"157.154005ms","start":"2026-06-30T17:08:54.034552Z","end":"2026-06-30T17:08:54.191706Z","steps":["trace[2013669853] 'process raft request' (duration: 156.468773ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:54.19178Z","caller":"traceutil/trace.go:171","msg":"trace[121154658] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"157.202627ms","start":"2026-06-30T17:08:54.034561Z","end":"2026-06-30T17:08:54.191763Z","steps":["trace[121154658] 'process raft request' (duration: 156.515835ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:54.191805Z","caller":"traceutil/trace.go:171","msg":"trace[1115151088] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"156.69537ms","start":"2026-06-30T17:08:54.035102Z","end":"2026-06-30T17:08:54.191797Z","steps":["trace[1115151088] 'process raft request' (duration: 156.107231ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:54.191738Z","caller":"traceutil/trace.go:171","msg":"trace[964451883] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"156.825665ms","start":"2026-06-30T17:08:54.034893Z","end":"2026-06-30T17:08:54.191718Z","steps":["trace[964451883] 'process raft request' (duration: 156.250436ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:54.19189Z","caller":"traceutil/trace.go:171","msg":"trace[334270328] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"156.798284ms","start":"2026-06-30T17:08:54.035085Z","end":"2026-06-30T17:08:54.191883Z","steps":["trace[334270328] 'process raft request' (duration: 156.097941ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:08:54.395216Z","caller":"traceutil/trace.go:171","msg":"trace[218905604] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"159.370868ms","start":"2026-06-30T17:08:54.23581Z","end":"2026-06-30T17:08:54.395181Z","steps":["trace[218905604] 'process raft request' (duration: 79.927597ms)","trace[218905604] 'compare' (duration: 79.256245ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:08:57.231197Z","caller":"traceutil/trace.go:171","msg":"trace[582623734] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"120.219456ms","start":"2026-06-30T17:08:57.110922Z","end":"2026-06-30T17:08:57.231141Z","steps":["trace[582623734] 'process raft request' (duration: 109.721122ms)","trace[582623734] 'compare' (duration: 10.328948ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:08:57.851185Z","caller":"traceutil/trace.go:171","msg":"trace[571650144] linearizableReadLoop","detail":"{readStateIndex:301; appliedIndex:300; }","duration":"101.053819ms","start":"2026-06-30T17:08:57.750101Z","end":"2026-06-30T17:08:57.851155Z","steps":["trace[571650144] 'read index received' (duration: 40.024281ms)","trace[571650144] 'applied index is now lower than readState.Index' (duration: 61.028508ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:08:57.851212Z","caller":"traceutil/trace.go:171","msg":"trace[1337716213] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"118.545251ms","start":"2026-06-30T17:08:57.732619Z","end":"2026-06-30T17:08:57.851164Z","steps":["trace[1337716213] 'process raft request' (duration: 57.607036ms)","trace[1337716213] 'compare' (duration: 60.79676ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:08:57.851378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.007342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-30T17:08:57.851421Z","caller":"traceutil/trace.go:171","msg":"trace[1007622391] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:295; }","duration":"110.097374ms","start":"2026-06-30T17:08:57.741311Z","end":"2026-06-30T17:08:57.851408Z","steps":["trace[1007622391] 'agreement among raft nodes before linearized reading' (duration: 109.97497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:08:57.851493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.692893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:08:57.851523Z","caller":"traceutil/trace.go:171","msg":"trace[1207444373] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:295; }","duration":"117.779726ms","start":"2026-06-30T17:08:57.733733Z","end":"2026-06-30T17:08:57.851513Z","steps":["trace[1207444373] 'agreement among raft nodes before linearized reading' (duration: 117.709164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:08:57.876817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.913317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-30T17:08:57.876893Z","caller":"traceutil/trace.go:171","msg":"trace[1481555878] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:300; }","duration":"124.029521ms","start":"2026-06-30T17:08:57.752846Z","end":"2026-06-30T17:08:57.876875Z","steps":["trace[1481555878] 'agreement among raft nodes before linearized reading' (duration: 123.887636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:08:57.877043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.126209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"} {"level":"info","ts":"2026-06-30T17:08:57.877098Z","caller":"traceutil/trace.go:171","msg":"trace[1288058141] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:300; }","duration":"122.196791ms","start":"2026-06-30T17:08:57.754887Z","end":"2026-06-30T17:08:57.877084Z","steps":["trace[1288058141] 'agreement among raft nodes before linearized reading' (duration: 122.114368ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:16.886683Z","caller":"traceutil/trace.go:171","msg":"trace[1449351740] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"279.271422ms","start":"2026-06-30T17:09:16.607382Z","end":"2026-06-30T17:09:16.886653Z","steps":["trace[1449351740] 'process raft request' (duration: 279.124517ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:16.926832Z","caller":"traceutil/trace.go:171","msg":"trace[1516893154] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"319.281878ms","start":"2026-06-30T17:09:16.607517Z","end":"2026-06-30T17:09:16.926799Z","steps":["trace[1516893154] 'process raft request' (duration: 319.095632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:16.927218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:16.607481Z","time spent":"319.441414ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:21.945901Z","caller":"traceutil/trace.go:171","msg":"trace[186431370] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"159.493219ms","start":"2026-06-30T17:09:21.78638Z","end":"2026-06-30T17:09:21.945873Z","steps":["trace[186431370] 'process raft request' (duration: 159.316293ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:25.92683Z","caller":"traceutil/trace.go:171","msg":"trace[1555971900] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"262.7357ms","start":"2026-06-30T17:09:25.664063Z","end":"2026-06-30T17:09:25.926799Z","steps":["trace[1555971900] 'process raft request' (duration: 187.752978ms)","trace[1555971900] 'compare' (duration: 74.842777ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:26.307326Z","caller":"traceutil/trace.go:171","msg":"trace[1511367043] linearizableReadLoop","detail":"{readStateIndex:503; appliedIndex:502; }","duration":"283.779156ms","start":"2026-06-30T17:09:26.02352Z","end":"2026-06-30T17:09:26.307299Z","steps":["trace[1511367043] 'read index received' (duration: 256.908452ms)","trace[1511367043] 'applied index is now lower than readState.Index' (duration: 26.869834ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:26.307461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.925001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:09:26.307499Z","caller":"traceutil/trace.go:171","msg":"trace[2022277368] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:487; }","duration":"284.018143ms","start":"2026-06-30T17:09:26.02347Z","end":"2026-06-30T17:09:26.307488Z","steps":["trace[2022277368] 'agreement among raft nodes before linearized reading' (duration: 283.932901ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:26.307634Z","caller":"traceutil/trace.go:171","msg":"trace[387066062] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"338.864578ms","start":"2026-06-30T17:09:25.968757Z","end":"2026-06-30T17:09:26.307621Z","steps":["trace[387066062] 'process raft request' (duration: 311.602051ms)","trace[387066062] 'compare' (duration: 26.815002ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:26.307729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:25.968745Z","time spent":"338.93132ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:31.194232Z","caller":"traceutil/trace.go:171","msg":"trace[1477516509] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"102.197677ms","start":"2026-06-30T17:09:31.092005Z","end":"2026-06-30T17:09:31.194203Z","steps":["trace[1477516509] 'process raft request' (duration: 99.841402ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.459975Z","caller":"traceutil/trace.go:171","msg":"trace[1039287334] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"239.934026ms","start":"2026-06-30T17:09:31.220015Z","end":"2026-06-30T17:09:31.459949Z","steps":["trace[1039287334] 'process raft request' (duration: 239.803322ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.52171Z","caller":"traceutil/trace.go:171","msg":"trace[269474337] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"300.35379ms","start":"2026-06-30T17:09:31.221325Z","end":"2026-06-30T17:09:31.521678Z","steps":["trace[269474337] 'process raft request' (duration: 300.143933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:31.521864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:31.221318Z","time spent":"300.477413ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:09:31.521962Z","caller":"traceutil/trace.go:171","msg":"trace[355247009] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"278.737574ms","start":"2026-06-30T17:09:31.243098Z","end":"2026-06-30T17:09:31.521836Z","steps":["trace[355247009] 'process raft request' (duration: 278.466065ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.522102Z","caller":"traceutil/trace.go:171","msg":"trace[941101667] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"301.205957ms","start":"2026-06-30T17:09:31.220419Z","end":"2026-06-30T17:09:31.521625Z","steps":["trace[941101667] 'process raft request' (duration: 300.786293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:31.522183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:31.220411Z","time spent":"301.734394ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:09:31.522846Z","caller":"traceutil/trace.go:171","msg":"trace[1526484046] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"275.788439ms","start":"2026-06-30T17:09:31.247009Z","end":"2026-06-30T17:09:31.522797Z","steps":["trace[1526484046] 'process raft request' (duration: 275.478719ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.523222Z","caller":"traceutil/trace.go:171","msg":"trace[1210318918] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"264.223058ms","start":"2026-06-30T17:09:31.258981Z","end":"2026-06-30T17:09:31.523204Z","steps":["trace[1210318918] 'process raft request' (duration: 263.859226ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.523278Z","caller":"traceutil/trace.go:171","msg":"trace[1012861791] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"137.42894ms","start":"2026-06-30T17:09:31.385818Z","end":"2026-06-30T17:09:31.523247Z","steps":["trace[1012861791] 'process raft request' (duration: 137.273035ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.523348Z","caller":"traceutil/trace.go:171","msg":"trace[604154993] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"272.39684ms","start":"2026-06-30T17:09:31.25094Z","end":"2026-06-30T17:09:31.523336Z","steps":["trace[604154993] 'process raft request' (duration: 271.726539ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.523433Z","caller":"traceutil/trace.go:171","msg":"trace[2024481795] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"269.544839ms","start":"2026-06-30T17:09:31.25388Z","end":"2026-06-30T17:09:31.523425Z","steps":["trace[2024481795] 'process raft request' (duration: 268.899328ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.523489Z","caller":"traceutil/trace.go:171","msg":"trace[1154798661] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"254.872327ms","start":"2026-06-30T17:09:31.268606Z","end":"2026-06-30T17:09:31.523478Z","steps":["trace[1154798661] 'process raft request' (duration: 254.287118ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.523547Z","caller":"traceutil/trace.go:171","msg":"trace[1596819023] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"254.881707ms","start":"2026-06-30T17:09:31.268655Z","end":"2026-06-30T17:09:31.523536Z","steps":["trace[1596819023] 'process raft request' (duration: 254.293328ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.523579Z","caller":"traceutil/trace.go:171","msg":"trace[1888777311] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"229.663186ms","start":"2026-06-30T17:09:31.293908Z","end":"2026-06-30T17:09:31.523571Z","steps":["trace[1888777311] 'process raft request' (duration: 229.098757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:31.831257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.615045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:09:31.83161Z","caller":"traceutil/trace.go:171","msg":"trace[2075405626] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"366.291309ms","start":"2026-06-30T17:09:31.46529Z","end":"2026-06-30T17:09:31.831581Z","steps":["trace[2075405626] 'process raft request' (duration: 265.286471ms)","trace[2075405626] 'compare' (duration: 100.44143ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:31.831705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:31.465267Z","time spent":"366.402282ms","remote":"127.0.0.1:47714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:09:31.831839Z","caller":"traceutil/trace.go:171","msg":"trace[2000793531] transaction","detail":"{read_only:false; number_of_response:1; response_revision:547; }","duration":"364.126368ms","start":"2026-06-30T17:09:31.467691Z","end":"2026-06-30T17:09:31.831817Z","steps":["trace[2000793531] 'process raft request' (duration: 363.947683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:31.831905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:31.46768Z","time spent":"364.185571ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:31.832037Z","caller":"traceutil/trace.go:171","msg":"trace[1555289750] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"364.533272ms","start":"2026-06-30T17:09:31.467185Z","end":"2026-06-30T17:09:31.831718Z","steps":["trace[1555289750] 'process raft request' (duration: 364.16494ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.832233Z","caller":"traceutil/trace.go:171","msg":"trace[139562708] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"306.793375ms","start":"2026-06-30T17:09:31.525423Z","end":"2026-06-30T17:09:31.832217Z","steps":["trace[139562708] 'process raft request' (duration: 306.255268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:31.832306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:31.525399Z","time spent":"306.877888ms","remote":"127.0.0.1:47714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:09:31.832441Z","caller":"traceutil/trace.go:171","msg":"trace[440352770] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"298.489698ms","start":"2026-06-30T17:09:31.53394Z","end":"2026-06-30T17:09:31.83243Z","steps":["trace[440352770] 'process raft request' (duration: 298.075125ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.832475Z","caller":"traceutil/trace.go:171","msg":"trace[861460734] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"289.997275ms","start":"2026-06-30T17:09:31.542436Z","end":"2026-06-30T17:09:31.832433Z","steps":["trace[861460734] 'process raft request' (duration: 289.692015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:31.832474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:31.46717Z","time spent":"364.956275ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:31.832678Z","caller":"traceutil/trace.go:171","msg":"trace[1761891853] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"243.150939ms","start":"2026-06-30T17:09:31.589421Z","end":"2026-06-30T17:09:31.832571Z","steps":["trace[1761891853] 'process raft request' (duration: 243.086807ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.832747Z","caller":"traceutil/trace.go:171","msg":"trace[453834039] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"298.627483ms","start":"2026-06-30T17:09:31.534079Z","end":"2026-06-30T17:09:31.832707Z","steps":["trace[453834039] 'process raft request' (duration: 298.000233ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.832892Z","caller":"traceutil/trace.go:171","msg":"trace[556372508] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"278.35449ms","start":"2026-06-30T17:09:31.554517Z","end":"2026-06-30T17:09:31.832872Z","steps":["trace[556372508] 'process raft request' (duration: 277.940827ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.832896Z","caller":"traceutil/trace.go:171","msg":"trace[1601259648] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"287.129123ms","start":"2026-06-30T17:09:31.545751Z","end":"2026-06-30T17:09:31.83288Z","steps":["trace[1601259648] 'process raft request' (duration: 286.403019ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.832981Z","caller":"traceutil/trace.go:171","msg":"trace[532832308] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"283.367232ms","start":"2026-06-30T17:09:31.549555Z","end":"2026-06-30T17:09:31.832922Z","steps":["trace[532832308] 'process raft request' (duration: 282.752982ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:31.833441Z","caller":"traceutil/trace.go:171","msg":"trace[1615955480] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"285.271383ms","start":"2026-06-30T17:09:31.547341Z","end":"2026-06-30T17:09:31.832612Z","steps":["trace[1615955480] 'process raft request' (duration: 284.847729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:32.830243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868376010,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T17:09:33.018823Z","caller":"traceutil/trace.go:171","msg":"trace[493020917] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"895.200778ms","start":"2026-06-30T17:09:32.123573Z","end":"2026-06-30T17:09:33.018773Z","steps":["trace[493020917] 'process raft request' (duration: 888.674017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:33.019033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:32.123523Z","time spent":"895.390034ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:33.020041Z","caller":"traceutil/trace.go:171","msg":"trace[807902462] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:593; }","duration":"690.868427ms","start":"2026-06-30T17:09:32.329138Z","end":"2026-06-30T17:09:33.020006Z","steps":["trace[807902462] 'read index received' (duration: 683.80609ms)","trace[807902462] 'applied index is now lower than readState.Index' (duration: 7.061417ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:33.020173Z","caller":"traceutil/trace.go:171","msg":"trace[2058344629] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"827.264973ms","start":"2026-06-30T17:09:32.192897Z","end":"2026-06-30T17:09:33.020162Z","steps":["trace[2058344629] 'process raft request' (duration: 827.020295ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:33.020156Z","caller":"traceutil/trace.go:171","msg":"trace[1396027788] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"894.180285ms","start":"2026-06-30T17:09:32.125911Z","end":"2026-06-30T17:09:33.020092Z","steps":["trace[1396027788] 'process raft request' (duration: 893.834954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:33.020283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:32.192875Z","time spent":"827.333156ms","remote":"127.0.0.1:58360","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-06-30T17:09:33.020367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:32.125883Z","time spent":"894.369671ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:09:33.020547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.413545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-30T17:09:33.020599Z","caller":"traceutil/trace.go:171","msg":"trace[1278117745] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"691.504107ms","start":"2026-06-30T17:09:32.32907Z","end":"2026-06-30T17:09:33.020574Z","steps":["trace[1278117745] 'agreement among raft nodes before linearized reading' (duration: 691.348432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:33.020634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:32.329027Z","time spent":"691.599871ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:09:33.020688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.987515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:09:33.020745Z","caller":"traceutil/trace.go:171","msg":"trace[1194755483] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"688.050747ms","start":"2026-06-30T17:09:32.332671Z","end":"2026-06-30T17:09:33.020722Z","steps":["trace[1194755483] 'agreement among raft nodes before linearized reading' (duration: 687.877511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:33.020786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:32.332637Z","time spent":"688.14001ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-30T17:09:34.14393Z","caller":"traceutil/trace.go:171","msg":"trace[1784453456] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"636.685966ms","start":"2026-06-30T17:09:33.507195Z","end":"2026-06-30T17:09:34.143881Z","steps":["trace[1784453456] 'process raft request' (duration: 627.722247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:34.144323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:33.50716Z","time spent":"636.936264ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:09:34.144408Z","caller":"traceutil/trace.go:171","msg":"trace[1997406032] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"628.155822ms","start":"2026-06-30T17:09:33.51622Z","end":"2026-06-30T17:09:34.144376Z","steps":["trace[1997406032] 'process raft request' (duration: 627.402168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:34.144571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:33.516194Z","time spent":"628.292366ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:34.144838Z","caller":"traceutil/trace.go:171","msg":"trace[581592986] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:624; }","duration":"148.838007ms","start":"2026-06-30T17:09:33.995976Z","end":"2026-06-30T17:09:34.144814Z","steps":["trace[581592986] 'read index received' (duration: 139.057742ms)","trace[581592986] 'applied index is now lower than readState.Index' (duration: 9.779345ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:34.144861Z","caller":"traceutil/trace.go:171","msg":"trace[729791890] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"501.664085ms","start":"2026-06-30T17:09:33.643169Z","end":"2026-06-30T17:09:34.144833Z","steps":["trace[729791890] 'process raft request' (duration: 500.793466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:34.144937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.9557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:09:34.144965Z","caller":"traceutil/trace.go:171","msg":"trace[696837204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"149.032533ms","start":"2026-06-30T17:09:33.995925Z","end":"2026-06-30T17:09:34.144957Z","steps":["trace[696837204] 'agreement among raft nodes before linearized reading' (duration: 148.974571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:34.145012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:33.643136Z","time spent":"501.792689ms","remote":"127.0.0.1:58360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:36.51721Z","caller":"traceutil/trace.go:171","msg":"trace[1228810362] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"206.841092ms","start":"2026-06-30T17:09:36.310342Z","end":"2026-06-30T17:09:36.517183Z","steps":["trace[1228810362] 'process raft request' (duration: 205.800508ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:38.097703Z","caller":"traceutil/trace.go:171","msg":"trace[2113373816] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"106.881887ms","start":"2026-06-30T17:09:37.990722Z","end":"2026-06-30T17:09:38.097604Z","steps":["trace[2113373816] 'process raft request' (duration: 103.648583ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:38.265742Z","caller":"traceutil/trace.go:171","msg":"trace[319295339] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"107.822818ms","start":"2026-06-30T17:09:38.157843Z","end":"2026-06-30T17:09:38.265666Z","steps":["trace[319295339] 'process raft request' (duration: 26.638947ms)","trace[319295339] 'compare' (duration: 80.928863ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:38.885298Z","caller":"traceutil/trace.go:171","msg":"trace[681156907] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"128.664657ms","start":"2026-06-30T17:09:38.756613Z","end":"2026-06-30T17:09:38.885278Z","steps":["trace[681156907] 'process raft request' (duration: 127.771989ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:41.112901Z","caller":"traceutil/trace.go:171","msg":"trace[975547019] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"206.132589ms","start":"2026-06-30T17:09:40.906742Z","end":"2026-06-30T17:09:41.112875Z","steps":["trace[975547019] 'process raft request' (duration: 205.997415ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:41.202269Z","caller":"traceutil/trace.go:171","msg":"trace[1209848377] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:677; }","duration":"127.137919ms","start":"2026-06-30T17:09:41.075102Z","end":"2026-06-30T17:09:41.20224Z","steps":["trace[1209848377] 'read index received' (duration: 37.63313ms)","trace[1209848377] 'applied index is now lower than readState.Index' (duration: 89.503229ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:41.202691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.619161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:09:41.202776Z","caller":"traceutil/trace.go:171","msg":"trace[1372447310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:654; }","duration":"121.795346ms","start":"2026-06-30T17:09:41.080964Z","end":"2026-06-30T17:09:41.202759Z","steps":["trace[1372447310] 'agreement among raft nodes before linearized reading' (duration: 121.524488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:41.20284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.727117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:09:41.202909Z","caller":"traceutil/trace.go:171","msg":"trace[75883754] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:654; }","duration":"127.836731ms","start":"2026-06-30T17:09:41.075056Z","end":"2026-06-30T17:09:41.202892Z","steps":["trace[75883754] 'agreement among raft nodes before linearized reading' (duration: 127.314704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:41.738062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.894806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:09:41.738236Z","caller":"traceutil/trace.go:171","msg":"trace[841299764] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"531.666188ms","start":"2026-06-30T17:09:41.20655Z","end":"2026-06-30T17:09:41.738216Z","steps":["trace[841299764] 'process raft request' (duration: 63.544354ms)","trace[841299764] 'compare' (duration: 467.776862ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:41.738296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:41.206526Z","time spent":"531.74163ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:41.738386Z","caller":"traceutil/trace.go:171","msg":"trace[1783862293] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:679; }","duration":"497.442767ms","start":"2026-06-30T17:09:41.240896Z","end":"2026-06-30T17:09:41.738338Z","steps":["trace[1783862293] 'read index received' (duration: 11.252492ms)","trace[1783862293] 'applied index is now lower than readState.Index' (duration: 486.188474ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:41.738485Z","caller":"traceutil/trace.go:171","msg":"trace[1548755237] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"531.494602ms","start":"2026-06-30T17:09:41.20697Z","end":"2026-06-30T17:09:41.738464Z","steps":["trace[1548755237] 'process raft request' (duration: 531.201722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:41.738653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:41.206955Z","time spent":"531.579455ms","remote":"127.0.0.1:58608","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-06-30T17:09:41.738688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.708625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-30T17:09:41.738772Z","caller":"traceutil/trace.go:171","msg":"trace[1390020492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"497.895951ms","start":"2026-06-30T17:09:41.240858Z","end":"2026-06-30T17:09:41.738754Z","steps":["trace[1390020492] 'agreement among raft nodes before linearized reading' (duration: 497.603071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:41.738814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:41.240844Z","time spent":"497.958573ms","remote":"127.0.0.1:58608","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":"info","ts":"2026-06-30T17:09:42.349735Z","caller":"traceutil/trace.go:171","msg":"trace[1182552974] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"372.354373ms","start":"2026-06-30T17:09:41.977348Z","end":"2026-06-30T17:09:42.349703Z","steps":["trace[1182552974] 'read index received' (duration: 372.138607ms)","trace[1182552974] 'applied index is now lower than readState.Index' (duration: 214.446µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:42.349898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.516829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:09:42.349956Z","caller":"traceutil/trace.go:171","msg":"trace[2047165224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"372.636143ms","start":"2026-06-30T17:09:41.977305Z","end":"2026-06-30T17:09:42.349941Z","steps":["trace[2047165224] 'agreement among raft nodes before linearized reading' (duration: 372.520579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:42.35001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:41.977268Z","time spent":"372.730236ms","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:09:42.350075Z","caller":"traceutil/trace.go:171","msg":"trace[321114870] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"606.440202ms","start":"2026-06-30T17:09:41.743491Z","end":"2026-06-30T17:09:42.349931Z","steps":["trace[321114870] 'process raft request' (duration: 606.051649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:42.350276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:41.743474Z","time spent":"606.70899ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:09:43.799731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868376187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:09:44.300907Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868376187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:09:44.772397Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.510807837s","expected-duration":"1s"} {"level":"info","ts":"2026-06-30T17:09:44.772654Z","caller":"traceutil/trace.go:171","msg":"trace[643745915] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:683; }","duration":"1.473276659s","start":"2026-06-30T17:09:43.29936Z","end":"2026-06-30T17:09:44.772636Z","steps":["trace[643745915] 'read index received' (duration: 1.473138645s)","trace[643745915] 'applied index is now lower than readState.Index' (duration: 137.254µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:44.772759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.473397264s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:09:44.772787Z","caller":"traceutil/trace.go:171","msg":"trace[1314790050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"1.473504057s","start":"2026-06-30T17:09:43.299276Z","end":"2026-06-30T17:09:44.77278Z","steps":["trace[1314790050] 'agreement among raft nodes before linearized reading' (duration: 1.473423104s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:44.772811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:43.299243Z","time spent":"1.473562869s","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:09:44.772805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.977355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:09:44.772853Z","caller":"traceutil/trace.go:171","msg":"trace[408105662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"795.10945ms","start":"2026-06-30T17:09:43.97773Z","end":"2026-06-30T17:09:44.772839Z","steps":["trace[408105662] 'agreement among raft nodes before linearized reading' (duration: 795.036468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:44.772894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:43.977686Z","time spent":"795.201684ms","remote":"127.0.0.1:58336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:09:44.772939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.840597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-30T17:09:44.773002Z","caller":"traceutil/trace.go:171","msg":"trace[35178326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:659; }","duration":"417.953631ms","start":"2026-06-30T17:09:44.355031Z","end":"2026-06-30T17:09:44.772985Z","steps":["trace[35178326] 'agreement among raft nodes before linearized reading' (duration: 417.769285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:44.773057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:44.355008Z","time spent":"418.040394ms","remote":"127.0.0.1:58608","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-06-30T17:09:44.773121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03081567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:09:44.773149Z","caller":"traceutil/trace.go:171","msg":"trace[1776643640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:659; }","duration":"1.030904583s","start":"2026-06-30T17:09:43.742236Z","end":"2026-06-30T17:09:44.773141Z","steps":["trace[1776643640] 'agreement among raft nodes before linearized reading' (duration: 1.03052189s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:44.773168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:43.742205Z","time spent":"1.030958464s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-30T17:09:44.772728Z","caller":"traceutil/trace.go:171","msg":"trace[823794476] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"1.51121668s","start":"2026-06-30T17:09:43.26149Z","end":"2026-06-30T17:09:44.772706Z","steps":["trace[823794476] 'process raft request' (duration: 1.511048724s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:44.773295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:43.261465Z","time spent":"1.511736967s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:09:44.773522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.030407647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:09:44.773565Z","caller":"traceutil/trace.go:171","msg":"trace[26281220] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:659; }","duration":"1.030462379s","start":"2026-06-30T17:09:43.74309Z","end":"2026-06-30T17:09:44.773552Z","steps":["trace[26281220] 'agreement among raft nodes before linearized reading' (duration: 1.030311244s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:44.773594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:43.743082Z","time spent":"1.03050529s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:09:45.577442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.339974ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:09:45.577986Z","caller":"traceutil/trace.go:171","msg":"trace[183314146] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"801.441784ms","start":"2026-06-30T17:09:44.776448Z","end":"2026-06-30T17:09:45.577889Z","steps":["trace[183314146] 'process raft request' (duration: 613.570522ms)","trace[183314146] 'compare' (duration: 187.225351ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:45.578025Z","caller":"traceutil/trace.go:171","msg":"trace[582061835] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"801.514386ms","start":"2026-06-30T17:09:44.776482Z","end":"2026-06-30T17:09:45.577997Z","steps":["trace[582061835] 'process raft request' (duration: 801.345681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:45.578139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:44.776467Z","time spent":"801.623259ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:45.578266Z","caller":"traceutil/trace.go:171","msg":"trace[520398079] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"801.225767ms","start":"2026-06-30T17:09:44.777007Z","end":"2026-06-30T17:09:45.578233Z","steps":["trace[520398079] 'process raft request' (duration: 800.951848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:45.578303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:44.776421Z","time spent":"801.671551ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:09:45.578368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:44.776997Z","time spent":"801.320289ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:45.578566Z","caller":"traceutil/trace.go:171","msg":"trace[2013273585] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:684; }","duration":"602.135604ms","start":"2026-06-30T17:09:44.976415Z","end":"2026-06-30T17:09:45.578551Z","steps":["trace[2013273585] 'read index received' (duration: 413.652273ms)","trace[2013273585] 'applied index is now lower than readState.Index' (duration: 188.482371ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:45.578649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.230907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:09:45.578678Z","caller":"traceutil/trace.go:171","msg":"trace[1237585276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"602.30411ms","start":"2026-06-30T17:09:44.976364Z","end":"2026-06-30T17:09:45.578668Z","steps":["trace[1237585276] 'agreement among raft nodes before linearized reading' (duration: 602.262268ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:45.57868Z","caller":"traceutil/trace.go:171","msg":"trace[1476692082] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"485.395519ms","start":"2026-06-30T17:09:45.093201Z","end":"2026-06-30T17:09:45.578596Z","steps":["trace[1476692082] 'process raft request' (duration: 484.968626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:45.578722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:44.976344Z","time spent":"602.349591ms","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:09:45.578878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:45.093169Z","time spent":"485.573836ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:46.073372Z","caller":"traceutil/trace.go:171","msg":"trace[595818338] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"149.603941ms","start":"2026-06-30T17:09:45.923714Z","end":"2026-06-30T17:09:46.073318Z","steps":["trace[595818338] 'process raft request' (duration: 147.543755ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:51.723773Z","caller":"traceutil/trace.go:171","msg":"trace[1207506839] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"108.870422ms","start":"2026-06-30T17:09:51.614871Z","end":"2026-06-30T17:09:51.723742Z","steps":["trace[1207506839] 'process raft request' (duration: 108.657045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:51.724003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.568114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-30T17:09:51.724045Z","caller":"traceutil/trace.go:171","msg":"trace[50169098] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:745; }","duration":"100.627226ms","start":"2026-06-30T17:09:51.623409Z","end":"2026-06-30T17:09:51.724036Z","steps":["trace[50169098] 'agreement among raft nodes before linearized reading' (duration: 100.536703ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:51.723895Z","caller":"traceutil/trace.go:171","msg":"trace[1816501431] linearizableReadLoop","detail":"{readStateIndex:772; appliedIndex:770; }","duration":"100.248504ms","start":"2026-06-30T17:09:51.623423Z","end":"2026-06-30T17:09:51.723672Z","steps":["trace[1816501431] 'read index received' (duration: 65.655712ms)","trace[1816501431] 'applied index is now lower than readState.Index' (duration: 34.591542ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:51.999743Z","caller":"traceutil/trace.go:171","msg":"trace[1812796800] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"136.168659ms","start":"2026-06-30T17:09:51.863536Z","end":"2026-06-30T17:09:51.999705Z","steps":["trace[1812796800] 'process raft request' (duration: 98.614532ms)","trace[1812796800] 'compare' (duration: 37.437964ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:52.000316Z","caller":"traceutil/trace.go:171","msg":"trace[1161415048] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"107.065423ms","start":"2026-06-30T17:09:51.893203Z","end":"2026-06-30T17:09:52.000268Z","steps":["trace[1161415048] 'process raft request' (duration: 106.831275ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:55.334315Z","caller":"traceutil/trace.go:171","msg":"trace[1650858346] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"116.942821ms","start":"2026-06-30T17:09:55.217352Z","end":"2026-06-30T17:09:55.334294Z","steps":["trace[1650858346] 'process raft request' (duration: 100.543853ms)","trace[1650858346] 'compare' (duration: 16.295164ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:55.798534Z","caller":"traceutil/trace.go:171","msg":"trace[1872555044] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:802; }","duration":"153.975501ms","start":"2026-06-30T17:09:55.64453Z","end":"2026-06-30T17:09:55.798505Z","steps":["trace[1872555044] 'read index received' (duration: 116.088153ms)","trace[1872555044] 'applied index is now lower than readState.Index' (duration: 37.886198ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:55.798899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.345744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-30T17:09:55.798944Z","caller":"traceutil/trace.go:171","msg":"trace[1647027932] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:774; }","duration":"154.442757ms","start":"2026-06-30T17:09:55.64449Z","end":"2026-06-30T17:09:55.798933Z","steps":["trace[1647027932] 'agreement among raft nodes before linearized reading' (duration: 154.146257ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:55.798673Z","caller":"traceutil/trace.go:171","msg":"trace[1535361366] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"164.770989ms","start":"2026-06-30T17:09:55.63384Z","end":"2026-06-30T17:09:55.798611Z","steps":["trace[1535361366] 'process raft request' (duration: 126.759816ms)","trace[1535361366] 'compare' (duration: 37.783395ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:55.841926Z","caller":"traceutil/trace.go:171","msg":"trace[1696869670] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"174.873564ms","start":"2026-06-30T17:09:55.667014Z","end":"2026-06-30T17:09:55.841888Z","steps":["trace[1696869670] 'process raft request' (duration: 174.678737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:55.842481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.127595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T17:09:55.84258Z","caller":"traceutil/trace.go:171","msg":"trace[159812271] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:775; }","duration":"195.299231ms","start":"2026-06-30T17:09:55.647257Z","end":"2026-06-30T17:09:55.842556Z","steps":["trace[159812271] 'agreement among raft nodes before linearized reading' (duration: 194.928839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:55.845408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.518255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:09:55.845503Z","caller":"traceutil/trace.go:171","msg":"trace[1542442825] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:775; }","duration":"104.368846ms","start":"2026-06-30T17:09:55.74111Z","end":"2026-06-30T17:09:55.845479Z","steps":["trace[1542442825] 'agreement among raft nodes before linearized reading' (duration: 101.420971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:56.006018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.36293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:09:56.006222Z","caller":"traceutil/trace.go:171","msg":"trace[310913022] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"201.864961ms","start":"2026-06-30T17:09:55.804326Z","end":"2026-06-30T17:09:56.006191Z","steps":["trace[310913022] 'process raft request' (duration: 100.217603ms)","trace[310913022] 'compare' (duration: 101.039699ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:56.006285Z","caller":"traceutil/trace.go:171","msg":"trace[417949846] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"152.968099ms","start":"2026-06-30T17:09:55.853281Z","end":"2026-06-30T17:09:56.006249Z","steps":["trace[417949846] 'process raft request' (duration: 152.853386ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:56.006389Z","caller":"traceutil/trace.go:171","msg":"trace[1492136495] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"152.97854ms","start":"2026-06-30T17:09:55.853389Z","end":"2026-06-30T17:09:56.006368Z","steps":["trace[1492136495] 'process raft request' (duration: 152.793374ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:56.200233Z","caller":"traceutil/trace.go:171","msg":"trace[206381101] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"180.021369ms","start":"2026-06-30T17:09:56.020193Z","end":"2026-06-30T17:09:56.200214Z","steps":["trace[206381101] 'process raft request' (duration: 179.668648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:56.200389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.374321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:09:56.200497Z","caller":"traceutil/trace.go:171","msg":"trace[338714692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"129.524475ms","start":"2026-06-30T17:09:56.070942Z","end":"2026-06-30T17:09:56.200466Z","steps":["trace[338714692] 'agreement among raft nodes before linearized reading' (duration: 129.36542ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:56.200424Z","caller":"traceutil/trace.go:171","msg":"trace[1086617344] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"129.164804ms","start":"2026-06-30T17:09:56.070983Z","end":"2026-06-30T17:09:56.200148Z","steps":["trace[1086617344] 'read index received' (duration: 128.911996ms)","trace[1086617344] 'applied index is now lower than readState.Index' (duration: 251.728µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:56.371541Z","caller":"traceutil/trace.go:171","msg":"trace[2106788320] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"151.313836ms","start":"2026-06-30T17:09:56.220201Z","end":"2026-06-30T17:09:56.371515Z","steps":["trace[2106788320] 'process raft request' (duration: 151.155161ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:56.527195Z","caller":"traceutil/trace.go:171","msg":"trace[2018516388] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"148.207396ms","start":"2026-06-30T17:09:56.378962Z","end":"2026-06-30T17:09:56.527169Z","steps":["trace[2018516388] 'process raft request' (duration: 148.062641ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:56.743821Z","caller":"traceutil/trace.go:171","msg":"trace[410440223] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"362.047913ms","start":"2026-06-30T17:09:56.381715Z","end":"2026-06-30T17:09:56.743763Z","steps":["trace[410440223] 'process raft request' (duration: 277.664629ms)","trace[410440223] 'compare' (duration: 84.205829ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:56.744067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:56.381693Z","time spent":"362.225799ms","remote":"127.0.0.1:47688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:09:56.745283Z","caller":"traceutil/trace.go:171","msg":"trace[2018361479] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"211.163231ms","start":"2026-06-30T17:09:56.53409Z","end":"2026-06-30T17:09:56.745254Z","steps":["trace[2018361479] 'process raft request' (duration: 210.992346ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:57.589894Z","caller":"traceutil/trace.go:171","msg":"trace[1178253023] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:815; }","duration":"220.297375ms","start":"2026-06-30T17:09:57.369551Z","end":"2026-06-30T17:09:57.589849Z","steps":["trace[1178253023] 'read index received' (duration: 141.279534ms)","trace[1178253023] 'applied index is now lower than readState.Index' (duration: 79.0154ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:57.58994Z","caller":"traceutil/trace.go:171","msg":"trace[2049968399] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"221.124291ms","start":"2026-06-30T17:09:57.36875Z","end":"2026-06-30T17:09:57.589874Z","steps":["trace[2049968399] 'process raft request' (duration: 142.152582ms)","trace[2049968399] 'compare' (duration: 78.712411ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:09:57.590115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.541082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:09:57.5902Z","caller":"traceutil/trace.go:171","msg":"trace[1498600528] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:786; }","duration":"220.686467ms","start":"2026-06-30T17:09:57.369495Z","end":"2026-06-30T17:09:57.590181Z","steps":["trace[1498600528] 'agreement among raft nodes before linearized reading' (duration: 220.496251ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:59.051283Z","caller":"traceutil/trace.go:171","msg":"trace[1387182478] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"109.228983ms","start":"2026-06-30T17:09:58.942027Z","end":"2026-06-30T17:09:59.051256Z","steps":["trace[1387182478] 'process raft request' (duration: 108.973504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:09:59.277185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.769454ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:09:59.277308Z","caller":"traceutil/trace.go:171","msg":"trace[1522143166] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"221.38941ms","start":"2026-06-30T17:09:59.055892Z","end":"2026-06-30T17:09:59.277282Z","steps":["trace[1522143166] 'process raft request' (duration: 35.325596ms)","trace[1522143166] 'compare' (duration: 185.516726ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:59.287533Z","caller":"traceutil/trace.go:171","msg":"trace[838791112] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"227.046552ms","start":"2026-06-30T17:09:59.060463Z","end":"2026-06-30T17:09:59.28751Z","steps":["trace[838791112] 'process raft request' (duration: 226.902167ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:59.502033Z","caller":"traceutil/trace.go:171","msg":"trace[1994631732] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"208.133103ms","start":"2026-06-30T17:09:59.293871Z","end":"2026-06-30T17:09:59.502004Z","steps":["trace[1994631732] 'process raft request' (duration: 163.628492ms)","trace[1994631732] 'compare' (duration: 44.364637ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:09:59.578282Z","caller":"traceutil/trace.go:171","msg":"trace[1088176917] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"283.466296ms","start":"2026-06-30T17:09:59.294795Z","end":"2026-06-30T17:09:59.578261Z","steps":["trace[1088176917] 'process raft request' (duration: 283.303781ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:59.578508Z","caller":"traceutil/trace.go:171","msg":"trace[1478120162] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"277.808074ms","start":"2026-06-30T17:09:59.300667Z","end":"2026-06-30T17:09:59.578475Z","steps":["trace[1478120162] 'process raft request' (duration: 277.552546ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:09:59.733137Z","caller":"traceutil/trace.go:171","msg":"trace[1206894816] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"147.679719ms","start":"2026-06-30T17:09:59.585412Z","end":"2026-06-30T17:09:59.733092Z","steps":["trace[1206894816] 'process raft request' (duration: 147.414031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:00.022492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.465062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:10:00.02277Z","caller":"traceutil/trace.go:171","msg":"trace[1951908293] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:829; }","duration":"404.958964ms","start":"2026-06-30T17:09:59.617791Z","end":"2026-06-30T17:10:00.02275Z","steps":["trace[1951908293] 'read index received' (duration: 115.069121ms)","trace[1951908293] 'applied index is now lower than readState.Index' (duration: 289.832111ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:00.022808Z","caller":"traceutil/trace.go:171","msg":"trace[1884689709] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"437.19854ms","start":"2026-06-30T17:09:59.585467Z","end":"2026-06-30T17:10:00.022665Z","steps":["trace[1884689709] 'process raft request' (duration: 317.466129ms)","trace[1884689709] 'compare' (duration: 119.350379ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:00.022875Z","caller":"traceutil/trace.go:171","msg":"trace[1250734879] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"435.929059ms","start":"2026-06-30T17:09:59.586932Z","end":"2026-06-30T17:10:00.022861Z","steps":["trace[1250734879] 'process raft request' (duration: 435.675351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:00.022924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:59.58544Z","time spent":"437.422277ms","remote":"127.0.0.1:58488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:10:00.022993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.19099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T17:10:00.023192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:59.586924Z","time spent":"436.213198ms","remote":"127.0.0.1:47690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3852,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:10:00.023302Z","caller":"traceutil/trace.go:171","msg":"trace[1559483716] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:802; }","duration":"405.561953ms","start":"2026-06-30T17:09:59.617718Z","end":"2026-06-30T17:10:00.02328Z","steps":["trace[1559483716] 'agreement among raft nodes before linearized reading' (duration: 405.152349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:00.023356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:59.617689Z","time spent":"405.652306ms","remote":"127.0.0.1:47642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:10:00.234792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.456791ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:10:00.235071Z","caller":"traceutil/trace.go:171","msg":"trace[299112573] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"387.795141ms","start":"2026-06-30T17:09:59.847236Z","end":"2026-06-30T17:10:00.235031Z","steps":["trace[299112573] 'process raft request' (duration: 281.571605ms)","trace[299112573] 'compare' (duration: 105.321007ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:00.235199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.070977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:00.235254Z","caller":"traceutil/trace.go:171","msg":"trace[1020566100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"257.15872ms","start":"2026-06-30T17:09:59.97808Z","end":"2026-06-30T17:10:00.235239Z","steps":["trace[1020566100] 'agreement among raft nodes before linearized reading' (duration: 257.011565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:00.235225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:59.847198Z","time spent":"387.947526ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:10:00.235335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.843275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:10:00.235455Z","caller":"traceutil/trace.go:171","msg":"trace[1090116920] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:803; }","duration":"213.00533ms","start":"2026-06-30T17:10:00.022426Z","end":"2026-06-30T17:10:00.235431Z","steps":["trace[1090116920] 'agreement among raft nodes before linearized reading' (duration: 212.547376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:00.235329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.785887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:10:00.235645Z","caller":"traceutil/trace.go:171","msg":"trace[993228632] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:803; }","duration":"215.185331ms","start":"2026-06-30T17:10:00.020445Z","end":"2026-06-30T17:10:00.23563Z","steps":["trace[993228632] 'agreement among raft nodes before linearized reading' (duration: 214.617462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:00.235968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.200888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:10:00.236029Z","caller":"traceutil/trace.go:171","msg":"trace[10987512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:803; }","duration":"408.303611ms","start":"2026-06-30T17:09:59.82771Z","end":"2026-06-30T17:10:00.236014Z","steps":["trace[10987512] 'agreement among raft nodes before linearized reading' (duration: 408.058493ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:00.236052Z","caller":"traceutil/trace.go:171","msg":"trace[229559] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:832; }","duration":"212.098391ms","start":"2026-06-30T17:10:00.022823Z","end":"2026-06-30T17:10:00.234922Z","steps":["trace[229559] 'read index received' (duration: 105.984798ms)","trace[229559] 'applied index is now lower than readState.Index' (duration: 106.111843ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:00.236092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:09:59.827685Z","time spent":"408.384374ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T17:10:00.238344Z","caller":"traceutil/trace.go:171","msg":"trace[349801858] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"207.37579ms","start":"2026-06-30T17:10:00.030954Z","end":"2026-06-30T17:10:00.238329Z","steps":["trace[349801858] 'process raft request' (duration: 207.09055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:00.238578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.48483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:10:00.238622Z","caller":"traceutil/trace.go:171","msg":"trace[1474155237] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:804; }","duration":"215.563623ms","start":"2026-06-30T17:10:00.023048Z","end":"2026-06-30T17:10:00.238611Z","steps":["trace[1474155237] 'agreement among raft nodes before linearized reading' (duration: 215.456689ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:01.362743Z","caller":"traceutil/trace.go:171","msg":"trace[1333609842] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"258.430791ms","start":"2026-06-30T17:10:01.10426Z","end":"2026-06-30T17:10:01.362691Z","steps":["trace[1333609842] 'read index received' (duration: 256.189249ms)","trace[1333609842] 'applied index is now lower than readState.Index' (duration: 2.240592ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:01.36292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.285586ms","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":"warn","ts":"2026-06-30T17:10:01.36292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.614747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:01.36296Z","caller":"traceutil/trace.go:171","msg":"trace[15743103] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:808; }","duration":"258.743091ms","start":"2026-06-30T17:10:01.104207Z","end":"2026-06-30T17:10:01.36295Z","steps":["trace[15743103] 'agreement among raft nodes before linearized reading' (duration: 258.624797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:01.363029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.37883ms","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":"info","ts":"2026-06-30T17:10:01.363097Z","caller":"traceutil/trace.go:171","msg":"trace[195836829] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:808; }","duration":"212.463983ms","start":"2026-06-30T17:10:01.150627Z","end":"2026-06-30T17:10:01.363091Z","steps":["trace[195836829] 'agreement among raft nodes before linearized reading' (duration: 212.36835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:01.363215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.00867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:01.36326Z","caller":"traceutil/trace.go:171","msg":"trace[153449849] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:808; }","duration":"213.086882ms","start":"2026-06-30T17:10:01.150166Z","end":"2026-06-30T17:10:01.363253Z","steps":["trace[153449849] 'agreement among raft nodes before linearized reading' (duration: 213.02696ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:01.362953Z","caller":"traceutil/trace.go:171","msg":"trace[355234875] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:808; }","duration":"258.40451ms","start":"2026-06-30T17:10:01.10454Z","end":"2026-06-30T17:10:01.362944Z","steps":["trace[355234875] 'agreement among raft nodes before linearized reading' (duration: 258.309757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:01.363717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.530467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:01.36379Z","caller":"traceutil/trace.go:171","msg":"trace[2095184203] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:808; }","duration":"213.672551ms","start":"2026-06-30T17:10:01.150107Z","end":"2026-06-30T17:10:01.363779Z","steps":["trace[2095184203] 'agreement among raft nodes before linearized reading' (duration: 213.573398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:04.759359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868376585,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:10:05.260379Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868376585,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:10:05.297637Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.267965756s","expected-duration":"1s"} {"level":"info","ts":"2026-06-30T17:10:05.298038Z","caller":"traceutil/trace.go:171","msg":"trace[228792252] linearizableReadLoop","detail":"{readStateIndex:854; appliedIndex:853; }","duration":"1.039703016s","start":"2026-06-30T17:10:04.258298Z","end":"2026-06-30T17:10:05.298001Z","steps":["trace[228792252] 'read index received' (duration: 1.039481169s)","trace[228792252] 'applied index is now lower than readState.Index' (duration: 220.857µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:05.298124Z","caller":"traceutil/trace.go:171","msg":"trace[1454972126] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"1.268631698s","start":"2026-06-30T17:10:04.029482Z","end":"2026-06-30T17:10:05.298114Z","steps":["trace[1454972126] 'process raft request' (duration: 1.268357379s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:05.328544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:04.029438Z","time spent":"1.26871468s","remote":"127.0.0.1:58514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:10:05.676742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.41483114s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-30T17:10:05.67681Z","caller":"traceutil/trace.go:171","msg":"trace[1322290086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:823; }","duration":"1.414936614s","start":"2026-06-30T17:10:04.261853Z","end":"2026-06-30T17:10:05.67679Z","steps":["trace[1322290086] 'agreement among raft nodes before linearized reading' (duration: 1.066635353s)","trace[1322290086] 'range keys from in-memory index tree' (duration: 348.123475ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:05.676845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:04.261836Z","time spent":"1.414999306s","remote":"127.0.0.1:58608","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-06-30T17:10:05.67687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.41854468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:10:05.676962Z","caller":"traceutil/trace.go:171","msg":"trace[1428329167] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:823; }","duration":"1.418666613s","start":"2026-06-30T17:10:04.258268Z","end":"2026-06-30T17:10:05.676935Z","steps":["trace[1428329167] 'agreement among raft nodes before linearized reading' (duration: 1.039975385s)","trace[1428329167] 'get authentication metadata' (duration: 30.230212ms)","trace[1428329167] 'range keys from in-memory index tree' (duration: 348.26039ms)"],"step_count":3} {"level":"warn","ts":"2026-06-30T17:10:05.677009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:04.258252Z","time spent":"1.418750927s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:10:05.676982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.415022446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:10:05.677064Z","caller":"traceutil/trace.go:171","msg":"trace[719739444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:823; }","duration":"1.415157651s","start":"2026-06-30T17:10:04.261887Z","end":"2026-06-30T17:10:05.677045Z","steps":["trace[719739444] 'agreement among raft nodes before linearized reading' (duration: 1.066599942s)","trace[719739444] 'range keys from in-memory index tree' (duration: 348.373063ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:05.677112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:04.261873Z","time spent":"1.415227983s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:10:05.677214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.631497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:05.677237Z","caller":"traceutil/trace.go:171","msg":"trace[645009325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:823; }","duration":"698.68805ms","start":"2026-06-30T17:10:04.978542Z","end":"2026-06-30T17:10:05.677231Z","steps":["trace[645009325] 'agreement among raft nodes before linearized reading' (duration: 349.957855ms)","trace[645009325] 'range keys from in-memory index tree' (duration: 348.699854ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:05.677244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.266927ms","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-06-30T17:10:05.677256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:04.978524Z","time spent":"698.727361ms","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:10:05.677273Z","caller":"traceutil/trace.go:171","msg":"trace[276178072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:823; }","duration":"291.34989ms","start":"2026-06-30T17:10:05.385916Z","end":"2026-06-30T17:10:05.677266Z","steps":["trace[276178072] 'range keys from in-memory index tree' (duration: 291.149113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:05.677316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.415336427s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:10:05.677429Z","caller":"traceutil/trace.go:171","msg":"trace[949273131] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:823; }","duration":"1.415584084s","start":"2026-06-30T17:10:04.261821Z","end":"2026-06-30T17:10:05.677405Z","steps":["trace[949273131] 'agreement among raft nodes before linearized reading' (duration: 1.066652353s)","trace[949273131] 'range keys from in-memory index tree' (duration: 348.419895ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:05.677458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.245885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-30T17:10:05.677509Z","caller":"traceutil/trace.go:171","msg":"trace[295716773] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:823; }","duration":"119.321847ms","start":"2026-06-30T17:10:05.55817Z","end":"2026-06-30T17:10:05.677492Z","steps":["trace[295716773] 'range keys from in-memory index tree' (duration: 119.09503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:05.677605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:04.261799Z","time spent":"1.415785871s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-30T17:10:09.219889Z","caller":"traceutil/trace.go:171","msg":"trace[1533496526] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"134.967601ms","start":"2026-06-30T17:10:09.084875Z","end":"2026-06-30T17:10:09.219843Z","steps":["trace[1533496526] 'process raft request' (duration: 44.038417ms)","trace[1533496526] 'compare' (duration: 90.644425ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:09.220009Z","caller":"traceutil/trace.go:171","msg":"trace[245974019] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"134.602129ms","start":"2026-06-30T17:10:09.085372Z","end":"2026-06-30T17:10:09.219974Z","steps":["trace[245974019] 'process raft request' (duration: 134.344991ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:09.464151Z","caller":"traceutil/trace.go:171","msg":"trace[466929418] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"112.379904ms","start":"2026-06-30T17:10:09.351746Z","end":"2026-06-30T17:10:09.464126Z","steps":["trace[466929418] 'process raft request' (duration: 112.327942ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:09.464217Z","caller":"traceutil/trace.go:171","msg":"trace[1793147570] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"114.594205ms","start":"2026-06-30T17:10:09.349592Z","end":"2026-06-30T17:10:09.464186Z","steps":["trace[1793147570] 'process raft request' (duration: 112.685514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:09.727096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.550149ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:10:09.727291Z","caller":"traceutil/trace.go:171","msg":"trace[1366397869] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"223.199308ms","start":"2026-06-30T17:10:09.504073Z","end":"2026-06-30T17:10:09.727272Z","steps":["trace[1366397869] 'process raft request' (duration: 223.124655ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:09.727336Z","caller":"traceutil/trace.go:171","msg":"trace[1031589705] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"224.929404ms","start":"2026-06-30T17:10:09.502383Z","end":"2026-06-30T17:10:09.727312Z","steps":["trace[1031589705] 'process raft request' (duration: 94.096556ms)","trace[1031589705] 'compare' (duration: 130.422575ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:09.792293Z","caller":"traceutil/trace.go:171","msg":"trace[1035680154] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"248.532573ms","start":"2026-06-30T17:10:09.543733Z","end":"2026-06-30T17:10:09.792265Z","steps":["trace[1035680154] 'process raft request' (duration: 248.335917ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:09.792399Z","caller":"traceutil/trace.go:171","msg":"trace[1500454109] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"246.156646ms","start":"2026-06-30T17:10:09.546208Z","end":"2026-06-30T17:10:09.792365Z","steps":["trace[1500454109] 'process raft request' (duration: 246.028192ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:09.792429Z","caller":"traceutil/trace.go:171","msg":"trace[1151738484] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"248.053937ms","start":"2026-06-30T17:10:09.54435Z","end":"2026-06-30T17:10:09.792404Z","steps":["trace[1151738484] 'process raft request' (duration: 247.82446ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:10.03201Z","caller":"traceutil/trace.go:171","msg":"trace[1155574819] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"176.814626ms","start":"2026-06-30T17:10:09.855163Z","end":"2026-06-30T17:10:10.031977Z","steps":["trace[1155574819] 'process raft request' (duration: 156.355308ms)","trace[1155574819] 'compare' (duration: 19.628351ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:10.080946Z","caller":"traceutil/trace.go:171","msg":"trace[1289789502] linearizableReadLoop","detail":"{readStateIndex:905; appliedIndex:903; }","duration":"208.049761ms","start":"2026-06-30T17:10:09.872858Z","end":"2026-06-30T17:10:10.080908Z","steps":["trace[1289789502] 'read index received' (duration: 138.032569ms)","trace[1289789502] 'applied index is now lower than readState.Index' (duration: 70.016511ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:10.08105Z","caller":"traceutil/trace.go:171","msg":"trace[450818673] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"208.526566ms","start":"2026-06-30T17:10:09.872486Z","end":"2026-06-30T17:10:10.081012Z","steps":["trace[450818673] 'process raft request' (duration: 208.282068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:10.081157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.283479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:5577"} {"level":"info","ts":"2026-06-30T17:10:10.081212Z","caller":"traceutil/trace.go:171","msg":"trace[1849863819] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:873; }","duration":"208.360901ms","start":"2026-06-30T17:10:09.87282Z","end":"2026-06-30T17:10:10.081181Z","steps":["trace[1849863819] 'agreement among raft nodes before linearized reading' (duration: 208.205866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:10.081278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.241713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:10:10.081308Z","caller":"traceutil/trace.go:171","msg":"trace[2090365074] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:873; }","duration":"141.312315ms","start":"2026-06-30T17:10:09.939988Z","end":"2026-06-30T17:10:10.0813Z","steps":["trace[2090365074] 'agreement among raft nodes before linearized reading' (duration: 141.231123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:10.081467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.709348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:10.081551Z","caller":"traceutil/trace.go:171","msg":"trace[1468455664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:873; }","duration":"104.803711ms","start":"2026-06-30T17:10:09.976711Z","end":"2026-06-30T17:10:10.081515Z","steps":["trace[1468455664] 'agreement among raft nodes before linearized reading' (duration: 104.679167ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:10.230655Z","caller":"traceutil/trace.go:171","msg":"trace[2113880678] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"135.646772ms","start":"2026-06-30T17:10:10.094972Z","end":"2026-06-30T17:10:10.230619Z","steps":["trace[2113880678] 'process raft request' (duration: 104.294474ms)","trace[2113880678] 'compare' (duration: 31.067709ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:10.515727Z","caller":"traceutil/trace.go:171","msg":"trace[884845661] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"150.831591ms","start":"2026-06-30T17:10:10.364853Z","end":"2026-06-30T17:10:10.515684Z","steps":["trace[884845661] 'process raft request' (duration: 150.631304ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:10.704191Z","caller":"traceutil/trace.go:171","msg":"trace[1927763924] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"179.562425ms","start":"2026-06-30T17:10:10.524608Z","end":"2026-06-30T17:10:10.70417Z","steps":["trace[1927763924] 'process raft request' (duration: 93.082744ms)","trace[1927763924] 'compare' (duration: 86.188122ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:10.815575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.446314ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-30T17:10:11.501707Z","caller":"traceutil/trace.go:171","msg":"trace[71408632] linearizableReadLoop","detail":"{readStateIndex:910; appliedIndex:909; }","duration":"112.445715ms","start":"2026-06-30T17:10:11.389227Z","end":"2026-06-30T17:10:11.501672Z","steps":["trace[71408632] 'read index received' (duration: 112.2686ms)","trace[71408632] 'applied index is now lower than readState.Index' (duration: 175.645µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:11.501762Z","caller":"traceutil/trace.go:171","msg":"trace[1456194401] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"173.699435ms","start":"2026-06-30T17:10:11.328021Z","end":"2026-06-30T17:10:11.50172Z","steps":["trace[1456194401] 'process raft request' (duration: 173.467647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:11.501885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.636581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/eg\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:11.50192Z","caller":"traceutil/trace.go:171","msg":"trace[1285370305] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/eg; range_end:; response_count:0; response_revision:877; }","duration":"112.755605ms","start":"2026-06-30T17:10:11.389152Z","end":"2026-06-30T17:10:11.501907Z","steps":["trace[1285370305] 'agreement among raft nodes before linearized reading' (duration: 112.633121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:12.255442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.408046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:12.255756Z","caller":"traceutil/trace.go:171","msg":"trace[291799698] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:0; response_revision:888; }","duration":"103.761777ms","start":"2026-06-30T17:10:12.15197Z","end":"2026-06-30T17:10:12.255732Z","steps":["trace[291799698] 'range keys from in-memory index tree' (duration: 103.347913ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:13.612271Z","caller":"traceutil/trace.go:171","msg":"trace[547847554] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"155.450439ms","start":"2026-06-30T17:10:13.4568Z","end":"2026-06-30T17:10:13.61225Z","steps":["trace[547847554] 'process raft request' (duration: 155.085887ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:13.65029Z","caller":"traceutil/trace.go:171","msg":"trace[933344530] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"193.38533ms","start":"2026-06-30T17:10:13.456883Z","end":"2026-06-30T17:10:13.650269Z","steps":["trace[933344530] 'process raft request' (duration: 193.218594ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:13.650439Z","caller":"traceutil/trace.go:171","msg":"trace[414210726] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"190.416894ms","start":"2026-06-30T17:10:13.460013Z","end":"2026-06-30T17:10:13.65043Z","steps":["trace[414210726] 'process raft request' (duration: 190.205537ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:18.172426Z","caller":"traceutil/trace.go:171","msg":"trace[670525803] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"187.735447ms","start":"2026-06-30T17:10:17.984661Z","end":"2026-06-30T17:10:18.172396Z","steps":["trace[670525803] 'process raft request' (duration: 115.479754ms)","trace[670525803] 'compare' (duration: 72.069627ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:18.172598Z","caller":"traceutil/trace.go:171","msg":"trace[286748675] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"186.425755ms","start":"2026-06-30T17:10:17.98612Z","end":"2026-06-30T17:10:18.172546Z","steps":["trace[286748675] 'process raft request' (duration: 186.232009ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:28.39497Z","caller":"traceutil/trace.go:171","msg":"trace[1319437667] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"173.259532ms","start":"2026-06-30T17:10:28.221675Z","end":"2026-06-30T17:10:28.394935Z","steps":["trace[1319437667] 'process raft request' (duration: 139.549248ms)","trace[1319437667] 'compare' (duration: 33.434436ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:10:43.290031Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868377040,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:10:43.790839Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868377040,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:10:44.291865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868377040,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:10:44.320652Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.72145018s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-30T17:10:44.321004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.137324623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:10:44.321068Z","caller":"traceutil/trace.go:171","msg":"trace[1476068245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1040; }","duration":"2.137415557s","start":"2026-06-30T17:10:42.18363Z","end":"2026-06-30T17:10:44.321046Z","steps":["trace[1476068245] 'range keys from in-memory index tree' (duration: 2.13719422s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:44.321118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:42.183615Z","time spent":"2.137494279s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T17:10:44.32146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.12539346s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:10:44.321515Z","caller":"traceutil/trace.go:171","msg":"trace[940985436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1040; }","duration":"2.125489743s","start":"2026-06-30T17:10:42.196008Z","end":"2026-06-30T17:10:44.321498Z","steps":["trace[940985436] 'range keys from in-memory index tree' (duration: 2.125235115s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:44.321553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:42.195984Z","time spent":"2.125560496s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:10:44.321664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000091501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-30T17:10:44.321649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.870314717s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:10:44.321708Z","caller":"traceutil/trace.go:171","msg":"trace[877510196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1040; }","duration":"2.000173493s","start":"2026-06-30T17:10:42.321521Z","end":"2026-06-30T17:10:44.321694Z","steps":["trace[877510196] 'range keys from in-memory index tree' (duration: 1.999919555s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:44.321723Z","caller":"traceutil/trace.go:171","msg":"trace[859461600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"1.870430101s","start":"2026-06-30T17:10:42.451275Z","end":"2026-06-30T17:10:44.321705Z","steps":["trace[859461600] 'range keys from in-memory index tree' (duration: 1.870148602s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:44.321739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:42.3215Z","time spent":"2.000231375s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:10:44.321761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:42.451257Z","time spent":"1.870494892s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T17:10:44.321754Z","caller":"traceutil/trace.go:171","msg":"trace[420415489] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1080; }","duration":"1.532325717s","start":"2026-06-30T17:10:42.789414Z","end":"2026-06-30T17:10:44.321739Z","steps":["trace[420415489] 'read index received' (duration: 1.531373336s)","trace[420415489] 'applied index is now lower than readState.Index' (duration: 951.461µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:44.321831Z","caller":"traceutil/trace.go:171","msg":"trace[1874634972] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"1.72270068s","start":"2026-06-30T17:10:42.599111Z","end":"2026-06-30T17:10:44.321812Z","steps":["trace[1874634972] 'process raft request' (duration: 1.721727439s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:44.321856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.53243633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T17:10:44.321866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346072488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:10:44.321884Z","caller":"traceutil/trace.go:171","msg":"trace[1639346231] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1041; }","duration":"1.532489632s","start":"2026-06-30T17:10:42.789385Z","end":"2026-06-30T17:10:44.321875Z","steps":["trace[1639346231] 'agreement among raft nodes before linearized reading' (duration: 1.53242495s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:44.321898Z","caller":"traceutil/trace.go:171","msg":"trace[1085172410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1041; }","duration":"1.3461312s","start":"2026-06-30T17:10:42.975755Z","end":"2026-06-30T17:10:44.321887Z","steps":["trace[1085172410] 'agreement among raft nodes before linearized reading' (duration: 1.346072518s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:44.321911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:42.78937Z","time spent":"1.532533834s","remote":"127.0.0.1:47690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":29,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:10:44.321915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:42.599092Z","time spent":"1.722770512s","remote":"127.0.0.1:58608","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-06-30T17:10:44.321926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.209467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T17:10:44.321928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:42.975739Z","time spent":"1.346181162s","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:10:44.321962Z","caller":"traceutil/trace.go:171","msg":"trace[2145840373] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1041; }","duration":"737.29034ms","start":"2026-06-30T17:10:43.584659Z","end":"2026-06-30T17:10:44.32195Z","steps":["trace[2145840373] 'agreement among raft nodes before linearized reading' (duration: 737.222707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:44.32199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:10:43.584617Z","time spent":"737.365022ms","remote":"127.0.0.1:47714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:10:44.321987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.175081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T17:10:44.322026Z","caller":"traceutil/trace.go:171","msg":"trace[1807767161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1041; }","duration":"183.365567ms","start":"2026-06-30T17:10:44.138648Z","end":"2026-06-30T17:10:44.322014Z","steps":["trace[1807767161] 'agreement among raft nodes before linearized reading' (duration: 183.207992ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:10:46.457821Z","caller":"traceutil/trace.go:171","msg":"trace[873577724] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"123.725149ms","start":"2026-06-30T17:10:46.334066Z","end":"2026-06-30T17:10:46.457792Z","steps":["trace[873577724] 'read index received' (duration: 123.523762ms)","trace[873577724] 'applied index is now lower than readState.Index' (duration: 200.087µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:10:46.457897Z","caller":"traceutil/trace.go:171","msg":"trace[36952453] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"126.421205ms","start":"2026-06-30T17:10:46.331449Z","end":"2026-06-30T17:10:46.45787Z","steps":["trace[36952453] 'process raft request' (duration: 126.163527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:46.458106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.019608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:10:46.458157Z","caller":"traceutil/trace.go:171","msg":"trace[1670860095] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1048; }","duration":"124.116451ms","start":"2026-06-30T17:10:46.334025Z","end":"2026-06-30T17:10:46.458141Z","steps":["trace[1670860095] 'agreement among raft nodes before linearized reading' (duration: 123.926465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:46.458569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.055449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T17:10:46.458602Z","caller":"traceutil/trace.go:171","msg":"trace[1377100336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1048; }","duration":"124.129932ms","start":"2026-06-30T17:10:46.334463Z","end":"2026-06-30T17:10:46.458593Z","steps":["trace[1377100336] 'agreement among raft nodes before linearized reading' (duration: 123.975017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:46.458619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.816565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:10:46.458661Z","caller":"traceutil/trace.go:171","msg":"trace[102978146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1048; }","duration":"120.878297ms","start":"2026-06-30T17:10:46.33777Z","end":"2026-06-30T17:10:46.458648Z","steps":["trace[102978146] 'agreement among raft nodes before linearized reading' (duration: 120.765074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:46.458725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.180834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:10:46.458745Z","caller":"traceutil/trace.go:171","msg":"trace[805898734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1048; }","duration":"124.210734ms","start":"2026-06-30T17:10:46.334528Z","end":"2026-06-30T17:10:46.458738Z","steps":["trace[805898734] 'agreement among raft nodes before linearized reading' (duration: 124.125332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:10:46.458867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.503045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:10:46.458923Z","caller":"traceutil/trace.go:171","msg":"trace[508969621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1048; }","duration":"120.580578ms","start":"2026-06-30T17:10:46.338329Z","end":"2026-06-30T17:10:46.458909Z","steps":["trace[508969621] 'agreement among raft nodes before linearized reading' (duration: 120.458074ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:00.171188Z","caller":"traceutil/trace.go:171","msg":"trace[1325865617] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1136; }","duration":"194.357341ms","start":"2026-06-30T17:10:59.976802Z","end":"2026-06-30T17:11:00.171159Z","steps":["trace[1325865617] 'read index received' (duration: 194.190835ms)","trace[1325865617] 'applied index is now lower than readState.Index' (duration: 165.616µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:00.171317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.487404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:00.171276Z","caller":"traceutil/trace.go:171","msg":"trace[296274330] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"221.948778ms","start":"2026-06-30T17:10:59.9493Z","end":"2026-06-30T17:11:00.171249Z","steps":["trace[296274330] 'process raft request' (duration: 221.70593ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:00.171368Z","caller":"traceutil/trace.go:171","msg":"trace[516646355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1094; }","duration":"194.593018ms","start":"2026-06-30T17:10:59.976764Z","end":"2026-06-30T17:11:00.171357Z","steps":["trace[516646355] 'agreement among raft nodes before linearized reading' (duration: 194.491325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.120261Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868377231,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:11:07.620933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868377231,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:11:07.650378Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.085077075s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-30T17:11:07.654995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471671418s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:07.655069Z","caller":"traceutil/trace.go:171","msg":"trace[1586168041] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1113; }","duration":"1.471780102s","start":"2026-06-30T17:11:06.183268Z","end":"2026-06-30T17:11:07.655048Z","steps":["trace[1586168041] 'count revisions from in-memory index tree' (duration: 1.471604826s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.655104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.183251Z","time spent":"1.471843593s","remote":"127.0.0.1:59612","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:11:07.655885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468822757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:07.655956Z","caller":"traceutil/trace.go:171","msg":"trace[1423825145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1113; }","duration":"1.468922949s","start":"2026-06-30T17:11:06.187012Z","end":"2026-06-30T17:11:07.655935Z","steps":["trace[1423825145] 'range keys from in-memory index tree' (duration: 1.468780385s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.655958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099687505s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T17:11:07.656006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.187005Z","time spent":"1.468988901s","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:11:07.65602Z","caller":"traceutil/trace.go:171","msg":"trace[2013193234] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1113; }","duration":"1.099794389s","start":"2026-06-30T17:11:06.556207Z","end":"2026-06-30T17:11:07.656002Z","steps":["trace[2013193234] 'count revisions from in-memory index tree' (duration: 1.099588772s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.656065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.556183Z","time spent":"1.099866881s","remote":"127.0.0.1:59830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:11:07.656045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057498508s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:07.65615Z","caller":"traceutil/trace.go:171","msg":"trace[678724263] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1113; }","duration":"1.057605642s","start":"2026-06-30T17:11:06.598526Z","end":"2026-06-30T17:11:07.656132Z","steps":["trace[678724263] 'range keys from in-memory index tree' (duration: 1.057486568s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:07.657104Z","caller":"traceutil/trace.go:171","msg":"trace[1138481186] linearizableReadLoop","detail":"{readStateIndex:1159; appliedIndex:1158; }","duration":"1.037824376s","start":"2026-06-30T17:11:06.619258Z","end":"2026-06-30T17:11:07.657083Z","steps":["trace[1138481186] 'read index received' (duration: 1.031298576s)","trace[1138481186] 'applied index is now lower than readState.Index' (duration: 6.52406ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:11:07.657224Z","caller":"traceutil/trace.go:171","msg":"trace[1681241720] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"1.092013849s","start":"2026-06-30T17:11:06.565197Z","end":"2026-06-30T17:11:07.65721Z","steps":["trace[1681241720] 'process raft request' (duration: 1.085410526s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.65731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.565176Z","time spent":"1.092078441s","remote":"127.0.0.1:58608","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-06-30T17:11:07.657769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.038292101s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-30T17:11:07.657855Z","caller":"traceutil/trace.go:171","msg":"trace[1765782902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1114; }","duration":"1.038607781s","start":"2026-06-30T17:11:06.619199Z","end":"2026-06-30T17:11:07.657807Z","steps":["trace[1765782902] 'agreement among raft nodes before linearized reading' (duration: 1.038082184s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.65791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.619177Z","time spent":"1.038718295s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:11:07.658913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.752625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:11:07.658947Z","caller":"traceutil/trace.go:171","msg":"trace[1679821109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1114; }","duration":"945.815017ms","start":"2026-06-30T17:11:06.713122Z","end":"2026-06-30T17:11:07.658937Z","steps":["trace[1679821109] 'agreement among raft nodes before linearized reading' (duration: 945.725684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.658941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.012365447s","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-06-30T17:11:07.658973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.713106Z","time spent":"945.861298ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T17:11:07.659039Z","caller":"traceutil/trace.go:171","msg":"trace[210643022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1114; }","duration":"1.012499552s","start":"2026-06-30T17:11:06.646484Z","end":"2026-06-30T17:11:07.658984Z","steps":["trace[210643022] 'agreement among raft nodes before linearized reading' (duration: 1.011918753s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.659133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.206091ms","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-06-30T17:11:07.659136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.646469Z","time spent":"1.012608466s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-30T17:11:07.659156Z","caller":"traceutil/trace.go:171","msg":"trace[1144068644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1114; }","duration":"942.258583ms","start":"2026-06-30T17:11:06.71689Z","end":"2026-06-30T17:11:07.659149Z","steps":["trace[1144068644] 'agreement among raft nodes before linearized reading' (duration: 942.186541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.659177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.716873Z","time spent":"942.299074ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T17:11:07.659308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007509921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:11:07.659345Z","caller":"traceutil/trace.go:171","msg":"trace[501182580] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1114; }","duration":"1.007579343s","start":"2026-06-30T17:11:06.651755Z","end":"2026-06-30T17:11:07.659335Z","steps":["trace[501182580] 'agreement among raft nodes before linearized reading' (duration: 1.00748225s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:07.659374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:06.651731Z","time spent":"1.007634755s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-30T17:11:07.77191Z","caller":"traceutil/trace.go:171","msg":"trace[483415843] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"107.486186ms","start":"2026-06-30T17:11:07.664402Z","end":"2026-06-30T17:11:07.771889Z","steps":["trace[483415843] 'process raft request' (duration: 107.448535ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:07.772107Z","caller":"traceutil/trace.go:171","msg":"trace[1337079724] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"107.696914ms","start":"2026-06-30T17:11:07.664388Z","end":"2026-06-30T17:11:07.772084Z","steps":["trace[1337079724] 'process raft request' (duration: 95.47356ms)","trace[1337079724] 'compare' (duration: 11.884483ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:11:07.77438Z","caller":"traceutil/trace.go:171","msg":"trace[231239751] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"109.927235ms","start":"2026-06-30T17:11:07.664441Z","end":"2026-06-30T17:11:07.774368Z","steps":["trace[231239751] 'process raft request' (duration: 109.848212ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:07.774632Z","caller":"traceutil/trace.go:171","msg":"trace[1956526247] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"108.923963ms","start":"2026-06-30T17:11:07.66569Z","end":"2026-06-30T17:11:07.774613Z","steps":["trace[1956526247] 'process raft request' (duration: 108.656574ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:07.774652Z","caller":"traceutil/trace.go:171","msg":"trace[660893670] linearizableReadLoop","detail":"{readStateIndex:1164; appliedIndex:1159; }","duration":"107.745755ms","start":"2026-06-30T17:11:07.666897Z","end":"2026-06-30T17:11:07.774642Z","steps":["trace[660893670] 'read index received' (duration: 93.033102ms)","trace[660893670] 'applied index is now lower than readState.Index' (duration: 14.712063ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:07.774744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.833337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:07.774773Z","caller":"traceutil/trace.go:171","msg":"trace[1269180735] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"108.925693ms","start":"2026-06-30T17:11:07.665839Z","end":"2026-06-30T17:11:07.774765Z","steps":["trace[1269180735] 'process raft request' (duration: 108.648484ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:07.774783Z","caller":"traceutil/trace.go:171","msg":"trace[1076064031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1120; }","duration":"107.9016ms","start":"2026-06-30T17:11:07.66687Z","end":"2026-06-30T17:11:07.774772Z","steps":["trace[1076064031] 'agreement among raft nodes before linearized reading' (duration: 107.809497ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:09.894084Z","caller":"traceutil/trace.go:171","msg":"trace[1399804664] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"113.111668ms","start":"2026-06-30T17:11:09.78095Z","end":"2026-06-30T17:11:09.894062Z","steps":["trace[1399804664] 'process raft request' (duration: 26.192173ms)","trace[1399804664] 'compare' (duration: 86.843493ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:11:09.942402Z","caller":"traceutil/trace.go:171","msg":"trace[662054797] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"160.45346ms","start":"2026-06-30T17:11:09.781917Z","end":"2026-06-30T17:11:09.942371Z","steps":["trace[662054797] 'process raft request' (duration: 160.400649ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:09.942626Z","caller":"traceutil/trace.go:171","msg":"trace[411128021] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"161.146013ms","start":"2026-06-30T17:11:09.78145Z","end":"2026-06-30T17:11:09.942596Z","steps":["trace[411128021] 'process raft request' (duration: 160.640846ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:09.942826Z","caller":"traceutil/trace.go:171","msg":"trace[1242122189] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"161.251765ms","start":"2026-06-30T17:11:09.781554Z","end":"2026-06-30T17:11:09.942806Z","steps":["trace[1242122189] 'process raft request' (duration: 160.669127ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:09.942991Z","caller":"traceutil/trace.go:171","msg":"trace[1355872975] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"161.431812ms","start":"2026-06-30T17:11:09.781545Z","end":"2026-06-30T17:11:09.942977Z","steps":["trace[1355872975] 'process raft request' (duration: 160.722179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:11.27234Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868377259,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T17:11:11.676654Z","caller":"traceutil/trace.go:171","msg":"trace[863679668] linearizableReadLoop","detail":"{readStateIndex:1173; appliedIndex:1172; }","duration":"905.047226ms","start":"2026-06-30T17:11:10.771577Z","end":"2026-06-30T17:11:11.676624Z","steps":["trace[863679668] 'read index received' (duration: 879.418032ms)","trace[863679668] 'applied index is now lower than readState.Index' (duration: 25.627664ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:11.676819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.220161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:11.676873Z","caller":"traceutil/trace.go:171","msg":"trace[235039802] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1127; }","duration":"905.362895ms","start":"2026-06-30T17:11:10.771491Z","end":"2026-06-30T17:11:11.676854Z","steps":["trace[235039802] 'agreement among raft nodes before linearized reading' (duration: 905.246062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:11.676921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:10.77147Z","time spent":"905.438768ms","remote":"127.0.0.1:59724","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-06-30T17:11:12.067584Z","caller":"traceutil/trace.go:171","msg":"trace[1309631779] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"117.163199ms","start":"2026-06-30T17:11:11.950395Z","end":"2026-06-30T17:11:12.067558Z","steps":["trace[1309631779] 'process raft request' (duration: 116.984453ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:12.067762Z","caller":"traceutil/trace.go:171","msg":"trace[1428153615] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"116.681913ms","start":"2026-06-30T17:11:11.951064Z","end":"2026-06-30T17:11:12.067746Z","steps":["trace[1428153615] 'process raft request' (duration: 116.458945ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:12.067971Z","caller":"traceutil/trace.go:171","msg":"trace[110852274] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"116.240938ms","start":"2026-06-30T17:11:11.951719Z","end":"2026-06-30T17:11:12.06796Z","steps":["trace[110852274] 'process raft request' (duration: 115.97794ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:12.068199Z","caller":"traceutil/trace.go:171","msg":"trace[638575645] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"115.887147ms","start":"2026-06-30T17:11:11.952302Z","end":"2026-06-30T17:11:12.068189Z","steps":["trace[638575645] 'process raft request' (duration: 115.626158ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:15.909047Z","caller":"traceutil/trace.go:171","msg":"trace[1619036004] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"142.019796ms","start":"2026-06-30T17:11:15.767Z","end":"2026-06-30T17:11:15.90902Z","steps":["trace[1619036004] 'process raft request' (duration: 141.82696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:32.991032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.529614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-30T17:11:32.99107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.512873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:11:32.991137Z","caller":"traceutil/trace.go:171","msg":"trace[1728675920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1246; }","duration":"705.69482ms","start":"2026-06-30T17:11:32.285418Z","end":"2026-06-30T17:11:32.991113Z","steps":["trace[1728675920] 'range keys from in-memory index tree' (duration: 705.313177ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:32.991154Z","caller":"traceutil/trace.go:171","msg":"trace[1149209874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1246; }","duration":"841.639237ms","start":"2026-06-30T17:11:32.149497Z","end":"2026-06-30T17:11:32.991136Z","steps":["trace[1149209874] 'range keys from in-memory index tree' (duration: 841.225114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:32.99118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:32.285392Z","time spent":"705.775693ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:11:32.99119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:32.149466Z","time spent":"841.717389ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:11:32.991439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.892673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T17:11:32.991464Z","caller":"traceutil/trace.go:171","msg":"trace[1358489881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1246; }","duration":"699.919604ms","start":"2026-06-30T17:11:32.291538Z","end":"2026-06-30T17:11:32.991457Z","steps":["trace[1358489881] 'range keys from in-memory index tree' (duration: 699.294704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:32.991483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:32.291452Z","time spent":"700.025888ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T17:11:32.991584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.613185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:11:32.99161Z","caller":"traceutil/trace.go:171","msg":"trace[108528177] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1246; }","duration":"704.697968ms","start":"2026-06-30T17:11:32.286904Z","end":"2026-06-30T17:11:32.991602Z","steps":["trace[108528177] 'range keys from in-memory index tree' (duration: 703.872921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:32.991634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:32.286895Z","time spent":"704.734809ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:11:32.991788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.690631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T17:11:32.991833Z","caller":"traceutil/trace.go:171","msg":"trace[717848458] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1246; }","duration":"701.775704ms","start":"2026-06-30T17:11:32.290048Z","end":"2026-06-30T17:11:32.991823Z","steps":["trace[717848458] 'range keys from in-memory index tree' (duration: 701.547126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:32.991855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:32.290027Z","time spent":"701.823816ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-30T17:11:37.201255Z","caller":"traceutil/trace.go:171","msg":"trace[1167514428] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"123.044523ms","start":"2026-06-30T17:11:37.078184Z","end":"2026-06-30T17:11:37.201229Z","steps":["trace[1167514428] 'process raft request' (duration: 123.009372ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:37.20128Z","caller":"traceutil/trace.go:171","msg":"trace[440606776] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"123.527159ms","start":"2026-06-30T17:11:37.07772Z","end":"2026-06-30T17:11:37.201247Z","steps":["trace[440606776] 'process raft request' (duration: 123.299001ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:37.201448Z","caller":"traceutil/trace.go:171","msg":"trace[1915595404] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"123.611221ms","start":"2026-06-30T17:11:37.077778Z","end":"2026-06-30T17:11:37.201389Z","steps":["trace[1915595404] 'process raft request' (duration: 123.380024ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:43.330402Z","caller":"traceutil/trace.go:171","msg":"trace[681242438] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1333; }","duration":"170.643642ms","start":"2026-06-30T17:11:43.15974Z","end":"2026-06-30T17:11:43.330383Z","steps":["trace[681242438] 'read index received' (duration: 170.468696ms)","trace[681242438] 'applied index is now lower than readState.Index' (duration: 174.286µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:11:43.33062Z","caller":"traceutil/trace.go:171","msg":"trace[1743633306] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"216.401682ms","start":"2026-06-30T17:11:43.114206Z","end":"2026-06-30T17:11:43.330608Z","steps":["trace[1743633306] 'process raft request' (duration: 216.062141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:43.330884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.135487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:11:43.330919Z","caller":"traceutil/trace.go:171","msg":"trace[1979976243] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1280; }","duration":"171.21608ms","start":"2026-06-30T17:11:43.159695Z","end":"2026-06-30T17:11:43.330911Z","steps":["trace[1979976243] 'agreement among raft nodes before linearized reading' (duration: 171.101416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:43.331045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.191221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:11:43.331072Z","caller":"traceutil/trace.go:171","msg":"trace[2016803432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1280; }","duration":"101.258073ms","start":"2026-06-30T17:11:43.229808Z","end":"2026-06-30T17:11:43.331066Z","steps":["trace[2016803432] 'agreement among raft nodes before linearized reading' (duration: 101.194301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:43.331219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.241451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-30T17:11:43.331245Z","caller":"traceutil/trace.go:171","msg":"trace[484241478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1280; }","duration":"100.295151ms","start":"2026-06-30T17:11:43.230944Z","end":"2026-06-30T17:11:43.331239Z","steps":["trace[484241478] 'agreement among raft nodes before linearized reading' (duration: 100.23653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:43.331356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.509319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T17:11:43.331381Z","caller":"traceutil/trace.go:171","msg":"trace[607982854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1280; }","duration":"100.562551ms","start":"2026-06-30T17:11:43.230813Z","end":"2026-06-30T17:11:43.331375Z","steps":["trace[607982854] 'agreement among raft nodes before linearized reading' (duration: 100.504469ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:45.540745Z","caller":"traceutil/trace.go:171","msg":"trace[10361371] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"198.456356ms","start":"2026-06-30T17:11:45.342238Z","end":"2026-06-30T17:11:45.540695Z","steps":["trace[10361371] 'process raft request' (duration: 198.224408ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:45.540633Z","caller":"traceutil/trace.go:171","msg":"trace[1741319327] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1339; }","duration":"198.263789ms","start":"2026-06-30T17:11:45.342343Z","end":"2026-06-30T17:11:45.540607Z","steps":["trace[1741319327] 'read index received' (duration: 198.220718ms)","trace[1741319327] 'applied index is now lower than readState.Index' (duration: 41.601µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:45.541103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.711993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:11:45.541184Z","caller":"traceutil/trace.go:171","msg":"trace[37985203] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1286; }","duration":"198.841048ms","start":"2026-06-30T17:11:45.342319Z","end":"2026-06-30T17:11:45.54116Z","steps":["trace[37985203] 'agreement among raft nodes before linearized reading' (duration: 198.529868ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:45.553654Z","caller":"traceutil/trace.go:171","msg":"trace[2038826408] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"207.965011ms","start":"2026-06-30T17:11:45.345655Z","end":"2026-06-30T17:11:45.55362Z","steps":["trace[2038826408] 'process raft request' (duration: 207.725403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:45.553801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.374821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-30T17:11:45.553884Z","caller":"traceutil/trace.go:171","msg":"trace[373221029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1287; }","duration":"211.477473ms","start":"2026-06-30T17:11:45.342372Z","end":"2026-06-30T17:11:45.55385Z","steps":["trace[373221029] 'agreement among raft nodes before linearized reading' (duration: 211.194264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:45.554061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.277831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:11:45.554182Z","caller":"traceutil/trace.go:171","msg":"trace[1106909386] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1287; }","duration":"208.455636ms","start":"2026-06-30T17:11:45.345696Z","end":"2026-06-30T17:11:45.554152Z","steps":["trace[1106909386] 'agreement among raft nodes before linearized reading' (duration: 208.076784ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:50.30331Z","caller":"traceutil/trace.go:171","msg":"trace[291487798] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1362; }","duration":"703.51286ms","start":"2026-06-30T17:11:49.599762Z","end":"2026-06-30T17:11:50.303275Z","steps":["trace[291487798] 'read index received' (duration: 39.712016ms)","trace[291487798] 'applied index is now lower than readState.Index' (duration: 663.799554ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:11:50.303317Z","caller":"traceutil/trace.go:171","msg":"trace[468241330] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"723.937307ms","start":"2026-06-30T17:11:49.579328Z","end":"2026-06-30T17:11:50.303265Z","steps":["trace[468241330] 'process raft request' (duration: 694.676007ms)","trace[468241330] 'compare' (duration: 28.779134ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:11:50.303426Z","caller":"traceutil/trace.go:171","msg":"trace[1019472505] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"723.201092ms","start":"2026-06-30T17:11:49.580206Z","end":"2026-06-30T17:11:50.303407Z","steps":["trace[1019472505] 'process raft request' (duration: 722.954304ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:50.303529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:49.580195Z","time spent":"723.260585ms","remote":"127.0.0.1:58608","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-06-30T17:11:50.303531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:49.579311Z","time spent":"724.126012ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:11:50.30358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.79915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:11:50.303638Z","caller":"traceutil/trace.go:171","msg":"trace[172667267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1310; }","duration":"703.910683ms","start":"2026-06-30T17:11:49.599708Z","end":"2026-06-30T17:11:50.303618Z","steps":["trace[172667267] 'agreement among raft nodes before linearized reading' (duration: 703.720987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:50.303684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:49.599688Z","time spent":"703.984726ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:11:50.803623Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292526868377683,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T17:11:51.051492Z","caller":"traceutil/trace.go:171","msg":"trace[1855386297] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"859.519113ms","start":"2026-06-30T17:11:50.191939Z","end":"2026-06-30T17:11:51.051458Z","steps":["trace[1855386297] 'process raft request' (duration: 787.261001ms)","trace[1855386297] 'compare' (duration: 72.150138ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:51.051638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:50.1919Z","time spent":"859.661407ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:11:51.062453Z","caller":"traceutil/trace.go:171","msg":"trace[776053626] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"752.884617ms","start":"2026-06-30T17:11:50.309527Z","end":"2026-06-30T17:11:51.062411Z","steps":["trace[776053626] 'process raft request' (duration: 752.614358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:51.062606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:50.309501Z","time spent":"753.027382ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:11:51.095073Z","caller":"traceutil/trace.go:171","msg":"trace[689039614] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1365; }","duration":"791.647942ms","start":"2026-06-30T17:11:50.303401Z","end":"2026-06-30T17:11:51.095049Z","steps":["trace[689039614] 'read index received' (duration: 675.806711ms)","trace[689039614] 'applied index is now lower than readState.Index' (duration: 115.840211ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:51.09521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116400784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:11:51.095281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290858149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:51.095284Z","caller":"traceutil/trace.go:171","msg":"trace[1376399503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1312; }","duration":"1.11656913s","start":"2026-06-30T17:11:49.978689Z","end":"2026-06-30T17:11:51.095258Z","steps":["trace[1376399503] 'agreement among raft nodes before linearized reading' (duration: 1.116442126s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:51.095317Z","caller":"traceutil/trace.go:171","msg":"trace[1744016974] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1312; }","duration":"1.290902411s","start":"2026-06-30T17:11:49.804404Z","end":"2026-06-30T17:11:51.095306Z","steps":["trace[1744016974] 'agreement among raft nodes before linearized reading' (duration: 1.290834068s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:51.095341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:49.804302Z","time spent":"1.291033154s","remote":"127.0.0.1:59750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:11:51.095334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:49.978657Z","time spent":"1.116667033s","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:11:51.095348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.493243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T17:11:51.095369Z","caller":"traceutil/trace.go:171","msg":"trace[88318239] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1312; }","duration":"1.493302502s","start":"2026-06-30T17:11:49.60206Z","end":"2026-06-30T17:11:51.095363Z","steps":["trace[88318239] 'agreement among raft nodes before linearized reading' (duration: 1.493068055s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:51.095389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:49.602046Z","time spent":"1.493337524s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T17:11:51.095519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.363898095s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:11:51.095631Z","caller":"traceutil/trace.go:171","msg":"trace[901220715] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1312; }","duration":"1.36404729s","start":"2026-06-30T17:11:49.731555Z","end":"2026-06-30T17:11:51.095602Z","steps":["trace[901220715] 'agreement among raft nodes before linearized reading' (duration: 1.363787022s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:51.095688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:49.731536Z","time spent":"1.364139623s","remote":"127.0.0.1:58488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":5,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-06-30T17:11:51.430832Z","caller":"traceutil/trace.go:171","msg":"trace[1596251906] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"110.17523ms","start":"2026-06-30T17:11:51.320627Z","end":"2026-06-30T17:11:51.430802Z","steps":["trace[1596251906] 'process raft request' (duration: 109.933592ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:52.649194Z","caller":"traceutil/trace.go:171","msg":"trace[1083104808] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"337.282015ms","start":"2026-06-30T17:11:52.311885Z","end":"2026-06-30T17:11:52.649167Z","steps":["trace[1083104808] 'process raft request' (duration: 337.12585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:52.649409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:52.31187Z","time spent":"337.393209ms","remote":"127.0.0.1:58608","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-06-30T17:11:53.733631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.821772ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:11:53.7341Z","caller":"traceutil/trace.go:171","msg":"trace[2064862465] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"675.233513ms","start":"2026-06-30T17:11:53.05883Z","end":"2026-06-30T17:11:53.734064Z","steps":["trace[2064862465] 'process raft request' (duration: 674.977584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:53.734214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:53.058814Z","time spent":"675.351846ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:11:53.734959Z","caller":"traceutil/trace.go:171","msg":"trace[352032963] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"1.421397374s","start":"2026-06-30T17:11:52.313538Z","end":"2026-06-30T17:11:53.734936Z","steps":["trace[352032963] 'process raft request' (duration: 781.119934ms)","trace[352032963] 'compare' (duration: 637.463239ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:53.735067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:52.313525Z","time spent":"1.421489216s","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:11:53.735655Z","caller":"traceutil/trace.go:171","msg":"trace[512700651] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1372; }","duration":"1.338654795s","start":"2026-06-30T17:11:52.396986Z","end":"2026-06-30T17:11:53.735641Z","steps":["trace[512700651] 'read index received' (duration: 252.097979ms)","trace[512700651] 'applied index is now lower than readState.Index' (duration: 1.086554836s)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:53.736153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.333783609s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:11:53.736149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.339142271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:11:53.736211Z","caller":"traceutil/trace.go:171","msg":"trace[564549440] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1319; }","duration":"1.339260175s","start":"2026-06-30T17:11:52.396934Z","end":"2026-06-30T17:11:53.736194Z","steps":["trace[564549440] 'agreement among raft nodes before linearized reading' (duration: 1.33912109s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:53.736245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:52.396911Z","time spent":"1.339328937s","remote":"127.0.0.1:58404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-06-30T17:11:53.7362Z","caller":"traceutil/trace.go:171","msg":"trace[323755945] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1319; }","duration":"1.333865542s","start":"2026-06-30T17:11:52.40232Z","end":"2026-06-30T17:11:53.736186Z","steps":["trace[323755945] 'agreement among raft nodes before linearized reading' (duration: 1.333780919s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:53.736409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:52.402309Z","time spent":"1.334041107s","remote":"127.0.0.1:59780","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-06-30T17:11:53.736511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.916791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T17:11:53.736532Z","caller":"traceutil/trace.go:171","msg":"trace[1683891827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1319; }","duration":"556.985964ms","start":"2026-06-30T17:11:53.179541Z","end":"2026-06-30T17:11:53.736527Z","steps":["trace[1683891827] 'agreement among raft nodes before linearized reading' (duration: 556.897341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:53.736546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:53.179519Z","time spent":"557.024675ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T17:11:53.736657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.06217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:11:53.736674Z","caller":"traceutil/trace.go:171","msg":"trace[2120160805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1319; }","duration":"667.116141ms","start":"2026-06-30T17:11:53.069554Z","end":"2026-06-30T17:11:53.73667Z","steps":["trace[2120160805] 'agreement among raft nodes before linearized reading' (duration: 667.07019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:53.736688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:53.069531Z","time spent":"667.154283ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:11:53.73666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.190759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:53.736726Z","caller":"traceutil/trace.go:171","msg":"trace[198558606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1319; }","duration":"759.298683ms","start":"2026-06-30T17:11:52.97741Z","end":"2026-06-30T17:11:53.736708Z","steps":["trace[198558606] 'agreement among raft nodes before linearized reading' (duration: 759.20681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:53.736773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:52.977379Z","time spent":"759.386385ms","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:11:53.736428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.221421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:11:53.736937Z","caller":"traceutil/trace.go:171","msg":"trace[953248434] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1319; }","duration":"698.744037ms","start":"2026-06-30T17:11:53.038185Z","end":"2026-06-30T17:11:53.736929Z","steps":["trace[953248434] 'agreement among raft nodes before linearized reading' (duration: 698.221861ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:53.736944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.268603ms","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":"warn","ts":"2026-06-30T17:11:53.736965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:53.038179Z","time spent":"698.775798ms","remote":"127.0.0.1:59670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-06-30T17:11:53.736977Z","caller":"traceutil/trace.go:171","msg":"trace[623796994] 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:1319; }","duration":"703.343306ms","start":"2026-06-30T17:11:53.033622Z","end":"2026-06-30T17:11:53.736965Z","steps":["trace[623796994] 'agreement among raft nodes before linearized reading' (duration: 703.288064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:53.737015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:53.03359Z","time spent":"703.416478ms","remote":"127.0.0.1:59686","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":"info","ts":"2026-06-30T17:11:53.998964Z","caller":"traceutil/trace.go:171","msg":"trace[188435644] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"256.645325ms","start":"2026-06-30T17:11:53.742293Z","end":"2026-06-30T17:11:53.998938Z","steps":["trace[188435644] 'read index received' (duration: 174.694672ms)","trace[188435644] 'applied index is now lower than readState.Index' (duration: 81.949433ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:11:53.999003Z","caller":"traceutil/trace.go:171","msg":"trace[1107286865] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"256.7863ms","start":"2026-06-30T17:11:53.742184Z","end":"2026-06-30T17:11:53.99897Z","steps":["trace[1107286865] 'process raft request' (duration: 174.564988ms)","trace[1107286865] 'compare' (duration: 82.081717ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:11:53.999071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.761529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-30T17:11:53.999106Z","caller":"traceutil/trace.go:171","msg":"trace[1039974772] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1320; }","duration":"256.81406ms","start":"2026-06-30T17:11:53.742281Z","end":"2026-06-30T17:11:53.999095Z","steps":["trace[1039974772] 'agreement among raft nodes before linearized reading' (duration: 256.745128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:54.033713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.564034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:103622"} {"level":"info","ts":"2026-06-30T17:11:54.033803Z","caller":"traceutil/trace.go:171","msg":"trace[503679200] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1322; }","duration":"285.691088ms","start":"2026-06-30T17:11:53.74809Z","end":"2026-06-30T17:11:54.033782Z","steps":["trace[503679200] 'agreement among raft nodes before linearized reading' (duration: 285.418059ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:54.034155Z","caller":"traceutil/trace.go:171","msg":"trace[2073717493] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"290.125531ms","start":"2026-06-30T17:11:53.744017Z","end":"2026-06-30T17:11:54.034142Z","steps":["trace[2073717493] 'process raft request' (duration: 289.334395ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:54.034291Z","caller":"traceutil/trace.go:171","msg":"trace[1367297312] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"290.195683ms","start":"2026-06-30T17:11:53.744084Z","end":"2026-06-30T17:11:54.034279Z","steps":["trace[1367297312] 'process raft request' (duration: 289.382007ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:55.020014Z","caller":"traceutil/trace.go:171","msg":"trace[231517773] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"147.173948ms","start":"2026-06-30T17:11:54.872817Z","end":"2026-06-30T17:11:55.019991Z","steps":["trace[231517773] 'read index received' (duration: 146.92865ms)","trace[231517773] 'applied index is now lower than readState.Index' (duration: 244.278µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:11:55.020136Z","caller":"traceutil/trace.go:171","msg":"trace[2066101782] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"363.123495ms","start":"2026-06-30T17:11:54.657003Z","end":"2026-06-30T17:11:55.020126Z","steps":["trace[2066101782] 'process raft request' (duration: 362.833306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:11:55.020234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:11:54.656978Z","time spent":"363.182067ms","remote":"127.0.0.1:58608","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-06-30T17:11:55.020444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.602881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:11:55.020537Z","caller":"traceutil/trace.go:171","msg":"trace[597382950] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1323; }","duration":"147.738876ms","start":"2026-06-30T17:11:54.872782Z","end":"2026-06-30T17:11:55.02052Z","steps":["trace[597382950] 'agreement among raft nodes before linearized reading' (duration: 147.616902ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:11:55.239165Z","caller":"traceutil/trace.go:171","msg":"trace[102508486] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"214.357355ms","start":"2026-06-30T17:11:55.024755Z","end":"2026-06-30T17:11:55.239112Z","steps":["trace[102508486] 'process raft request' (duration: 207.137533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:00.167996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.049516ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:12:00.168086Z","caller":"traceutil/trace.go:171","msg":"trace[793267442] linearizableReadLoop","detail":"{readStateIndex:1415; appliedIndex:1414; }","duration":"190.81318ms","start":"2026-06-30T17:11:59.97726Z","end":"2026-06-30T17:12:00.168073Z","steps":["trace[793267442] 'read index received' (duration: 89.601279ms)","trace[793267442] 'applied index is now lower than readState.Index' (duration: 101.211061ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:12:00.168345Z","caller":"traceutil/trace.go:171","msg":"trace[927665560] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"231.730984ms","start":"2026-06-30T17:11:59.936603Z","end":"2026-06-30T17:12:00.168334Z","steps":["trace[927665560] 'process raft request' (duration: 130.270405ms)","trace[927665560] 'compare' (duration: 100.944473ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:12:00.168488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.234663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:12:00.168512Z","caller":"traceutil/trace.go:171","msg":"trace[555594082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1358; }","duration":"191.292125ms","start":"2026-06-30T17:11:59.977214Z","end":"2026-06-30T17:12:00.168506Z","steps":["trace[555594082] 'agreement among raft nodes before linearized reading' (duration: 191.250663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:00.168678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.930255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:12:00.168702Z","caller":"traceutil/trace.go:171","msg":"trace[2090922696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1358; }","duration":"144.990488ms","start":"2026-06-30T17:12:00.023705Z","end":"2026-06-30T17:12:00.168695Z","steps":["trace[2090922696] 'agreement among raft nodes before linearized reading' (duration: 144.908605ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:01.781316Z","caller":"traceutil/trace.go:171","msg":"trace[762870303] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1426; }","duration":"181.440599ms","start":"2026-06-30T17:12:01.59985Z","end":"2026-06-30T17:12:01.78129Z","steps":["trace[762870303] 'read index received' (duration: 181.283824ms)","trace[762870303] 'applied index is now lower than readState.Index' (duration: 155.475µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:12:01.781508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.644626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-30T17:12:01.781488Z","caller":"traceutil/trace.go:171","msg":"trace[1633249768] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"242.527661ms","start":"2026-06-30T17:12:01.538812Z","end":"2026-06-30T17:12:01.781339Z","steps":["trace[1633249768] 'process raft request' (duration: 242.309094ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:01.781627Z","caller":"traceutil/trace.go:171","msg":"trace[986344640] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1369; }","duration":"181.815511ms","start":"2026-06-30T17:12:01.599798Z","end":"2026-06-30T17:12:01.781613Z","steps":["trace[986344640] 'agreement among raft nodes before linearized reading' (duration: 181.586754ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:02.849344Z","caller":"traceutil/trace.go:171","msg":"trace[1699242265] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"332.976957ms","start":"2026-06-30T17:12:02.516345Z","end":"2026-06-30T17:12:02.849322Z","steps":["trace[1699242265] 'process raft request' (duration: 332.871314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:02.849454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:02.51631Z","time spent":"333.095941ms","remote":"127.0.0.1:58382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":890,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:12:03.482076Z","caller":"traceutil/trace.go:171","msg":"trace[337365185] linearizableReadLoop","detail":"{readStateIndex:1436; appliedIndex:1435; }","duration":"180.802799ms","start":"2026-06-30T17:12:03.301234Z","end":"2026-06-30T17:12:03.482037Z","steps":["trace[337365185] 'read index received' (duration: 180.508489ms)","trace[337365185] 'applied index is now lower than readState.Index' (duration: 293µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:12:03.482249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.980474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:12:03.482294Z","caller":"traceutil/trace.go:171","msg":"trace[1007389693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1378; }","duration":"181.087367ms","start":"2026-06-30T17:12:03.301192Z","end":"2026-06-30T17:12:03.482279Z","steps":["trace[1007389693] 'agreement among raft nodes before linearized reading' (duration: 180.979564ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:03.482384Z","caller":"traceutil/trace.go:171","msg":"trace[1479891129] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"285.101189ms","start":"2026-06-30T17:12:03.19723Z","end":"2026-06-30T17:12:03.482331Z","steps":["trace[1479891129] 'process raft request' (duration: 284.571012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:04.54841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.998523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:12:04.548482Z","caller":"traceutil/trace.go:171","msg":"trace[130616466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1378; }","duration":"571.119087ms","start":"2026-06-30T17:12:03.977345Z","end":"2026-06-30T17:12:04.548464Z","steps":["trace[130616466] 'range keys from in-memory index tree' (duration: 570.940552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:04.548519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:03.977328Z","time spent":"571.183329ms","remote":"127.0.0.1:58336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:12:04.549703Z","caller":"traceutil/trace.go:171","msg":"trace[1266068441] linearizableReadLoop","detail":"{readStateIndex:1437; appliedIndex:1436; }","duration":"356.665858ms","start":"2026-06-30T17:12:04.192997Z","end":"2026-06-30T17:12:04.549663Z","steps":["trace[1266068441] 'read index received' (duration: 354.282221ms)","trace[1266068441] 'applied index is now lower than readState.Index' (duration: 2.382467ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:12:04.549845Z","caller":"traceutil/trace.go:171","msg":"trace[836117560] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"570.440975ms","start":"2026-06-30T17:12:03.979392Z","end":"2026-06-30T17:12:04.549833Z","steps":["trace[836117560] 'process raft request' (duration: 567.942975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:04.550147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:03.979376Z","time spent":"570.492998ms","remote":"127.0.0.1:58608","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-06-30T17:12:04.55032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.265563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-30T17:12:04.550409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.406862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:12:04.550436Z","caller":"traceutil/trace.go:171","msg":"trace[2009278712] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1379; }","duration":"317.421107ms","start":"2026-06-30T17:12:04.23299Z","end":"2026-06-30T17:12:04.550411Z","steps":["trace[2009278712] 'agreement among raft nodes before linearized reading' (duration: 316.89346ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:04.550451Z","caller":"traceutil/trace.go:171","msg":"trace[1262508932] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1379; }","duration":"357.485465ms","start":"2026-06-30T17:12:04.192954Z","end":"2026-06-30T17:12:04.550439Z","steps":["trace[1262508932] 'agreement among raft nodes before linearized reading' (duration: 357.34186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:04.550485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:04.192935Z","time spent":"357.543356ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:12:04.55049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:04.23294Z","time spent":"317.538121ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T17:12:04.550685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.769046ms","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-06-30T17:12:04.550743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.737956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:12:04.550793Z","caller":"traceutil/trace.go:171","msg":"trace[2116796762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1379; }","duration":"293.811319ms","start":"2026-06-30T17:12:04.25697Z","end":"2026-06-30T17:12:04.550781Z","steps":["trace[2116796762] 'agreement among raft nodes before linearized reading' (duration: 293.594752ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:04.550798Z","caller":"traceutil/trace.go:171","msg":"trace[154481694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1379; }","duration":"259.942351ms","start":"2026-06-30T17:12:04.290833Z","end":"2026-06-30T17:12:04.550776Z","steps":["trace[154481694] 'agreement among raft nodes before linearized reading' (duration: 259.721474ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:05.22438Z","caller":"traceutil/trace.go:171","msg":"trace[28914030] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"646.900883ms","start":"2026-06-30T17:12:04.577436Z","end":"2026-06-30T17:12:05.224337Z","steps":["trace[28914030] 'process raft request' (duration: 645.732855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:05.224634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:04.577405Z","time spent":"647.1148ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:12:05.225371Z","caller":"traceutil/trace.go:171","msg":"trace[1311372715] linearizableReadLoop","detail":"{readStateIndex:1441; appliedIndex:1437; }","duration":"352.587917ms","start":"2026-06-30T17:12:04.872756Z","end":"2026-06-30T17:12:05.225344Z","steps":["trace[1311372715] 'read index received' (duration: 350.49622ms)","trace[1311372715] 'applied index is now lower than readState.Index' (duration: 2.090447ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:12:05.225406Z","caller":"traceutil/trace.go:171","msg":"trace[1243628] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"647.908285ms","start":"2026-06-30T17:12:04.577446Z","end":"2026-06-30T17:12:05.225354Z","steps":["trace[1243628] 'process raft request' (duration: 647.73752ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:05.225499Z","caller":"traceutil/trace.go:171","msg":"trace[757411593] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"647.609646ms","start":"2026-06-30T17:12:04.577876Z","end":"2026-06-30T17:12:05.225486Z","steps":["trace[757411593] 'process raft request' (duration: 647.408869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:05.225606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:04.577861Z","time spent":"647.660457ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:12:05.225611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:04.57742Z","time spent":"648.07185ms","remote":"127.0.0.1:58608","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-06-30T17:12:05.225712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.95843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:12:05.22575Z","caller":"traceutil/trace.go:171","msg":"trace[404339174] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1383; }","duration":"353.037132ms","start":"2026-06-30T17:12:04.872704Z","end":"2026-06-30T17:12:05.225742Z","steps":["trace[404339174] 'agreement among raft nodes before linearized reading' (duration: 352.9648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:05.225772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:04.872679Z","time spent":"353.088024ms","remote":"127.0.0.1:58662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:12:05.225793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.506641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:12:05.225819Z","caller":"traceutil/trace.go:171","msg":"trace[1259843278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1383; }","duration":"247.568743ms","start":"2026-06-30T17:12:04.97824Z","end":"2026-06-30T17:12:05.225809Z","steps":["trace[1259843278] 'agreement among raft nodes before linearized reading' (duration: 247.530012ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:05.225885Z","caller":"traceutil/trace.go:171","msg":"trace[2103299109] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"647.12615ms","start":"2026-06-30T17:12:04.57875Z","end":"2026-06-30T17:12:05.225876Z","steps":["trace[2103299109] 'process raft request' (duration: 646.563862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:05.225924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:12:04.578741Z","time spent":"647.160901ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:12:07.352771Z","caller":"traceutil/trace.go:171","msg":"trace[2036600745] linearizableReadLoop","detail":"{readStateIndex:1457; appliedIndex:1453; }","duration":"109.850699ms","start":"2026-06-30T17:12:07.242893Z","end":"2026-06-30T17:12:07.352744Z","steps":["trace[2036600745] 'read index received' (duration: 91.2194ms)","trace[2036600745] 'applied index is now lower than readState.Index' (duration: 18.630029ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:12:07.353039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.131568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T17:12:07.353098Z","caller":"traceutil/trace.go:171","msg":"trace[1982082085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1398; }","duration":"110.242132ms","start":"2026-06-30T17:12:07.242841Z","end":"2026-06-30T17:12:07.353083Z","steps":["trace[1982082085] 'agreement among raft nodes before linearized reading' (duration: 110.007404ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:07.353172Z","caller":"traceutil/trace.go:171","msg":"trace[957453055] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"117.252407ms","start":"2026-06-30T17:12:07.235895Z","end":"2026-06-30T17:12:07.353147Z","steps":["trace[957453055] 'process raft request' (duration: 116.786582ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:07.353211Z","caller":"traceutil/trace.go:171","msg":"trace[1676741476] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"117.06273ms","start":"2026-06-30T17:12:07.236103Z","end":"2026-06-30T17:12:07.353166Z","steps":["trace[1676741476] 'process raft request' (duration: 116.612036ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:07.353618Z","caller":"traceutil/trace.go:171","msg":"trace[1022229258] transaction","detail":"{read_only:false; response_revision:1396; number_of_response:1; }","duration":"118.29952ms","start":"2026-06-30T17:12:07.235209Z","end":"2026-06-30T17:12:07.353509Z","steps":["trace[1022229258] 'process raft request' (duration: 117.386631ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:07.498441Z","caller":"traceutil/trace.go:171","msg":"trace[2014569744] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"140.119511ms","start":"2026-06-30T17:12:07.358275Z","end":"2026-06-30T17:12:07.498395Z","steps":["trace[2014569744] 'process raft request' (duration: 125.865083ms)","trace[2014569744] 'compare' (duration: 13.804404ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:12:13.741639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.250757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T17:12:13.741762Z","caller":"traceutil/trace.go:171","msg":"trace[1450790869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1442; }","duration":"206.525635ms","start":"2026-06-30T17:12:13.535198Z","end":"2026-06-30T17:12:13.741723Z","steps":["trace[1450790869] 'range keys from in-memory index tree' (duration: 206.07699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:19.627825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.470648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:12:19.62803Z","caller":"traceutil/trace.go:171","msg":"trace[1380568676] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"183.725642ms","start":"2026-06-30T17:12:19.444266Z","end":"2026-06-30T17:12:19.627992Z","steps":["trace[1380568676] 'process raft request' (duration: 68.972415ms)","trace[1380568676] 'compare' (duration: 114.242421ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:12:19.628197Z","caller":"traceutil/trace.go:171","msg":"trace[898837976] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"182.374439ms","start":"2026-06-30T17:12:19.445801Z","end":"2026-06-30T17:12:19.628175Z","steps":["trace[898837976] 'process raft request' (duration: 182.156752ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:19.62821Z","caller":"traceutil/trace.go:171","msg":"trace[677602942] linearizableReadLoop","detail":"{readStateIndex:1528; appliedIndex:1527; }","duration":"183.814516ms","start":"2026-06-30T17:12:19.444353Z","end":"2026-06-30T17:12:19.628168Z","steps":["trace[677602942] 'read index received' (duration: 68.894314ms)","trace[677602942] 'applied index is now lower than readState.Index' (duration: 114.916001ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:12:19.628485Z","caller":"traceutil/trace.go:171","msg":"trace[1400529734] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"181.984087ms","start":"2026-06-30T17:12:19.446477Z","end":"2026-06-30T17:12:19.628461Z","steps":["trace[1400529734] 'process raft request' (duration: 181.600995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:19.628829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.468646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T17:12:19.628948Z","caller":"traceutil/trace.go:171","msg":"trace[1150421887] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1469; }","duration":"184.650202ms","start":"2026-06-30T17:12:19.444279Z","end":"2026-06-30T17:12:19.628929Z","steps":["trace[1150421887] 'agreement among raft nodes before linearized reading' (duration: 183.990641ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:20.568906Z","caller":"traceutil/trace.go:171","msg":"trace[1482603761] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"128.950062ms","start":"2026-06-30T17:12:20.439929Z","end":"2026-06-30T17:12:20.568879Z","steps":["trace[1482603761] 'process raft request' (duration: 109.25604ms)","trace[1482603761] 'compare' (duration: 19.590169ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:12:20.803891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.316465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:12:20.804064Z","caller":"traceutil/trace.go:171","msg":"trace[1872307082] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"149.643037ms","start":"2026-06-30T17:12:20.654386Z","end":"2026-06-30T17:12:20.804029Z","steps":["trace[1872307082] 'process raft request' (duration: 15.032752ms)","trace[1872307082] 'compare' (duration: 134.057157ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:12:21.628365Z","caller":"traceutil/trace.go:171","msg":"trace[856754907] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"176.945354ms","start":"2026-06-30T17:12:21.451392Z","end":"2026-06-30T17:12:21.628337Z","steps":["trace[856754907] 'process raft request' (duration: 176.789559ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:21.920461Z","caller":"traceutil/trace.go:171","msg":"trace[1964870039] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"207.647601ms","start":"2026-06-30T17:12:21.712782Z","end":"2026-06-30T17:12:21.92043Z","steps":["trace[1964870039] 'process raft request' (duration: 201.763352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:47.927946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.556846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:12:47.928071Z","caller":"traceutil/trace.go:171","msg":"trace[2073311960] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1596; }","duration":"109.764482ms","start":"2026-06-30T17:12:47.818279Z","end":"2026-06-30T17:12:47.928044Z","steps":["trace[2073311960] 'range keys from in-memory index tree' (duration: 109.294507ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:48.168088Z","caller":"traceutil/trace.go:171","msg":"trace[362016522] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"137.170351ms","start":"2026-06-30T17:12:48.030879Z","end":"2026-06-30T17:12:48.168049Z","steps":["trace[362016522] 'process raft request' (duration: 126.8549ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:12:48.262079Z","caller":"traceutil/trace.go:171","msg":"trace[1269092192] linearizableReadLoop","detail":"{readStateIndex:1666; appliedIndex:1664; }","duration":"165.423168ms","start":"2026-06-30T17:12:48.096627Z","end":"2026-06-30T17:12:48.26205Z","steps":["trace[1269092192] 'read index received' (duration: 61.09314ms)","trace[1269092192] 'applied index is now lower than readState.Index' (duration: 104.329158ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:12:48.262175Z","caller":"traceutil/trace.go:171","msg":"trace[1829754537] transaction","detail":"{read_only:false; response_revision:1599; number_of_response:1; }","duration":"230.483446ms","start":"2026-06-30T17:12:48.03165Z","end":"2026-06-30T17:12:48.262134Z","steps":["trace[1829754537] 'process raft request' (duration: 230.266669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:12:48.262328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.677297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:12:48.262373Z","caller":"traceutil/trace.go:171","msg":"trace[1148775157] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1599; }","duration":"165.78419ms","start":"2026-06-30T17:12:48.096576Z","end":"2026-06-30T17:12:48.26236Z","steps":["trace[1148775157] 'agreement among raft nodes before linearized reading' (duration: 165.608424ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:13:02.023893Z","caller":"traceutil/trace.go:171","msg":"trace[1523431536] transaction","detail":"{read_only:false; response_revision:1660; number_of_response:1; }","duration":"130.494647ms","start":"2026-06-30T17:13:01.893368Z","end":"2026-06-30T17:13:02.023862Z","steps":["trace[1523431536] 'process raft request' (duration: 130.329092ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:13:02.547649Z","caller":"traceutil/trace.go:171","msg":"trace[1734636751] transaction","detail":"{read_only:false; response_revision:1666; number_of_response:1; }","duration":"129.489545ms","start":"2026-06-30T17:13:02.418123Z","end":"2026-06-30T17:13:02.547612Z","steps":["trace[1734636751] 'process raft request' (duration: 129.429253ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:13:02.547909Z","caller":"traceutil/trace.go:171","msg":"trace[347661368] transaction","detail":"{read_only:false; response_revision:1665; number_of_response:1; }","duration":"131.575563ms","start":"2026-06-30T17:13:02.416083Z","end":"2026-06-30T17:13:02.547659Z","steps":["trace[347661368] 'process raft request' (duration: 88.582313ms)","trace[347661368] 'compare' (duration: 42.68622ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:13:53.919467Z","caller":"traceutil/trace.go:171","msg":"trace[1133254194] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"139.747955ms","start":"2026-06-30T17:13:53.779689Z","end":"2026-06-30T17:13:53.919437Z","steps":["trace[1133254194] 'process raft request' (duration: 139.580759ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:14:27.14071Z","caller":"traceutil/trace.go:171","msg":"trace[1588735157] transaction","detail":"{read_only:false; response_revision:2054; number_of_response:1; }","duration":"110.058192ms","start":"2026-06-30T17:14:27.030615Z","end":"2026-06-30T17:14:27.140673Z","steps":["trace[1588735157] 'process raft request' (duration: 30.54168ms)","trace[1588735157] 'compare' (duration: 79.402708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:14:29.13087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.919814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:14:29.131211Z","caller":"traceutil/trace.go:171","msg":"trace[708357067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2059; }","duration":"152.329717ms","start":"2026-06-30T17:14:28.978858Z","end":"2026-06-30T17:14:29.131188Z","steps":["trace[708357067] 'range keys from in-memory index tree' (duration: 151.78061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:14:29.131054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.949718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-30T17:14:29.131552Z","caller":"traceutil/trace.go:171","msg":"trace[1385074811] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2059; }","duration":"144.477365ms","start":"2026-06-30T17:14:28.987043Z","end":"2026-06-30T17:14:29.13152Z","steps":["trace[1385074811] 'range keys from in-memory index tree' (duration: 143.815134ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:14:29.602946Z","caller":"traceutil/trace.go:171","msg":"trace[883941701] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"120.247349ms","start":"2026-06-30T17:14:29.482678Z","end":"2026-06-30T17:14:29.602926Z","steps":["trace[883941701] 'process raft request' (duration: 120.133766ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:14:44.976625Z","caller":"traceutil/trace.go:171","msg":"trace[406596133] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"145.840874ms","start":"2026-06-30T17:14:44.830754Z","end":"2026-06-30T17:14:44.976595Z","steps":["trace[406596133] 'process raft request' (duration: 124.974796ms)","trace[406596133] 'compare' (duration: 20.456595ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:15:21.104809Z","caller":"traceutil/trace.go:171","msg":"trace[2017288321] linearizableReadLoop","detail":"{readStateIndex:2393; appliedIndex:2392; }","duration":"129.006004ms","start":"2026-06-30T17:15:20.975783Z","end":"2026-06-30T17:15:21.104789Z","steps":["trace[2017288321] 'read index received' (duration: 95.112118ms)","trace[2017288321] 'applied index is now lower than readState.Index' (duration: 33.892876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:15:21.104963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.172739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:15:21.104985Z","caller":"traceutil/trace.go:171","msg":"trace[1256947765] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2295; }","duration":"129.244513ms","start":"2026-06-30T17:15:20.975735Z","end":"2026-06-30T17:15:21.104979Z","steps":["trace[1256947765] 'agreement among raft nodes before linearized reading' (duration: 129.183391ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:16:09.692939Z","caller":"traceutil/trace.go:171","msg":"trace[2010692303] linearizableReadLoop","detail":"{readStateIndex:2652; appliedIndex:2651; }","duration":"222.835677ms","start":"2026-06-30T17:16:09.47008Z","end":"2026-06-30T17:16:09.692916Z","steps":["trace[2010692303] 'read index received' (duration: 222.648941ms)","trace[2010692303] 'applied index is now lower than readState.Index' (duration: 183.116µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:16:09.693082Z","caller":"traceutil/trace.go:171","msg":"trace[2045363966] transaction","detail":"{read_only:false; response_revision:2544; number_of_response:1; }","duration":"351.537633ms","start":"2026-06-30T17:16:09.34151Z","end":"2026-06-30T17:16:09.693048Z","steps":["trace[2045363966] 'process raft request' (duration: 351.269965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:16:09.693214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.113135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-30T17:16:09.693263Z","caller":"traceutil/trace.go:171","msg":"trace[751629510] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2544; }","duration":"223.230529ms","start":"2026-06-30T17:16:09.470019Z","end":"2026-06-30T17:16:09.693249Z","steps":["trace[751629510] 'agreement among raft nodes before linearized reading' (duration: 223.030173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:16:09.693291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:16:09.341494Z","time spent":"351.690027ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:16:09.693553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.145539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T17:16:09.693588Z","caller":"traceutil/trace.go:171","msg":"trace[671663667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2544; }","duration":"174.207411ms","start":"2026-06-30T17:16:09.519368Z","end":"2026-06-30T17:16:09.693575Z","steps":["trace[671663667] 'agreement among raft nodes before linearized reading' (duration: 174.073267ms)"],"step_count":1}