{"level":"warn","ts":"2026-04-07T00:10:16.423939Z","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:10:16.424023Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.206: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.206:2380","--initial-cluster=instance=https://199.19.213.206:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.206:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.206: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:10:16.424092Z","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:10:16.424109Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.206:2380"]} {"level":"info","ts":"2026-04-07T00:10:16.424125Z","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:10:16.424925Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"]} {"level":"info","ts":"2026-04-07T00:10:16.425Z","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.206:2380"],"listen-peer-urls":["https://199.19.213.206:2380"],"advertise-client-urls":["https://199.19.213.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.206: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:10:16.432825Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.608153ms"} {"level":"info","ts":"2026-04-07T00:10:16.443763Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b696d7a595057bfe","cluster-id":"9b00ba6f3f3b7ac2"} {"level":"info","ts":"2026-04-07T00:10:16.443855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T00:10:16.44388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became follower at term 0"} {"level":"info","ts":"2026-04-07T00:10:16.443898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b696d7a595057bfe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T00:10:16.443911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became follower at term 1"} {"level":"info","ts":"2026-04-07T00:10:16.443955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=(13156940467579223038)"} {"level":"warn","ts":"2026-04-07T00:10:16.453304Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T00:10:16.454681Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T00:10:16.455957Z","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:10:16.459369Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b696d7a595057bfe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T00:10:16.459817Z","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:10:16.459888Z","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:10:16.459914Z","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:10:16.460145Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b696d7a595057bfe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T00:10:16.46362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=(13156940467579223038)"} {"level":"info","ts":"2026-04-07T00:10:16.463726Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9b00ba6f3f3b7ac2","local-member-id":"b696d7a595057bfe","added-peer-id":"b696d7a595057bfe","added-peer-peer-urls":["https://199.19.213.206:2380"]} {"level":"info","ts":"2026-04-07T00:10:16.464876Z","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:10:16.46507Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b696d7a595057bfe","initial-advertise-peer-urls":["https://199.19.213.206:2380"],"listen-peer-urls":["https://199.19.213.206:2380"],"advertise-client-urls":["https://199.19.213.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T00:10:16.465106Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T00:10:16.465157Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.206:2380"} {"level":"info","ts":"2026-04-07T00:10:16.465177Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.206:2380"} {"level":"info","ts":"2026-04-07T00:10:16.645055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T00:10:16.645117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T00:10:16.645142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe received MsgPreVoteResp from b696d7a595057bfe at term 1"} {"level":"info","ts":"2026-04-07T00:10:16.64516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became candidate at term 2"} {"level":"info","ts":"2026-04-07T00:10:16.645172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe received MsgVoteResp from b696d7a595057bfe at term 2"} {"level":"info","ts":"2026-04-07T00:10:16.645186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became leader at term 2"} {"level":"info","ts":"2026-04-07T00:10:16.645198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b696d7a595057bfe elected leader b696d7a595057bfe at term 2"} {"level":"info","ts":"2026-04-07T00:10:16.646268Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:10:16.646892Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b696d7a595057bfe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.206:2379]}","request-path":"/0/members/b696d7a595057bfe/attributes","cluster-id":"9b00ba6f3f3b7ac2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T00:10:16.647061Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:10:16.64743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:10:16.649141Z","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:10:16.650626Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9b00ba6f3f3b7ac2","local-member-id":"b696d7a595057bfe","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:10:16.650715Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:10:16.650738Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:10:16.650772Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T00:10:16.650804Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T00:10:16.651107Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.206:2379"} {"level":"info","ts":"2026-04-07T00:10:46.128442Z","caller":"traceutil/trace.go:171","msg":"trace[549294170] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"262.421703ms","start":"2026-04-07T00:10:45.865993Z","end":"2026-04-07T00:10:46.128414Z","steps":["trace[549294170] 'process raft request' (duration: 262.261329ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.135767Z","caller":"traceutil/trace.go:171","msg":"trace[519592226] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"264.573091ms","start":"2026-04-07T00:10:45.871164Z","end":"2026-04-07T00:10:46.135737Z","steps":["trace[519592226] 'process raft request' (duration: 264.358817ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.136042Z","caller":"traceutil/trace.go:171","msg":"trace[1738309532] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"234.781686ms","start":"2026-04-07T00:10:45.901254Z","end":"2026-04-07T00:10:46.136036Z","steps":["trace[1738309532] 'process raft request' (duration: 234.577073ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.135816Z","caller":"traceutil/trace.go:171","msg":"trace[816149641] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"257.684487ms","start":"2026-04-07T00:10:45.878109Z","end":"2026-04-07T00:10:46.135793Z","steps":["trace[816149641] 'process raft request' (duration: 257.538325ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.136127Z","caller":"traceutil/trace.go:171","msg":"trace[1192460999] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"226.847644ms","start":"2026-04-07T00:10:45.909267Z","end":"2026-04-07T00:10:46.136115Z","steps":["trace[1192460999] 'process raft request' (duration: 226.687251ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.135873Z","caller":"traceutil/trace.go:171","msg":"trace[585433397] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"254.426029ms","start":"2026-04-07T00:10:45.881441Z","end":"2026-04-07T00:10:46.135867Z","steps":["trace[585433397] 'process raft request' (duration: 254.295947ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.135906Z","caller":"traceutil/trace.go:171","msg":"trace[1857480015] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"254.771395ms","start":"2026-04-07T00:10:45.881106Z","end":"2026-04-07T00:10:46.135877Z","steps":["trace[1857480015] 'process raft request' (duration: 254.605772ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.135871Z","caller":"traceutil/trace.go:171","msg":"trace[493635569] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"263.769397ms","start":"2026-04-07T00:10:45.872066Z","end":"2026-04-07T00:10:46.135835Z","steps":["trace[493635569] 'process raft request' (duration: 263.551573ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.136425Z","caller":"traceutil/trace.go:171","msg":"trace[2074071054] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"107.877137ms","start":"2026-04-07T00:10:46.028535Z","end":"2026-04-07T00:10:46.136412Z","steps":["trace[2074071054] 'process raft request' (duration: 107.821596ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.135923Z","caller":"traceutil/trace.go:171","msg":"trace[1572960987] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"253.603174ms","start":"2026-04-07T00:10:45.882292Z","end":"2026-04-07T00:10:46.135895Z","steps":["trace[1572960987] 'process raft request' (duration: 253.478902ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.13596Z","caller":"traceutil/trace.go:171","msg":"trace[2054465401] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"249.437099ms","start":"2026-04-07T00:10:45.886511Z","end":"2026-04-07T00:10:46.135948Z","steps":["trace[2054465401] 'process raft request' (duration: 249.288236ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:46.136333Z","caller":"traceutil/trace.go:171","msg":"trace[1753766602] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"210.329936ms","start":"2026-04-07T00:10:45.925996Z","end":"2026-04-07T00:10:46.136326Z","steps":["trace[1753766602] 'process raft request' (duration: 210.027871ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:52.455438Z","caller":"traceutil/trace.go:171","msg":"trace[461781176] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"192.053928ms","start":"2026-04-07T00:10:52.263365Z","end":"2026-04-07T00:10:52.455419Z","steps":["trace[461781176] 'process raft request' (duration: 191.951397ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:52.655113Z","caller":"traceutil/trace.go:171","msg":"trace[2038707384] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"222.797221ms","start":"2026-04-07T00:10:52.432282Z","end":"2026-04-07T00:10:52.655079Z","steps":["trace[2038707384] 'process raft request' (duration: 205.633083ms)","trace[2038707384] 'compare' (duration: 16.20306ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:10:53.147704Z","caller":"traceutil/trace.go:171","msg":"trace[1985650099] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"434.409112ms","start":"2026-04-07T00:10:52.713217Z","end":"2026-04-07T00:10:53.147626Z","steps":["trace[1985650099] 'read index received' (duration: 380.093766ms)","trace[1985650099] 'applied index is now lower than readState.Index' (duration: 54.313085ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:10:53.147825Z","caller":"traceutil/trace.go:171","msg":"trace[1433170904] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"435.837406ms","start":"2026-04-07T00:10:52.71194Z","end":"2026-04-07T00:10:53.147777Z","steps":["trace[1433170904] 'process raft request' (duration: 381.360768ms)","trace[1433170904] 'compare' (duration: 53.932578ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:10:53.148283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.009892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fm58v\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-07T00:10:53.148372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.212119ms","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:10:53.148402Z","caller":"traceutil/trace.go:171","msg":"trace[531470307] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fm58v; range_end:; response_count:1; response_revision:622; }","duration":"435.190194ms","start":"2026-04-07T00:10:52.713187Z","end":"2026-04-07T00:10:53.148377Z","steps":["trace[531470307] 'agreement among raft nodes before linearized reading' (duration: 434.727776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:53.148372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.110233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T00:10:53.148457Z","caller":"traceutil/trace.go:171","msg":"trace[1771780865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"418.334071ms","start":"2026-04-07T00:10:52.730092Z","end":"2026-04-07T00:10:53.148426Z","steps":["trace[1771780865] 'agreement among raft nodes before linearized reading' (duration: 418.067437ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:53.148466Z","caller":"traceutil/trace.go:171","msg":"trace[1997445841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"406.242035ms","start":"2026-04-07T00:10:52.742202Z","end":"2026-04-07T00:10:53.148444Z","steps":["trace[1997445841] 'agreement among raft nodes before linearized reading' (duration: 405.97353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:53.148459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:52.713177Z","time spent":"435.268437ms","remote":"127.0.0.1:47836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-fm58v\" "} {"level":"warn","ts":"2026-04-07T00:10:53.148519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:52.742187Z","time spent":"406.323196ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T00:10:53.148516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:52.730072Z","time spent":"418.433503ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T00:10:53.148919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:52.711922Z","time spent":"436.004269ms","remote":"127.0.0.1:47892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:10:53.14904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.564837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:10:53.149215Z","caller":"traceutil/trace.go:171","msg":"trace[2085526589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"418.73903ms","start":"2026-04-07T00:10:52.730453Z","end":"2026-04-07T00:10:53.149192Z","steps":["trace[2085526589] 'agreement among raft nodes before linearized reading' (duration: 417.826273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:53.149372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:52.730402Z","time spent":"418.952543ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T00:10:53.486885Z","caller":"traceutil/trace.go:171","msg":"trace[1762060782] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"332.059903ms","start":"2026-04-07T00:10:53.154803Z","end":"2026-04-07T00:10:53.486863Z","steps":["trace[1762060782] 'process raft request' (duration: 262.520854ms)","trace[1762060782] 'compare' (duration: 69.185213ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:10:53.48715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:53.154767Z","time spent":"332.174114ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:10:53.487425Z","caller":"traceutil/trace.go:171","msg":"trace[1262262064] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"332.600342ms","start":"2026-04-07T00:10:53.154788Z","end":"2026-04-07T00:10:53.487389Z","steps":["trace[1262262064] 'process raft request' (duration: 332.087163ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:53.487525Z","caller":"traceutil/trace.go:171","msg":"trace[1763752431] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"330.987344ms","start":"2026-04-07T00:10:53.156528Z","end":"2026-04-07T00:10:53.487515Z","steps":["trace[1763752431] 'process raft request' (duration: 330.541505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:53.487571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:53.156107Z","time spent":"331.439252ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:10:53.487664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:53.154771Z","time spent":"332.780716ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:10:53.48774Z","caller":"traceutil/trace.go:171","msg":"trace[698363327] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"322.589433ms","start":"2026-04-07T00:10:53.165143Z","end":"2026-04-07T00:10:53.487732Z","steps":["trace[698363327] 'process raft request' (duration: 322.060043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:53.487785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:53.165115Z","time spent":"322.648544ms","remote":"127.0.0.1:47836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:10:53.487752Z","caller":"traceutil/trace.go:171","msg":"trace[923384431] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:641; }","duration":"330.284161ms","start":"2026-04-07T00:10:53.157318Z","end":"2026-04-07T00:10:53.487602Z","steps":["trace[923384431] 'read index received' (duration: 260.019788ms)","trace[923384431] 'applied index is now lower than readState.Index' (duration: 70.263362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:10:53.487864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.570736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-07T00:10:53.488001Z","caller":"traceutil/trace.go:171","msg":"trace[1134147526] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:626; }","duration":"330.717818ms","start":"2026-04-07T00:10:53.157268Z","end":"2026-04-07T00:10:53.487986Z","steps":["trace[1134147526] 'agreement among raft nodes before linearized reading' (duration: 330.563125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:53.488193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:53.157257Z","time spent":"330.904571ms","remote":"127.0.0.1:47848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-04-07T00:11:09.43505Z","caller":"traceutil/trace.go:171","msg":"trace[2093760278] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"177.030718ms","start":"2026-04-07T00:11:09.257964Z","end":"2026-04-07T00:11:09.434995Z","steps":["trace[2093760278] 'process raft request' (duration: 176.888066ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:42.962348Z","caller":"traceutil/trace.go:171","msg":"trace[1267915022] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"123.867939ms","start":"2026-04-07T00:11:42.838437Z","end":"2026-04-07T00:11:42.962305Z","steps":["trace[1267915022] 'process raft request' (duration: 123.721696ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:43.325283Z","caller":"traceutil/trace.go:171","msg":"trace[1360853010] linearizableReadLoop","detail":"{readStateIndex:1029; appliedIndex:1028; }","duration":"234.57496ms","start":"2026-04-07T00:11:43.090674Z","end":"2026-04-07T00:11:43.325249Z","steps":["trace[1360853010] 'read index received' (duration: 234.262343ms)","trace[1360853010] 'applied index is now lower than readState.Index' (duration: 309.137µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:11:43.325541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.848935ms","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:11:43.325585Z","caller":"traceutil/trace.go:171","msg":"trace[827147341] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:999; }","duration":"234.945186ms","start":"2026-04-07T00:11:43.090625Z","end":"2026-04-07T00:11:43.32557Z","steps":["trace[827147341] 'agreement among raft nodes before linearized reading' (duration: 234.764643ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:43.325588Z","caller":"traceutil/trace.go:171","msg":"trace[2128800182] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"248.94331ms","start":"2026-04-07T00:11:43.076621Z","end":"2026-04-07T00:11:43.325564Z","steps":["trace[2128800182] 'process raft request' (duration: 248.40751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:04.310363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.493744ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:12:04.310438Z","caller":"traceutil/trace.go:171","msg":"trace[389912823] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"340.031749ms","start":"2026-04-07T00:12:03.970394Z","end":"2026-04-07T00:12:04.310425Z","steps":["trace[389912823] 'process raft request' (duration: 146.277211ms)","trace[389912823] 'compare' (duration: 193.048966ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:04.310471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:03.970367Z","time spent":"340.089251ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:12:04.325826Z","caller":"traceutil/trace.go:171","msg":"trace[2036753010] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1101; }","duration":"314.118328ms","start":"2026-04-07T00:12:04.011687Z","end":"2026-04-07T00:12:04.325805Z","steps":["trace[2036753010] 'read index received' (duration: 105.081403ms)","trace[2036753010] 'applied index is now lower than readState.Index' (duration: 209.036235ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:04.325936Z","caller":"traceutil/trace.go:171","msg":"trace[96902217] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"355.053042ms","start":"2026-04-07T00:12:03.970846Z","end":"2026-04-07T00:12:04.325899Z","steps":["trace[96902217] 'process raft request' (duration: 354.864718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:04.326017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.313132ms","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:04.326107Z","caller":"traceutil/trace.go:171","msg":"trace[1728093698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1069; }","duration":"314.423723ms","start":"2026-04-07T00:12:04.011662Z","end":"2026-04-07T00:12:04.326086Z","steps":["trace[1728093698] 'agreement among raft nodes before linearized reading' (duration: 314.25242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:04.326138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:04.011652Z","time spent":"314.480774ms","remote":"127.0.0.1:47666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T00:12:04.326115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:03.97082Z","time spent":"355.206244ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:12:05.514189Z","caller":"traceutil/trace.go:171","msg":"trace[90406082] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"109.57598ms","start":"2026-04-07T00:12:05.404581Z","end":"2026-04-07T00:12:05.514157Z","steps":["trace[90406082] 'process raft request' (duration: 109.088112ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:18.928753Z","caller":"traceutil/trace.go:171","msg":"trace[301650039] linearizableReadLoop","detail":"{readStateIndex:1204; appliedIndex:1203; }","duration":"429.987056ms","start":"2026-04-07T00:12:18.498739Z","end":"2026-04-07T00:12:18.928726Z","steps":["trace[301650039] 'read index received' (duration: 429.815583ms)","trace[301650039] 'applied index is now lower than readState.Index' (duration: 170.413µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:18.929081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.314422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T00:12:18.929156Z","caller":"traceutil/trace.go:171","msg":"trace[1842084140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1165; }","duration":"430.424785ms","start":"2026-04-07T00:12:18.49871Z","end":"2026-04-07T00:12:18.929134Z","steps":["trace[1842084140] 'agreement among raft nodes before linearized reading' (duration: 430.20476ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:18.929172Z","caller":"traceutil/trace.go:171","msg":"trace[2141229859] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"459.537782ms","start":"2026-04-07T00:12:18.469614Z","end":"2026-04-07T00:12:18.929152Z","steps":["trace[2141229859] 'process raft request' (duration: 458.968742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:18.929197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:18.498694Z","time spent":"430.494526ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T00:12:18.929509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:18.469587Z","time spent":"459.744266ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:12:31.880265Z","caller":"traceutil/trace.go:171","msg":"trace[109869245] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"217.940914ms","start":"2026-04-07T00:12:31.662303Z","end":"2026-04-07T00:12:31.880244Z","steps":["trace[109869245] 'read index received' (duration: 217.751111ms)","trace[109869245] 'applied index is now lower than readState.Index' (duration: 188.923µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:31.88033Z","caller":"traceutil/trace.go:171","msg":"trace[1686923494] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"288.045325ms","start":"2026-04-07T00:12:31.592263Z","end":"2026-04-07T00:12:31.880308Z","steps":["trace[1686923494] 'process raft request' (duration: 287.852822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:31.880403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.090388ms","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:31.880434Z","caller":"traceutil/trace.go:171","msg":"trace[1427152685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1209; }","duration":"218.173379ms","start":"2026-04-07T00:12:31.662251Z","end":"2026-04-07T00:12:31.880425Z","steps":["trace[1427152685] 'agreement among raft nodes before linearized reading' (duration: 218.105808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:31.880561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.562846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T00:12:31.880594Z","caller":"traceutil/trace.go:171","msg":"trace[2027444031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1209; }","duration":"193.632978ms","start":"2026-04-07T00:12:31.68695Z","end":"2026-04-07T00:12:31.880583Z","steps":["trace[2027444031] 'agreement among raft nodes before linearized reading' (duration: 193.524196ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:36.03519Z","caller":"traceutil/trace.go:171","msg":"trace[1332503993] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1291; }","duration":"137.480872ms","start":"2026-04-07T00:12:35.897689Z","end":"2026-04-07T00:12:36.03517Z","steps":["trace[1332503993] 'read index received' (duration: 137.243828ms)","trace[1332503993] 'applied index is now lower than readState.Index' (duration: 236.074µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:36.035257Z","caller":"traceutil/trace.go:171","msg":"trace[288926568] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"141.815102ms","start":"2026-04-07T00:12:35.893409Z","end":"2026-04-07T00:12:36.035225Z","steps":["trace[288926568] 'process raft request' (duration: 141.618459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:36.036246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.477521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T00:12:36.036361Z","caller":"traceutil/trace.go:171","msg":"trace[1250155077] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1249; }","duration":"138.688155ms","start":"2026-04-07T00:12:35.897655Z","end":"2026-04-07T00:12:36.036343Z","steps":["trace[1250155077] 'agreement among raft nodes before linearized reading' (duration: 138.40461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:36.270558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.709499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:12:36.270655Z","caller":"traceutil/trace.go:171","msg":"trace[1609036297] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1292; }","duration":"123.921242ms","start":"2026-04-07T00:12:36.146718Z","end":"2026-04-07T00:12:36.27064Z","steps":["trace[1609036297] 'read index received' (duration: 37.3µs)","trace[1609036297] 'applied index is now lower than readState.Index' (duration: 123.882682ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:36.270738Z","caller":"traceutil/trace.go:171","msg":"trace[132032559] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"228.899796ms","start":"2026-04-07T00:12:36.041813Z","end":"2026-04-07T00:12:36.270713Z","steps":["trace[132032559] 'process raft request' (duration: 66.949753ms)","trace[132032559] 'compare' (duration: 161.491135ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:36.270788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.066114ms","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.270824Z","caller":"traceutil/trace.go:171","msg":"trace[161216238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1250; }","duration":"124.136366ms","start":"2026-04-07T00:12:36.146677Z","end":"2026-04-07T00:12:36.270814Z","steps":["trace[161216238] 'agreement among raft nodes before linearized reading' (duration: 124.003054ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:37.189608Z","caller":"traceutil/trace.go:171","msg":"trace[2068653769] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"169.311528ms","start":"2026-04-07T00:12:37.020261Z","end":"2026-04-07T00:12:37.189572Z","steps":["trace[2068653769] 'process raft request' (duration: 169.067334ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:37.465734Z","caller":"traceutil/trace.go:171","msg":"trace[3526336] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1294; }","duration":"380.317086ms","start":"2026-04-07T00:12:37.085394Z","end":"2026-04-07T00:12:37.465711Z","steps":["trace[3526336] 'read index received' (duration: 103.868313ms)","trace[3526336] 'applied index is now lower than readState.Index' (duration: 276.447513ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:37.465923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.49624ms","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:37.465951Z","caller":"traceutil/trace.go:171","msg":"trace[1796417533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1253; }","duration":"380.599831ms","start":"2026-04-07T00:12:37.085344Z","end":"2026-04-07T00:12:37.465944Z","steps":["trace[1796417533] 'agreement among raft nodes before linearized reading' (duration: 380.448779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:37.465977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:37.08532Z","time spent":"380.651453ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T00:12:37.466259Z","caller":"traceutil/trace.go:171","msg":"trace[1449365299] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"442.473422ms","start":"2026-04-07T00:12:37.023773Z","end":"2026-04-07T00:12:37.466246Z","steps":["trace[1449365299] 'process raft request' (duration: 441.762829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:37.466352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:37.023747Z","time spent":"442.548072ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:12:38.457481Z","caller":"traceutil/trace.go:171","msg":"trace[1519903009] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"143.194978ms","start":"2026-04-07T00:12:38.314254Z","end":"2026-04-07T00:12:38.457449Z","steps":["trace[1519903009] 'process raft request' (duration: 94.207845ms)","trace[1519903009] 'compare' (duration: 48.784259ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:12:49.39911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.512257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-07T00:12:49.399177Z","caller":"traceutil/trace.go:171","msg":"trace[1927884889] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1333; }","duration":"160.63454ms","start":"2026-04-07T00:12:49.238528Z","end":"2026-04-07T00:12:49.399162Z","steps":["trace[1927884889] 'range keys from in-memory index tree' (duration: 160.351405ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:49.719066Z","caller":"traceutil/trace.go:171","msg":"trace[438414859] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"190.52076ms","start":"2026-04-07T00:12:49.528507Z","end":"2026-04-07T00:12:49.719027Z","steps":["trace[438414859] 'read index received' (duration: 190.223235ms)","trace[438414859] 'applied index is now lower than readState.Index' (duration: 296.195µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:12:49.719237Z","caller":"traceutil/trace.go:171","msg":"trace[1303366326] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"315.879759ms","start":"2026-04-07T00:12:49.403319Z","end":"2026-04-07T00:12:49.719199Z","steps":["trace[1303366326] 'process raft request' (duration: 315.456422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:49.719399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:12:49.403292Z","time spent":"316.021361ms","remote":"127.0.0.1:47924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:12:49.719467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.766549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T00:12:49.719564Z","caller":"traceutil/trace.go:171","msg":"trace[579397141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1334; }","duration":"162.912792ms","start":"2026-04-07T00:12:49.556626Z","end":"2026-04-07T00:12:49.719539Z","steps":["trace[579397141] 'agreement among raft nodes before linearized reading' (duration: 162.652246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:49.719747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.223743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T00:12:49.71982Z","caller":"traceutil/trace.go:171","msg":"trace[844867357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1334; }","duration":"191.307225ms","start":"2026-04-07T00:12:49.528494Z","end":"2026-04-07T00:12:49.719802Z","steps":["trace[844867357] 'agreement among raft nodes before linearized reading' (duration: 190.709583ms)"],"step_count":1}