{"level":"warn","ts":"2026-04-07T00:12:00.007161Z","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-07T00:12:00.007276Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.81:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.81:2380","--initial-cluster=instance=https://199.19.213.81:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.81:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.81: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-07T00:12:00.007355Z","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-07T00:12:00.007375Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.81:2380"]} {"level":"info","ts":"2026-04-07T00:12:00.007403Z","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-07T00:12:00.008218Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"]} {"level":"info","ts":"2026-04-07T00:12:00.008309Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.81:2380"],"listen-peer-urls":["https://199.19.213.81:2380"],"advertise-client-urls":["https://199.19.213.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.81: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-07T00:12:00.028972Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"20.37548ms"} {"level":"info","ts":"2026-04-07T00:12:00.07527Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1627b0b72e417489","cluster-id":"d42e5eae8a1b814c"} {"level":"info","ts":"2026-04-07T00:12:00.075365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T00:12:00.075388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became follower at term 0"} {"level":"info","ts":"2026-04-07T00:12:00.075402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1627b0b72e417489 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T00:12:00.075414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became follower at term 1"} {"level":"info","ts":"2026-04-07T00:12:00.075451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=(1596438893727675529)"} {"level":"warn","ts":"2026-04-07T00:12:00.086126Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T00:12:00.089436Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T00:12:00.091124Z","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-07T00:12:00.093992Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1627b0b72e417489","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T00:12:00.094253Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1627b0b72e417489","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T00:12:00.094403Z","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-07T00:12:00.094487Z","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-07T00:12:00.094503Z","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-07T00:12:00.096548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=(1596438893727675529)"} {"level":"info","ts":"2026-04-07T00:12:00.096794Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d42e5eae8a1b814c","local-member-id":"1627b0b72e417489","added-peer-id":"1627b0b72e417489","added-peer-peer-urls":["https://199.19.213.81:2380"]} {"level":"info","ts":"2026-04-07T00:12:00.100421Z","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-07T00:12:00.100669Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.81:2380"} {"level":"info","ts":"2026-04-07T00:12:00.10072Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.81:2380"} {"level":"info","ts":"2026-04-07T00:12:00.100709Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1627b0b72e417489","initial-advertise-peer-urls":["https://199.19.213.81:2380"],"listen-peer-urls":["https://199.19.213.81:2380"],"advertise-client-urls":["https://199.19.213.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T00:12:00.100814Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T00:12:00.276303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T00:12:00.276378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T00:12:00.276396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 received MsgPreVoteResp from 1627b0b72e417489 at term 1"} {"level":"info","ts":"2026-04-07T00:12:00.276411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became candidate at term 2"} {"level":"info","ts":"2026-04-07T00:12:00.276418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 received MsgVoteResp from 1627b0b72e417489 at term 2"} {"level":"info","ts":"2026-04-07T00:12:00.27643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became leader at term 2"} {"level":"info","ts":"2026-04-07T00:12:00.27644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1627b0b72e417489 elected leader 1627b0b72e417489 at term 2"} {"level":"info","ts":"2026-04-07T00:12:00.278953Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1627b0b72e417489","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.81:2379]}","request-path":"/0/members/1627b0b72e417489/attributes","cluster-id":"d42e5eae8a1b814c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T00:12:00.279063Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:12:00.279174Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:12:00.279327Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:12:00.279372Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T00:12:00.279653Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T00:12:00.281448Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.81:2379"} {"level":"info","ts":"2026-04-07T00:12:00.281574Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d42e5eae8a1b814c","local-member-id":"1627b0b72e417489","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:12:00.281795Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:12:00.281905Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:12:00.28322Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T00:12:02.092128Z","caller":"traceutil/trace.go:171","msg":"trace[767270672] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"269.897662ms","start":"2026-04-07T00:12:01.822202Z","end":"2026-04-07T00:12:02.092099Z","steps":["trace[767270672] 'process raft request' (duration: 269.710807ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.4088Z","caller":"traceutil/trace.go:171","msg":"trace[681966701] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"585.366669ms","start":"2026-04-07T00:12:01.823412Z","end":"2026-04-07T00:12:02.408779Z","steps":["trace[681966701] 'read index received' (duration: 268.515606ms)","trace[681966701] 'applied index is now lower than readState.Index' (duration: 316.850443ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:02.408986Z","caller":"traceutil/trace.go:171","msg":"trace[1316167200] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"586.634302ms","start":"2026-04-07T00:12:01.822326Z","end":"2026-04-07T00:12:02.408961Z","steps":["trace[1316167200] 'process raft request' (duration: 586.122298ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.409125Z","caller":"traceutil/trace.go:171","msg":"trace[1284986958] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"488.539793ms","start":"2026-04-07T00:12:01.920513Z","end":"2026-04-07T00:12:02.409053Z","steps":["trace[1284986958] 'process raft request' (duration: 488.223825ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.409158Z","caller":"traceutil/trace.go:171","msg":"trace[1540874064] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"488.623365ms","start":"2026-04-07T00:12:01.920506Z","end":"2026-04-07T00:12:02.40913Z","steps":["trace[1540874064] 'process raft request' (duration: 488.250356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.409171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.657824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:12:02.409431Z","caller":"traceutil/trace.go:171","msg":"trace[1418056743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"583.964072ms","start":"2026-04-07T00:12:01.825453Z","end":"2026-04-07T00:12:02.409417Z","steps":["trace[1418056743] 'agreement among raft nodes before linearized reading' (duration: 583.608292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.409464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.825446Z","time spent":"584.007273ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T00:12:02.409547Z","caller":"traceutil/trace.go:171","msg":"trace[223433461] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"502.65664ms","start":"2026-04-07T00:12:01.90686Z","end":"2026-04-07T00:12:02.409517Z","steps":["trace[223433461] 'process raft request' (duration: 501.825188ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.409724Z","caller":"traceutil/trace.go:171","msg":"trace[1038907219] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"503.879972ms","start":"2026-04-07T00:12:01.90582Z","end":"2026-04-07T00:12:02.4097Z","steps":["trace[1038907219] 'process raft request' (duration: 502.816615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.409738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.51128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:12:02.409748Z","caller":"traceutil/trace.go:171","msg":"trace[1492655612] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"502.312981ms","start":"2026-04-07T00:12:01.907414Z","end":"2026-04-07T00:12:02.409727Z","steps":["trace[1492655612] 'process raft request' (duration: 501.303115ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.409771Z","caller":"traceutil/trace.go:171","msg":"trace[1737799936] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"439.596982ms","start":"2026-04-07T00:12:01.970165Z","end":"2026-04-07T00:12:02.409762Z","steps":["trace[1737799936] 'agreement among raft nodes before linearized reading' (duration: 439.54807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.409773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.020589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.81\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:12:02.409782Z","caller":"traceutil/trace.go:171","msg":"trace[1789172631] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"503.41078ms","start":"2026-04-07T00:12:01.906359Z","end":"2026-04-07T00:12:02.40977Z","steps":["trace[1789172631] 'process raft request' (duration: 502.304432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.409813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.151979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T00:12:02.409796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.970135Z","time spent":"439.654303ms","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-07T00:12:02.409835Z","caller":"traceutil/trace.go:171","msg":"trace[1320019792] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"504.188239ms","start":"2026-04-07T00:12:01.905639Z","end":"2026-04-07T00:12:02.409827Z","steps":["trace[1320019792] 'agreement among raft nodes before linearized reading' (duration: 504.151358ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.409807Z","caller":"traceutil/trace.go:171","msg":"trace[1948167678] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"502.941957ms","start":"2026-04-07T00:12:01.906819Z","end":"2026-04-07T00:12:02.409761Z","steps":["trace[1948167678] 'process raft request' (duration: 501.88469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.409847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.014437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T00:12:02.409854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.905631Z","time spent":"504.217861ms","remote":"127.0.0.1:53490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-04-07T00:12:02.409872Z","caller":"traceutil/trace.go:171","msg":"trace[1317809674] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"506.079529ms","start":"2026-04-07T00:12:01.903786Z","end":"2026-04-07T00:12:02.409865Z","steps":["trace[1317809674] 'agreement among raft nodes before linearized reading' (duration: 506.042238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.409897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.903773Z","time spent":"506.1175ms","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-07T00:12:02.409838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.218018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:12:02.4088Z","caller":"traceutil/trace.go:171","msg":"trace[1639019835] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"502.969029ms","start":"2026-04-07T00:12:01.905792Z","end":"2026-04-07T00:12:02.408761Z","steps":["trace[1639019835] 'process raft request' (duration: 502.802455ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.410021Z","caller":"traceutil/trace.go:171","msg":"trace[1310359099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"584.427825ms","start":"2026-04-07T00:12:01.825584Z","end":"2026-04-07T00:12:02.410012Z","steps":["trace[1310359099] 'agreement among raft nodes before linearized reading' (duration: 584.227359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.410034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.872649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:12:02.410135Z","caller":"traceutil/trace.go:171","msg":"trace[126952631] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"454.974181ms","start":"2026-04-07T00:12:01.955142Z","end":"2026-04-07T00:12:02.410116Z","steps":["trace[126952631] 'agreement among raft nodes before linearized reading' (duration: 454.752355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.410214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.95512Z","time spent":"455.080683ms","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-07T00:12:02.410053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.825561Z","time spent":"584.483706ms","remote":"127.0.0.1:53690","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":"info","ts":"2026-04-07T00:12:02.409811Z","caller":"traceutil/trace.go:171","msg":"trace[2139014218] range","detail":"{range_begin:/registry/masterleases/199.19.213.81; range_end:; response_count:0; response_revision:11; }","duration":"508.099831ms","start":"2026-04-07T00:12:01.901699Z","end":"2026-04-07T00:12:02.409799Z","steps":["trace[2139014218] 'agreement among raft nodes before linearized reading' (duration: 508.018349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.410369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.901674Z","time spent":"508.668257ms","remote":"127.0.0.1:53440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.81\" "} {"level":"warn","ts":"2026-04-07T00:12:02.410913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.920505Z","time spent":"488.690837ms","remote":"127.0.0.1:53584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:02.411044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.906839Z","time spent":"502.768693ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:02.411459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.905807Z","time spent":"503.950694ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:02.411557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.907325Z","time spent":"502.451714ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:02.411747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.906332Z","time spent":"503.487641ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:02.411802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.906786Z","time spent":"503.08455ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:02.412062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.822323Z","time spent":"586.783686ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:12:02.412179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.90576Z","time spent":"504.290104ms","remote":"127.0.0.1:53896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:02.412278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.920489Z","time spent":"488.713148ms","remote":"127.0.0.1:53682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:02.411161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.73303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-07T00:12:02.412419Z","caller":"traceutil/trace.go:171","msg":"trace[1383714305] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"588.998333ms","start":"2026-04-07T00:12:01.8234Z","end":"2026-04-07T00:12:02.412398Z","steps":["trace[1383714305] 'agreement among raft nodes before linearized reading' (duration: 586.684214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.41248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:01.823394Z","time spent":"589.059825ms","remote":"127.0.0.1:53584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-07T00:12:02.553508Z","caller":"traceutil/trace.go:171","msg":"trace[1851500391] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"138.607661ms","start":"2026-04-07T00:12:02.414869Z","end":"2026-04-07T00:12:02.553476Z","steps":["trace[1851500391] 'process raft request' (duration: 119.647698ms)","trace[1851500391] 'compare' (duration: 18.722897ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:02.553688Z","caller":"traceutil/trace.go:171","msg":"trace[1555822469] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"136.891327ms","start":"2026-04-07T00:12:02.416768Z","end":"2026-04-07T00:12:02.55366Z","steps":["trace[1555822469] 'process raft request' (duration: 136.619259ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.553697Z","caller":"traceutil/trace.go:171","msg":"trace[2034512456] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:14; }","duration":"136.541927ms","start":"2026-04-07T00:12:02.41714Z","end":"2026-04-07T00:12:02.553682Z","steps":["trace[2034512456] 'read index received' (duration: 117.383189ms)","trace[2034512456] 'applied index is now lower than readState.Index' (duration: 19.157748ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:02.553948Z","caller":"traceutil/trace.go:171","msg":"trace[998779044] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"135.323226ms","start":"2026-04-07T00:12:02.418615Z","end":"2026-04-07T00:12:02.553938Z","steps":["trace[998779044] 'process raft request' (duration: 134.887315ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.553938Z","caller":"traceutil/trace.go:171","msg":"trace[1334521352] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"137.067051ms","start":"2026-04-07T00:12:02.416809Z","end":"2026-04-07T00:12:02.553876Z","steps":["trace[1334521352] 'process raft request' (duration: 136.607589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:02.553908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.66866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-s84p8\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-04-07T00:12:02.554168Z","caller":"traceutil/trace.go:171","msg":"trace[1388352399] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-s84p8; range_end:; response_count:1; response_revision:20; }","duration":"137.02876ms","start":"2026-04-07T00:12:02.417118Z","end":"2026-04-07T00:12:02.554146Z","steps":["trace[1388352399] 'agreement among raft nodes before linearized reading' (duration: 136.61773ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.5542Z","caller":"traceutil/trace.go:171","msg":"trace[1036944944] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"135.518082ms","start":"2026-04-07T00:12:02.418671Z","end":"2026-04-07T00:12:02.554189Z","steps":["trace[1036944944] 'process raft request' (duration: 134.864515ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.554352Z","caller":"traceutil/trace.go:171","msg":"trace[662097752] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"135.550363ms","start":"2026-04-07T00:12:02.418791Z","end":"2026-04-07T00:12:02.554342Z","steps":["trace[662097752] 'process raft request' (duration: 134.769862ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.554488Z","caller":"traceutil/trace.go:171","msg":"trace[647243698] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"137.312418ms","start":"2026-04-07T00:12:02.417161Z","end":"2026-04-07T00:12:02.554473Z","steps":["trace[647243698] 'process raft request' (duration: 136.312221ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.554538Z","caller":"traceutil/trace.go:171","msg":"trace[358975174] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"135.679355ms","start":"2026-04-07T00:12:02.418843Z","end":"2026-04-07T00:12:02.554523Z","steps":["trace[358975174] 'process raft request' (duration: 134.741691ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.554663Z","caller":"traceutil/trace.go:171","msg":"trace[1350080766] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"135.699216ms","start":"2026-04-07T00:12:02.418956Z","end":"2026-04-07T00:12:02.554655Z","steps":["trace[1350080766] 'process raft request' (duration: 134.65423ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:02.554886Z","caller":"traceutil/trace.go:171","msg":"trace[629440618] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"134.140754ms","start":"2026-04-07T00:12:02.420724Z","end":"2026-04-07T00:12:02.554864Z","steps":["trace[629440618] 'process raft request' (duration: 132.911543ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:06.04791Z","caller":"traceutil/trace.go:171","msg":"trace[844373170] linearizableReadLoop","detail":"{readStateIndex:300; appliedIndex:299; }","duration":"137.324683ms","start":"2026-04-07T00:12:05.910563Z","end":"2026-04-07T00:12:06.047888Z","steps":["trace[844373170] 'read index received' (duration: 7.202616ms)","trace[844373170] 'applied index is now lower than readState.Index' (duration: 130.121297ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:06.047987Z","caller":"traceutil/trace.go:171","msg":"trace[978292090] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"141.756288ms","start":"2026-04-07T00:12:05.90621Z","end":"2026-04-07T00:12:06.047966Z","steps":["trace[978292090] 'process raft request' (duration: 135.885707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:06.048041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.460206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:06.048068Z","caller":"traceutil/trace.go:171","msg":"trace[3223545] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:292; }","duration":"137.523138ms","start":"2026-04-07T00:12:05.910536Z","end":"2026-04-07T00:12:06.04806Z","steps":["trace[3223545] 'agreement among raft nodes before linearized reading' (duration: 137.433896ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:10.621715Z","caller":"traceutil/trace.go:171","msg":"trace[757419957] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:366; }","duration":"120.284164ms","start":"2026-04-07T00:12:10.501391Z","end":"2026-04-07T00:12:10.621676Z","steps":["trace[757419957] 'read index received' (duration: 57.566845ms)","trace[757419957] 'applied index is now lower than readState.Index' (duration: 62.716509ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:10.621857Z","caller":"traceutil/trace.go:171","msg":"trace[1189691344] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"151.55444ms","start":"2026-04-07T00:12:10.470287Z","end":"2026-04-07T00:12:10.621841Z","steps":["trace[1189691344] 'process raft request' (duration: 88.661447ms)","trace[1189691344] 'compare' (duration: 62.566665ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:10.621765Z","caller":"traceutil/trace.go:171","msg":"trace[1941894040] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"151.100129ms","start":"2026-04-07T00:12:10.470636Z","end":"2026-04-07T00:12:10.621737Z","steps":["trace[1941894040] 'process raft request' (duration: 151.000687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:10.621923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.508829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-07T00:12:10.622166Z","caller":"traceutil/trace.go:171","msg":"trace[1530480443] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:356; }","duration":"120.796957ms","start":"2026-04-07T00:12:10.501349Z","end":"2026-04-07T00:12:10.622146Z","steps":["trace[1530480443] 'agreement among raft nodes before linearized reading' (duration: 120.482268ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:11.641453Z","caller":"traceutil/trace.go:171","msg":"trace[1154944695] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"192.352193ms","start":"2026-04-07T00:12:11.449074Z","end":"2026-04-07T00:12:11.641426Z","steps":["trace[1154944695] 'process raft request' (duration: 192.190048ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:30.097627Z","caller":"traceutil/trace.go:171","msg":"trace[801798301] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"584.533161ms","start":"2026-04-07T00:12:29.513063Z","end":"2026-04-07T00:12:30.097596Z","steps":["trace[801798301] 'process raft request' (duration: 584.329396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.097801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.513045Z","time spent":"584.678104ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.10428Z","caller":"traceutil/trace.go:171","msg":"trace[1499666801] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"414.150554ms","start":"2026-04-07T00:12:29.690107Z","end":"2026-04-07T00:12:30.104257Z","steps":["trace[1499666801] 'process raft request' (duration: 414.101733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.1044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.69008Z","time spent":"414.264327ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.104628Z","caller":"traceutil/trace.go:171","msg":"trace[213558966] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"584.202241ms","start":"2026-04-07T00:12:29.520418Z","end":"2026-04-07T00:12:30.104621Z","steps":["trace[213558966] 'process raft request' (duration: 583.286928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.10467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.520394Z","time spent":"584.256174ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.104754Z","caller":"traceutil/trace.go:171","msg":"trace[1797568229] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"584.230402ms","start":"2026-04-07T00:12:29.520517Z","end":"2026-04-07T00:12:30.104747Z","steps":["trace[1797568229] 'process raft request' (duration: 583.276838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.104788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.520509Z","time spent":"584.265673ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.104865Z","caller":"traceutil/trace.go:171","msg":"trace[1237013204] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"575.073356ms","start":"2026-04-07T00:12:29.529786Z","end":"2026-04-07T00:12:30.104859Z","steps":["trace[1237013204] 'process raft request' (duration: 574.030149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.104901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.52977Z","time spent":"575.115967ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.104983Z","caller":"traceutil/trace.go:171","msg":"trace[274272563] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"570.481908ms","start":"2026-04-07T00:12:29.534494Z","end":"2026-04-07T00:12:30.104976Z","steps":["trace[274272563] 'process raft request' (duration: 569.362049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.105017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.534485Z","time spent":"570.517629ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.105095Z","caller":"traceutil/trace.go:171","msg":"trace[1551561657] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"568.050666ms","start":"2026-04-07T00:12:29.537038Z","end":"2026-04-07T00:12:30.105089Z","steps":["trace[1551561657] 'process raft request' (duration: 566.841805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.105131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.53703Z","time spent":"568.086937ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.105241Z","caller":"traceutil/trace.go:171","msg":"trace[1991181841] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"542.323542ms","start":"2026-04-07T00:12:29.562911Z","end":"2026-04-07T00:12:30.105235Z","steps":["trace[1991181841] 'process raft request' (duration: 541.09637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.105277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.562896Z","time spent":"542.367383ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.105334Z","caller":"traceutil/trace.go:171","msg":"trace[962628285] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"534.354546ms","start":"2026-04-07T00:12:29.570957Z","end":"2026-04-07T00:12:30.105312Z","steps":["trace[962628285] 'process raft request' (duration: 533.103333ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:30.105371Z","caller":"traceutil/trace.go:171","msg":"trace[1370502546] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"563.067676ms","start":"2026-04-07T00:12:29.542296Z","end":"2026-04-07T00:12:30.105364Z","steps":["trace[1370502546] 'process raft request' (duration: 561.603478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.105406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.542285Z","time spent":"563.107148ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:12:30.105413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.570948Z","time spent":"534.425557ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.105475Z","caller":"traceutil/trace.go:171","msg":"trace[1888514152] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"557.821242ms","start":"2026-04-07T00:12:29.547648Z","end":"2026-04-07T00:12:30.105469Z","steps":["trace[1888514152] 'process raft request' (duration: 556.274432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.105509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.547631Z","time spent":"557.862212ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.10553Z","caller":"traceutil/trace.go:171","msg":"trace[1304321348] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"527.272583ms","start":"2026-04-07T00:12:29.57825Z","end":"2026-04-07T00:12:30.105523Z","steps":["trace[1304321348] 'process raft request' (duration: 525.851716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.105581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:29.578221Z","time spent":"527.345105ms","remote":"127.0.0.1:53456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:30.555098Z","caller":"traceutil/trace.go:171","msg":"trace[310550383] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"117.671516ms","start":"2026-04-07T00:12:30.437404Z","end":"2026-04-07T00:12:30.555076Z","steps":["trace[310550383] 'read index received' (duration: 111.326922ms)","trace[310550383] 'applied index is now lower than readState.Index' (duration: 6.343644ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:30.555175Z","caller":"traceutil/trace.go:171","msg":"trace[1260751439] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"119.447041ms","start":"2026-04-07T00:12:30.43569Z","end":"2026-04-07T00:12:30.555137Z","steps":["trace[1260751439] 'process raft request' (duration: 112.977685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:30.555243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.81566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:30.555281Z","caller":"traceutil/trace.go:171","msg":"trace[1473203504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"117.871691ms","start":"2026-04-07T00:12:30.4374Z","end":"2026-04-07T00:12:30.555271Z","steps":["trace[1473203504] 'agreement among raft nodes before linearized reading' (duration: 117.774659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:34.065863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.903356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.81\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-07T00:12:34.065988Z","caller":"traceutil/trace.go:171","msg":"trace[955737210] range","detail":"{range_begin:/registry/masterleases/199.19.213.81; range_end:; response_count:1; response_revision:599; }","duration":"546.039819ms","start":"2026-04-07T00:12:33.51992Z","end":"2026-04-07T00:12:34.06596Z","steps":["trace[955737210] 'range keys from in-memory index tree' (duration: 545.818324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:34.066043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:33.519884Z","time spent":"546.145402ms","remote":"127.0.0.1:53440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.81\" "} {"level":"info","ts":"2026-04-07T00:12:34.068164Z","caller":"traceutil/trace.go:171","msg":"trace[1723438709] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"434.562043ms","start":"2026-04-07T00:12:33.633569Z","end":"2026-04-07T00:12:34.068131Z","steps":["trace[1723438709] 'process raft request' (duration: 409.482047ms)","trace[1723438709] 'compare' (duration: 23.818934ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:34.06831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:33.633539Z","time spent":"434.692516ms","remote":"127.0.0.1:53496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:12:36.685997Z","caller":"traceutil/trace.go:171","msg":"trace[125599110] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"661.467046ms","start":"2026-04-07T00:12:36.024506Z","end":"2026-04-07T00:12:36.685973Z","steps":["trace[125599110] 'process raft request' (duration: 659.839913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:36.686163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:36.024479Z","time spent":"661.60363ms","remote":"127.0.0.1:53496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:12:36.85473Z","caller":"traceutil/trace.go:171","msg":"trace[1661440365] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"674.143053ms","start":"2026-04-07T00:12:36.180564Z","end":"2026-04-07T00:12:36.854707Z","steps":["trace[1661440365] 'process raft request' (duration: 645.492374ms)","trace[1661440365] 'compare' (duration: 28.251079ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:36.854783Z","caller":"traceutil/trace.go:171","msg":"trace[1542922616] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"104.261271ms","start":"2026-04-07T00:12:36.750498Z","end":"2026-04-07T00:12:36.854759Z","steps":["trace[1542922616] 'process raft request' (duration: 103.969453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:36.854866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:36.180543Z","time spent":"674.256857ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:12:36.855055Z","caller":"traceutil/trace.go:171","msg":"trace[1552389567] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"558.357546ms","start":"2026-04-07T00:12:36.29665Z","end":"2026-04-07T00:12:36.855007Z","steps":["trace[1552389567] 'read index received' (duration: 386.854641ms)","trace[1552389567] 'applied index is now lower than readState.Index' (duration: 171.499805ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:36.855179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.692418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:36.85521Z","caller":"traceutil/trace.go:171","msg":"trace[1983617355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"426.76938ms","start":"2026-04-07T00:12:36.428432Z","end":"2026-04-07T00:12:36.855202Z","steps":["trace[1983617355] 'agreement among raft nodes before linearized reading' (duration: 426.705009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:36.855216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.562771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T00:12:36.855234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:36.428404Z","time spent":"426.823911ms","remote":"127.0.0.1:53416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T00:12:36.855264Z","caller":"traceutil/trace.go:171","msg":"trace[2091021795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"558.629362ms","start":"2026-04-07T00:12:36.296618Z","end":"2026-04-07T00:12:36.855247Z","steps":["trace[2091021795] 'agreement among raft nodes before linearized reading' (duration: 558.466258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:36.855303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:36.296605Z","time spent":"558.690916ms","remote":"127.0.0.1:53690","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-07T00:12:36.855481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.361538ms","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-07T00:12:36.855538Z","caller":"traceutil/trace.go:171","msg":"trace[616209141] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"410.45637ms","start":"2026-04-07T00:12:36.445065Z","end":"2026-04-07T00:12:36.855522Z","steps":["trace[616209141] 'agreement among raft nodes before linearized reading' (duration: 410.289476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:36.855572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:36.445047Z","time spent":"410.517691ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T00:12:37.792722Z","caller":"traceutil/trace.go:171","msg":"trace[1999812653] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"271.484624ms","start":"2026-04-07T00:12:37.521213Z","end":"2026-04-07T00:12:37.792697Z","steps":["trace[1999812653] 'process raft request' (duration: 271.32853ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:38.371626Z","caller":"traceutil/trace.go:171","msg":"trace[1168445690] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"597.541998ms","start":"2026-04-07T00:12:37.774016Z","end":"2026-04-07T00:12:38.371558Z","steps":["trace[1168445690] 'process raft request' (duration: 592.861588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:38.37189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:37.773981Z","time spent":"597.727653ms","remote":"127.0.0.1:53496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:12:39.365222Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8397416038536630302,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T00:12:39.866222Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8397416038536630302,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T00:12:40.212295Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.753233455s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T00:12:40.414808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.892981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:12:40.415362Z","caller":"traceutil/trace.go:171","msg":"trace[2127839626] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.957754973s","start":"2026-04-07T00:12:38.457544Z","end":"2026-04-07T00:12:40.415299Z","steps":["trace[2127839626] 'process raft request' (duration: 1.755160844s)","trace[2127839626] 'compare' (duration: 201.412948ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:40.415603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:38.457527Z","time spent":"1.957973858s","remote":"127.0.0.1:53586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:12:40.4988Z","caller":"traceutil/trace.go:171","msg":"trace[2053531779] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"1.633945937s","start":"2026-04-07T00:12:38.864832Z","end":"2026-04-07T00:12:40.498778Z","steps":["trace[2053531779] 'read index received' (duration: 1.347795453s)","trace[2053531779] 'applied index is now lower than readState.Index' (duration: 286.146134ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:40.499035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.634178622s","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-07T00:12:40.499107Z","caller":"traceutil/trace.go:171","msg":"trace[1042599979] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"1.634296915s","start":"2026-04-07T00:12:38.864793Z","end":"2026-04-07T00:12:40.49909Z","steps":["trace[1042599979] 'agreement among raft nodes before linearized reading' (duration: 1.634053429s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:40.499341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:38.864755Z","time spent":"1.63449413s","remote":"127.0.0.1:53690","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-07T00:12:40.499525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.632841828s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-07T00:12:40.499737Z","caller":"traceutil/trace.go:171","msg":"trace[1133223940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"1.633097615s","start":"2026-04-07T00:12:38.866629Z","end":"2026-04-07T00:12:40.499726Z","steps":["trace[1133223940] 'agreement among raft nodes before linearized reading' (duration: 1.632851559s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:40.499777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:38.866609Z","time spent":"1.633155317s","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T00:12:40.500133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.632915861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-07T00:12:40.500171Z","caller":"traceutil/trace.go:171","msg":"trace[754623973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"1.632984382s","start":"2026-04-07T00:12:38.867177Z","end":"2026-04-07T00:12:40.500162Z","steps":["trace[754623973] 'agreement among raft nodes before linearized reading' (duration: 1.632920811s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:40.500197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:38.867135Z","time spent":"1.633055574s","remote":"127.0.0.1:53690","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-07T00:12:40.500455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.632709785s","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-07T00:12:40.50049Z","caller":"traceutil/trace.go:171","msg":"trace[1294342077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"1.632771026s","start":"2026-04-07T00:12:38.86771Z","end":"2026-04-07T00:12:40.500481Z","steps":["trace[1294342077] 'agreement among raft nodes before linearized reading' (duration: 1.632631923s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:40.500511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:38.867703Z","time spent":"1.632802887s","remote":"127.0.0.1:53690","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-07T00:12:42.013273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.815993ms","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-07T00:12:42.01329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.572219ms","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-07T00:12:42.013343Z","caller":"traceutil/trace.go:171","msg":"trace[1427119725] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:647; }","duration":"352.905846ms","start":"2026-04-07T00:12:41.660414Z","end":"2026-04-07T00:12:42.01332Z","steps":["trace[1427119725] 'count revisions from in-memory index tree' (duration: 352.69736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:42.013339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.942491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:42.01336Z","caller":"traceutil/trace.go:171","msg":"trace[1075939877] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:647; }","duration":"366.712933ms","start":"2026-04-07T00:12:41.646634Z","end":"2026-04-07T00:12:42.013347Z","steps":["trace[1075939877] 'range keys from in-memory index tree' (duration: 366.468296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:42.013374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:41.660398Z","time spent":"352.967557ms","remote":"127.0.0.1:57168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"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-07T00:12:42.013389Z","caller":"traceutil/trace.go:171","msg":"trace[768086872] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:647; }","duration":"352.009292ms","start":"2026-04-07T00:12:41.661361Z","end":"2026-04-07T00:12:42.01337Z","steps":["trace[768086872] 'range keys from in-memory index tree' (duration: 351.87893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:42.013397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:41.646613Z","time spent":"366.773534ms","remote":"127.0.0.1:57160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T00:12:42.013429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:41.661352Z","time spent":"352.061054ms","remote":"127.0.0.1:57160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-07T00:12:42.013551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.065859ms","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-07T00:12:42.013607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.010151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:42.013629Z","caller":"traceutil/trace.go:171","msg":"trace[1550899899] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:647; }","duration":"367.041201ms","start":"2026-04-07T00:12:41.646579Z","end":"2026-04-07T00:12:42.013621Z","steps":["trace[1550899899] 'count revisions from in-memory index tree' (duration: 366.98721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:42.013646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:41.646576Z","time spent":"367.065192ms","remote":"127.0.0.1:57160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"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-07T00:12:42.01364Z","caller":"traceutil/trace.go:171","msg":"trace[852946125] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:647; }","duration":"353.147722ms","start":"2026-04-07T00:12:41.660466Z","end":"2026-04-07T00:12:42.013614Z","steps":["trace[852946125] 'range keys from in-memory index tree' (duration: 353.001038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:42.013689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:41.660424Z","time spent":"353.249014ms","remote":"127.0.0.1:57168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T00:12:42.013717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.223635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-07T00:12:42.013733Z","caller":"traceutil/trace.go:171","msg":"trace[2121780730] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:647; }","duration":"367.317718ms","start":"2026-04-07T00:12:41.64641Z","end":"2026-04-07T00:12:42.013727Z","steps":["trace[2121780730] 'range keys from in-memory index tree' (duration: 367.164604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:42.013751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:41.646396Z","time spent":"367.347728ms","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-07T00:12:46.512191Z","caller":"traceutil/trace.go:171","msg":"trace[412055494] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"132.56088ms","start":"2026-04-07T00:12:46.379582Z","end":"2026-04-07T00:12:46.512143Z","steps":["trace[412055494] 'process raft request' (duration: 132.350274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:46.5123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.987834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:46.512568Z","caller":"traceutil/trace.go:171","msg":"trace[1190571821] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:717; }","duration":"132.115928ms","start":"2026-04-07T00:12:46.380219Z","end":"2026-04-07T00:12:46.512352Z","steps":["trace[1190571821] 'agreement among raft nodes before linearized reading' (duration: 131.970854ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:46.512153Z","caller":"traceutil/trace.go:171","msg":"trace[1588244326] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:744; }","duration":"131.812211ms","start":"2026-04-07T00:12:46.380292Z","end":"2026-04-07T00:12:46.512104Z","steps":["trace[1588244326] 'read index received' (duration: 131.722698ms)","trace[1588244326] 'applied index is now lower than readState.Index' (duration: 88.133µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:46.636791Z","caller":"traceutil/trace.go:171","msg":"trace[529104664] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:745; }","duration":"123.837755ms","start":"2026-04-07T00:12:46.512926Z","end":"2026-04-07T00:12:46.636764Z","steps":["trace[529104664] 'read index received' (duration: 92.935508ms)","trace[529104664] 'applied index is now lower than readState.Index' (duration: 30.901297ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:46.636915Z","caller":"traceutil/trace.go:171","msg":"trace[223344985] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"256.019015ms","start":"2026-04-07T00:12:46.380836Z","end":"2026-04-07T00:12:46.636855Z","steps":["trace[223344985] 'process raft request' (duration: 225.065407ms)","trace[223344985] 'compare' (duration: 30.748873ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:46.637147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.708464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:46.637273Z","caller":"traceutil/trace.go:171","msg":"trace[198156452] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:718; }","duration":"256.907439ms","start":"2026-04-07T00:12:46.380346Z","end":"2026-04-07T00:12:46.637254Z","steps":["trace[198156452] 'agreement among raft nodes before linearized reading' (duration: 256.666913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:46.637296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.588165ms","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-07T00:12:46.637386Z","caller":"traceutil/trace.go:171","msg":"trace[1228607240] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:718; }","duration":"105.710687ms","start":"2026-04-07T00:12:46.531653Z","end":"2026-04-07T00:12:46.637363Z","steps":["trace[1228607240] 'agreement among raft nodes before linearized reading' (duration: 105.522153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:46.637544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.763887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-07T00:12:46.637633Z","caller":"traceutil/trace.go:171","msg":"trace[529670618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:718; }","duration":"103.86978ms","start":"2026-04-07T00:12:46.533754Z","end":"2026-04-07T00:12:46.637624Z","steps":["trace[529670618] 'agreement among raft nodes before linearized reading' (duration: 103.731156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:46.637849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.188258ms","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-07T00:12:46.637886Z","caller":"traceutil/trace.go:171","msg":"trace[660655929] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:718; }","duration":"104.285221ms","start":"2026-04-07T00:12:46.533591Z","end":"2026-04-07T00:12:46.637876Z","steps":["trace[660655929] 'agreement among raft nodes before linearized reading' (duration: 104.196099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:46.638396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.039525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-04-07T00:12:46.638438Z","caller":"traceutil/trace.go:171","msg":"trace[410630539] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:718; }","duration":"192.163768ms","start":"2026-04-07T00:12:46.446264Z","end":"2026-04-07T00:12:46.638428Z","steps":["trace[410630539] 'agreement among raft nodes before linearized reading' (duration: 190.682419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:46.637125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.662073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:46.639274Z","caller":"traceutil/trace.go:171","msg":"trace[2042343860] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:718; }","duration":"258.869649ms","start":"2026-04-07T00:12:46.380383Z","end":"2026-04-07T00:12:46.639253Z","steps":["trace[2042343860] 'agreement among raft nodes before linearized reading' (duration: 256.642842ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:46.772808Z","caller":"traceutil/trace.go:171","msg":"trace[1659136570] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"121.637357ms","start":"2026-04-07T00:12:46.651152Z","end":"2026-04-07T00:12:46.772789Z","steps":["trace[1659136570] 'process raft request' (duration: 121.507774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:57.1897Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8397416038536630673,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-07T00:12:57.367942Z","caller":"traceutil/trace.go:171","msg":"trace[291514109] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"678.267231ms","start":"2026-04-07T00:12:56.689652Z","end":"2026-04-07T00:12:57.367919Z","steps":["trace[291514109] 'read index received' (duration: 678.054845ms)","trace[291514109] 'applied index is now lower than readState.Index' (duration: 211.466µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:57.368048Z","caller":"traceutil/trace.go:171","msg":"trace[757752379] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"752.463024ms","start":"2026-04-07T00:12:56.615571Z","end":"2026-04-07T00:12:57.368034Z","steps":["trace[757752379] 'process raft request' (duration: 752.194508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:57.368142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:56.61556Z","time spent":"752.513686ms","remote":"127.0.0.1:53586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:12:57.368348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.928807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-07T00:12:57.368411Z","caller":"traceutil/trace.go:171","msg":"trace[1794339235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:790; }","duration":"591.002619ms","start":"2026-04-07T00:12:56.777398Z","end":"2026-04-07T00:12:57.3684Z","steps":["trace[1794339235] 'agreement among raft nodes before linearized reading' (duration: 590.861026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:57.368442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.782514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-07T00:12:57.368465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:56.777393Z","time spent":"591.0537ms","remote":"127.0.0.1:53690","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-07T00:12:57.368508Z","caller":"traceutil/trace.go:171","msg":"trace[1988471285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:790; }","duration":"678.871886ms","start":"2026-04-07T00:12:56.689611Z","end":"2026-04-07T00:12:57.368483Z","steps":["trace[1988471285] 'agreement among raft nodes before linearized reading' (duration: 678.701102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:57.368544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:56.689598Z","time spent":"678.937578ms","remote":"127.0.0.1:53690","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-07T00:12:57.368526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.113132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-07T00:12:57.368628Z","caller":"traceutil/trace.go:171","msg":"trace[1013194117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:790; }","duration":"591.253445ms","start":"2026-04-07T00:12:56.777357Z","end":"2026-04-07T00:12:57.36861Z","steps":["trace[1013194117] 'agreement among raft nodes before linearized reading' (duration: 590.978009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:57.368683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:56.777347Z","time spent":"591.324647ms","remote":"127.0.0.1:53690","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-07T00:12:57.368977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.840261ms","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-07T00:12:57.369011Z","caller":"traceutil/trace.go:171","msg":"trace[1024597414] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:790; }","duration":"591.874792ms","start":"2026-04-07T00:12:56.777127Z","end":"2026-04-07T00:12:57.369002Z","steps":["trace[1024597414] 'agreement among raft nodes before linearized reading' (duration: 591.135373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:57.369038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:56.777081Z","time spent":"591.951404ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T00:12:57.569783Z","caller":"traceutil/trace.go:171","msg":"trace[895796163] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"197.295801ms","start":"2026-04-07T00:12:57.37246Z","end":"2026-04-07T00:12:57.569756Z","steps":["trace[895796163] 'process raft request' (duration: 197.077214ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:57.573019Z","caller":"traceutil/trace.go:171","msg":"trace[1667513570] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"199.322833ms","start":"2026-04-07T00:12:57.373637Z","end":"2026-04-07T00:12:57.572959Z","steps":["trace[1667513570] 'process raft request' (duration: 199.23357ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:57.573061Z","caller":"traceutil/trace.go:171","msg":"trace[51100543] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"200.157344ms","start":"2026-04-07T00:12:57.372828Z","end":"2026-04-07T00:12:57.572986Z","steps":["trace[51100543] 'process raft request' (duration: 199.843987ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:57.573363Z","caller":"traceutil/trace.go:171","msg":"trace[710228818] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"199.500607ms","start":"2026-04-07T00:12:57.373851Z","end":"2026-04-07T00:12:57.573352Z","steps":["trace[710228818] 'process raft request' (duration: 199.075876ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:57.573315Z","caller":"traceutil/trace.go:171","msg":"trace[1739408414] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"148.525352ms","start":"2026-04-07T00:12:57.424769Z","end":"2026-04-07T00:12:57.573294Z","steps":["trace[1739408414] 'process raft request' (duration: 148.418279ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:02.308168Z","caller":"traceutil/trace.go:171","msg":"trace[1427187104] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"114.593787ms","start":"2026-04-07T00:13:02.193545Z","end":"2026-04-07T00:13:02.308139Z","steps":["trace[1427187104] 'process raft request' (duration: 114.394632ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:02.483762Z","caller":"traceutil/trace.go:171","msg":"trace[360851805] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"169.540924ms","start":"2026-04-07T00:13:02.314185Z","end":"2026-04-07T00:13:02.483726Z","steps":["trace[360851805] 'process raft request' (duration: 169.319418ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:20.504039Z","caller":"traceutil/trace.go:171","msg":"trace[1765593498] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"109.594299ms","start":"2026-04-07T00:13:20.394405Z","end":"2026-04-07T00:13:20.503999Z","steps":["trace[1765593498] 'process raft request' (duration: 109.313722ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:32.766286Z","caller":"traceutil/trace.go:171","msg":"trace[444090341] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"151.861384ms","start":"2026-04-07T00:13:32.6144Z","end":"2026-04-07T00:13:32.766261Z","steps":["trace[444090341] 'process raft request' (duration: 151.73224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:34.128369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.407493ms","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-07T00:13:34.128437Z","caller":"traceutil/trace.go:171","msg":"trace[481159586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1007; }","duration":"353.525786ms","start":"2026-04-07T00:13:33.774895Z","end":"2026-04-07T00:13:34.128421Z","steps":["trace[481159586] 'range keys from in-memory index tree' (duration: 353.25961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:34.128468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:13:33.774874Z","time spent":"353.586848ms","remote":"127.0.0.1:53690","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-07T00:13:34.128634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.343934ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:13:34.128707Z","caller":"traceutil/trace.go:171","msg":"trace[1176731849] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1048; }","duration":"323.932233ms","start":"2026-04-07T00:13:33.804763Z","end":"2026-04-07T00:13:34.128696Z","steps":["trace[1176731849] 'read index received' (duration: 54.400634ms)","trace[1176731849] 'applied index is now lower than readState.Index' (duration: 269.530889ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:13:34.12892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.152329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-07T00:13:34.128943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.11399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-07T00:13:34.128959Z","caller":"traceutil/trace.go:171","msg":"trace[2011651121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1008; }","duration":"324.21867ms","start":"2026-04-07T00:13:33.804726Z","end":"2026-04-07T00:13:34.128944Z","steps":["trace[2011651121] 'agreement among raft nodes before linearized reading' (duration: 324.041606ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:34.128967Z","caller":"traceutil/trace.go:171","msg":"trace[1338033705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1008; }","duration":"293.177661ms","start":"2026-04-07T00:13:33.835782Z","end":"2026-04-07T00:13:34.12896Z","steps":["trace[1338033705] 'agreement among raft nodes before linearized reading' (duration: 293.081969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:34.128986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:13:33.804708Z","time spent":"324.271502ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T00:13:34.129066Z","caller":"traceutil/trace.go:171","msg":"trace[1697279211] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"327.363249ms","start":"2026-04-07T00:13:33.801691Z","end":"2026-04-07T00:13:34.129054Z","steps":["trace[1697279211] 'process raft request' (duration: 57.533873ms)","trace[1697279211] 'compare' (duration: 269.031656ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:13:34.129138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.248732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-07T00:13:34.129193Z","caller":"traceutil/trace.go:171","msg":"trace[969687884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1008; }","duration":"293.315835ms","start":"2026-04-07T00:13:33.835835Z","end":"2026-04-07T00:13:34.129151Z","steps":["trace[969687884] 'agreement among raft nodes before linearized reading' (duration: 293.261093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:34.129192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:13:33.801673Z","time spent":"327.415101ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:13:39.109372Z","caller":"traceutil/trace.go:171","msg":"trace[1820466545] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"171.596087ms","start":"2026-04-07T00:13:38.937755Z","end":"2026-04-07T00:13:39.109351Z","steps":["trace[1820466545] 'process raft request' (duration: 171.456353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:55.179976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.917272ms","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-07T00:13:55.180085Z","caller":"traceutil/trace.go:171","msg":"trace[1884998524] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1079; }","duration":"313.392055ms","start":"2026-04-07T00:13:54.866666Z","end":"2026-04-07T00:13:55.180058Z","steps":["trace[1884998524] 'range keys from in-memory index tree' (duration: 312.727258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:55.180132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:13:54.866646Z","time spent":"313.472477ms","remote":"127.0.0.1:53690","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-07T00:13:55.374048Z","caller":"traceutil/trace.go:171","msg":"trace[868822409] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"189.259996ms","start":"2026-04-07T00:13:55.184762Z","end":"2026-04-07T00:13:55.374022Z","steps":["trace[868822409] 'process raft request' (duration: 189.132423ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:56.589085Z","caller":"traceutil/trace.go:171","msg":"trace[442385471] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"303.709229ms","start":"2026-04-07T00:13:56.285346Z","end":"2026-04-07T00:13:56.589055Z","steps":["trace[442385471] 'read index received' (duration: 303.473922ms)","trace[442385471] 'applied index is now lower than readState.Index' (duration: 234.477µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:13:56.58915Z","caller":"traceutil/trace.go:171","msg":"trace[594611407] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"314.954074ms","start":"2026-04-07T00:13:56.27416Z","end":"2026-04-07T00:13:56.589114Z","steps":["trace[594611407] 'process raft request' (duration: 314.747439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:56.589338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:13:56.274138Z","time spent":"315.099078ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:13:56.589363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.966695ms","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-07T00:13:56.589427Z","caller":"traceutil/trace.go:171","msg":"trace[685948888] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1081; }","duration":"304.072828ms","start":"2026-04-07T00:13:56.285339Z","end":"2026-04-07T00:13:56.589412Z","steps":["trace[685948888] 'agreement among raft nodes before linearized reading' (duration: 303.931704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:56.589467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:13:56.28529Z","time spent":"304.16687ms","remote":"127.0.0.1:57084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"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-07T00:13:56.589483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.158365ms","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-07T00:13:56.589542Z","caller":"traceutil/trace.go:171","msg":"trace[139816591] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1081; }","duration":"294.243707ms","start":"2026-04-07T00:13:56.295282Z","end":"2026-04-07T00:13:56.589525Z","steps":["trace[139816591] 'agreement among raft nodes before linearized reading' (duration: 294.063683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:56.589732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.178983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-07T00:13:56.589737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.07082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:13:56.589767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.448477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-07T00:13:56.589792Z","caller":"traceutil/trace.go:171","msg":"trace[1480736487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1081; }","duration":"275.259695ms","start":"2026-04-07T00:13:56.31452Z","end":"2026-04-07T00:13:56.589779Z","steps":["trace[1480736487] 'agreement among raft nodes before linearized reading' (duration: 275.115191ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:56.589805Z","caller":"traceutil/trace.go:171","msg":"trace[481662297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1081; }","duration":"161.166522ms","start":"2026-04-07T00:13:56.428622Z","end":"2026-04-07T00:13:56.589788Z","steps":["trace[481662297] 'agreement among raft nodes before linearized reading' (duration: 161.070918ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:56.589838Z","caller":"traceutil/trace.go:171","msg":"trace[1065428125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1081; }","duration":"280.530409ms","start":"2026-04-07T00:13:56.309282Z","end":"2026-04-07T00:13:56.589813Z","steps":["trace[1065428125] 'agreement among raft nodes before linearized reading' (duration: 280.382275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:56.590004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.841546ms","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-07T00:13:56.590133Z","caller":"traceutil/trace.go:171","msg":"trace[1080228701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1081; }","duration":"281.03663ms","start":"2026-04-07T00:13:56.309079Z","end":"2026-04-07T00:13:56.590115Z","steps":["trace[1080228701] 'agreement among raft nodes before linearized reading' (duration: 280.584039ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:56.806298Z","caller":"traceutil/trace.go:171","msg":"trace[1057454111] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"211.541653ms","start":"2026-04-07T00:13:56.594718Z","end":"2026-04-07T00:13:56.806259Z","steps":["trace[1057454111] 'process raft request' (duration: 172.136881ms)","trace[1057454111] 'compare' (duration: 39.077773ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:13:56.850107Z","caller":"traceutil/trace.go:171","msg":"trace[880360548] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"254.999579ms","start":"2026-04-07T00:13:56.59508Z","end":"2026-04-07T00:13:56.85008Z","steps":["trace[880360548] 'process raft request' (duration: 254.917707ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:56.850283Z","caller":"traceutil/trace.go:171","msg":"trace[763209938] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"255.215795ms","start":"2026-04-07T00:13:56.595057Z","end":"2026-04-07T00:13:56.850272Z","steps":["trace[763209938] 'process raft request' (duration: 254.830465ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:56.850381Z","caller":"traceutil/trace.go:171","msg":"trace[2096592467] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"255.277037ms","start":"2026-04-07T00:13:56.595092Z","end":"2026-04-07T00:13:56.85037Z","steps":["trace[2096592467] 'process raft request' (duration: 254.953848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:11.402857Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8397416038536631553,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-07T00:14:11.527721Z","caller":"traceutil/trace.go:171","msg":"trace[1879973524] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1231; }","duration":"625.918248ms","start":"2026-04-07T00:14:10.90178Z","end":"2026-04-07T00:14:11.527698Z","steps":["trace[1879973524] 'read index received' (duration: 625.572658ms)","trace[1879973524] 'applied index is now lower than readState.Index' (duration: 345µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:14:11.527983Z","caller":"traceutil/trace.go:171","msg":"trace[413171240] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"666.595522ms","start":"2026-04-07T00:14:10.861378Z","end":"2026-04-07T00:14:11.527974Z","steps":["trace[413171240] 'process raft request' (duration: 666.023388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:11.52806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:10.861358Z","time spent":"666.645834ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:14:11.52824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.459061ms","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-07T00:14:11.528264Z","caller":"traceutil/trace.go:171","msg":"trace[1255598278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1182; }","duration":"626.505972ms","start":"2026-04-07T00:14:10.901752Z","end":"2026-04-07T00:14:11.528258Z","steps":["trace[1255598278] 'agreement among raft nodes before linearized reading' (duration: 626.4258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:11.528283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:10.901742Z","time spent":"626.537293ms","remote":"127.0.0.1:53690","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-07T00:14:11.528375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.12722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-07T00:14:11.528398Z","caller":"traceutil/trace.go:171","msg":"trace[354569410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1182; }","duration":"605.15985ms","start":"2026-04-07T00:14:10.923233Z","end":"2026-04-07T00:14:11.528393Z","steps":["trace[354569410] 'agreement among raft nodes before linearized reading' (duration: 605.107109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:11.528414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:10.923228Z","time spent":"605.181991ms","remote":"127.0.0.1:53690","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-07T00:14:11.528881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.343523ms","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-07T00:14:11.528904Z","caller":"traceutil/trace.go:171","msg":"trace[27615890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1182; }","duration":"603.375745ms","start":"2026-04-07T00:14:10.925523Z","end":"2026-04-07T00:14:11.528899Z","steps":["trace[27615890] 'agreement among raft nodes before linearized reading' (duration: 603.324693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:11.528921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:10.925512Z","time spent":"603.403775ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T00:14:11.940445Z","caller":"traceutil/trace.go:171","msg":"trace[289063351] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"407.650393ms","start":"2026-04-07T00:14:11.532762Z","end":"2026-04-07T00:14:11.940412Z","steps":["trace[289063351] 'process raft request' (duration: 407.461289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:11.940602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:11.532751Z","time spent":"407.770216ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:14:11.94082Z","caller":"traceutil/trace.go:171","msg":"trace[991295890] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"407.308945ms","start":"2026-04-07T00:14:11.533488Z","end":"2026-04-07T00:14:11.940797Z","steps":["trace[991295890] 'process raft request' (duration: 407.277524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:11.940944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:11.533477Z","time spent":"407.408847ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:14:11.941027Z","caller":"traceutil/trace.go:171","msg":"trace[1981056100] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"408.007943ms","start":"2026-04-07T00:14:11.533006Z","end":"2026-04-07T00:14:11.941014Z","steps":["trace[1981056100] 'process raft request' (duration: 407.645393ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:11.94108Z","caller":"traceutil/trace.go:171","msg":"trace[601736383] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"407.729935ms","start":"2026-04-07T00:14:11.533345Z","end":"2026-04-07T00:14:11.941075Z","steps":["trace[601736383] 'process raft request' (duration: 407.395177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:11.941098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:11.532999Z","time spent":"408.064864ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:14:11.941114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:11.533319Z","time spent":"407.779756ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:14:26.562154Z","caller":"traceutil/trace.go:171","msg":"trace[90855563] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"474.428126ms","start":"2026-04-07T00:14:26.087699Z","end":"2026-04-07T00:14:26.562127Z","steps":["trace[90855563] 'read index received' (duration: 474.202341ms)","trace[90855563] 'applied index is now lower than readState.Index' (duration: 224.905µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:26.562395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.680023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-07T00:14:26.562419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.626265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-07T00:14:26.562451Z","caller":"traceutil/trace.go:171","msg":"trace[706307722] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1238; }","duration":"474.755285ms","start":"2026-04-07T00:14:26.087684Z","end":"2026-04-07T00:14:26.562439Z","steps":["trace[706307722] 'agreement among raft nodes before linearized reading' (duration: 474.58168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:26.562444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.592536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:14:26.562481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.957257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-07T00:14:26.562481Z","caller":"traceutil/trace.go:171","msg":"trace[1698676774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1238; }","duration":"445.732297ms","start":"2026-04-07T00:14:26.116731Z","end":"2026-04-07T00:14:26.562463Z","steps":["trace[1698676774] 'agreement among raft nodes before linearized reading' (duration: 445.597794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:26.562496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.087645Z","time spent":"474.841957ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T00:14:26.562515Z","caller":"traceutil/trace.go:171","msg":"trace[1071080921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1238; }","duration":"445.016888ms","start":"2026-04-07T00:14:26.117489Z","end":"2026-04-07T00:14:26.562506Z","steps":["trace[1071080921] 'agreement among raft nodes before linearized reading' (duration: 444.862505ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:26.562506Z","caller":"traceutil/trace.go:171","msg":"trace[957462478] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"133.730969ms","start":"2026-04-07T00:14:26.428765Z","end":"2026-04-07T00:14:26.562496Z","steps":["trace[957462478] 'agreement among raft nodes before linearized reading' (duration: 133.580435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:26.562527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.116712Z","time spent":"445.805339ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T00:14:26.562544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.117475Z","time spent":"445.0636ms","remote":"127.0.0.1:53690","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-07T00:14:26.562277Z","caller":"traceutil/trace.go:171","msg":"trace[1537554252] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"513.380632ms","start":"2026-04-07T00:14:26.048859Z","end":"2026-04-07T00:14:26.562239Z","steps":["trace[1537554252] 'process raft request' (duration: 513.127285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:26.562954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.048844Z","time spent":"514.060129ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:14:27.646493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.760201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:14:27.646632Z","caller":"traceutil/trace.go:171","msg":"trace[1050805009] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"1.081148907s","start":"2026-04-07T00:14:26.565458Z","end":"2026-04-07T00:14:27.646607Z","steps":["trace[1050805009] 'process raft request' (duration: 888.182529ms)","trace[1050805009] 'compare' (duration: 192.311961ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:27.646712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.565437Z","time spent":"1.081234258s","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:14:27.828254Z","caller":"traceutil/trace.go:171","msg":"trace[438300369] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"1.261704562s","start":"2026-04-07T00:14:26.566535Z","end":"2026-04-07T00:14:27.828239Z","steps":["trace[438300369] 'process raft request' (duration: 1.261485717s)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:27.828281Z","caller":"traceutil/trace.go:171","msg":"trace[519734601] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"1.262716549s","start":"2026-04-07T00:14:26.565512Z","end":"2026-04-07T00:14:27.828228Z","steps":["trace[519734601] 'process raft request' (duration: 1.241649085s)","trace[519734601] 'compare' (duration: 20.421327ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:27.828368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.566529Z","time spent":"1.261767274s","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:14:27.828167Z","caller":"traceutil/trace.go:171","msg":"trace[896403433] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1292; }","duration":"240.353919ms","start":"2026-04-07T00:14:27.587788Z","end":"2026-04-07T00:14:27.828142Z","steps":["trace[896403433] 'read index received' (duration: 219.303867ms)","trace[896403433] 'applied index is now lower than readState.Index' (duration: 21.049182ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:27.828523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.565492Z","time spent":"1.262889083s","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:14:27.828606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.923431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:14:27.828595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.78822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-07T00:14:27.82892Z","caller":"traceutil/trace.go:171","msg":"trace[1938667298] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1242; }","duration":"236.981433ms","start":"2026-04-07T00:14:27.591648Z","end":"2026-04-07T00:14:27.828629Z","steps":["trace[1938667298] 'agreement among raft nodes before linearized reading' (duration: 236.929171ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:27.829093Z","caller":"traceutil/trace.go:171","msg":"trace[1328456542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1242; }","duration":"240.928495ms","start":"2026-04-07T00:14:27.587737Z","end":"2026-04-07T00:14:27.828666Z","steps":["trace[1328456542] 'agreement among raft nodes before linearized reading' (duration: 240.669798ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:27.828367Z","caller":"traceutil/trace.go:171","msg":"trace[1067793751] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"1.120904461s","start":"2026-04-07T00:14:26.707384Z","end":"2026-04-07T00:14:27.828288Z","steps":["trace[1067793751] 'process raft request' (duration: 1.120715926s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:27.830285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.707366Z","time spent":"1.122836251s","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:14:28.718322Z","caller":"traceutil/trace.go:171","msg":"trace[717340593] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"149.102135ms","start":"2026-04-07T00:14:28.569197Z","end":"2026-04-07T00:14:28.7183Z","steps":["trace[717340593] 'process raft request' (duration: 148.937671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:29.753372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.270924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:29.753476Z","caller":"traceutil/trace.go:171","msg":"trace[2010776667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1248; }","duration":"324.431929ms","start":"2026-04-07T00:14:29.42902Z","end":"2026-04-07T00:14:29.753452Z","steps":["trace[2010776667] 'range keys from in-memory index tree' (duration: 324.186041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:29.753525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:29.429001Z","time spent":"324.51211ms","remote":"127.0.0.1:53408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T00:14:29.753765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.001464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5330"} {"level":"info","ts":"2026-04-07T00:14:29.753835Z","caller":"traceutil/trace.go:171","msg":"trace[1882625285] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1248; }","duration":"175.108607ms","start":"2026-04-07T00:14:29.578709Z","end":"2026-04-07T00:14:29.753817Z","steps":["trace[1882625285] 'range keys from in-memory index tree' (duration: 174.84651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:29.753851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.287523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-07T00:14:29.753908Z","caller":"traceutil/trace.go:171","msg":"trace[77349481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1248; }","duration":"103.380846ms","start":"2026-04-07T00:14:29.650511Z","end":"2026-04-07T00:14:29.753891Z","steps":["trace[77349481] 'range keys from in-memory index tree' (duration: 103.100509ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:29.922715Z","caller":"traceutil/trace.go:171","msg":"trace[1254978313] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"161.589148ms","start":"2026-04-07T00:14:29.761093Z","end":"2026-04-07T00:14:29.922682Z","steps":["trace[1254978313] 'process raft request' (duration: 157.718237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:29.93557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.493513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-07T00:14:29.93565Z","caller":"traceutil/trace.go:171","msg":"trace[282473848] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1251; }","duration":"102.624326ms","start":"2026-04-07T00:14:29.833009Z","end":"2026-04-07T00:14:29.935634Z","steps":["trace[282473848] 'agreement among raft nodes before linearized reading' (duration: 102.35214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:30.154249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.710171ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:14:30.154388Z","caller":"traceutil/trace.go:171","msg":"trace[787172876] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"218.367553ms","start":"2026-04-07T00:14:29.935997Z","end":"2026-04-07T00:14:30.154365Z","steps":["trace[787172876] 'process raft request' (duration: 108.210851ms)","trace[787172876] 'compare' (duration: 109.576707ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:14:30.178931Z","caller":"traceutil/trace.go:171","msg":"trace[30878359] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"240.552455ms","start":"2026-04-07T00:14:29.93836Z","end":"2026-04-07T00:14:30.178913Z","steps":["trace[30878359] 'process raft request' (duration: 240.276067ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:30.179203Z","caller":"traceutil/trace.go:171","msg":"trace[2027283971] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"240.159654ms","start":"2026-04-07T00:14:29.939016Z","end":"2026-04-07T00:14:30.179175Z","steps":["trace[2027283971] 'process raft request' (duration: 239.9728ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:30.17931Z","caller":"traceutil/trace.go:171","msg":"trace[1186433593] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"240.097223ms","start":"2026-04-07T00:14:29.939197Z","end":"2026-04-07T00:14:30.179294Z","steps":["trace[1186433593] 'process raft request' (duration: 239.860427ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:41.018728Z","caller":"traceutil/trace.go:171","msg":"trace[1656067745] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"253.268272ms","start":"2026-04-07T00:14:40.765432Z","end":"2026-04-07T00:14:41.018701Z","steps":["trace[1656067745] 'process raft request' (duration: 253.113979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:41.811223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.776257ms","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-07T00:14:41.811312Z","caller":"traceutil/trace.go:171","msg":"trace[959016041] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1342; }","duration":"550.914459ms","start":"2026-04-07T00:14:41.260374Z","end":"2026-04-07T00:14:41.811289Z","steps":["trace[959016041] 'range keys from in-memory index tree' (duration: 550.5263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:41.811325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.05403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-04-07T00:14:41.811357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:41.260348Z","time spent":"550.999352ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-07T00:14:41.811411Z","caller":"traceutil/trace.go:171","msg":"trace[1284918784] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1342; }","duration":"452.193554ms","start":"2026-04-07T00:14:41.359197Z","end":"2026-04-07T00:14:41.811391Z","steps":["trace[1284918784] 'count revisions from in-memory index tree' (duration: 451.920406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:41.811433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.783043ms","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-07T00:14:41.811527Z","caller":"traceutil/trace.go:171","msg":"trace[947431704] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1342; }","duration":"325.925256ms","start":"2026-04-07T00:14:41.485579Z","end":"2026-04-07T00:14:41.811504Z","steps":["trace[947431704] 'count revisions from in-memory index tree' (duration: 325.563247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:41.811547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.702685ms","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":"warn","ts":"2026-04-07T00:14:41.811577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:41.48556Z","time spent":"326.005368ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-07T00:14:41.811464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:41.359178Z","time spent":"452.275655ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":161,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-04-07T00:14:41.811625Z","caller":"traceutil/trace.go:171","msg":"trace[743467105] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1342; }","duration":"445.785719ms","start":"2026-04-07T00:14:41.365815Z","end":"2026-04-07T00:14:41.8116Z","steps":["trace[743467105] 'range keys from in-memory index tree' (duration: 445.539501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:41.811676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:41.365804Z","time spent":"445.86175ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T00:14:41.811389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.848045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:41.811732Z","caller":"traceutil/trace.go:171","msg":"trace[289099960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1342; }","duration":"383.242606ms","start":"2026-04-07T00:14:41.428476Z","end":"2026-04-07T00:14:41.811719Z","steps":["trace[289099960] 'range keys from in-memory index tree' (duration: 382.763102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:41.811776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:41.428457Z","time spent":"383.307257ms","remote":"127.0.0.1:53408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}