{"level":"warn","ts":"2026-04-03T02:23:41.519978Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-03T02:23:41.520052Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.155: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.155:2380","--initial-cluster=instance=https://199.204.45.155:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.155:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.155:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-03T02:23:41.520107Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-03T02:23:41.520119Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-03T02:23:41.520146Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-03T02:23:41.52077Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"]} {"level":"info","ts":"2026-04-03T02:23:41.520842Z","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.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.155:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-03T02:23:41.528107Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.718424ms"} {"level":"info","ts":"2026-04-03T02:23:41.541341Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"344940fc142d902f","cluster-id":"c7d65bf2a36fbd4"} {"level":"info","ts":"2026-04-03T02:23:41.541441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=()"} {"level":"info","ts":"2026-04-03T02:23:41.541471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 0"} {"level":"info","ts":"2026-04-03T02:23:41.541486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 344940fc142d902f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-03T02:23:41.541498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 1"} {"level":"info","ts":"2026-04-03T02:23:41.54153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"warn","ts":"2026-04-03T02:23:41.547367Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-03T02:23:41.548764Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-03T02:23:41.550826Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-03T02:23:41.553334Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"344940fc142d902f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-03T02:23:41.554378Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"344940fc142d902f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-03T02:23:41.554646Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T02:23:41.554789Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T02:23:41.554847Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T02:23:41.55817Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-03T02:23:41.558322Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-03T02:23:41.558378Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-03T02:23:41.559296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"info","ts":"2026-04-03T02:23:41.559467Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","added-peer-id":"344940fc142d902f","added-peer-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-03T02:23:41.559587Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"344940fc142d902f","initial-advertise-peer-urls":["https://199.204.45.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-03T02:23:41.559644Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-03T02:23:41.942302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f is starting a new election at term 1"} {"level":"info","ts":"2026-04-03T02:23:41.942377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-03T02:23:41.942471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgPreVoteResp from 344940fc142d902f at term 1"} {"level":"info","ts":"2026-04-03T02:23:41.942516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became candidate at term 2"} {"level":"info","ts":"2026-04-03T02:23:41.94254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgVoteResp from 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-03T02:23:41.942563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became leader at term 2"} {"level":"info","ts":"2026-04-03T02:23:41.942588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 344940fc142d902f elected leader 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-03T02:23:41.943589Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"344940fc142d902f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.155:2379]}","request-path":"/0/members/344940fc142d902f/attributes","cluster-id":"c7d65bf2a36fbd4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-03T02:23:41.94364Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-03T02:23:41.943966Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-03T02:23:41.944151Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T02:23:41.946238Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T02:23:41.946419Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T02:23:41.946526Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T02:23:41.946279Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-03T02:23:41.946635Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-03T02:23:41.947247Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.155:2379"} {"level":"info","ts":"2026-04-03T02:23:41.947468Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-03T02:23:44.91652Z","caller":"traceutil/trace.go:171","msg":"trace[1468604262] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"238.509046ms","start":"2026-04-03T02:23:44.677987Z","end":"2026-04-03T02:23:44.916497Z","steps":["trace[1468604262] 'process raft request' (duration: 229.847668ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:23:45.566747Z","caller":"traceutil/trace.go:171","msg":"trace[1971987522] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"108.134869ms","start":"2026-04-03T02:23:45.458589Z","end":"2026-04-03T02:23:45.566724Z","steps":["trace[1971987522] 'process raft request' (duration: 107.995126ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:23:46.147905Z","caller":"traceutil/trace.go:171","msg":"trace[1074039835] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:252; }","duration":"330.070766ms","start":"2026-04-03T02:23:45.817807Z","end":"2026-04-03T02:23:46.147878Z","steps":["trace[1074039835] 'read index received' (duration: 329.79764ms)","trace[1074039835] 'applied index is now lower than readState.Index' (duration: 272.056µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:23:46.147996Z","caller":"traceutil/trace.go:171","msg":"trace[1105135903] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"559.197297ms","start":"2026-04-03T02:23:45.588763Z","end":"2026-04-03T02:23:46.14796Z","steps":["trace[1105135903] 'process raft request' (duration: 558.974882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:23:46.148075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.25163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"info","ts":"2026-04-03T02:23:46.148146Z","caller":"traceutil/trace.go:171","msg":"trace[741485728] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:247; }","duration":"330.381833ms","start":"2026-04-03T02:23:45.817752Z","end":"2026-04-03T02:23:46.148133Z","steps":["trace[741485728] 'agreement among raft nodes before linearized reading' (duration: 330.228429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:23:46.148184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:23:45.817728Z","time spent":"330.446525ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3514,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-03T02:23:46.148643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:23:45.588745Z","time spent":"559.32455ms","remote":"127.0.0.1:48418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:23:47.255145Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695837243828022,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T02:23:47.696525Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.540258936s","expected-duration":"1s"} {"level":"info","ts":"2026-04-03T02:23:47.700441Z","caller":"traceutil/trace.go:171","msg":"trace[1944748961] linearizableReadLoop","detail":"{readStateIndex:254; appliedIndex:253; }","duration":"993.337969ms","start":"2026-04-03T02:23:46.707064Z","end":"2026-04-03T02:23:47.700402Z","steps":["trace[1944748961] 'read index received' (duration: 989.615384ms)","trace[1944748961] 'applied index is now lower than readState.Index' (duration: 3.721545ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:23:47.701784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.954377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:23:47.701892Z","caller":"traceutil/trace.go:171","msg":"trace[1596682750] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:248; }","duration":"420.179372ms","start":"2026-04-03T02:23:47.281678Z","end":"2026-04-03T02:23:47.701857Z","steps":["trace[1596682750] 'agreement among raft nodes before linearized reading' (duration: 419.586089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:23:47.701945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:23:47.281655Z","time spent":"420.278194ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-03T02:23:47.702068Z","caller":"traceutil/trace.go:171","msg":"trace[754656270] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"1.545914156s","start":"2026-04-03T02:23:46.156127Z","end":"2026-04-03T02:23:47.702042Z","steps":["trace[754656270] 'process raft request' (duration: 1.540604484s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:23:47.702334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.260383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:23:47.702443Z","caller":"traceutil/trace.go:171","msg":"trace[382600196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:248; }","duration":"995.398246ms","start":"2026-04-03T02:23:46.707009Z","end":"2026-04-03T02:23:47.702407Z","steps":["trace[382600196] 'agreement among raft nodes before linearized reading' (duration: 994.196679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:23:47.702503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:23:46.706987Z","time spent":"995.503899ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:23:47.703307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:23:46.156093Z","time spent":"1.5461168s","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:24:14.355039Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695837243828583,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-03T02:24:14.46079Z","caller":"traceutil/trace.go:171","msg":"trace[1795694486] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"626.89801ms","start":"2026-04-03T02:24:13.833869Z","end":"2026-04-03T02:24:14.460767Z","steps":["trace[1795694486] 'process raft request' (duration: 626.783547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.460907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.833849Z","time spent":"627.007232ms","remote":"127.0.0.1:48316","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-04-03T02:24:14.469683Z","caller":"traceutil/trace.go:171","msg":"trace[244841291] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"631.932955ms","start":"2026-04-03T02:24:13.837737Z","end":"2026-04-03T02:24:14.46967Z","steps":["trace[244841291] 'process raft request' (duration: 631.761941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.469749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.837711Z","time spent":"632.006216ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:24:14.469842Z","caller":"traceutil/trace.go:171","msg":"trace[284510068] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"626.741985ms","start":"2026-04-03T02:24:13.843068Z","end":"2026-04-03T02:24:14.46981Z","steps":["trace[284510068] 'process raft request' (duration: 626.51511ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:14.469931Z","caller":"traceutil/trace.go:171","msg":"trace[99068708] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"619.011439ms","start":"2026-04-03T02:24:13.850877Z","end":"2026-04-03T02:24:14.469889Z","steps":["trace[99068708] 'process raft request' (duration: 618.734723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.469961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.843046Z","time spent":"626.862958ms","remote":"127.0.0.1:48316","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-04-03T02:24:14.469997Z","caller":"traceutil/trace.go:171","msg":"trace[580985424] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"617.743489ms","start":"2026-04-03T02:24:13.852243Z","end":"2026-04-03T02:24:14.469986Z","steps":["trace[580985424] 'process raft request' (duration: 617.444812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.470037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.8522Z","time spent":"617.820451ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:24:14.47005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.850862Z","time spent":"619.136491ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:24:14.482309Z","caller":"traceutil/trace.go:171","msg":"trace[1619501390] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"627.144546ms","start":"2026-04-03T02:24:13.855152Z","end":"2026-04-03T02:24:14.482297Z","steps":["trace[1619501390] 'process raft request' (duration: 614.961116ms)","trace[1619501390] 'compare' (duration: 11.913574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:24:14.482383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.855136Z","time spent":"627.209257ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:24:14.482693Z","caller":"traceutil/trace.go:171","msg":"trace[256047276] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"626.960002ms","start":"2026-04-03T02:24:13.855725Z","end":"2026-04-03T02:24:14.482685Z","steps":["trace[256047276] 'process raft request' (duration: 626.814168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.482754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.855719Z","time spent":"626.997572ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:24:14.482818Z","caller":"traceutil/trace.go:171","msg":"trace[890831462] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"619.434969ms","start":"2026-04-03T02:24:13.863377Z","end":"2026-04-03T02:24:14.482812Z","steps":["trace[890831462] 'process raft request' (duration: 619.295385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.48285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.863371Z","time spent":"619.465759ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:24:14.482862Z","caller":"traceutil/trace.go:171","msg":"trace[1524344837] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"624.462064ms","start":"2026-04-03T02:24:13.858377Z","end":"2026-04-03T02:24:14.482839Z","steps":["trace[1524344837] 'process raft request' (duration: 624.244009ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:14.482913Z","caller":"traceutil/trace.go:171","msg":"trace[772802412] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"611.68639ms","start":"2026-04-03T02:24:13.871207Z","end":"2026-04-03T02:24:14.482893Z","steps":["trace[772802412] 'process raft request' (duration: 611.514116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.482981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.858372Z","time spent":"624.553776ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:24:14.483015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.871196Z","time spent":"611.772563ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:24:14.483352Z","caller":"traceutil/trace.go:171","msg":"trace[1598699931] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"589.011551ms","start":"2026-04-03T02:24:13.89433Z","end":"2026-04-03T02:24:14.483342Z","steps":["trace[1598699931] 'process raft request' (duration: 588.815057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.483431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.894297Z","time spent":"589.080262ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:24:14.483544Z","caller":"traceutil/trace.go:171","msg":"trace[2033731707] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"479.9106ms","start":"2026-04-03T02:24:14.003627Z","end":"2026-04-03T02:24:14.483538Z","steps":["trace[2033731707] 'process raft request' (duration: 479.652574ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:14.483559Z","caller":"traceutil/trace.go:171","msg":"trace[399954984] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"122.619901ms","start":"2026-04-03T02:24:14.360927Z","end":"2026-04-03T02:24:14.483547Z","steps":["trace[399954984] 'process raft request' (duration: 122.414476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.483576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:14.003598Z","time spent":"479.965061ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:24:14.483725Z","caller":"traceutil/trace.go:171","msg":"trace[398696228] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:530; }","duration":"628.740612ms","start":"2026-04-03T02:24:13.854975Z","end":"2026-04-03T02:24:14.483715Z","steps":["trace[398696228] 'read index received' (duration: 605.836787ms)","trace[398696228] 'applied index is now lower than readState.Index' (duration: 22.900795ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:24:14.483825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.843134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-03T02:24:14.48385Z","caller":"traceutil/trace.go:171","msg":"trace[4145243] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"628.894985ms","start":"2026-04-03T02:24:13.85495Z","end":"2026-04-03T02:24:14.483845Z","steps":["trace[4145243] 'agreement among raft nodes before linearized reading' (duration: 628.809633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.483869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.854939Z","time spent":"628.925975ms","remote":"127.0.0.1:48490","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-04-03T02:24:14.512423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.396308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:24:14.512581Z","caller":"traceutil/trace.go:171","msg":"trace[26594623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"657.544242ms","start":"2026-04-03T02:24:13.854999Z","end":"2026-04-03T02:24:14.512543Z","steps":["trace[26594623] 'agreement among raft nodes before linearized reading' (duration: 656.330654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.512647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.854996Z","time spent":"657.642094ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:24:14.516844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.698871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-03T02:24:14.516857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.861854ms","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-04-03T02:24:14.516876Z","caller":"traceutil/trace.go:171","msg":"trace[592047119] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:532; }","duration":"529.731832ms","start":"2026-04-03T02:24:13.987136Z","end":"2026-04-03T02:24:14.516868Z","steps":["trace[592047119] 'agreement among raft nodes before linearized reading' (duration: 524.518902ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:14.516882Z","caller":"traceutil/trace.go:171","msg":"trace[163420350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"659.904097ms","start":"2026-04-03T02:24:13.856971Z","end":"2026-04-03T02:24:14.516875Z","steps":["trace[163420350] 'agreement among raft nodes before linearized reading' (duration: 654.764899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:14.516895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.987079Z","time spent":"529.810764ms","remote":"127.0.0.1:48490","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-04-03T02:24:14.5169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:13.856963Z","time spent":"659.931857ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-03T02:24:15.57588Z","caller":"traceutil/trace.go:171","msg":"trace[259360675] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"154.468331ms","start":"2026-04-03T02:24:15.421374Z","end":"2026-04-03T02:24:15.575842Z","steps":["trace[259360675] 'process raft request' (duration: 154.333428ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:15.667774Z","caller":"traceutil/trace.go:171","msg":"trace[301468475] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"211.089138ms","start":"2026-04-03T02:24:15.456652Z","end":"2026-04-03T02:24:15.667741Z","steps":["trace[301468475] 'process raft request' (duration: 210.813852ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:15.675184Z","caller":"traceutil/trace.go:171","msg":"trace[218179615] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"108.404965ms","start":"2026-04-03T02:24:15.566756Z","end":"2026-04-03T02:24:15.675161Z","steps":["trace[218179615] 'process raft request' (duration: 101.008705ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:15.876924Z","caller":"traceutil/trace.go:171","msg":"trace[2119969848] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"106.311627ms","start":"2026-04-03T02:24:15.7706Z","end":"2026-04-03T02:24:15.876912Z","steps":["trace[2119969848] 'read index received' (duration: 94.135488ms)","trace[2119969848] 'applied index is now lower than readState.Index' (duration: 12.174189ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:24:15.876878Z","caller":"traceutil/trace.go:171","msg":"trace[147582972] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"121.352662ms","start":"2026-04-03T02:24:15.755506Z","end":"2026-04-03T02:24:15.876858Z","steps":["trace[147582972] 'process raft request' (duration: 109.171992ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:15.877049Z","caller":"traceutil/trace.go:171","msg":"trace[1226527314] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"102.405698ms","start":"2026-04-03T02:24:15.774633Z","end":"2026-04-03T02:24:15.877039Z","steps":["trace[1226527314] 'process raft request' (duration: 102.236464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:15.877249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.634405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-04-03T02:24:15.87863Z","caller":"traceutil/trace.go:171","msg":"trace[1332138818] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:590; }","duration":"108.039906ms","start":"2026-04-03T02:24:15.770574Z","end":"2026-04-03T02:24:15.878614Z","steps":["trace[1332138818] 'agreement among raft nodes before linearized reading' (duration: 106.392809ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:17.57138Z","caller":"traceutil/trace.go:171","msg":"trace[602022523] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"204.925737ms","start":"2026-04-03T02:24:17.366424Z","end":"2026-04-03T02:24:17.571349Z","steps":["trace[602022523] 'process raft request' (duration: 204.789154ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:17.572929Z","caller":"traceutil/trace.go:171","msg":"trace[800297332] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"205.178192ms","start":"2026-04-03T02:24:17.367738Z","end":"2026-04-03T02:24:17.572916Z","steps":["trace[800297332] 'process raft request' (duration: 205.123411ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:21.63723Z","caller":"traceutil/trace.go:171","msg":"trace[875029725] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"868.586889ms","start":"2026-04-03T02:24:20.768595Z","end":"2026-04-03T02:24:21.637182Z","steps":["trace[875029725] 'process raft request' (duration: 867.953845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:21.637453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:20.768552Z","time spent":"868.789454ms","remote":"127.0.0.1:48364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:24:22.408722Z","caller":"traceutil/trace.go:171","msg":"trace[1907119251] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"282.829673ms","start":"2026-04-03T02:24:22.125865Z","end":"2026-04-03T02:24:22.408695Z","steps":["trace[1907119251] 'read index received' (duration: 281.429781ms)","trace[1907119251] 'applied index is now lower than readState.Index' (duration: 1.32773ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:24:22.409065Z","caller":"traceutil/trace.go:171","msg":"trace[1057680111] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"284.861289ms","start":"2026-04-03T02:24:22.124171Z","end":"2026-04-03T02:24:22.409032Z","steps":["trace[1057680111] 'process raft request' (duration: 283.341675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.409282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.384456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.40932Z","caller":"traceutil/trace.go:171","msg":"trace[55040762] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:625; }","duration":"283.456627ms","start":"2026-04-03T02:24:22.125849Z","end":"2026-04-03T02:24:22.409306Z","steps":["trace[55040762] 'agreement among raft nodes before linearized reading' (duration: 283.171841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.409802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.497779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.409841Z","caller":"traceutil/trace.go:171","msg":"trace[1952381146] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:625; }","duration":"283.563361ms","start":"2026-04-03T02:24:22.12626Z","end":"2026-04-03T02:24:22.409823Z","steps":["trace[1952381146] 'agreement among raft nodes before linearized reading' (duration: 283.155291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.409807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.818831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:22.409889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.033688ms","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-04-03T02:24:22.410023Z","caller":"traceutil/trace.go:171","msg":"trace[1596187680] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:625; }","duration":"101.043926ms","start":"2026-04-03T02:24:22.308904Z","end":"2026-04-03T02:24:22.409948Z","steps":["trace[1596187680] 'agreement among raft nodes before linearized reading' (duration: 100.676328ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:22.41003Z","caller":"traceutil/trace.go:171","msg":"trace[1377831393] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"180.203712ms","start":"2026-04-03T02:24:22.229776Z","end":"2026-04-03T02:24:22.40998Z","steps":["trace[1377831393] 'agreement among raft nodes before linearized reading' (duration: 179.798202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.410549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.11326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.410625Z","caller":"traceutil/trace.go:171","msg":"trace[389764998] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"153.207802ms","start":"2026-04-03T02:24:22.257397Z","end":"2026-04-03T02:24:22.410605Z","steps":["trace[389764998] 'agreement among raft nodes before linearized reading' (duration: 153.078289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.41081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.257774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.410835Z","caller":"traceutil/trace.go:171","msg":"trace[1207924823] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:625; }","duration":"205.283715ms","start":"2026-04-03T02:24:22.205544Z","end":"2026-04-03T02:24:22.410828Z","steps":["trace[1207924823] 'agreement among raft nodes before linearized reading' (duration: 205.04925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.411823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.855832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.411868Z","caller":"traceutil/trace.go:171","msg":"trace[1332968205] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"155.951884ms","start":"2026-04-03T02:24:22.255906Z","end":"2026-04-03T02:24:22.411858Z","steps":["trace[1332968205] 'agreement among raft nodes before linearized reading' (duration: 155.882972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.620645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.412194Z","caller":"traceutil/trace.go:171","msg":"trace[1714302251] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:625; }","duration":"206.658916ms","start":"2026-04-03T02:24:22.205514Z","end":"2026-04-03T02:24:22.412173Z","steps":["trace[1714302251] 'agreement among raft nodes before linearized reading' (duration: 206.154325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.644435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.413035Z","caller":"traceutil/trace.go:171","msg":"trace[1554256521] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:625; }","duration":"104.343033ms","start":"2026-04-03T02:24:22.30867Z","end":"2026-04-03T02:24:22.413013Z","steps":["trace[1554256521] 'agreement among raft nodes before linearized reading' (duration: 102.582932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.41235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.82431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:22.412368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.483116ms","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-04-03T02:24:22.413384Z","caller":"traceutil/trace.go:171","msg":"trace[2008944001] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"157.49911ms","start":"2026-04-03T02:24:22.255865Z","end":"2026-04-03T02:24:22.413364Z","steps":["trace[2008944001] 'agreement among raft nodes before linearized reading' (duration: 156.477876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.356919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.413496Z","caller":"traceutil/trace.go:171","msg":"trace[1784024904] 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:625; }","duration":"244.148367ms","start":"2026-04-03T02:24:22.169337Z","end":"2026-04-03T02:24:22.413486Z","steps":["trace[1784024904] 'agreement among raft nodes before linearized reading' (duration: 243.02821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.468945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.413691Z","caller":"traceutil/trace.go:171","msg":"trace[894677833] 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:625; }","duration":"245.380315ms","start":"2026-04-03T02:24:22.168297Z","end":"2026-04-03T02:24:22.413677Z","steps":["trace[894677833] 'agreement among raft nodes before linearized reading' (duration: 244.471825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.410577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.846276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.413093Z","caller":"traceutil/trace.go:171","msg":"trace[602850454] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:625; }","duration":"207.633339ms","start":"2026-04-03T02:24:22.205443Z","end":"2026-04-03T02:24:22.413077Z","steps":["trace[602850454] 'agreement among raft nodes before linearized reading' (duration: 206.843581ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:22.414098Z","caller":"traceutil/trace.go:171","msg":"trace[358252025] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"184.395187ms","start":"2026-04-03T02:24:22.229668Z","end":"2026-04-03T02:24:22.414063Z","steps":["trace[358252025] 'agreement among raft nodes before linearized reading' (duration: 180.866276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.585127ms","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-04-03T02:24:22.412848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.183829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.416103Z","caller":"traceutil/trace.go:171","msg":"trace[1756664938] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:625; }","duration":"107.406773ms","start":"2026-04-03T02:24:22.308618Z","end":"2026-04-03T02:24:22.416025Z","steps":["trace[1756664938] 'agreement among raft nodes before linearized reading' (duration: 104.192409ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:22.414922Z","caller":"traceutil/trace.go:171","msg":"trace[984411719] 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:625; }","duration":"246.691195ms","start":"2026-04-03T02:24:22.168221Z","end":"2026-04-03T02:24:22.414912Z","steps":["trace[984411719] 'agreement among raft nodes before linearized reading' (duration: 244.584047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.136788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.41694Z","caller":"traceutil/trace.go:171","msg":"trace[34362744] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:625; }","duration":"290.227572ms","start":"2026-04-03T02:24:22.126698Z","end":"2026-04-03T02:24:22.416926Z","steps":["trace[34362744] 'agreement among raft nodes before linearized reading' (duration: 286.121759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.025067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.417003Z","caller":"traceutil/trace.go:171","msg":"trace[749490581] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"273.127501ms","start":"2026-04-03T02:24:22.143858Z","end":"2026-04-03T02:24:22.416986Z","steps":["trace[749490581] 'agreement among raft nodes before linearized reading' (duration: 269.012287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.074158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.417144Z","caller":"traceutil/trace.go:171","msg":"trace[1107624930] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"273.355975ms","start":"2026-04-03T02:24:22.143778Z","end":"2026-04-03T02:24:22.417134Z","steps":["trace[1107624930] 'agreement among raft nodes before linearized reading' (duration: 269.095428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.412953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.363871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.417194Z","caller":"traceutil/trace.go:171","msg":"trace[760873282] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"272.604578ms","start":"2026-04-03T02:24:22.144581Z","end":"2026-04-03T02:24:22.417185Z","steps":["trace[760873282] 'agreement among raft nodes before linearized reading' (duration: 268.342741ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:22.707327Z","caller":"traceutil/trace.go:171","msg":"trace[1309839107] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"144.754838ms","start":"2026-04-03T02:24:22.562533Z","end":"2026-04-03T02:24:22.707288Z","steps":["trace[1309839107] 'read index received' (duration: 143.781635ms)","trace[1309839107] 'applied index is now lower than readState.Index' (duration: 972.583µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:24:22.707432Z","caller":"traceutil/trace.go:171","msg":"trace[1420109210] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"241.395553ms","start":"2026-04-03T02:24:22.466027Z","end":"2026-04-03T02:24:22.707423Z","steps":["trace[1420109210] 'process raft request' (duration: 240.379709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.707722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.28641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-03T02:24:22.707771Z","caller":"traceutil/trace.go:171","msg":"trace[658578706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"131.380562ms","start":"2026-04-03T02:24:22.576378Z","end":"2026-04-03T02:24:22.707758Z","steps":["trace[658578706] 'agreement among raft nodes before linearized reading' (duration: 131.247829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.707875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.471991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.707896Z","caller":"traceutil/trace.go:171","msg":"trace[1728084642] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"130.501762ms","start":"2026-04-03T02:24:22.577386Z","end":"2026-04-03T02:24:22.707888Z","steps":["trace[1728084642] 'agreement among raft nodes before linearized reading' (duration: 130.474081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.707978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.006653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.707994Z","caller":"traceutil/trace.go:171","msg":"trace[1355548390] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"131.024833ms","start":"2026-04-03T02:24:22.576965Z","end":"2026-04-03T02:24:22.70799Z","steps":["trace[1355548390] 'agreement among raft nodes before linearized reading' (duration: 131.001053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.708089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.128346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:22.708104Z","caller":"traceutil/trace.go:171","msg":"trace[801916898] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"131.161477ms","start":"2026-04-03T02:24:22.576938Z","end":"2026-04-03T02:24:22.7081Z","steps":["trace[801916898] 'agreement among raft nodes before linearized reading' (duration: 131.101815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.708121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.707899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:24:22.708153Z","caller":"traceutil/trace.go:171","msg":"trace[598550137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"131.792691ms","start":"2026-04-03T02:24:22.576351Z","end":"2026-04-03T02:24:22.708144Z","steps":["trace[598550137] 'agreement among raft nodes before linearized reading' (duration: 131.648367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.708421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.065157ms","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-04-03T02:24:22.708441Z","caller":"traceutil/trace.go:171","msg":"trace[568750796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"132.120288ms","start":"2026-04-03T02:24:22.576316Z","end":"2026-04-03T02:24:22.708436Z","steps":["trace[568750796] 'agreement among raft nodes before linearized reading' (duration: 132.070397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:22.708568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.936456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-03T02:24:22.7086Z","caller":"traceutil/trace.go:171","msg":"trace[988268456] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"146.13428ms","start":"2026-04-03T02:24:22.562457Z","end":"2026-04-03T02:24:22.708592Z","steps":["trace[988268456] 'agreement among raft nodes before linearized reading' (duration: 145.943886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.577036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.600769842s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:24:24.577194Z","caller":"traceutil/trace.go:171","msg":"trace[456617374] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"1.716813882s","start":"2026-04-03T02:24:22.860361Z","end":"2026-04-03T02:24:24.577175Z","steps":["trace[456617374] 'read index received' (duration: 115.630551ms)","trace[456617374] 'applied index is now lower than readState.Index' (duration: 1.601182011s)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:24:24.577497Z","caller":"traceutil/trace.go:171","msg":"trace[1045444850] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.805146876s","start":"2026-04-03T02:24:22.772335Z","end":"2026-04-03T02:24:24.577482Z","steps":["trace[1045444850] 'process raft request' (duration: 203.643608ms)","trace[1045444850] 'compare' (duration: 1.596061094s)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:24:24.577615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:22.772317Z","time spent":"1.805220148s","remote":"127.0.0.1:48418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:24:24.578075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.717580941s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.578193Z","caller":"traceutil/trace.go:171","msg":"trace[1770500880] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:631; }","duration":"1.717756584s","start":"2026-04-03T02:24:22.860413Z","end":"2026-04-03T02:24:24.57817Z","steps":["trace[1770500880] 'agreement among raft nodes before linearized reading' (duration: 1.717498118s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.578249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:22.860393Z","time spent":"1.717844956s","remote":"127.0.0.1:37878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-03T02:24:24.578505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429815284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.578551Z","caller":"traceutil/trace.go:171","msg":"trace[1740888422] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"1.429897406s","start":"2026-04-03T02:24:23.14864Z","end":"2026-04-03T02:24:24.578538Z","steps":["trace[1740888422] 'agreement among raft nodes before linearized reading' (duration: 1.429772903s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.578572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429904646s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.578588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.148624Z","time spent":"1.429955147s","remote":"127.0.0.1:37930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:24:24.578604Z","caller":"traceutil/trace.go:171","msg":"trace[584174964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"1.429938156s","start":"2026-04-03T02:24:23.148656Z","end":"2026-04-03T02:24:24.578594Z","steps":["trace[584174964] 'agreement among raft nodes before linearized reading' (duration: 1.429862005s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.578634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.148595Z","time spent":"1.430031869s","remote":"127.0.0.1:37930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-03T02:24:24.578678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.478315715s","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":"warn","ts":"2026-04-03T02:24:24.578734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.718358768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.578794Z","caller":"traceutil/trace.go:171","msg":"trace[625362130] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:631; }","duration":"1.718435249s","start":"2026-04-03T02:24:22.860339Z","end":"2026-04-03T02:24:24.578775Z","steps":["trace[625362130] 'agreement among raft nodes before linearized reading' (duration: 1.718358228s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.578849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.523487081s","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-04-03T02:24:24.578887Z","caller":"traceutil/trace.go:171","msg":"trace[1924377434] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"1.523550242s","start":"2026-04-03T02:24:23.055327Z","end":"2026-04-03T02:24:24.578877Z","steps":["trace[1924377434] 'agreement among raft nodes before linearized reading' (duration: 1.523501041s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.578891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.478564501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.57886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455456231s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.578924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.05531Z","time spent":"1.523606484s","remote":"127.0.0.1:37892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-03T02:24:24.578927Z","caller":"traceutil/trace.go:171","msg":"trace[383801364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"1.478618253s","start":"2026-04-03T02:24:23.1003Z","end":"2026-04-03T02:24:24.578919Z","steps":["trace[383801364] 'agreement among raft nodes before linearized reading' (duration: 1.478570102s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.578899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.33759902s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.578965Z","caller":"traceutil/trace.go:171","msg":"trace[421038988] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:631; }","duration":"1.455614715s","start":"2026-04-03T02:24:23.123328Z","end":"2026-04-03T02:24:24.578943Z","steps":["trace[421038988] 'agreement among raft nodes before linearized reading' (duration: 1.45537805s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.57898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.10029Z","time spent":"1.478679834s","remote":"127.0.0.1:37892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"info","ts":"2026-04-03T02:24:24.578991Z","caller":"traceutil/trace.go:171","msg":"trace[2138737647] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:631; }","duration":"1.337724884s","start":"2026-04-03T02:24:23.241244Z","end":"2026-04-03T02:24:24.578969Z","steps":["trace[2138737647] 'agreement among raft nodes before linearized reading' (duration: 1.33755164s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.12332Z","time spent":"1.455709147s","remote":"127.0.0.1:37916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-04-03T02:24:24.579084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.587670002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.579098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.804996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.57913Z","caller":"traceutil/trace.go:171","msg":"trace[2004591946] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:631; }","duration":"1.587717423s","start":"2026-04-03T02:24:22.991404Z","end":"2026-04-03T02:24:24.579122Z","steps":["trace[2004591946] 'agreement among raft nodes before linearized reading' (duration: 1.587656062s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:24.579145Z","caller":"traceutil/trace.go:171","msg":"trace[743271579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"954.892168ms","start":"2026-04-03T02:24:23.624243Z","end":"2026-04-03T02:24:24.579135Z","steps":["trace[743271579] 'agreement among raft nodes before linearized reading' (duration: 954.826796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429102647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.57898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.355390678s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.579207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.588299686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.579107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.369661705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.579218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455791879s","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-04-03T02:24:24.579231Z","caller":"traceutil/trace.go:171","msg":"trace[300258270] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"1.355659964s","start":"2026-04-03T02:24:23.22356Z","end":"2026-04-03T02:24:24.57922Z","steps":["trace[300258270] 'agreement among raft nodes before linearized reading' (duration: 1.355376488s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:24.579248Z","caller":"traceutil/trace.go:171","msg":"trace[1064809544] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"1.369851299s","start":"2026-04-03T02:24:23.209383Z","end":"2026-04-03T02:24:24.579235Z","steps":["trace[1064809544] 'agreement among raft nodes before linearized reading' (duration: 1.369693375s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:24.579258Z","caller":"traceutil/trace.go:171","msg":"trace[100119422] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:631; }","duration":"1.455869671s","start":"2026-04-03T02:24:23.12338Z","end":"2026-04-03T02:24:24.57925Z","steps":["trace[100119422] 'agreement among raft nodes before linearized reading' (duration: 1.45581083s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.588426479s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.579207Z","caller":"traceutil/trace.go:171","msg":"trace[51283855] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"1.429151508s","start":"2026-04-03T02:24:23.150044Z","end":"2026-04-03T02:24:24.579195Z","steps":["trace[51283855] 'agreement among raft nodes before linearized reading' (duration: 1.429088817s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.123361Z","time spent":"1.455921042s","remote":"127.0.0.1:37916","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-04-03T02:24:24.57931Z","caller":"traceutil/trace.go:171","msg":"trace[795453546] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:631; }","duration":"1.5884836s","start":"2026-04-03T02:24:22.99082Z","end":"2026-04-03T02:24:24.579303Z","steps":["trace[795453546] 'agreement among raft nodes before linearized reading' (duration: 1.588438099s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.14997Z","time spent":"1.429340303s","remote":"127.0.0.1:37930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-03T02:24:24.57934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:22.990802Z","time spent":"1.588530521s","remote":"127.0.0.1:37880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-03T02:24:24.579339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338512351s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.579378Z","caller":"traceutil/trace.go:171","msg":"trace[2091291560] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:631; }","duration":"1.338565113s","start":"2026-04-03T02:24:23.240804Z","end":"2026-04-03T02:24:24.579369Z","steps":["trace[2091291560] 'agreement among raft nodes before linearized reading' (duration: 1.338510872s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.240799Z","time spent":"1.338608454s","remote":"127.0.0.1:37950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-03T02:24:24.579435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455646606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.579463Z","caller":"traceutil/trace.go:171","msg":"trace[357803687] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:631; }","duration":"1.455682837s","start":"2026-04-03T02:24:23.123772Z","end":"2026-04-03T02:24:24.579455Z","steps":["trace[357803687] 'agreement among raft nodes before linearized reading' (duration: 1.455638976s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.123767Z","time spent":"1.455728028s","remote":"127.0.0.1:37916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-03T02:24:24.578852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.478490159s","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-04-03T02:24:24.579286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.209337Z","time spent":"1.369938971s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-03T02:24:24.579571Z","caller":"traceutil/trace.go:171","msg":"trace[691539682] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"1.479218716s","start":"2026-04-03T02:24:23.100339Z","end":"2026-04-03T02:24:24.579557Z","steps":["trace[691539682] 'agreement among raft nodes before linearized reading' (duration: 1.47848717s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.100203Z","time spent":"1.47940253s","remote":"127.0.0.1:37900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-03T02:24:24.579043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.241235Z","time spent":"1.337797135s","remote":"127.0.0.1:37950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-03T02:24:24.579166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:22.991346Z","time spent":"1.587811815s","remote":"127.0.0.1:37878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-03T02:24:24.578912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.355018559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.579711Z","caller":"traceutil/trace.go:171","msg":"trace[1878967204] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"1.355891679s","start":"2026-04-03T02:24:23.223808Z","end":"2026-04-03T02:24:24.5797Z","steps":["trace[1878967204] 'agreement among raft nodes before linearized reading' (duration: 1.355070001s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.223549Z","time spent":"1.355718386s","remote":"127.0.0.1:37948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-03T02:24:24.579761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.223769Z","time spent":"1.355979821s","remote":"127.0.0.1:37948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-03T02:24:24.579237Z","caller":"traceutil/trace.go:171","msg":"trace[1499142248] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:631; }","duration":"1.588330837s","start":"2026-04-03T02:24:22.990898Z","end":"2026-04-03T02:24:24.579229Z","steps":["trace[1499142248] 'agreement among raft nodes before linearized reading' (duration: 1.588285746s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.578854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:22.860331Z","time spent":"1.718508361s","remote":"127.0.0.1:37878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-03T02:24:24.579833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:22.990844Z","time spent":"1.588972731s","remote":"127.0.0.1:37880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-03T02:24:24.579049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.369244045s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.579169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.624148Z","time spent":"955.016031ms","remote":"127.0.0.1:48290","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-04-03T02:24:24.579901Z","caller":"traceutil/trace.go:171","msg":"trace[1834520451] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"1.370119626s","start":"2026-04-03T02:24:23.209769Z","end":"2026-04-03T02:24:24.579889Z","steps":["trace[1834520451] 'agreement among raft nodes before linearized reading' (duration: 1.369247976s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.579112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.353631027s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:24:24.579956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.209266Z","time spent":"1.370676068s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:24:24.578795Z","caller":"traceutil/trace.go:171","msg":"trace[1578455729] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"1.478481439s","start":"2026-04-03T02:24:23.100283Z","end":"2026-04-03T02:24:24.578765Z","steps":["trace[1578455729] 'agreement among raft nodes before linearized reading' (duration: 1.478256644s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.580044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.100248Z","time spent":"1.479784969s","remote":"127.0.0.1:37900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-03T02:24:24.578779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.523390358s","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-04-03T02:24:24.580163Z","caller":"traceutil/trace.go:171","msg":"trace[1996608296] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"1.524787949s","start":"2026-04-03T02:24:23.055359Z","end":"2026-04-03T02:24:24.580147Z","steps":["trace[1996608296] 'agreement among raft nodes before linearized reading' (duration: 1.523395738s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.580225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.055347Z","time spent":"1.524860652s","remote":"127.0.0.1:37892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:24:24.579958Z","caller":"traceutil/trace.go:171","msg":"trace[940971225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"1.35464488s","start":"2026-04-03T02:24:23.225302Z","end":"2026-04-03T02:24:24.579947Z","steps":["trace[940971225] 'agreement among raft nodes before linearized reading' (duration: 1.353443093s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.580431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.225274Z","time spent":"1.355140811s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-03T02:24:24.580237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.339428642s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.580533Z","caller":"traceutil/trace.go:171","msg":"trace[1301663676] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:631; }","duration":"1.33978422s","start":"2026-04-03T02:24:23.240738Z","end":"2026-04-03T02:24:24.580522Z","steps":["trace[1301663676] 'agreement among raft nodes before linearized reading' (duration: 1.338706646s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:24.580576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:24:23.240712Z","time spent":"1.339851002s","remote":"127.0.0.1:37950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-04-03T02:24:24.699047Z","caller":"traceutil/trace.go:171","msg":"trace[880746764] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"110.689128ms","start":"2026-04-03T02:24:24.588343Z","end":"2026-04-03T02:24:24.699032Z","steps":["trace[880746764] 'process raft request' (duration: 110.565625ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:24.707079Z","caller":"traceutil/trace.go:171","msg":"trace[152248391] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"118.19197ms","start":"2026-04-03T02:24:24.588869Z","end":"2026-04-03T02:24:24.707061Z","steps":["trace[152248391] 'read index received' (duration: 110.144836ms)","trace[152248391] 'applied index is now lower than readState.Index' (duration: 8.046384ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:24:24.707182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.296512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:24.707211Z","caller":"traceutil/trace.go:171","msg":"trace[2074686330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"118.368504ms","start":"2026-04-03T02:24:24.588835Z","end":"2026-04-03T02:24:24.707203Z","steps":["trace[2074686330] 'agreement among raft nodes before linearized reading' (duration: 118.294393ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:24.707348Z","caller":"traceutil/trace.go:171","msg":"trace[425820800] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"118.64616ms","start":"2026-04-03T02:24:24.588694Z","end":"2026-04-03T02:24:24.70734Z","steps":["trace[425820800] 'process raft request' (duration: 118.155229ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:24.707536Z","caller":"traceutil/trace.go:171","msg":"trace[65184274] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"117.866712ms","start":"2026-04-03T02:24:24.589657Z","end":"2026-04-03T02:24:24.707524Z","steps":["trace[65184274] 'process raft request' (duration: 117.3559ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:24.707682Z","caller":"traceutil/trace.go:171","msg":"trace[1965508463] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"118.456725ms","start":"2026-04-03T02:24:24.589218Z","end":"2026-04-03T02:24:24.707674Z","steps":["trace[1965508463] 'process raft request' (duration: 117.726658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:24:29.19331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.533874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-04-03T02:24:29.193598Z","caller":"traceutil/trace.go:171","msg":"trace[425975006] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:708; }","duration":"165.903222ms","start":"2026-04-03T02:24:29.027667Z","end":"2026-04-03T02:24:29.19357Z","steps":["trace[425975006] 'range keys from in-memory index tree' (duration: 165.181776ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:40.762207Z","caller":"traceutil/trace.go:171","msg":"trace[701563186] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"249.213219ms","start":"2026-04-03T02:24:40.512968Z","end":"2026-04-03T02:24:40.762181Z","steps":["trace[701563186] 'process raft request' (duration: 249.059745ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:24:40.876743Z","caller":"traceutil/trace.go:171","msg":"trace[660119745] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:821; }","duration":"252.910313ms","start":"2026-04-03T02:24:40.62381Z","end":"2026-04-03T02:24:40.87672Z","steps":["trace[660119745] 'read index received' (duration: 138.221833ms)","trace[660119745] 'applied index is now lower than readState.Index' (duration: 114.68704ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:24:40.876942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.111667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:24:40.876981Z","caller":"traceutil/trace.go:171","msg":"trace[768245981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"253.164428ms","start":"2026-04-03T02:24:40.623805Z","end":"2026-04-03T02:24:40.876969Z","steps":["trace[768245981] 'agreement among raft nodes before linearized reading' (duration: 253.082246ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:25:15.354218Z","caller":"traceutil/trace.go:171","msg":"trace[1239103299] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"236.242613ms","start":"2026-04-03T02:25:15.117944Z","end":"2026-04-03T02:25:15.354187Z","steps":["trace[1239103299] 'read index received' (duration: 236.076139ms)","trace[1239103299] 'applied index is now lower than readState.Index' (duration: 165.314µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:25:15.354319Z","caller":"traceutil/trace.go:171","msg":"trace[354393610] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"356.846247ms","start":"2026-04-03T02:25:14.997435Z","end":"2026-04-03T02:25:15.354281Z","steps":["trace[354393610] 'process raft request' (duration: 356.5378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:15.354431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.462599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:25:15.354477Z","caller":"traceutil/trace.go:171","msg":"trace[939615757] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1008; }","duration":"236.611351ms","start":"2026-04-03T02:25:15.117855Z","end":"2026-04-03T02:25:15.354466Z","steps":["trace[939615757] 'agreement among raft nodes before linearized reading' (duration: 236.507149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:15.354492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:14.997408Z","time spent":"356.98148ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:25:15.855296Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695837243829583,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-03T02:25:16.126276Z","caller":"traceutil/trace.go:171","msg":"trace[1898725028] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1045; }","duration":"771.942605ms","start":"2026-04-03T02:25:15.354322Z","end":"2026-04-03T02:25:16.126265Z","steps":["trace[1898725028] 'read index received' (duration: 771.576316ms)","trace[1898725028] 'applied index is now lower than readState.Index' (duration: 365.049µs)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:25:16.126503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.058421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-03T02:25:16.126481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.960561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-03T02:25:16.126533Z","caller":"traceutil/trace.go:171","msg":"trace[1993587393] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1010; }","duration":"995.154144ms","start":"2026-04-03T02:25:15.131371Z","end":"2026-04-03T02:25:16.126525Z","steps":["trace[1993587393] 'agreement among raft nodes before linearized reading' (duration: 994.96872ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:25:16.126555Z","caller":"traceutil/trace.go:171","msg":"trace[791548362] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:1010; }","duration":"793.039762ms","start":"2026-04-03T02:25:15.333494Z","end":"2026-04-03T02:25:16.126534Z","steps":["trace[791548362] 'agreement among raft nodes before linearized reading' (duration: 792.826288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:16.126589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:15.333418Z","time spent":"793.165206ms","remote":"127.0.0.1:48312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.155\" "} {"level":"warn","ts":"2026-04-03T02:25:16.126616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.88348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-03T02:25:16.126635Z","caller":"traceutil/trace.go:171","msg":"trace[1214337691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1010; }","duration":"980.910251ms","start":"2026-04-03T02:25:15.145719Z","end":"2026-04-03T02:25:16.126629Z","steps":["trace[1214337691] 'agreement among raft nodes before linearized reading' (duration: 980.855639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:16.12665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:15.145714Z","time spent":"980.933381ms","remote":"127.0.0.1:48490","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-04-03T02:25:16.126559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:15.131346Z","time spent":"995.206466ms","remote":"127.0.0.1:48490","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-04-03T02:25:16.126751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.68221ms","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-04-03T02:25:16.126722Z","caller":"traceutil/trace.go:171","msg":"trace[1676576043] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"928.963354ms","start":"2026-04-03T02:25:15.19772Z","end":"2026-04-03T02:25:16.126683Z","steps":["trace[1676576043] 'process raft request' (duration: 928.401501ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:25:16.126782Z","caller":"traceutil/trace.go:171","msg":"trace[169992440] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1010; }","duration":"993.735952ms","start":"2026-04-03T02:25:15.133039Z","end":"2026-04-03T02:25:16.126775Z","steps":["trace[169992440] 'agreement among raft nodes before linearized reading' (duration: 993.65457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:16.126801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:15.133032Z","time spent":"993.766062ms","remote":"127.0.0.1:48490","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-04-03T02:25:16.126895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:15.197688Z","time spent":"929.110677ms","remote":"127.0.0.1:48490","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-04-03T02:25:16.126201Z","caller":"traceutil/trace.go:171","msg":"trace[1212727851] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"984.556544ms","start":"2026-04-03T02:25:15.141595Z","end":"2026-04-03T02:25:16.126151Z","steps":["trace[1212727851] 'process raft request' (duration: 984.356309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:16.127144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:15.141572Z","time spent":"985.505775ms","remote":"127.0.0.1:48490","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-04-03T02:25:16.128913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.145596ms","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-04-03T02:25:16.128956Z","caller":"traceutil/trace.go:171","msg":"trace[1930388455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1010; }","duration":"996.218308ms","start":"2026-04-03T02:25:15.132729Z","end":"2026-04-03T02:25:16.128947Z","steps":["trace[1930388455] 'agreement among raft nodes before linearized reading' (duration: 994.138911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:16.128981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:15.132718Z","time spent":"996.256889ms","remote":"127.0.0.1:48490","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":"info","ts":"2026-04-03T02:25:40.418324Z","caller":"traceutil/trace.go:171","msg":"trace[1695186225] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1131; }","duration":"100.879361ms","start":"2026-04-03T02:25:40.317422Z","end":"2026-04-03T02:25:40.418301Z","steps":["trace[1695186225] 'read index received' (duration: 100.661486ms)","trace[1695186225] 'applied index is now lower than readState.Index' (duration: 216.645µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:25:40.418358Z","caller":"traceutil/trace.go:171","msg":"trace[718884710] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"107.099659ms","start":"2026-04-03T02:25:40.31124Z","end":"2026-04-03T02:25:40.41834Z","steps":["trace[718884710] 'process raft request' (duration: 106.898704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:40.41862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.179277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:25:40.418673Z","caller":"traceutil/trace.go:171","msg":"trace[666378238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1090; }","duration":"101.29395ms","start":"2026-04-03T02:25:40.317366Z","end":"2026-04-03T02:25:40.41866Z","steps":["trace[666378238] 'agreement among raft nodes before linearized reading' (duration: 101.067465ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:25:40.763749Z","caller":"traceutil/trace.go:171","msg":"trace[1216946815] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"341.520509ms","start":"2026-04-03T02:25:40.422197Z","end":"2026-04-03T02:25:40.763718Z","steps":["trace[1216946815] 'process raft request' (duration: 288.278071ms)","trace[1216946815] 'compare' (duration: 52.782188ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:25:40.763884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:40.422176Z","time spent":"341.634912ms","remote":"127.0.0.1:48490","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-04-03T02:25:41.151422Z","caller":"traceutil/trace.go:171","msg":"trace[445487210] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"728.254547ms","start":"2026-04-03T02:25:40.42312Z","end":"2026-04-03T02:25:41.151375Z","steps":["trace[445487210] 'process raft request' (duration: 727.878959ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:25:41.151565Z","caller":"traceutil/trace.go:171","msg":"trace[363208228] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"728.344989ms","start":"2026-04-03T02:25:40.423168Z","end":"2026-04-03T02:25:41.151513Z","steps":["trace[363208228] 'process raft request' (duration: 727.996722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:41.151783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:40.423152Z","time spent":"728.523074ms","remote":"127.0.0.1:48490","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-04-03T02:25:41.151925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:40.423101Z","time spent":"728.606026ms","remote":"127.0.0.1:48490","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-04-03T02:25:41.186262Z","caller":"traceutil/trace.go:171","msg":"trace[1138577490] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1132; }","duration":"598.38686ms","start":"2026-04-03T02:25:40.587852Z","end":"2026-04-03T02:25:41.186238Z","steps":["trace[1138577490] 'read index received' (duration: 123.214629ms)","trace[1138577490] 'applied index is now lower than readState.Index' (duration: 475.170841ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:25:41.186396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.537723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-03T02:25:41.186435Z","caller":"traceutil/trace.go:171","msg":"trace[1850251770] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1093; }","duration":"598.645745ms","start":"2026-04-03T02:25:40.587776Z","end":"2026-04-03T02:25:41.186422Z","steps":["trace[1850251770] 'agreement among raft nodes before linearized reading' (duration: 598.550733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:41.186473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:40.587749Z","time spent":"598.712387ms","remote":"127.0.0.1:50632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:25:43.08287Z","caller":"traceutil/trace.go:171","msg":"trace[249631703] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"311.230324ms","start":"2026-04-03T02:25:42.771614Z","end":"2026-04-03T02:25:43.082844Z","steps":["trace[249631703] 'process raft request' (duration: 311.087471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:43.08303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:42.771592Z","time spent":"311.355966ms","remote":"127.0.0.1:48490","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-04-03T02:25:43.369938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.911267ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:25:43.370122Z","caller":"traceutil/trace.go:171","msg":"trace[1140533144] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"198.10299ms","start":"2026-04-03T02:25:43.172001Z","end":"2026-04-03T02:25:43.370104Z","steps":["trace[1140533144] 'process raft request' (duration: 198.046969ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:25:43.370136Z","caller":"traceutil/trace.go:171","msg":"trace[9736802] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"198.341335ms","start":"2026-04-03T02:25:43.171769Z","end":"2026-04-03T02:25:43.370111Z","steps":["trace[9736802] 'process raft request' (duration: 21.157902ms)","trace[9736802] 'compare' (duration: 176.749304ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:25:55.506456Z","caller":"traceutil/trace.go:171","msg":"trace[228334553] linearizableReadLoop","detail":"{readStateIndex:1235; appliedIndex:1234; }","duration":"169.409049ms","start":"2026-04-03T02:25:55.33703Z","end":"2026-04-03T02:25:55.506439Z","steps":["trace[228334553] 'read index received' (duration: 169.236945ms)","trace[228334553] 'applied index is now lower than readState.Index' (duration: 171.554µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:25:55.506735Z","caller":"traceutil/trace.go:171","msg":"trace[2094590332] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"372.172644ms","start":"2026-04-03T02:25:55.134546Z","end":"2026-04-03T02:25:55.506719Z","steps":["trace[2094590332] 'process raft request' (duration: 371.781836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:55.506843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:55.134537Z","time spent":"372.237865ms","remote":"127.0.0.1:48490","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-04-03T02:25:55.507096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.056003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-03T02:25:55.507132Z","caller":"traceutil/trace.go:171","msg":"trace[1374555517] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:1188; }","duration":"170.148725ms","start":"2026-04-03T02:25:55.336976Z","end":"2026-04-03T02:25:55.507125Z","steps":["trace[1374555517] 'agreement among raft nodes before linearized reading' (duration: 170.020412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:55.99689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.271463ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-04-03T02:25:55.996984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:55.509274Z","time spent":"487.704772ms","remote":"127.0.0.1:48312","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-03T02:25:56.006624Z","caller":"traceutil/trace.go:171","msg":"trace[1815716831] linearizableReadLoop","detail":"{readStateIndex:1238; appliedIndex:1235; }","duration":"404.739391ms","start":"2026-04-03T02:25:55.60185Z","end":"2026-04-03T02:25:56.006589Z","steps":["trace[1815716831] 'read index received' (duration: 67.758591ms)","trace[1815716831] 'applied index is now lower than readState.Index' (duration: 336.97997ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:25:56.006707Z","caller":"traceutil/trace.go:171","msg":"trace[474049360] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"494.911963ms","start":"2026-04-03T02:25:55.511786Z","end":"2026-04-03T02:25:56.006697Z","steps":["trace[474049360] 'process raft request' (duration: 493.707006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:56.006789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:55.51177Z","time spent":"494.959524ms","remote":"127.0.0.1:48490","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-04-03T02:25:56.006857Z","caller":"traceutil/trace.go:171","msg":"trace[381063797] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"494.643757ms","start":"2026-04-03T02:25:55.512168Z","end":"2026-04-03T02:25:56.006812Z","steps":["trace[381063797] 'process raft request' (duration: 494.368871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:56.007036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:55.512159Z","time spent":"494.77846ms","remote":"127.0.0.1:48490","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-04-03T02:25:56.008335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.475049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-03T02:25:56.008397Z","caller":"traceutil/trace.go:171","msg":"trace[2017206282] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1190; }","duration":"406.552461ms","start":"2026-04-03T02:25:55.601819Z","end":"2026-04-03T02:25:56.008371Z","steps":["trace[2017206282] 'agreement among raft nodes before linearized reading' (duration: 405.102669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:56.008436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:55.601805Z","time spent":"406.623852ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-03T02:25:56.054891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.477385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:25:56.055052Z","caller":"traceutil/trace.go:171","msg":"trace[1139744622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1191; }","duration":"430.69271ms","start":"2026-04-03T02:25:55.624334Z","end":"2026-04-03T02:25:56.055027Z","steps":["trace[1139744622] 'agreement among raft nodes before linearized reading' (duration: 430.23656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:56.055104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:55.624321Z","time spent":"430.774472ms","remote":"127.0.0.1:48290","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-04-03T02:25:58.123363Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695837243830032,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T02:25:58.686996Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695837243830032,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T02:25:59.198248Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695837243830032,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T02:25:59.48842Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.975863634s","expected-duration":"1s"} {"level":"info","ts":"2026-04-03T02:25:59.488795Z","caller":"traceutil/trace.go:171","msg":"trace[385911193] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"1.976275033s","start":"2026-04-03T02:25:57.512498Z","end":"2026-04-03T02:25:59.488773Z","steps":["trace[385911193] 'process raft request' (duration: 1.97612886s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:59.488918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:57.512488Z","time spent":"1.976356944s","remote":"127.0.0.1:48490","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-04-03T02:25:59.623328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000753749s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-03T02:25:59.623432Z","caller":"traceutil/trace.go:171","msg":"trace[1809471240] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000902693s","start":"2026-04-03T02:25:57.622507Z","end":"2026-04-03T02:25:59.623409Z","steps":["trace[1809471240] 'agreement among raft nodes before linearized reading' (duration: 2.000754299s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:59.623492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:57.622492Z","time spent":"2.000989114s","remote":"127.0.0.1:48290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-03T02:25:59.660005Z","caller":"traceutil/trace.go:171","msg":"trace[989654949] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1243; }","duration":"2.037448067s","start":"2026-04-03T02:25:57.622538Z","end":"2026-04-03T02:25:59.659986Z","steps":["trace[989654949] 'read index received' (duration: 1.866018683s)","trace[989654949] 'applied index is now lower than readState.Index' (duration: 171.428124ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:25:59.66003Z","caller":"traceutil/trace.go:171","msg":"trace[542241081] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"1.285487691s","start":"2026-04-03T02:25:58.374508Z","end":"2026-04-03T02:25:59.659996Z","steps":["trace[542241081] 'process raft request' (duration: 1.283733051s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:59.660194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.648651203s","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-04-03T02:25:59.660223Z","caller":"traceutil/trace.go:171","msg":"trace[2113576832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1197; }","duration":"1.648724984s","start":"2026-04-03T02:25:58.011491Z","end":"2026-04-03T02:25:59.660216Z","steps":["trace[2113576832] 'agreement among raft nodes before linearized reading' (duration: 1.648596332s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:59.660219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:58.374489Z","time spent":"1.285617223s","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:25:59.660245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:58.011474Z","time spent":"1.648766135s","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-03T02:25:59.66032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.112198974s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-03T02:25:59.66039Z","caller":"traceutil/trace.go:171","msg":"trace[1296811353] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1197; }","duration":"1.112270736s","start":"2026-04-03T02:25:58.548104Z","end":"2026-04-03T02:25:59.660375Z","steps":["trace[1296811353] 'agreement among raft nodes before linearized reading' (duration: 1.112042271s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:59.660437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.566309235s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-03T02:25:59.66044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:58.548016Z","time spent":"1.112409238s","remote":"127.0.0.1:48490","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-04-03T02:25:59.660467Z","caller":"traceutil/trace.go:171","msg":"trace[2068814932] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1197; }","duration":"1.566364707s","start":"2026-04-03T02:25:58.094094Z","end":"2026-04-03T02:25:59.660459Z","steps":["trace[2068814932] 'agreement among raft nodes before linearized reading' (duration: 1.566293385s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:59.660486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:58.094079Z","time spent":"1.566403467s","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-03T02:25:59.66057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.648920029s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:25:59.660633Z","caller":"traceutil/trace.go:171","msg":"trace[1692600043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1197; }","duration":"1.64899826s","start":"2026-04-03T02:25:58.011621Z","end":"2026-04-03T02:25:59.66062Z","steps":["trace[1692600043] 'agreement among raft nodes before linearized reading' (duration: 1.648849877s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:25:59.660681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:25:58.011616Z","time spent":"1.649049391s","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-03T02:26:07.953785Z","caller":"traceutil/trace.go:171","msg":"trace[1700519418] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"129.651523ms","start":"2026-04-03T02:26:07.824112Z","end":"2026-04-03T02:26:07.953764Z","steps":["trace[1700519418] 'process raft request' (duration: 88.892524ms)","trace[1700519418] 'compare' (duration: 40.647217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:12.437654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.347448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:26:12.43773Z","caller":"traceutil/trace.go:171","msg":"trace[1932503987] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"604.858735ms","start":"2026-04-03T02:26:11.832859Z","end":"2026-04-03T02:26:12.437718Z","steps":["trace[1932503987] 'read index received' (duration: 50.322433ms)","trace[1932503987] 'applied index is now lower than readState.Index' (duration: 554.535252ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:12.437778Z","caller":"traceutil/trace.go:171","msg":"trace[767749591] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"641.40216ms","start":"2026-04-03T02:26:11.796345Z","end":"2026-04-03T02:26:12.437747Z","steps":["trace[767749591] 'process raft request' (duration: 86.896199ms)","trace[767749591] 'compare' (duration: 554.207685ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:12.437845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.986018ms","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-04-03T02:26:12.437866Z","caller":"traceutil/trace.go:171","msg":"trace[2108329609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1239; }","duration":"605.037409ms","start":"2026-04-03T02:26:11.832822Z","end":"2026-04-03T02:26:12.437859Z","steps":["trace[2108329609] 'agreement among raft nodes before linearized reading' (duration: 604.953807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:12.437887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:11.832804Z","time spent":"605.079059ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-03T02:26:12.437873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.846396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:26:12.437918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.022628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-03T02:26:12.437932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:11.796323Z","time spent":"641.528953ms","remote":"127.0.0.1:48490","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-04-03T02:26:12.437954Z","caller":"traceutil/trace.go:171","msg":"trace[1267567488] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1239; }","duration":"202.969858ms","start":"2026-04-03T02:26:12.234967Z","end":"2026-04-03T02:26:12.437937Z","steps":["trace[1267567488] 'agreement among raft nodes before linearized reading' (duration: 202.844525ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:12.437985Z","caller":"traceutil/trace.go:171","msg":"trace[2077194608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1239; }","duration":"605.132621ms","start":"2026-04-03T02:26:11.832836Z","end":"2026-04-03T02:26:12.437969Z","steps":["trace[2077194608] 'agreement among raft nodes before linearized reading' (duration: 604.956317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:12.438031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:11.83282Z","time spent":"605.202923ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:26:12.438074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.901835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-03T02:26:12.438095Z","caller":"traceutil/trace.go:171","msg":"trace[1791887147] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1239; }","duration":"465.949065ms","start":"2026-04-03T02:26:11.972141Z","end":"2026-04-03T02:26:12.43809Z","steps":["trace[1791887147] 'agreement among raft nodes before linearized reading' (duration: 465.900994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:12.438112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:11.972117Z","time spent":"465.991846ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-03T02:26:12.43773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.363971ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:12.438214Z","caller":"traceutil/trace.go:171","msg":"trace[1134652847] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1238; }","duration":"421.899543ms","start":"2026-04-03T02:26:12.016305Z","end":"2026-04-03T02:26:12.438204Z","steps":["trace[1134652847] 'range keys from in-memory index tree' (duration: 420.85753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:13.124938Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695837243830140,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-03T02:26:13.160071Z","caller":"traceutil/trace.go:171","msg":"trace[875748901] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"717.256303ms","start":"2026-04-03T02:26:12.44279Z","end":"2026-04-03T02:26:13.160046Z","steps":["trace[875748901] 'process raft request' (duration: 717.10994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:13.160223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:12.442772Z","time spent":"717.360715ms","remote":"127.0.0.1:48490","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-04-03T02:26:13.194243Z","caller":"traceutil/trace.go:171","msg":"trace[1482424084] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"751.256501ms","start":"2026-04-03T02:26:12.442958Z","end":"2026-04-03T02:26:13.194215Z","steps":["trace[1482424084] 'process raft request' (duration: 751.010365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:13.194405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:12.442951Z","time spent":"751.372143ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:13.194492Z","caller":"traceutil/trace.go:171","msg":"trace[2100837298] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1291; }","duration":"570.222761ms","start":"2026-04-03T02:26:12.624242Z","end":"2026-04-03T02:26:13.194464Z","steps":["trace[2100837298] 'read index received' (duration: 535.918626ms)","trace[2100837298] 'applied index is now lower than readState.Index' (duration: 34.302915ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:13.19469Z","caller":"traceutil/trace.go:171","msg":"trace[545029467] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"750.920254ms","start":"2026-04-03T02:26:12.443757Z","end":"2026-04-03T02:26:13.194678Z","steps":["trace[545029467] 'process raft request' (duration: 750.360672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:13.194803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.569659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:13.194856Z","caller":"traceutil/trace.go:171","msg":"trace[1496931699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1242; }","duration":"570.664391ms","start":"2026-04-03T02:26:12.624177Z","end":"2026-04-03T02:26:13.194842Z","steps":["trace[1496931699] 'agreement among raft nodes before linearized reading' (duration: 570.59358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:13.194894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:12.624137Z","time spent":"570.750183ms","remote":"127.0.0.1:48290","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-04-03T02:26:13.194803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:12.443737Z","time spent":"750.989415ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:26:13.807066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.699971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-03T02:26:13.807141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.394497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-03T02:26:13.807155Z","caller":"traceutil/trace.go:171","msg":"trace[404023504] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1242; }","duration":"240.843963ms","start":"2026-04-03T02:26:13.566294Z","end":"2026-04-03T02:26:13.807138Z","steps":["trace[404023504] 'range keys from in-memory index tree' (duration: 240.535777ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:13.807188Z","caller":"traceutil/trace.go:171","msg":"trace[791072102] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1242; }","duration":"354.49817ms","start":"2026-04-03T02:26:13.452677Z","end":"2026-04-03T02:26:13.807175Z","steps":["trace[791072102] 'count revisions from in-memory index tree' (duration: 354.329476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:13.807211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.402906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:26:13.807253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:13.452664Z","time spent":"354.579491ms","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:26:13.807288Z","caller":"traceutil/trace.go:171","msg":"trace[921732115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1242; }","duration":"180.517398ms","start":"2026-04-03T02:26:13.626753Z","end":"2026-04-03T02:26:13.80727Z","steps":["trace[921732115] 'range keys from in-memory index tree' (duration: 180.336775ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:14.154966Z","caller":"traceutil/trace.go:171","msg":"trace[1428998385] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"438.569285ms","start":"2026-04-03T02:26:13.71637Z","end":"2026-04-03T02:26:14.154939Z","steps":["trace[1428998385] 'process raft request' (duration: 438.411181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:14.155103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.187597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:14.155006Z","caller":"traceutil/trace.go:171","msg":"trace[1739197077] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1294; }","duration":"434.091835ms","start":"2026-04-03T02:26:13.720894Z","end":"2026-04-03T02:26:14.154986Z","steps":["trace[1739197077] 'read index received' (duration: 434.081285ms)","trace[1739197077] 'applied index is now lower than readState.Index' (duration: 8.65µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:14.155192Z","caller":"traceutil/trace.go:171","msg":"trace[461379490] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1243; }","duration":"434.33375ms","start":"2026-04-03T02:26:13.720849Z","end":"2026-04-03T02:26:14.155182Z","steps":["trace[461379490] 'agreement among raft nodes before linearized reading' (duration: 434.195097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:14.155148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:13.716328Z","time spent":"438.740729ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:26:14.15523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:13.72083Z","time spent":"434.389841ms","remote":"127.0.0.1:48520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:26:14.55009Z","caller":"traceutil/trace.go:171","msg":"trace[346686827] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1294; }","duration":"112.994001ms","start":"2026-04-03T02:26:14.437076Z","end":"2026-04-03T02:26:14.55007Z","steps":["trace[346686827] 'read index received' (duration: 24.471125ms)","trace[346686827] 'applied index is now lower than readState.Index' (duration: 88.521956ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:14.550209Z","caller":"traceutil/trace.go:171","msg":"trace[1661193367] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"738.427185ms","start":"2026-04-03T02:26:13.811747Z","end":"2026-04-03T02:26:14.550174Z","steps":["trace[1661193367] 'process raft request' (duration: 649.780777ms)","trace[1661193367] 'compare' (duration: 88.391943ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:14.550353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.227532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-03T02:26:14.550376Z","caller":"traceutil/trace.go:171","msg":"trace[628623087] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1244; }","duration":"107.269373ms","start":"2026-04-03T02:26:14.4431Z","end":"2026-04-03T02:26:14.550369Z","steps":["trace[628623087] 'agreement among raft nodes before linearized reading' (duration: 107.174341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:14.550382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:13.811729Z","time spent":"738.568398ms","remote":"127.0.0.1:48490","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-04-03T02:26:14.550254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.169424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:14.550599Z","caller":"traceutil/trace.go:171","msg":"trace[138683890] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1244; }","duration":"113.559153ms","start":"2026-04-03T02:26:14.437024Z","end":"2026-04-03T02:26:14.550583Z","steps":["trace[138683890] 'agreement among raft nodes before linearized reading' (duration: 113.149784ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:14.909335Z","caller":"traceutil/trace.go:171","msg":"trace[1172064614] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"285.693575ms","start":"2026-04-03T02:26:14.623614Z","end":"2026-04-03T02:26:14.909307Z","steps":["trace[1172064614] 'read index received' (duration: 263.881089ms)","trace[1172064614] 'applied index is now lower than readState.Index' (duration: 21.811016ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:14.909389Z","caller":"traceutil/trace.go:171","msg":"trace[1809487097] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"355.030931ms","start":"2026-04-03T02:26:14.554334Z","end":"2026-04-03T02:26:14.909365Z","steps":["trace[1809487097] 'process raft request' (duration: 333.167814ms)","trace[1809487097] 'compare' (duration: 21.507529ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:14.909507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.867568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:26:14.90952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:14.554312Z","time spent":"355.137443ms","remote":"127.0.0.1:48490","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-04-03T02:26:14.909541Z","caller":"traceutil/trace.go:171","msg":"trace[2124868807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1245; }","duration":"285.95936ms","start":"2026-04-03T02:26:14.623571Z","end":"2026-04-03T02:26:14.90953Z","steps":["trace[2124868807] 'agreement among raft nodes before linearized reading' (duration: 285.866958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:14.909664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.986154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:14.909733Z","caller":"traceutil/trace.go:171","msg":"trace[1176038710] 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:1245; }","duration":"205.109227ms","start":"2026-04-03T02:26:14.704607Z","end":"2026-04-03T02:26:14.909716Z","steps":["trace[1176038710] 'agreement among raft nodes before linearized reading' (duration: 204.993184ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:15.603882Z","caller":"traceutil/trace.go:171","msg":"trace[124524588] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"403.910261ms","start":"2026-04-03T02:26:15.199945Z","end":"2026-04-03T02:26:15.603856Z","steps":["trace[124524588] 'process raft request' (duration: 403.674286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:15.604117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:15.199935Z","time spent":"404.095235ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:15.607285Z","caller":"traceutil/trace.go:171","msg":"trace[471776625] linearizableReadLoop","detail":"{readStateIndex:1299; appliedIndex:1296; }","duration":"269.787969ms","start":"2026-04-03T02:26:15.337474Z","end":"2026-04-03T02:26:15.607262Z","steps":["trace[471776625] 'read index received' (duration: 266.22064ms)","trace[471776625] 'applied index is now lower than readState.Index' (duration: 3.566239ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:15.607414Z","caller":"traceutil/trace.go:171","msg":"trace[768236853] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"406.000077ms","start":"2026-04-03T02:26:15.201361Z","end":"2026-04-03T02:26:15.607361Z","steps":["trace[768236853] 'process raft request' (duration: 405.66042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:15.607547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.057366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-03T02:26:15.607591Z","caller":"traceutil/trace.go:171","msg":"trace[917503484] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:1248; }","duration":"270.169888ms","start":"2026-04-03T02:26:15.33741Z","end":"2026-04-03T02:26:15.607579Z","steps":["trace[917503484] 'agreement among raft nodes before linearized reading' (duration: 269.945812ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:15.607655Z","caller":"traceutil/trace.go:171","msg":"trace[1067147460] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"404.879254ms","start":"2026-04-03T02:26:15.202633Z","end":"2026-04-03T02:26:15.607512Z","steps":["trace[1067147460] 'process raft request' (duration: 404.582966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:15.607708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:15.201348Z","time spent":"406.211853ms","remote":"127.0.0.1:48490","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-04-03T02:26:15.607815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:15.202603Z","time spent":"405.126419ms","remote":"127.0.0.1:48490","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-04-03T02:26:20.136357Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695837243830224,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-03T02:26:20.156341Z","caller":"traceutil/trace.go:171","msg":"trace[1465651058] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"520.241507ms","start":"2026-04-03T02:26:19.636083Z","end":"2026-04-03T02:26:20.156325Z","steps":["trace[1465651058] 'read index received' (duration: 520.092103ms)","trace[1465651058] 'applied index is now lower than readState.Index' (duration: 148.804µs)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:20.156615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.515813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:26:20.156595Z","caller":"traceutil/trace.go:171","msg":"trace[1280744172] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"524.273587ms","start":"2026-04-03T02:26:19.63229Z","end":"2026-04-03T02:26:20.156563Z","steps":["trace[1280744172] 'process raft request' (duration: 523.941759ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:20.156644Z","caller":"traceutil/trace.go:171","msg":"trace[1885573242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1280; }","duration":"520.566943ms","start":"2026-04-03T02:26:19.636068Z","end":"2026-04-03T02:26:20.156635Z","steps":["trace[1885573242] 'agreement among raft nodes before linearized reading' (duration: 520.461421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:20.156663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:19.636061Z","time spent":"520.597814ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:26:20.156716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.315885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-03T02:26:20.156736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:19.632277Z","time spent":"524.377509ms","remote":"127.0.0.1:48490","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-04-03T02:26:20.156785Z","caller":"traceutil/trace.go:171","msg":"trace[1721869698] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1280; }","duration":"480.421858ms","start":"2026-04-03T02:26:19.676344Z","end":"2026-04-03T02:26:20.156766Z","steps":["trace[1721869698] 'agreement among raft nodes before linearized reading' (duration: 480.189843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:20.156822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.124315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:26:20.156828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:19.676331Z","time spent":"480.488219ms","remote":"127.0.0.1:48490","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-04-03T02:26:20.15684Z","caller":"traceutil/trace.go:171","msg":"trace[1160447624] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1280; }","duration":"356.178807ms","start":"2026-04-03T02:26:19.800656Z","end":"2026-04-03T02:26:20.156835Z","steps":["trace[1160447624] 'agreement among raft nodes before linearized reading' (duration: 356.144086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:20.156857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:19.800638Z","time spent":"356.216357ms","remote":"127.0.0.1:48666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:26:20.591942Z","caller":"traceutil/trace.go:171","msg":"trace[1853455428] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"429.612325ms","start":"2026-04-03T02:26:20.162263Z","end":"2026-04-03T02:26:20.591875Z","steps":["trace[1853455428] 'process raft request' (duration: 418.475097ms)","trace[1853455428] 'compare' (duration: 10.695979ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:20.592044Z","caller":"traceutil/trace.go:171","msg":"trace[1513395954] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"429.722268ms","start":"2026-04-03T02:26:20.1623Z","end":"2026-04-03T02:26:20.592022Z","steps":["trace[1513395954] 'process raft request' (duration: 429.504393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:20.592093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:20.162229Z","time spent":"429.786799ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:26:20.59217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:20.162275Z","time spent":"429.8178ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:20.627549Z","caller":"traceutil/trace.go:171","msg":"trace[901046749] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"449.477949ms","start":"2026-04-03T02:26:20.178039Z","end":"2026-04-03T02:26:20.627517Z","steps":["trace[901046749] 'process raft request' (duration: 449.327144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:20.627895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:20.178024Z","time spent":"449.605081ms","remote":"127.0.0.1:48490","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-04-03T02:26:20.75162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.167101ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-03T02:26:20.751767Z","caller":"traceutil/trace.go:171","msg":"trace[2096090879] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1332; }","duration":"367.166651ms","start":"2026-04-03T02:26:20.384544Z","end":"2026-04-03T02:26:20.75171Z","steps":["trace[2096090879] 'read index received' (duration: 196.34788ms)","trace[2096090879] 'applied index is now lower than readState.Index' (duration: 170.817421ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:20.751811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.253063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:20.751862Z","caller":"traceutil/trace.go:171","msg":"trace[239930411] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1283; }","duration":"367.355675ms","start":"2026-04-03T02:26:20.384494Z","end":"2026-04-03T02:26:20.751849Z","steps":["trace[239930411] 'agreement among raft nodes before linearized reading' (duration: 367.237903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:20.752026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:20.384475Z","time spent":"367.534419ms","remote":"127.0.0.1:50688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:26:21.579999Z","caller":"traceutil/trace.go:171","msg":"trace[1646898839] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"112.310315ms","start":"2026-04-03T02:26:21.467629Z","end":"2026-04-03T02:26:21.579939Z","steps":["trace[1646898839] 'process raft request' (duration: 112.100111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.480985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.087705ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:26:22.481213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.207119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:26:22.481363Z","caller":"traceutil/trace.go:171","msg":"trace[1474301945] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1340; }","duration":"856.97991ms","start":"2026-04-03T02:26:21.624368Z","end":"2026-04-03T02:26:22.481348Z","steps":["trace[1474301945] 'read index received' (duration: 252.692959ms)","trace[1474301945] 'applied index is now lower than readState.Index' (duration: 604.285371ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:22.481405Z","caller":"traceutil/trace.go:171","msg":"trace[871738649] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"780.183235ms","start":"2026-04-03T02:26:21.701208Z","end":"2026-04-03T02:26:22.481391Z","steps":["trace[871738649] 'process raft request' (duration: 780.141814ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:22.481354Z","caller":"traceutil/trace.go:171","msg":"trace[1142945528] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"896.00205ms","start":"2026-04-03T02:26:21.585298Z","end":"2026-04-03T02:26:22.4813Z","steps":["trace[1142945528] 'process raft request' (duration: 291.685898ms)","trace[1142945528] 'compare' (duration: 603.885083ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:22.481459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:21.701182Z","time spent":"780.247817ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5883,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:26:22.481497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.130633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:22.481534Z","caller":"traceutil/trace.go:171","msg":"trace[1305279437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1290; }","duration":"857.204665ms","start":"2026-04-03T02:26:21.624321Z","end":"2026-04-03T02:26:22.481525Z","steps":["trace[1305279437] 'agreement among raft nodes before linearized reading' (duration: 857.115083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.481573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:21.624308Z","time spent":"857.256746ms","remote":"127.0.0.1:48290","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-04-03T02:26:22.48156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:21.585278Z","time spent":"896.173955ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:26:22.481602Z","caller":"traceutil/trace.go:171","msg":"trace[394650536] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"823.079993ms","start":"2026-04-03T02:26:21.658517Z","end":"2026-04-03T02:26:22.481597Z","steps":["trace[394650536] 'process raft request' (duration: 822.775876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.481636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:21.658493Z","time spent":"823.124853ms","remote":"127.0.0.1:48334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:26:22.481156Z","caller":"traceutil/trace.go:171","msg":"trace[612631727] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1287; }","duration":"464.272909ms","start":"2026-04-03T02:26:22.016864Z","end":"2026-04-03T02:26:22.481137Z","steps":["trace[612631727] 'range keys from in-memory index tree' (duration: 464.070453ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:22.507474Z","caller":"traceutil/trace.go:171","msg":"trace[1683770807] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"343.483493ms","start":"2026-04-03T02:26:22.16397Z","end":"2026-04-03T02:26:22.507454Z","steps":["trace[1683770807] 'process raft request' (duration: 343.147155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.507488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.078385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:26:22.507535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.071486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-03T02:26:22.50757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.163942Z","time spent":"343.581406ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:22.507582Z","caller":"traceutil/trace.go:171","msg":"trace[120408784] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1291; }","duration":"326.220719ms","start":"2026-04-03T02:26:22.181336Z","end":"2026-04-03T02:26:22.507556Z","steps":["trace[120408784] 'agreement among raft nodes before linearized reading' (duration: 326.060735ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:22.507598Z","caller":"traceutil/trace.go:171","msg":"trace[417860017] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1291; }","duration":"257.213829ms","start":"2026-04-03T02:26:22.250365Z","end":"2026-04-03T02:26:22.507578Z","steps":["trace[417860017] 'agreement among raft nodes before linearized reading' (duration: 257.088016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.507602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.009858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-03T02:26:22.507635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.181319Z","time spent":"326.30381ms","remote":"127.0.0.1:50656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:26:22.507671Z","caller":"traceutil/trace.go:171","msg":"trace[1983482223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1291; }","duration":"345.148441ms","start":"2026-04-03T02:26:22.162507Z","end":"2026-04-03T02:26:22.507656Z","steps":["trace[1983482223] 'agreement among raft nodes before linearized reading' (duration: 344.930866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.507709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.162485Z","time spent":"345.216593ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-03T02:26:22.764824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.212595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:26:22.765032Z","caller":"traceutil/trace.go:171","msg":"trace[1488978264] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1344; }","duration":"257.773851ms","start":"2026-04-03T02:26:22.507244Z","end":"2026-04-03T02:26:22.765018Z","steps":["trace[1488978264] 'read index received' (duration: 153.3231ms)","trace[1488978264] 'applied index is now lower than readState.Index' (duration: 104.449801ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:22.765096Z","caller":"traceutil/trace.go:171","msg":"trace[1379040434] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"279.64228ms","start":"2026-04-03T02:26:22.485447Z","end":"2026-04-03T02:26:22.76509Z","steps":["trace[1379040434] 'process raft request' (duration: 175.104917ms)","trace[1379040434] 'compare' (duration: 104.127503ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:22.76529Z","caller":"traceutil/trace.go:171","msg":"trace[1301102105] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"275.695602ms","start":"2026-04-03T02:26:22.489589Z","end":"2026-04-03T02:26:22.765285Z","steps":["trace[1301102105] 'process raft request' (duration: 275.392536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.765428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.309838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:22.765525Z","caller":"traceutil/trace.go:171","msg":"trace[29816635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1293; }","duration":"281.480211ms","start":"2026-04-03T02:26:22.484023Z","end":"2026-04-03T02:26:22.765504Z","steps":["trace[29816635] 'agreement among raft nodes before linearized reading' (duration: 281.285827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.7656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.460671ms","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-04-03T02:26:22.765669Z","caller":"traceutil/trace.go:171","msg":"trace[268030872] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1293; }","duration":"277.581153ms","start":"2026-04-03T02:26:22.488074Z","end":"2026-04-03T02:26:22.765655Z","steps":["trace[268030872] 'agreement among raft nodes before linearized reading' (duration: 277.379319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.991135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.019691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:26:22.991554Z","caller":"traceutil/trace.go:171","msg":"trace[1068298993] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"357.894184ms","start":"2026-04-03T02:26:22.633643Z","end":"2026-04-03T02:26:22.991537Z","steps":["trace[1068298993] 'process raft request' (duration: 357.584597ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:22.991621Z","caller":"traceutil/trace.go:171","msg":"trace[453999956] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"479.075919ms","start":"2026-04-03T02:26:22.512485Z","end":"2026-04-03T02:26:22.991561Z","steps":["trace[453999956] 'process raft request' (duration: 352.542486ms)","trace[453999956] 'compare' (duration: 125.773716ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:22.991761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.633622Z","time spent":"357.984647ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:26:22.991815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.512465Z","time spent":"479.247733ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:22.991787Z","caller":"traceutil/trace.go:171","msg":"trace[2120840398] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1346; }","duration":"226.650886ms","start":"2026-04-03T02:26:22.765065Z","end":"2026-04-03T02:26:22.991716Z","steps":["trace[2120840398] 'read index received' (duration: 100.070052ms)","trace[2120840398] 'applied index is now lower than readState.Index' (duration: 126.571674ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:22.991821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.27074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:22.991343Z","caller":"traceutil/trace.go:171","msg":"trace[1574042736] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"200.603534ms","start":"2026-04-03T02:26:22.790722Z","end":"2026-04-03T02:26:22.991325Z","steps":["trace[1574042736] 'process raft request' (duration: 200.565544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.991909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.472381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:26:22.991933Z","caller":"traceutil/trace.go:171","msg":"trace[2051140748] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1296; }","duration":"227.471515ms","start":"2026-04-03T02:26:22.764429Z","end":"2026-04-03T02:26:22.991901Z","steps":["trace[2051140748] 'agreement among raft nodes before linearized reading' (duration: 227.28871ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:22.991972Z","caller":"traceutil/trace.go:171","msg":"trace[277578908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1296; }","duration":"394.560223ms","start":"2026-04-03T02:26:22.597402Z","end":"2026-04-03T02:26:22.991963Z","steps":["trace[277578908] 'agreement among raft nodes before linearized reading' (duration: 394.323157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.992026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.59739Z","time spent":"394.602974ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:26:22.992102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.273776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:22.992158Z","caller":"traceutil/trace.go:171","msg":"trace[836832575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1296; }","duration":"221.340688ms","start":"2026-04-03T02:26:22.770803Z","end":"2026-04-03T02:26:22.992144Z","steps":["trace[836832575] 'agreement among raft nodes before linearized reading' (duration: 221.255607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.992298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.774078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-03T02:26:22.992309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.811221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-03T02:26:22.992343Z","caller":"traceutil/trace.go:171","msg":"trace[1252562526] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1296; }","duration":"160.840089ms","start":"2026-04-03T02:26:22.831491Z","end":"2026-04-03T02:26:22.992331Z","steps":["trace[1252562526] 'agreement among raft nodes before linearized reading' (duration: 160.712556ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:22.992364Z","caller":"traceutil/trace.go:171","msg":"trace[1366589616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1296; }","duration":"395.974045ms","start":"2026-04-03T02:26:22.596377Z","end":"2026-04-03T02:26:22.992351Z","steps":["trace[1366589616] 'agreement among raft nodes before linearized reading' (duration: 395.587957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:22.99241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.596353Z","time spent":"396.048407ms","remote":"127.0.0.1:48490","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-04-03T02:26:23.425026Z","caller":"traceutil/trace.go:171","msg":"trace[271293376] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"428.413878ms","start":"2026-04-03T02:26:22.996582Z","end":"2026-04-03T02:26:23.424995Z","steps":["trace[271293376] 'process raft request' (duration: 428.167503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:23.4253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.99655Z","time spent":"428.606293ms","remote":"127.0.0.1:48490","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-04-03T02:26:23.996125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.491825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:26:23.996352Z","caller":"traceutil/trace.go:171","msg":"trace[196460543] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"998.738512ms","start":"2026-04-03T02:26:22.997582Z","end":"2026-04-03T02:26:23.996321Z","steps":["trace[196460543] 'process raft request' (duration: 662.727395ms)","trace[196460543] 'compare' (duration: 335.337122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:23.996506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.997565Z","time spent":"998.859255ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:23.997172Z","caller":"traceutil/trace.go:171","msg":"trace[335205192] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1349; }","duration":"686.24126ms","start":"2026-04-03T02:26:23.310915Z","end":"2026-04-03T02:26:23.997156Z","steps":["trace[335205192] 'read index received' (duration: 113.86759ms)","trace[335205192] 'applied index is now lower than readState.Index' (duration: 572.37217ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:23.997236Z","caller":"traceutil/trace.go:171","msg":"trace[1649674203] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"999.272334ms","start":"2026-04-03T02:26:22.997931Z","end":"2026-04-03T02:26:23.997204Z","steps":["trace[1649674203] 'process raft request' (duration: 999.0517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:23.997306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.375603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-03T02:26:23.997366Z","caller":"traceutil/trace.go:171","msg":"trace[204294678] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1300; }","duration":"686.467376ms","start":"2026-04-03T02:26:23.310884Z","end":"2026-04-03T02:26:23.997351Z","steps":["trace[204294678] 'agreement among raft nodes before linearized reading' (duration: 686.352613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:23.997406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.997922Z","time spent":"999.395457ms","remote":"127.0.0.1:48490","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-04-03T02:26:23.997418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:23.310869Z","time spent":"686.534027ms","remote":"127.0.0.1:48532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":17,"response size":29,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-04-03T02:26:23.997435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.040394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:23.997469Z","caller":"traceutil/trace.go:171","msg":"trace[737310146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1300; }","duration":"374.111456ms","start":"2026-04-03T02:26:23.623347Z","end":"2026-04-03T02:26:23.997459Z","steps":["trace[737310146] 'agreement among raft nodes before linearized reading' (duration: 374.057485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:23.997467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.047455ms","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":"warn","ts":"2026-04-03T02:26:23.997499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:23.623327Z","time spent":"374.167268ms","remote":"127.0.0.1:48286","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-04-03T02:26:23.997513Z","caller":"traceutil/trace.go:171","msg":"trace[261627027] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1300; }","duration":"348.129807ms","start":"2026-04-03T02:26:23.649368Z","end":"2026-04-03T02:26:23.997498Z","steps":["trace[261627027] 'agreement among raft nodes before linearized reading' (duration: 348.053785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:23.997558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:23.649351Z","time spent":"348.197099ms","remote":"127.0.0.1:37850","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":"info","ts":"2026-04-03T02:26:23.997077Z","caller":"traceutil/trace.go:171","msg":"trace[1445343315] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"999.190522ms","start":"2026-04-03T02:26:22.997867Z","end":"2026-04-03T02:26:23.997058Z","steps":["trace[1445343315] 'process raft request' (duration: 998.360504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:23.997865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:22.997857Z","time spent":"999.965ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:26:28.697638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.399648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:26:28.697825Z","caller":"traceutil/trace.go:171","msg":"trace[1332807172] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"680.188215ms","start":"2026-04-03T02:26:28.017617Z","end":"2026-04-03T02:26:28.697805Z","steps":["trace[1332807172] 'process raft request' (duration: 680.111803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:28.697902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:28.017607Z","time spent":"680.259736ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:28.698184Z","caller":"traceutil/trace.go:171","msg":"trace[2070605139] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"680.86716ms","start":"2026-04-03T02:26:28.017275Z","end":"2026-04-03T02:26:28.698142Z","steps":["trace[2070605139] 'process raft request' (duration: 112.874209ms)","trace[2070605139] 'compare' (duration: 567.271435ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:28.698379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:28.017263Z","time spent":"680.997704ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:26:29.688776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.466548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:26:29.688941Z","caller":"traceutil/trace.go:171","msg":"trace[69198363] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"597.438789ms","start":"2026-04-03T02:26:29.091488Z","end":"2026-04-03T02:26:29.688927Z","steps":["trace[69198363] 'process raft request' (duration: 597.366627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:29.688994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:29.091465Z","time spent":"597.49721ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:29.689036Z","caller":"traceutil/trace.go:171","msg":"trace[1301464570] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"782.1745ms","start":"2026-04-03T02:26:28.906821Z","end":"2026-04-03T02:26:29.688995Z","steps":["trace[1301464570] 'process raft request' (duration: 375.427026ms)","trace[1301464570] 'compare' (duration: 406.030179ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:29.689182Z","caller":"traceutil/trace.go:171","msg":"trace[629741344] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1377; }","duration":"760.168379ms","start":"2026-04-03T02:26:28.929005Z","end":"2026-04-03T02:26:29.689174Z","steps":["trace[629741344] 'read index received' (duration: 353.337193ms)","trace[629741344] 'applied index is now lower than readState.Index' (duration: 406.829806ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:29.689241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:28.906798Z","time spent":"782.364455ms","remote":"127.0.0.1:48334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:26:29.689365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.355093ms","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-04-03T02:26:29.689389Z","caller":"traceutil/trace.go:171","msg":"trace[1652925160] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1325; }","duration":"760.412985ms","start":"2026-04-03T02:26:28.928967Z","end":"2026-04-03T02:26:29.68938Z","steps":["trace[1652925160] 'agreement among raft nodes before linearized reading' (duration: 760.372134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:29.689413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:28.928945Z","time spent":"760.462226ms","remote":"127.0.0.1:37784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-03T02:26:29.68948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.169524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:26:29.689564Z","caller":"traceutil/trace.go:171","msg":"trace[1167681278] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1325; }","duration":"693.267166ms","start":"2026-04-03T02:26:28.996274Z","end":"2026-04-03T02:26:29.689541Z","steps":["trace[1167681278] 'agreement among raft nodes before linearized reading' (duration: 693.125263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:29.689607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.577615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-03T02:26:29.689617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:28.996209Z","time spent":"693.39588ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-03T02:26:29.689656Z","caller":"traceutil/trace.go:171","msg":"trace[1178682397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1325; }","duration":"153.670938ms","start":"2026-04-03T02:26:29.535972Z","end":"2026-04-03T02:26:29.689643Z","steps":["trace[1178682397] 'agreement among raft nodes before linearized reading' (duration: 153.509654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:29.689674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.401838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-03T02:26:29.689717Z","caller":"traceutil/trace.go:171","msg":"trace[1056577504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1325; }","duration":"584.468489ms","start":"2026-04-03T02:26:29.105235Z","end":"2026-04-03T02:26:29.689704Z","steps":["trace[1056577504] 'agreement among raft nodes before linearized reading' (duration: 584.336726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:29.689753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:29.105224Z","time spent":"584.520501ms","remote":"127.0.0.1:48490","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-04-03T02:26:30.580961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.419496ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:26:30.581072Z","caller":"traceutil/trace.go:171","msg":"trace[1578171844] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"885.187339ms","start":"2026-04-03T02:26:29.695853Z","end":"2026-04-03T02:26:30.58104Z","steps":["trace[1578171844] 'process raft request' (duration: 492.61156ms)","trace[1578171844] 'compare' (duration: 392.307924ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:26:30.581161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:29.69579Z","time spent":"885.348483ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:26:30.605721Z","caller":"traceutil/trace.go:171","msg":"trace[1871982590] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1379; }","duration":"563.727667ms","start":"2026-04-03T02:26:30.041964Z","end":"2026-04-03T02:26:30.605692Z","steps":["trace[1871982590] 'read index received' (duration: 146.569099ms)","trace[1871982590] 'applied index is now lower than readState.Index' (duration: 417.157638ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:30.605872Z","caller":"traceutil/trace.go:171","msg":"trace[1213972580] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"905.515623ms","start":"2026-04-03T02:26:29.700322Z","end":"2026-04-03T02:26:30.605837Z","steps":["trace[1213972580] 'process raft request' (duration: 905.330189ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:30.605799Z","caller":"traceutil/trace.go:171","msg":"trace[860306733] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"906.155187ms","start":"2026-04-03T02:26:29.699598Z","end":"2026-04-03T02:26:30.605753Z","steps":["trace[860306733] 'process raft request' (duration: 905.988243ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:30.605763Z","caller":"traceutil/trace.go:171","msg":"trace[1342930505] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"906.259569ms","start":"2026-04-03T02:26:29.699457Z","end":"2026-04-03T02:26:30.605717Z","steps":["trace[1342930505] 'process raft request' (duration: 905.977253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:30.606039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:29.699437Z","time spent":"906.582877ms","remote":"127.0.0.1:48334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:26:30.606044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.061376ms","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-04-03T02:26:30.606098Z","caller":"traceutil/trace.go:171","msg":"trace[1173101692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1329; }","duration":"564.177117ms","start":"2026-04-03T02:26:30.04191Z","end":"2026-04-03T02:26:30.606087Z","steps":["trace[1173101692] 'agreement among raft nodes before linearized reading' (duration: 563.937661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:30.606148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:30.041889Z","time spent":"564.25076ms","remote":"127.0.0.1:48490","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-04-03T02:26:30.60619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:29.69959Z","time spent":"906.431574ms","remote":"127.0.0.1:48490","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-04-03T02:26:30.60598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:29.700316Z","time spent":"905.605435ms","remote":"127.0.0.1:48490","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-04-03T02:26:30.606607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.716344ms","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":"info","ts":"2026-04-03T02:26:30.606702Z","caller":"traceutil/trace.go:171","msg":"trace[1258562488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1330; }","duration":"276.874318ms","start":"2026-04-03T02:26:30.32981Z","end":"2026-04-03T02:26:30.606684Z","steps":["trace[1258562488] 'agreement among raft nodes before linearized reading' (duration: 276.588791ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:33.099471Z","caller":"traceutil/trace.go:171","msg":"trace[1850997968] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"336.466858ms","start":"2026-04-03T02:26:32.762955Z","end":"2026-04-03T02:26:33.099422Z","steps":["trace[1850997968] 'process raft request' (duration: 336.299484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:26:33.099636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:26:32.762926Z","time spent":"336.620511ms","remote":"127.0.0.1:48418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13706,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:26:33.104433Z","caller":"traceutil/trace.go:171","msg":"trace[403415224] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"217.41074ms","start":"2026-04-03T02:26:32.88699Z","end":"2026-04-03T02:26:33.1044Z","steps":["trace[403415224] 'process raft request' (duration: 215.698842ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:26:52.959995Z","caller":"traceutil/trace.go:171","msg":"trace[590913294] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"169.611795ms","start":"2026-04-03T02:26:52.790345Z","end":"2026-04-03T02:26:52.959956Z","steps":["trace[590913294] 'process raft request' (duration: 98.10797ms)","trace[590913294] 'compare' (duration: 71.324422ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:26:53.408446Z","caller":"traceutil/trace.go:171","msg":"trace[1188508521] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"119.405965ms","start":"2026-04-03T02:26:53.288966Z","end":"2026-04-03T02:26:53.408372Z","steps":["trace[1188508521] 'process raft request' (duration: 93.876465ms)","trace[1188508521] 'compare' (duration: 25.252484ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:27:14.235909Z","caller":"traceutil/trace.go:171","msg":"trace[809414819] transaction","detail":"{read_only:false; response_revision:1549; number_of_response:1; }","duration":"149.082918ms","start":"2026-04-03T02:27:14.086806Z","end":"2026-04-03T02:27:14.235889Z","steps":["trace[809414819] 'process raft request' (duration: 82.424729ms)","trace[809414819] 'compare' (duration: 66.456864ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:27:14.730078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.306083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:27:14.730137Z","caller":"traceutil/trace.go:171","msg":"trace[13387374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1550; }","duration":"106.410775ms","start":"2026-04-03T02:27:14.623713Z","end":"2026-04-03T02:27:14.730124Z","steps":["trace[13387374] 'range keys from in-memory index tree' (duration: 106.221372ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:27:27.649082Z","caller":"traceutil/trace.go:171","msg":"trace[1718115122] linearizableReadLoop","detail":"{readStateIndex:1677; appliedIndex:1675; }","duration":"149.950957ms","start":"2026-04-03T02:27:27.499112Z","end":"2026-04-03T02:27:27.649062Z","steps":["trace[1718115122] 'read index received' (duration: 80.573638ms)","trace[1718115122] 'applied index is now lower than readState.Index' (duration: 69.376119ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:27:27.649519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.360656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-03T02:27:27.649638Z","caller":"traceutil/trace.go:171","msg":"trace[1871020602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1611; }","duration":"150.54956ms","start":"2026-04-03T02:27:27.499066Z","end":"2026-04-03T02:27:27.649616Z","steps":["trace[1871020602] 'agreement among raft nodes before linearized reading' (duration: 150.241203ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:27:27.649297Z","caller":"traceutil/trace.go:171","msg":"trace[1844123609] transaction","detail":"{read_only:false; response_revision:1611; number_of_response:1; }","duration":"162.237201ms","start":"2026-04-03T02:27:27.487033Z","end":"2026-04-03T02:27:27.64927Z","steps":["trace[1844123609] 'process raft request' (duration: 127.027856ms)","trace[1844123609] 'compare' (duration: 34.752795ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:27:27.829229Z","caller":"traceutil/trace.go:171","msg":"trace[1689083165] transaction","detail":"{read_only:false; response_revision:1612; number_of_response:1; }","duration":"174.870733ms","start":"2026-04-03T02:27:27.654325Z","end":"2026-04-03T02:27:27.829196Z","steps":["trace[1689083165] 'process raft request' (duration: 95.735437ms)","trace[1689083165] 'compare' (duration: 78.990033ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:27:54.162987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.989236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-03T02:27:54.163116Z","caller":"traceutil/trace.go:171","msg":"trace[1787380311] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1730; }","duration":"151.188752ms","start":"2026-04-03T02:27:54.011901Z","end":"2026-04-03T02:27:54.16309Z","steps":["trace[1787380311] 'range keys from in-memory index tree' (duration: 150.756622ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:28:26.012027Z","caller":"traceutil/trace.go:171","msg":"trace[205749820] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1951; }","duration":"142.663042ms","start":"2026-04-03T02:28:25.86934Z","end":"2026-04-03T02:28:26.012003Z","steps":["trace[205749820] 'read index received' (duration: 142.454607ms)","trace[205749820] 'applied index is now lower than readState.Index' (duration: 207.425µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:28:26.012092Z","caller":"traceutil/trace.go:171","msg":"trace[348420584] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"156.137123ms","start":"2026-04-03T02:28:25.855917Z","end":"2026-04-03T02:28:26.012054Z","steps":["trace[348420584] 'process raft request' (duration: 155.938818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:26.012231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.871856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-03T02:28:26.012268Z","caller":"traceutil/trace.go:171","msg":"trace[757658659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1874; }","duration":"142.954398ms","start":"2026-04-03T02:28:25.869302Z","end":"2026-04-03T02:28:26.012256Z","steps":["trace[757658659] 'agreement among raft nodes before linearized reading' (duration: 142.807495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:44.914614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.513086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-03T02:28:44.914699Z","caller":"traceutil/trace.go:171","msg":"trace[275446187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1959; }","duration":"350.640279ms","start":"2026-04-03T02:28:44.564041Z","end":"2026-04-03T02:28:44.914681Z","steps":["trace[275446187] 'range keys from in-memory index tree' (duration: 350.365333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:44.914748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:28:44.564024Z","time spent":"350.71505ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:28:44.914943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.519208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-03T02:28:44.915072Z","caller":"traceutil/trace.go:171","msg":"trace[888252197] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1959; }","duration":"303.673712ms","start":"2026-04-03T02:28:44.611363Z","end":"2026-04-03T02:28:44.915037Z","steps":["trace[888252197] 'range keys from in-memory index tree' (duration: 303.275042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:44.915134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:28:44.611348Z","time spent":"303.772105ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-03T02:28:44.915273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.690291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-03T02:28:44.915307Z","caller":"traceutil/trace.go:171","msg":"trace[564813228] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1959; }","duration":"598.771503ms","start":"2026-04-03T02:28:44.316526Z","end":"2026-04-03T02:28:44.915297Z","steps":["trace[564813228] 'range keys from in-memory index tree' (duration: 598.539337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:44.915334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:28:44.316509Z","time spent":"598.818753ms","remote":"127.0.0.1:48490","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-04-03T02:28:45.135838Z","caller":"traceutil/trace.go:171","msg":"trace[217686990] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"223.888493ms","start":"2026-04-03T02:28:44.911911Z","end":"2026-04-03T02:28:45.1358Z","steps":["trace[217686990] 'process raft request' (duration: 223.522005ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:28:45.141462Z","caller":"traceutil/trace.go:171","msg":"trace[130069290] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"222.677754ms","start":"2026-04-03T02:28:44.918768Z","end":"2026-04-03T02:28:45.141445Z","steps":["trace[130069290] 'process raft request' (duration: 222.638014ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:28:45.141743Z","caller":"traceutil/trace.go:171","msg":"trace[1503650501] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"223.624096ms","start":"2026-04-03T02:28:44.918107Z","end":"2026-04-03T02:28:45.141731Z","steps":["trace[1503650501] 'process raft request' (duration: 223.194586ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:28:45.141962Z","caller":"traceutil/trace.go:171","msg":"trace[1316500989] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"223.452143ms","start":"2026-04-03T02:28:44.918464Z","end":"2026-04-03T02:28:45.141917Z","steps":["trace[1316500989] 'process raft request' (duration: 222.90909ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:28:46.509183Z","caller":"traceutil/trace.go:171","msg":"trace[723921412] linearizableReadLoop","detail":"{readStateIndex:2049; appliedIndex:2048; }","duration":"262.166006ms","start":"2026-04-03T02:28:46.246987Z","end":"2026-04-03T02:28:46.509153Z","steps":["trace[723921412] 'read index received' (duration: 261.881869ms)","trace[723921412] 'applied index is now lower than readState.Index' (duration: 282.967µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:28:46.509209Z","caller":"traceutil/trace.go:171","msg":"trace[1805066497] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"350.195538ms","start":"2026-04-03T02:28:46.158985Z","end":"2026-04-03T02:28:46.50918Z","steps":["trace[1805066497] 'process raft request' (duration: 349.983083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:46.509372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.372281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-03T02:28:46.509404Z","caller":"traceutil/trace.go:171","msg":"trace[1343726503] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1967; }","duration":"262.456513ms","start":"2026-04-03T02:28:46.246942Z","end":"2026-04-03T02:28:46.509398Z","steps":["trace[1343726503] 'agreement among raft nodes before linearized reading' (duration: 262.31406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:46.509431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:28:46.158968Z","time spent":"350.372063ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:28:46.509638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.177316ms","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-04-03T02:28:46.509754Z","caller":"traceutil/trace.go:171","msg":"trace[272390789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1967; }","duration":"249.316289ms","start":"2026-04-03T02:28:46.260417Z","end":"2026-04-03T02:28:46.509733Z","steps":["trace[272390789] 'agreement among raft nodes before linearized reading' (duration: 249.074494ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:28:53.393223Z","caller":"traceutil/trace.go:171","msg":"trace[1767338604] linearizableReadLoop","detail":"{readStateIndex:2081; appliedIndex:2080; }","duration":"124.777603ms","start":"2026-04-03T02:28:53.26843Z","end":"2026-04-03T02:28:53.393208Z","steps":["trace[1767338604] 'read index received' (duration: 124.626019ms)","trace[1767338604] 'applied index is now lower than readState.Index' (duration: 151.183µs)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:28:53.393527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.807272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-03T02:28:53.393555Z","caller":"traceutil/trace.go:171","msg":"trace[1996394370] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1998; }","duration":"124.860304ms","start":"2026-04-03T02:28:53.268688Z","end":"2026-04-03T02:28:53.393548Z","steps":["trace[1996394370] 'agreement among raft nodes before linearized reading' (duration: 124.752952ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:28:53.393676Z","caller":"traceutil/trace.go:171","msg":"trace[2127263595] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"190.076308ms","start":"2026-04-03T02:28:53.203578Z","end":"2026-04-03T02:28:53.393654Z","steps":["trace[2127263595] 'process raft request' (duration: 189.544747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:53.393804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.373945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:28:53.393824Z","caller":"traceutil/trace.go:171","msg":"trace[688570159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1998; }","duration":"125.433117ms","start":"2026-04-03T02:28:53.268387Z","end":"2026-04-03T02:28:53.39382Z","steps":["trace[688570159] 'agreement among raft nodes before linearized reading' (duration: 125.332215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:28:53.393984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.18625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-03T02:28:53.394003Z","caller":"traceutil/trace.go:171","msg":"trace[476434324] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1998; }","duration":"125.232002ms","start":"2026-04-03T02:28:53.268767Z","end":"2026-04-03T02:28:53.393999Z","steps":["trace[476434324] 'agreement among raft nodes before linearized reading' (duration: 125.186461ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:01.635908Z","caller":"traceutil/trace.go:171","msg":"trace[241161368] linearizableReadLoop","detail":"{readStateIndex:2119; appliedIndex:2118; }","duration":"200.135878ms","start":"2026-04-03T02:29:01.435749Z","end":"2026-04-03T02:29:01.635885Z","steps":["trace[241161368] 'read index received' (duration: 199.806771ms)","trace[241161368] 'applied index is now lower than readState.Index' (duration: 327.797µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:29:01.63597Z","caller":"traceutil/trace.go:171","msg":"trace[1500324296] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"214.62576ms","start":"2026-04-03T02:29:01.42131Z","end":"2026-04-03T02:29:01.635936Z","steps":["trace[1500324296] 'process raft request' (duration: 214.405906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:01.636422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.023115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-04-03T02:29:01.636469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.212493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-03T02:29:01.636516Z","caller":"traceutil/trace.go:171","msg":"trace[98241486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2034; }","duration":"192.311375ms","start":"2026-04-03T02:29:01.444191Z","end":"2026-04-03T02:29:01.636503Z","steps":["trace[98241486] 'agreement among raft nodes before linearized reading' (duration: 192.13213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:01.636575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.746514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-03T02:29:01.636644Z","caller":"traceutil/trace.go:171","msg":"trace[143022115] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2034; }","duration":"192.872227ms","start":"2026-04-03T02:29:01.443756Z","end":"2026-04-03T02:29:01.636628Z","steps":["trace[143022115] 'agreement among raft nodes before linearized reading' (duration: 192.643842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:01.636848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.1039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-03T02:29:01.636938Z","caller":"traceutil/trace.go:171","msg":"trace[547771786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2034; }","duration":"201.225403ms","start":"2026-04-03T02:29:01.4357Z","end":"2026-04-03T02:29:01.636926Z","steps":["trace[547771786] 'agreement among raft nodes before linearized reading' (duration: 200.313112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:01.637022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.754131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-03T02:29:01.637087Z","caller":"traceutil/trace.go:171","msg":"trace[2013742776] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2034; }","duration":"195.897944ms","start":"2026-04-03T02:29:01.441176Z","end":"2026-04-03T02:29:01.637074Z","steps":["trace[2013742776] 'agreement among raft nodes before linearized reading' (duration: 194.934222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:01.637356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.7437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363678"} {"level":"info","ts":"2026-04-03T02:29:01.637486Z","caller":"traceutil/trace.go:171","msg":"trace[514435971] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2034; }","duration":"155.922544ms","start":"2026-04-03T02:29:01.481531Z","end":"2026-04-03T02:29:01.637453Z","steps":["trace[514435971] 'agreement among raft nodes before linearized reading' (duration: 154.618134ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:01.636496Z","caller":"traceutil/trace.go:171","msg":"trace[1202433153] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2034; }","duration":"103.135068ms","start":"2026-04-03T02:29:01.533339Z","end":"2026-04-03T02:29:01.636474Z","steps":["trace[1202433153] 'agreement among raft nodes before linearized reading' (duration: 102.910402ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:01.899157Z","caller":"traceutil/trace.go:171","msg":"trace[329680996] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"255.603283ms","start":"2026-04-03T02:29:01.643536Z","end":"2026-04-03T02:29:01.899139Z","steps":["trace[329680996] 'process raft request' (duration: 255.575293ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:01.899153Z","caller":"traceutil/trace.go:171","msg":"trace[48899542] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"258.421526ms","start":"2026-04-03T02:29:01.640696Z","end":"2026-04-03T02:29:01.899118Z","steps":["trace[48899542] 'process raft request' (duration: 256.108624ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:01.899189Z","caller":"traceutil/trace.go:171","msg":"trace[1291882339] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"255.796758ms","start":"2026-04-03T02:29:01.643368Z","end":"2026-04-03T02:29:01.899165Z","steps":["trace[1291882339] 'process raft request' (duration: 255.696956ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:01.899233Z","caller":"traceutil/trace.go:171","msg":"trace[874817954] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"255.724206ms","start":"2026-04-03T02:29:01.643501Z","end":"2026-04-03T02:29:01.899225Z","steps":["trace[874817954] 'process raft request' (duration: 255.585653ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:01.899173Z","caller":"traceutil/trace.go:171","msg":"trace[52431513] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"257.831263ms","start":"2026-04-03T02:29:01.641304Z","end":"2026-04-03T02:29:01.899135Z","steps":["trace[52431513] 'process raft request' (duration: 257.735431ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:02.705799Z","caller":"traceutil/trace.go:171","msg":"trace[2079760353] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"108.481836ms","start":"2026-04-03T02:29:02.597286Z","end":"2026-04-03T02:29:02.705767Z","steps":["trace[2079760353] 'process raft request' (duration: 108.284552ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:02.967378Z","caller":"traceutil/trace.go:171","msg":"trace[173849619] linearizableReadLoop","detail":"{readStateIndex:2127; appliedIndex:2126; }","duration":"233.660756ms","start":"2026-04-03T02:29:02.733685Z","end":"2026-04-03T02:29:02.967346Z","steps":["trace[173849619] 'read index received' (duration: 171.725156ms)","trace[173849619] 'applied index is now lower than readState.Index' (duration: 61.93408ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:29:02.967548Z","caller":"traceutil/trace.go:171","msg":"trace[1252765993] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"369.778987ms","start":"2026-04-03T02:29:02.597754Z","end":"2026-04-03T02:29:02.967533Z","steps":["trace[1252765993] 'process raft request' (duration: 307.690424ms)","trace[1252765993] 'compare' (duration: 61.756125ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:29:02.967695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:29:02.597735Z","time spent":"369.849829ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:29:02.967696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.998893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-03T02:29:02.967771Z","caller":"traceutil/trace.go:171","msg":"trace[1677679874] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2042; }","duration":"234.135106ms","start":"2026-04-03T02:29:02.733613Z","end":"2026-04-03T02:29:02.967748Z","steps":["trace[1677679874] 'agreement among raft nodes before linearized reading' (duration: 233.918042ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:38.245397Z","caller":"traceutil/trace.go:171","msg":"trace[2087258290] linearizableReadLoop","detail":"{readStateIndex:2315; appliedIndex:2314; }","duration":"164.992226ms","start":"2026-04-03T02:29:38.080384Z","end":"2026-04-03T02:29:38.245376Z","steps":["trace[2087258290] 'read index received' (duration: 162.257285ms)","trace[2087258290] 'applied index is now lower than readState.Index' (duration: 2.733841ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:29:38.24554Z","caller":"traceutil/trace.go:171","msg":"trace[2110035567] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"166.275664ms","start":"2026-04-03T02:29:38.079228Z","end":"2026-04-03T02:29:38.245503Z","steps":["trace[2110035567] 'process raft request' (duration: 163.465162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:38.245904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.512137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:29:38.245956Z","caller":"traceutil/trace.go:171","msg":"trace[1290782666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2222; }","duration":"165.602439ms","start":"2026-04-03T02:29:38.080342Z","end":"2026-04-03T02:29:38.245944Z","steps":["trace[1290782666] 'agreement among raft nodes before linearized reading' (duration: 165.156469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:38.245667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.790709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-03T02:29:38.246025Z","caller":"traceutil/trace.go:171","msg":"trace[1610231616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2222; }","duration":"160.189288ms","start":"2026-04-03T02:29:38.08583Z","end":"2026-04-03T02:29:38.24602Z","steps":["trace[1610231616] 'agreement among raft nodes before linearized reading' (duration: 159.703077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:38.245834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.839689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-03T02:29:38.246077Z","caller":"traceutil/trace.go:171","msg":"trace[1804055783] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2222; }","duration":"159.153926ms","start":"2026-04-03T02:29:38.086916Z","end":"2026-04-03T02:29:38.24607Z","steps":["trace[1804055783] 'agreement among raft nodes before linearized reading' (duration: 158.717306ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:38.383543Z","caller":"traceutil/trace.go:171","msg":"trace[1041622831] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"132.418769ms","start":"2026-04-03T02:29:38.251084Z","end":"2026-04-03T02:29:38.383502Z","steps":["trace[1041622831] 'process raft request' (duration: 132.203774ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:38.383352Z","caller":"traceutil/trace.go:171","msg":"trace[1477173860] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"132.685305ms","start":"2026-04-03T02:29:38.250642Z","end":"2026-04-03T02:29:38.383327Z","steps":["trace[1477173860] 'process raft request' (duration: 132.44018ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:29:57.59594Z","caller":"traceutil/trace.go:171","msg":"trace[1254637147] linearizableReadLoop","detail":"{readStateIndex:2417; appliedIndex:2416; }","duration":"353.691619ms","start":"2026-04-03T02:29:57.242226Z","end":"2026-04-03T02:29:57.595917Z","steps":["trace[1254637147] 'read index received' (duration: 353.452504ms)","trace[1254637147] 'applied index is now lower than readState.Index' (duration: 238.205µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:29:57.596101Z","caller":"traceutil/trace.go:171","msg":"trace[248933811] transaction","detail":"{read_only:false; response_revision:2320; number_of_response:1; }","duration":"392.431511ms","start":"2026-04-03T02:29:57.203639Z","end":"2026-04-03T02:29:57.596071Z","steps":["trace[248933811] 'process raft request' (duration: 392.091134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:57.596238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:29:57.203612Z","time spent":"392.544124ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:29:57.596258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.029526ms","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-04-03T02:29:57.596304Z","caller":"traceutil/trace.go:171","msg":"trace[839083955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2320; }","duration":"354.121808ms","start":"2026-04-03T02:29:57.242167Z","end":"2026-04-03T02:29:57.596288Z","steps":["trace[839083955] 'agreement among raft nodes before linearized reading' (duration: 353.846152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:29:57.596341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:29:57.242146Z","time spent":"354.18738ms","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-03T02:30:26.579789Z","caller":"traceutil/trace.go:171","msg":"trace[472146877] transaction","detail":"{read_only:false; response_revision:2459; number_of_response:1; }","duration":"103.262136ms","start":"2026-04-03T02:30:26.47651Z","end":"2026-04-03T02:30:26.579772Z","steps":["trace[472146877] 'process raft request' (duration: 51.393452ms)","trace[472146877] 'compare' (duration: 51.536526ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:30:26.770664Z","caller":"traceutil/trace.go:171","msg":"trace[1420277480] transaction","detail":"{read_only:false; response_revision:2461; number_of_response:1; }","duration":"143.02081ms","start":"2026-04-03T02:30:26.627614Z","end":"2026-04-03T02:30:26.770634Z","steps":["trace[1420277480] 'process raft request' (duration: 113.80153ms)","trace[1420277480] 'compare' (duration: 29.090877ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:30:27.205184Z","caller":"traceutil/trace.go:171","msg":"trace[547768832] linearizableReadLoop","detail":"{readStateIndex:2565; appliedIndex:2564; }","duration":"108.910181ms","start":"2026-04-03T02:30:27.09626Z","end":"2026-04-03T02:30:27.20517Z","steps":["trace[547768832] 'read index received' (duration: 108.802179ms)","trace[547768832] 'applied index is now lower than readState.Index' (duration: 107.402µs)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:30:27.205309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.034314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-03T02:30:27.205331Z","caller":"traceutil/trace.go:171","msg":"trace[2062096925] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:2462; }","duration":"109.091316ms","start":"2026-04-03T02:30:27.096232Z","end":"2026-04-03T02:30:27.205323Z","steps":["trace[2062096925] 'agreement among raft nodes before linearized reading' (duration: 109.015684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:30:27.205389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.719134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-03T02:30:27.205449Z","caller":"traceutil/trace.go:171","msg":"trace[648985364] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:1; response_revision:2462; }","duration":"102.797816ms","start":"2026-04-03T02:30:27.102637Z","end":"2026-04-03T02:30:27.205435Z","steps":["trace[648985364] 'agreement among raft nodes before linearized reading' (duration: 102.636902ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:30:27.205502Z","caller":"traceutil/trace.go:171","msg":"trace[735373969] transaction","detail":"{read_only:false; response_revision:2462; number_of_response:1; }","duration":"119.978427ms","start":"2026-04-03T02:30:27.085419Z","end":"2026-04-03T02:30:27.205397Z","steps":["trace[735373969] 'process raft request' (duration: 119.64017ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:30:27.910465Z","caller":"traceutil/trace.go:171","msg":"trace[1430599720] linearizableReadLoop","detail":"{readStateIndex:2569; appliedIndex:2568; }","duration":"118.011544ms","start":"2026-04-03T02:30:27.792429Z","end":"2026-04-03T02:30:27.910441Z","steps":["trace[1430599720] 'read index received' (duration: 117.84313ms)","trace[1430599720] 'applied index is now lower than readState.Index' (duration: 167.324µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:30:27.910506Z","caller":"traceutil/trace.go:171","msg":"trace[1303733627] transaction","detail":"{read_only:false; response_revision:2466; number_of_response:1; }","duration":"133.692763ms","start":"2026-04-03T02:30:27.776787Z","end":"2026-04-03T02:30:27.91048Z","steps":["trace[1303733627] 'process raft request' (duration: 133.486208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:30:27.910655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.212949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-03T02:30:27.910692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.951719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pvc-protection-controller\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-04-03T02:30:27.910701Z","caller":"traceutil/trace.go:171","msg":"trace[1132525310] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:2466; }","duration":"118.307611ms","start":"2026-04-03T02:30:27.792382Z","end":"2026-04-03T02:30:27.910689Z","steps":["trace[1132525310] 'agreement among raft nodes before linearized reading' (duration: 118.211539ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:30:27.910718Z","caller":"traceutil/trace.go:171","msg":"trace[2114007659] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pvc-protection-controller; range_end:; response_count:1; response_revision:2466; }","duration":"107.00338ms","start":"2026-04-03T02:30:27.803706Z","end":"2026-04-03T02:30:27.91071Z","steps":["trace[2114007659] 'agreement among raft nodes before linearized reading' (duration: 106.928238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:30:27.911204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.357611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-03T02:30:27.911318Z","caller":"traceutil/trace.go:171","msg":"trace[1635019187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2466; }","duration":"118.523315ms","start":"2026-04-03T02:30:27.792767Z","end":"2026-04-03T02:30:27.91129Z","steps":["trace[1635019187] 'agreement among raft nodes before linearized reading' (duration: 117.932672ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:30:28.103363Z","caller":"traceutil/trace.go:171","msg":"trace[969642284] transaction","detail":"{read_only:false; response_revision:2468; number_of_response:1; }","duration":"119.812763ms","start":"2026-04-03T02:30:27.9835Z","end":"2026-04-03T02:30:28.103313Z","steps":["trace[969642284] 'process raft request' (duration: 51.473814ms)","trace[969642284] 'compare' (duration: 68.026802ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:30:28.104318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.488145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:134 size:103272"} {"level":"info","ts":"2026-04-03T02:30:28.104436Z","caller":"traceutil/trace.go:171","msg":"trace[1595512412] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:134; response_revision:2468; }","duration":"100.675868ms","start":"2026-04-03T02:30:28.003736Z","end":"2026-04-03T02:30:28.104412Z","steps":["trace[1595512412] 'agreement among raft nodes before linearized reading' (duration: 99.505482ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:30:28.738329Z","caller":"traceutil/trace.go:171","msg":"trace[1053818646] linearizableReadLoop","detail":"{readStateIndex:2573; appliedIndex:2572; }","duration":"248.75114ms","start":"2026-04-03T02:30:28.489554Z","end":"2026-04-03T02:30:28.738305Z","steps":["trace[1053818646] 'read index received' (duration: 248.626808ms)","trace[1053818646] 'applied index is now lower than readState.Index' (duration: 123.422µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:30:28.738721Z","caller":"traceutil/trace.go:171","msg":"trace[1758761231] transaction","detail":"{read_only:false; response_revision:2470; number_of_response:1; }","duration":"256.165505ms","start":"2026-04-03T02:30:28.48249Z","end":"2026-04-03T02:30:28.738655Z","steps":["trace[1758761231] 'process raft request' (duration: 255.589923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:30:28.73894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.384145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-03T02:30:28.738987Z","caller":"traceutil/trace.go:171","msg":"trace[476301202] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:2470; }","duration":"249.514417ms","start":"2026-04-03T02:30:28.48946Z","end":"2026-04-03T02:30:28.738974Z","steps":["trace[476301202] 'agreement among raft nodes before linearized reading' (duration: 249.422985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:30:28.739158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.05593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-03T02:30:28.739195Z","caller":"traceutil/trace.go:171","msg":"trace[1183826966] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:2470; }","duration":"246.106871ms","start":"2026-04-03T02:30:28.493081Z","end":"2026-04-03T02:30:28.739188Z","steps":["trace[1183826966] 'agreement among raft nodes before linearized reading' (duration: 246.05148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:30:28.739451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.719733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-03T02:30:28.73949Z","caller":"traceutil/trace.go:171","msg":"trace[674034229] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2470; }","duration":"115.814815ms","start":"2026-04-03T02:30:28.623668Z","end":"2026-04-03T02:30:28.739482Z","steps":["trace[674034229] 'agreement among raft nodes before linearized reading' (duration: 115.702732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:30:28.739639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.643982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-03T02:30:28.739671Z","caller":"traceutil/trace.go:171","msg":"trace[133184878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2470; }","duration":"156.731024ms","start":"2026-04-03T02:30:28.582933Z","end":"2026-04-03T02:30:28.739664Z","steps":["trace[133184878] 'agreement among raft nodes before linearized reading' (duration: 156.651122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:30:28.739789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.199674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-03T02:30:28.73982Z","caller":"traceutil/trace.go:171","msg":"trace[1732343969] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2470; }","duration":"210.284305ms","start":"2026-04-03T02:30:28.529529Z","end":"2026-04-03T02:30:28.739814Z","steps":["trace[1732343969] 'agreement among raft nodes before linearized reading' (duration: 210.234444ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:30:29.329787Z","caller":"traceutil/trace.go:171","msg":"trace[1423524620] transaction","detail":"{read_only:false; response_revision:2475; number_of_response:1; }","duration":"107.98795ms","start":"2026-04-03T02:30:29.221767Z","end":"2026-04-03T02:30:29.329755Z","steps":["trace[1423524620] 'process raft request' (duration: 107.759805ms)"],"step_count":1}