{"level":"warn","ts":"2026-05-20T17:21:52.111489Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T17:21:52.111598Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-20T17:21:52.111689Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T17:21:52.111704Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-05-20T17:21:52.111728Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T17:21:52.112482Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-05-20T17:21:52.11257Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-20T17:21:52.116496Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.669865ms"} {"level":"info","ts":"2026-05-20T17:21:52.124769Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-05-20T17:21:52.124849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T17:21:52.124875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-05-20T17:21:52.124889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T17:21:52.124904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-05-20T17:21:52.124949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-05-20T17:21:52.131778Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T17:21:52.133328Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T17:21:52.134468Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-20T17:21:52.136741Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T17:21:52.13688Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T17:21:52.136984Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T17:21:52.137047Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T17:21:52.137059Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T17:21:52.13861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-05-20T17:21:52.139932Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-05-20T17:21:52.143254Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T17:21:52.143465Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-05-20T17:21:52.143516Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-05-20T17:21:52.143541Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T17:21:52.143609Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T17:21:52.225895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T17:21:52.226148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T17:21:52.226278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-05-20T17:21:52.226406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-05-20T17:21:52.226524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-05-20T17:21:52.226639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-05-20T17:21:52.226727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-05-20T17:21:52.227937Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T17:21:52.228217Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T17:21:52.228353Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T17:21:52.228486Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T17:21:52.228736Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T17:21:52.228856Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T17:21:52.229555Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T17:21:52.229801Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T17:21:52.229846Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T17:21:52.232378Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-20T17:21:52.23361Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-05-20T17:21:54.991983Z","caller":"traceutil/trace.go:171","msg":"trace[1357208296] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"168.525235ms","start":"2026-05-20T17:21:54.823429Z","end":"2026-05-20T17:21:54.991954Z","steps":["trace[1357208296] 'process raft request' (duration: 168.302522ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:54.991946Z","caller":"traceutil/trace.go:171","msg":"trace[525736601] linearizableReadLoop","detail":"{readStateIndex:118; appliedIndex:117; }","duration":"167.44231ms","start":"2026-05-20T17:21:54.824473Z","end":"2026-05-20T17:21:54.991915Z","steps":["trace[525736601] 'read index received' (duration: 167.164866ms)","trace[525736601] 'applied index is now lower than readState.Index' (duration: 276.244µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:21:54.992161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.648983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T17:21:54.992295Z","caller":"traceutil/trace.go:171","msg":"trace[1939772142] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:113; }","duration":"167.807755ms","start":"2026-05-20T17:21:54.824469Z","end":"2026-05-20T17:21:54.992276Z","steps":["trace[1939772142] 'agreement among raft nodes before linearized reading' (duration: 167.566062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:21:57.522434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.241296ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T17:21:57.522694Z","caller":"traceutil/trace.go:171","msg":"trace[586146552] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"148.390928ms","start":"2026-05-20T17:21:57.37427Z","end":"2026-05-20T17:21:57.522661Z","steps":["trace[586146552] 'process raft request' (duration: 148.325417ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:57.522698Z","caller":"traceutil/trace.go:171","msg":"trace[90556417] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"216.971917ms","start":"2026-05-20T17:21:57.305687Z","end":"2026-05-20T17:21:57.522659Z","steps":["trace[90556417] 'process raft request' (duration: 64.842979ms)","trace[90556417] 'compare' (duration: 151.049404ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:21:57.522941Z","caller":"traceutil/trace.go:171","msg":"trace[1609848618] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:291; }","duration":"215.65835ms","start":"2026-05-20T17:21:57.307235Z","end":"2026-05-20T17:21:57.522893Z","steps":["trace[1609848618] 'read index received' (duration: 63.289389ms)","trace[1609848618] 'applied index is now lower than readState.Index' (duration: 152.362251ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:21:57.523128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.885223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-20T17:21:57.523182Z","caller":"traceutil/trace.go:171","msg":"trace[482788378] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:287; }","duration":"215.970004ms","start":"2026-05-20T17:21:57.307197Z","end":"2026-05-20T17:21:57.523167Z","steps":["trace[482788378] 'agreement among raft nodes before linearized reading' (duration: 215.795661ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:57.680761Z","caller":"traceutil/trace.go:171","msg":"trace[1679691321] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"211.747417ms","start":"2026-05-20T17:21:57.468957Z","end":"2026-05-20T17:21:57.680704Z","steps":["trace[1679691321] 'process raft request' (duration: 208.891678ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:57.681023Z","caller":"traceutil/trace.go:171","msg":"trace[694766911] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:293; }","duration":"157.958186ms","start":"2026-05-20T17:21:57.523036Z","end":"2026-05-20T17:21:57.680994Z","steps":["trace[694766911] 'read index received' (duration: 154.845195ms)","trace[694766911] 'applied index is now lower than readState.Index' (duration: 3.111481ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:21:57.681133Z","caller":"traceutil/trace.go:171","msg":"trace[511228453] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"199.93221ms","start":"2026-05-20T17:21:57.481168Z","end":"2026-05-20T17:21:57.6811Z","steps":["trace[511228453] 'process raft request' (duration: 199.713416ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:57.681184Z","caller":"traceutil/trace.go:171","msg":"trace[520666632] transaction","detail":"{read_only:false; number_of_response:0; response_revision:290; }","duration":"199.486884ms","start":"2026-05-20T17:21:57.481686Z","end":"2026-05-20T17:21:57.681173Z","steps":["trace[520666632] 'process raft request' (duration: 199.24327ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:57.68127Z","caller":"traceutil/trace.go:171","msg":"trace[1879357835] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"200.255394ms","start":"2026-05-20T17:21:57.481001Z","end":"2026-05-20T17:21:57.681256Z","steps":["trace[1879357835] 'process raft request' (duration: 199.634105ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:57.681347Z","caller":"traceutil/trace.go:171","msg":"trace[745358750] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"200.221354ms","start":"2026-05-20T17:21:57.481119Z","end":"2026-05-20T17:21:57.68134Z","steps":["trace[745358750] 'process raft request' (duration: 199.715676ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:57.681415Z","caller":"traceutil/trace.go:171","msg":"trace[1395055951] transaction","detail":"{read_only:false; number_of_response:0; response_revision:290; }","duration":"199.451564ms","start":"2026-05-20T17:21:57.481949Z","end":"2026-05-20T17:21:57.681401Z","steps":["trace[1395055951] 'process raft request' (duration: 199.009247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:21:57.681456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.945383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T17:21:57.681527Z","caller":"traceutil/trace.go:171","msg":"trace[266715677] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:290; }","duration":"307.067895ms","start":"2026-05-20T17:21:57.374441Z","end":"2026-05-20T17:21:57.681509Z","steps":["trace[266715677] 'agreement among raft nodes before linearized reading' (duration: 306.930403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:21:57.681516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.174087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-20T17:21:57.681591Z","caller":"traceutil/trace.go:171","msg":"trace[1080677490] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:290; }","duration":"307.274088ms","start":"2026-05-20T17:21:57.374288Z","end":"2026-05-20T17:21:57.681563Z","steps":["trace[1080677490] 'agreement among raft nodes before linearized reading' (duration: 307.107956ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:21:57.681567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:21:57.374421Z","time spent":"307.135426ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-05-20T17:21:57.681625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:21:57.374265Z","time spent":"307.351749ms","remote":"127.0.0.1:37368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-20T17:21:57.684646Z","caller":"traceutil/trace.go:171","msg":"trace[1769191100] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"157.122996ms","start":"2026-05-20T17:21:57.527492Z","end":"2026-05-20T17:21:57.684615Z","steps":["trace[1769191100] 'process raft request' (duration: 156.947013ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:21:57.685196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.256911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-20T17:21:57.685276Z","caller":"traceutil/trace.go:171","msg":"trace[903752774] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:292; }","duration":"158.387773ms","start":"2026-05-20T17:21:57.526871Z","end":"2026-05-20T17:21:57.685258Z","steps":["trace[903752774] 'agreement among raft nodes before linearized reading' (duration: 158.197391ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:21:57.685459Z","caller":"traceutil/trace.go:171","msg":"trace[3628517] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"153.327565ms","start":"2026-05-20T17:21:57.532113Z","end":"2026-05-20T17:21:57.68544Z","steps":["trace[3628517] 'process raft request' (duration: 152.428974ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:03.768263Z","caller":"traceutil/trace.go:171","msg":"trace[1522158718] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"742.306152ms","start":"2026-05-20T17:22:03.025922Z","end":"2026-05-20T17:22:03.768228Z","steps":["trace[1522158718] 'process raft request' (duration: 742.106599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:03.769051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:03.025899Z","time spent":"742.489806ms","remote":"127.0.0.1:37262","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-05-20T17:22:05.441127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.33833221s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T17:22:05.441239Z","caller":"traceutil/trace.go:171","msg":"trace[395853215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:392; }","duration":"1.338465302s","start":"2026-05-20T17:22:04.102755Z","end":"2026-05-20T17:22:05.44122Z","steps":["trace[395853215] 'range keys from in-memory index tree' (duration: 1.338230188s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:05.44125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028897121s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-20T17:22:05.441281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:04.102679Z","time spent":"1.338591573s","remote":"127.0.0.1:36962","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-05-20T17:22:05.441303Z","caller":"traceutil/trace.go:171","msg":"trace[942384339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:392; }","duration":"1.028989262s","start":"2026-05-20T17:22:04.4123Z","end":"2026-05-20T17:22:05.441289Z","steps":["trace[942384339] 'range keys from in-memory index tree' (duration: 1.02879889s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:05.441349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:04.412276Z","time spent":"1.029062173s","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T17:22:05.441473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.332349782s","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-05-20T17:22:05.441568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.400285872s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T17:22:05.441609Z","caller":"traceutil/trace.go:171","msg":"trace[923409225] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:392; }","duration":"1.332695527s","start":"2026-05-20T17:22:04.108891Z","end":"2026-05-20T17:22:05.441586Z","steps":["trace[923409225] 'range keys from in-memory index tree' (duration: 1.332155419s)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:05.441665Z","caller":"traceutil/trace.go:171","msg":"trace[1935082755] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:392; }","duration":"1.400461245s","start":"2026-05-20T17:22:04.041184Z","end":"2026-05-20T17:22:05.441646Z","steps":["trace[1935082755] 'range keys from in-memory index tree' (duration: 1.400080079s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:05.441677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:04.10887Z","time spent":"1.332791658s","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T17:22:05.441716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:04.041156Z","time spent":"1.400550257s","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T17:22:05.441735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.65594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T17:22:05.44179Z","caller":"traceutil/trace.go:171","msg":"trace[696660124] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"949.587992ms","start":"2026-05-20T17:22:04.492191Z","end":"2026-05-20T17:22:05.441779Z","steps":["trace[696660124] 'process raft request' (duration: 388.8223ms)","trace[696660124] 'compare' (duration: 560.092802ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:22:05.441849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:04.492161Z","time spent":"949.666113ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T17:22:26.791582Z","caller":"traceutil/trace.go:171","msg":"trace[1682160121] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"661.014017ms","start":"2026-05-20T17:22:26.130544Z","end":"2026-05-20T17:22:26.791558Z","steps":["trace[1682160121] 'process raft request' (duration: 660.667551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:26.792176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:26.130514Z","time spent":"661.576018ms","remote":"127.0.0.1:37064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T17:22:29.004303Z","caller":"traceutil/trace.go:171","msg":"trace[294049629] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"380.132563ms","start":"2026-05-20T17:22:28.62414Z","end":"2026-05-20T17:22:29.004273Z","steps":["trace[294049629] 'process raft request' (duration: 288.855598ms)","trace[294049629] 'compare' (duration: 91.105222ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:22:29.004464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.624123Z","time spent":"380.273905ms","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T17:22:29.193647Z","caller":"traceutil/trace.go:171","msg":"trace[221876298] transaction","detail":"{read_only:false; number_of_response:1; response_revision:537; }","duration":"562.889227ms","start":"2026-05-20T17:22:28.630722Z","end":"2026-05-20T17:22:29.193611Z","steps":["trace[221876298] 'process raft request' (duration: 561.717065ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:29.193546Z","caller":"traceutil/trace.go:171","msg":"trace[139078504] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"567.052174ms","start":"2026-05-20T17:22:28.626435Z","end":"2026-05-20T17:22:29.193487Z","steps":["trace[139078504] 'process raft request' (duration: 556.934646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:29.19383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.630691Z","time spent":"563.04304ms","remote":"127.0.0.1:37012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T17:22:29.194121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.626428Z","time spent":"567.355569ms","remote":"127.0.0.1:37012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T17:22:29.194236Z","caller":"traceutil/trace.go:171","msg":"trace[651694725] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"561.652065ms","start":"2026-05-20T17:22:28.632359Z","end":"2026-05-20T17:22:29.194012Z","steps":["trace[651694725] 'process raft request' (duration: 560.283529ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:29.194291Z","caller":"traceutil/trace.go:171","msg":"trace[271535279] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"560.011344ms","start":"2026-05-20T17:22:28.634265Z","end":"2026-05-20T17:22:29.194276Z","steps":["trace[271535279] 'process raft request' (duration: 559.418993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:29.194414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.634257Z","time spent":"560.052985ms","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T17:22:29.194441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.63235Z","time spent":"561.94546ms","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T17:22:29.194828Z","caller":"traceutil/trace.go:171","msg":"trace[1549958626] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"558.489675ms","start":"2026-05-20T17:22:28.63631Z","end":"2026-05-20T17:22:29.1948Z","steps":["trace[1549958626] 'process raft request' (duration: 557.476377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:29.194967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.6363Z","time spent":"558.587718ms","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T17:22:29.199293Z","caller":"traceutil/trace.go:171","msg":"trace[1741483906] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"544.982699ms","start":"2026-05-20T17:22:28.654285Z","end":"2026-05-20T17:22:29.199268Z","steps":["trace[1741483906] 'process raft request' (duration: 544.732704ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:29.19932Z","caller":"traceutil/trace.go:171","msg":"trace[780333403] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:556; }","duration":"125.556288ms","start":"2026-05-20T17:22:29.073677Z","end":"2026-05-20T17:22:29.199233Z","steps":["trace[780333403] 'read index received' (duration: 109.709805ms)","trace[780333403] 'applied index is now lower than readState.Index' (duration: 15.845573ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:22:29.199413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.723482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T17:22:29.199425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.654276Z","time spent":"545.073912ms","remote":"127.0.0.1:37012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T17:22:29.199473Z","caller":"traceutil/trace.go:171","msg":"trace[1076693552] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"537.301829ms","start":"2026-05-20T17:22:28.662163Z","end":"2026-05-20T17:22:29.199465Z","steps":["trace[1076693552] 'process raft request' (duration: 536.908142ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:29.199544Z","caller":"traceutil/trace.go:171","msg":"trace[1892259930] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"556.960099ms","start":"2026-05-20T17:22:28.642575Z","end":"2026-05-20T17:22:29.199535Z","steps":["trace[1892259930] 'process raft request' (duration: 555.138005ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:29.199547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.66214Z","time spent":"537.35994ms","remote":"127.0.0.1:37012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T17:22:29.199586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.642566Z","time spent":"556.99988ms","remote":"127.0.0.1:37012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T17:22:29.199441Z","caller":"traceutil/trace.go:171","msg":"trace[2044239306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"125.770712ms","start":"2026-05-20T17:22:29.073663Z","end":"2026-05-20T17:22:29.199434Z","steps":["trace[2044239306] 'agreement among raft nodes before linearized reading' (duration: 125.700331ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:29.199661Z","caller":"traceutil/trace.go:171","msg":"trace[119796197] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"554.360291ms","start":"2026-05-20T17:22:28.645293Z","end":"2026-05-20T17:22:29.199653Z","steps":["trace[119796197] 'process raft request' (duration: 553.615017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:29.199695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.645278Z","time spent":"554.397593ms","remote":"127.0.0.1:37012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T17:22:29.19973Z","caller":"traceutil/trace.go:171","msg":"trace[115250456] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"464.189628ms","start":"2026-05-20T17:22:28.735532Z","end":"2026-05-20T17:22:29.199722Z","steps":["trace[115250456] 'process raft request' (duration: 463.594637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:29.199779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:28.735505Z","time spent":"464.254309ms","remote":"127.0.0.1:37012","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-05-20T17:22:29.199843Z","caller":"traceutil/trace.go:171","msg":"trace[1754612527] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"187.513662ms","start":"2026-05-20T17:22:29.012312Z","end":"2026-05-20T17:22:29.199825Z","steps":["trace[1754612527] 'process raft request' (duration: 186.874541ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:35.047937Z","caller":"traceutil/trace.go:171","msg":"trace[636823272] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"110.404068ms","start":"2026-05-20T17:22:34.937507Z","end":"2026-05-20T17:22:35.047911Z","steps":["trace[636823272] 'process raft request' (duration: 108.798898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:35.607339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.4588ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T17:22:35.607576Z","caller":"traceutil/trace.go:171","msg":"trace[1686165411] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:617; }","duration":"463.712144ms","start":"2026-05-20T17:22:35.14384Z","end":"2026-05-20T17:22:35.607552Z","steps":["trace[1686165411] 'range keys from in-memory index tree' (duration: 463.419018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:35.607714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.266757ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T17:22:35.60788Z","caller":"traceutil/trace.go:171","msg":"trace[1303911192] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"110.788972ms","start":"2026-05-20T17:22:35.497066Z","end":"2026-05-20T17:22:35.607855Z","steps":["trace[1303911192] 'read index received' (duration: 49.331µs)","trace[1303911192] 'applied index is now lower than readState.Index' (duration: 110.738101ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:22:35.607933Z","caller":"traceutil/trace.go:171","msg":"trace[717283161] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"476.295996ms","start":"2026-05-20T17:22:35.131599Z","end":"2026-05-20T17:22:35.607895Z","steps":["trace[717283161] 'process raft request' (duration: 26.725883ms)","trace[717283161] 'compare' (duration: 448.983452ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:22:35.608127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:35.131557Z","time spent":"476.474548ms","remote":"127.0.0.1:37188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T17:22:35.608139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.050397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-24mfk\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-20T17:22:35.608223Z","caller":"traceutil/trace.go:171","msg":"trace[968092334] range","detail":"{range_begin:/registry/pods/kube-system/cilium-24mfk; range_end:; response_count:1; response_revision:618; }","duration":"111.17492ms","start":"2026-05-20T17:22:35.497025Z","end":"2026-05-20T17:22:35.6082Z","steps":["trace[968092334] 'agreement among raft nodes before linearized reading' (duration: 110.891124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:36.053666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.621201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T17:22:36.053785Z","caller":"traceutil/trace.go:171","msg":"trace[1728309752] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"431.085504ms","start":"2026-05-20T17:22:35.622681Z","end":"2026-05-20T17:22:36.053766Z","steps":["trace[1728309752] 'process raft request' (duration: 232.275859ms)","trace[1728309752] 'compare' (duration: 198.479649ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:22:36.053842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:35.622663Z","time spent":"431.151226ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T17:22:36.076827Z","caller":"traceutil/trace.go:171","msg":"trace[1600894400] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"428.435817ms","start":"2026-05-20T17:22:35.648344Z","end":"2026-05-20T17:22:36.07678Z","steps":["trace[1600894400] 'read index received' (duration: 206.535467ms)","trace[1600894400] 'applied index is now lower than readState.Index' (duration: 221.89931ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:22:36.076899Z","caller":"traceutil/trace.go:171","msg":"trace[2021449780] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"450.739844ms","start":"2026-05-20T17:22:35.626141Z","end":"2026-05-20T17:22:36.076881Z","steps":["trace[2021449780] 'process raft request' (duration: 450.437618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:36.076987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:35.626124Z","time spent":"450.816756ms","remote":"127.0.0.1:37168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T17:22:36.077066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.700682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-20T17:22:36.077156Z","caller":"traceutil/trace.go:171","msg":"trace[1798056964] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"428.805754ms","start":"2026-05-20T17:22:35.648319Z","end":"2026-05-20T17:22:36.077125Z","steps":["trace[1798056964] 'agreement among raft nodes before linearized reading' (duration: 428.647941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:36.077202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:35.648311Z","time spent":"428.880175ms","remote":"127.0.0.1:37262","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-05-20T17:22:37.385943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145578506s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T17:22:37.386082Z","caller":"traceutil/trace.go:171","msg":"trace[1802476866] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"1.309137398s","start":"2026-05-20T17:22:36.076923Z","end":"2026-05-20T17:22:37.38606Z","steps":["trace[1802476866] 'read index received' (duration: 162.899109ms)","trace[1802476866] 'applied index is now lower than readState.Index' (duration: 1.146236839s)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:22:37.386348Z","caller":"traceutil/trace.go:171","msg":"trace[1095421274] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.367057905s","start":"2026-05-20T17:22:36.019249Z","end":"2026-05-20T17:22:37.386307Z","steps":["trace[1095421274] 'process raft request' (duration: 220.995249ms)","trace[1095421274] 'compare' (duration: 1.145096687s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:22:37.386382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470303015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T17:22:37.386434Z","caller":"traceutil/trace.go:171","msg":"trace[139592225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:621; }","duration":"1.470371636s","start":"2026-05-20T17:22:35.916049Z","end":"2026-05-20T17:22:37.38642Z","steps":["trace[139592225] 'agreement among raft nodes before linearized reading' (duration: 1.470153852s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:37.386498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:35.916001Z","time spent":"1.470488928s","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T17:22:37.386513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:36.019212Z","time spent":"1.367207488s","remote":"127.0.0.1:37064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T17:22:37.386581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.65271832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-20T17:22:37.386655Z","caller":"traceutil/trace.go:171","msg":"trace[968375165] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:621; }","duration":"1.652828602s","start":"2026-05-20T17:22:35.733809Z","end":"2026-05-20T17:22:37.386637Z","steps":["trace[968375165] 'agreement among raft nodes before linearized reading' (duration: 1.652677649s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:37.386698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:35.733798Z","time spent":"1.652892163s","remote":"127.0.0.1:36992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"warn","ts":"2026-05-20T17:22:37.386879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.714773098s","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-05-20T17:22:37.386995Z","caller":"traceutil/trace.go:171","msg":"trace[1380674780] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"1.714907041s","start":"2026-05-20T17:22:35.672051Z","end":"2026-05-20T17:22:37.386958Z","steps":["trace[1380674780] 'agreement among raft nodes before linearized reading' (duration: 1.714768629s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:37.387095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:35.672035Z","time spent":"1.715048164s","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T17:22:37.393718Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.153843987s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-20T17:22:37.394598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.603095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T17:22:37.394713Z","caller":"traceutil/trace.go:171","msg":"trace[1400233934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"876.776918ms","start":"2026-05-20T17:22:36.517911Z","end":"2026-05-20T17:22:37.394688Z","steps":["trace[1400233934] 'agreement among raft nodes before linearized reading' (duration: 876.520563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:37.394774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:36.517889Z","time spent":"876.8764ms","remote":"127.0.0.1:36962","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-05-20T17:22:37.395249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.050929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T17:22:37.395289Z","caller":"traceutil/trace.go:171","msg":"trace[1736017564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"324.13109ms","start":"2026-05-20T17:22:37.071148Z","end":"2026-05-20T17:22:37.395279Z","steps":["trace[1736017564] 'agreement among raft nodes before linearized reading' (duration: 324.067379ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:37.395313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:37.071119Z","time spent":"324.189801ms","remote":"127.0.0.1:36976","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-05-20T17:22:37.395429Z","caller":"traceutil/trace.go:171","msg":"trace[1802949236] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"1.31333122s","start":"2026-05-20T17:22:36.082082Z","end":"2026-05-20T17:22:37.395414Z","steps":["trace[1802949236] 'process raft request' (duration: 1.312052566s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:37.3955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:36.082059Z","time spent":"1.313396511s","remote":"127.0.0.1:37262","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-05-20T17:22:37.395524Z","caller":"traceutil/trace.go:171","msg":"trace[728013322] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"1.198771713s","start":"2026-05-20T17:22:36.196736Z","end":"2026-05-20T17:22:37.395508Z","steps":["trace[728013322] 'process raft request' (duration: 1.197621521s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:37.395671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:36.196708Z","time spent":"1.198879055s","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T17:22:39.023786Z","caller":"traceutil/trace.go:171","msg":"trace[643659554] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"191.682888ms","start":"2026-05-20T17:22:38.832077Z","end":"2026-05-20T17:22:39.02376Z","steps":["trace[643659554] 'process raft request' (duration: 181.203573ms)","trace[643659554] 'compare' (duration: 10.372073ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:22:39.031722Z","caller":"traceutil/trace.go:171","msg":"trace[712533755] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"164.589219ms","start":"2026-05-20T17:22:38.867089Z","end":"2026-05-20T17:22:39.031678Z","steps":["trace[712533755] 'process raft request' (duration: 164.12143ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:50.25412Z","caller":"traceutil/trace.go:171","msg":"trace[1393433232] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"123.689013ms","start":"2026-05-20T17:22:50.130403Z","end":"2026-05-20T17:22:50.254092Z","steps":["trace[1393433232] 'process raft request' (duration: 123.517879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:52.906567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.251447ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-05-20T17:22:54.040432Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604716009423817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T17:22:54.533531Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.319479455s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T17:22:54.534107Z","caller":"traceutil/trace.go:171","msg":"trace[2123164099] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"1.320132897s","start":"2026-05-20T17:22:53.213947Z","end":"2026-05-20T17:22:54.53408Z","steps":["trace[2123164099] 'process raft request' (duration: 1.319842621s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:54.534579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:53.213932Z","time spent":"1.32025307s","remote":"127.0.0.1:37262","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-05-20T17:22:54.695703Z","caller":"traceutil/trace.go:171","msg":"trace[2110025944] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:824; }","duration":"1.155559663s","start":"2026-05-20T17:22:53.540104Z","end":"2026-05-20T17:22:54.695664Z","steps":["trace[2110025944] 'read index received' (duration: 993.706228ms)","trace[2110025944] 'applied index is now lower than readState.Index' (duration: 161.852515ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:22:54.695804Z","caller":"traceutil/trace.go:171","msg":"trace[464686597] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"1.005508467s","start":"2026-05-20T17:22:53.690269Z","end":"2026-05-20T17:22:54.695778Z","steps":["trace[464686597] 'process raft request' (duration: 976.448268ms)","trace[464686597] 'compare' (duration: 28.812464ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:22:54.695948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155830169s","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-05-20T17:22:54.695974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:53.690246Z","time spent":"1.005611589s","remote":"127.0.0.1:37228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T17:22:54.695975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152525279s","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-05-20T17:22:54.695992Z","caller":"traceutil/trace.go:171","msg":"trace[1883545917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"1.155923311s","start":"2026-05-20T17:22:53.540056Z","end":"2026-05-20T17:22:54.69598Z","steps":["trace[1883545917] 'agreement among raft nodes before linearized reading' (duration: 1.155736917s)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:22:54.696013Z","caller":"traceutil/trace.go:171","msg":"trace[1212010883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:797; }","duration":"1.1526029s","start":"2026-05-20T17:22:53.5434Z","end":"2026-05-20T17:22:54.696003Z","steps":["trace[1212010883] 'agreement among raft nodes before linearized reading' (duration: 1.152433057s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:54.696022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:53.540034Z","time spent":"1.155981211s","remote":"127.0.0.1:37262","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-05-20T17:22:54.696048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:53.543388Z","time spent":"1.152651691s","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T17:22:54.696105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.508067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T17:22:54.696129Z","caller":"traceutil/trace.go:171","msg":"trace[1278491215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"416.560039ms","start":"2026-05-20T17:22:54.279562Z","end":"2026-05-20T17:22:54.696122Z","steps":["trace[1278491215] 'agreement among raft nodes before linearized reading' (duration: 416.493297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:54.69615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:54.279539Z","time spent":"416.606809ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T17:22:54.696169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.139323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T17:22:54.696194Z","caller":"traceutil/trace.go:171","msg":"trace[1450049085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"625.197735ms","start":"2026-05-20T17:22:54.070987Z","end":"2026-05-20T17:22:54.696185Z","steps":["trace[1450049085] 'agreement among raft nodes before linearized reading' (duration: 625.160634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:54.696217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:54.070967Z","time spent":"625.244835ms","remote":"127.0.0.1:36962","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-05-20T17:22:54.696247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152260493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T17:22:54.696264Z","caller":"traceutil/trace.go:171","msg":"trace[667603767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"1.152313294s","start":"2026-05-20T17:22:53.543945Z","end":"2026-05-20T17:22:54.696258Z","steps":["trace[667603767] 'agreement among raft nodes before linearized reading' (duration: 1.152263773s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:22:54.696279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T17:22:53.543924Z","time spent":"1.152351425s","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-20T17:23:04.184143Z","caller":"traceutil/trace.go:171","msg":"trace[349110895] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"234.098404ms","start":"2026-05-20T17:23:03.950016Z","end":"2026-05-20T17:23:04.184114Z","steps":["trace[349110895] 'process raft request' (duration: 170.203785ms)","trace[349110895] 'compare' (duration: 63.656414ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:23:04.184271Z","caller":"traceutil/trace.go:171","msg":"trace[668202218] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"185.550123ms","start":"2026-05-20T17:23:03.998696Z","end":"2026-05-20T17:23:04.184246Z","steps":["trace[668202218] 'process raft request' (duration: 185.341249ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:04.184214Z","caller":"traceutil/trace.go:171","msg":"trace[236345384] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"147.933726ms","start":"2026-05-20T17:23:04.03625Z","end":"2026-05-20T17:23:04.184184Z","steps":["trace[236345384] 'process raft request' (duration: 147.854014ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:04.512769Z","caller":"traceutil/trace.go:171","msg":"trace[1386400634] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"205.68039ms","start":"2026-05-20T17:23:04.307055Z","end":"2026-05-20T17:23:04.512736Z","steps":["trace[1386400634] 'process raft request' (duration: 146.195787ms)","trace[1386400634] 'compare' (duration: 59.34459ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:23:04.752263Z","caller":"traceutil/trace.go:171","msg":"trace[1306549058] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"166.024699ms","start":"2026-05-20T17:23:04.586208Z","end":"2026-05-20T17:23:04.752233Z","steps":["trace[1306549058] 'process raft request' (duration: 163.884932ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:04.958104Z","caller":"traceutil/trace.go:171","msg":"trace[1436266579] linearizableReadLoop","detail":"{readStateIndex:948; appliedIndex:946; }","duration":"197.391961ms","start":"2026-05-20T17:23:04.760675Z","end":"2026-05-20T17:23:04.958067Z","steps":["trace[1436266579] 'read index received' (duration: 86.087342ms)","trace[1436266579] 'applied index is now lower than readState.Index' (duration: 111.302998ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T17:23:04.958541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.467053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-20T17:23:04.958607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.878672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-20T17:23:04.958806Z","caller":"traceutil/trace.go:171","msg":"trace[1551494340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:916; }","duration":"198.161558ms","start":"2026-05-20T17:23:04.760625Z","end":"2026-05-20T17:23:04.958787Z","steps":["trace[1551494340] 'agreement among raft nodes before linearized reading' (duration: 197.707497ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:04.958637Z","caller":"traceutil/trace.go:171","msg":"trace[761878305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:916; }","duration":"197.600316ms","start":"2026-05-20T17:23:04.761014Z","end":"2026-05-20T17:23:04.958614Z","steps":["trace[761878305] 'agreement among raft nodes before linearized reading' (duration: 197.299379ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:04.958717Z","caller":"traceutil/trace.go:171","msg":"trace[225455898] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"197.812329ms","start":"2026-05-20T17:23:04.760426Z","end":"2026-05-20T17:23:04.958238Z","steps":["trace[225455898] 'process raft request' (duration: 162.150264ms)","trace[225455898] 'compare' (duration: 35.241616ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:23:06.310607Z","caller":"traceutil/trace.go:171","msg":"trace[1927920666] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"119.392942ms","start":"2026-05-20T17:23:06.190906Z","end":"2026-05-20T17:23:06.310298Z","steps":["trace[1927920666] 'process raft request' (duration: 119.249469ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:07.047558Z","caller":"traceutil/trace.go:171","msg":"trace[1416766825] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"137.8931ms","start":"2026-05-20T17:23:06.909628Z","end":"2026-05-20T17:23:07.047521Z","steps":["trace[1416766825] 'process raft request' (duration: 123.872782ms)","trace[1416766825] 'compare' (duration: 13.771442ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:23:07.047621Z","caller":"traceutil/trace.go:171","msg":"trace[1937358729] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"134.758761ms","start":"2026-05-20T17:23:06.912821Z","end":"2026-05-20T17:23:07.047579Z","steps":["trace[1937358729] 'process raft request' (duration: 134.608938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T17:23:12.706981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.864768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-2gv8m\" ","response":"range_response_count:1 size:5085"} {"level":"info","ts":"2026-05-20T17:23:12.707062Z","caller":"traceutil/trace.go:171","msg":"trace[1684273170] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-2gv8m; range_end:; response_count:1; response_revision:982; }","duration":"185.95949ms","start":"2026-05-20T17:23:12.521086Z","end":"2026-05-20T17:23:12.707046Z","steps":["trace[1684273170] 'range keys from in-memory index tree' (duration: 185.674244ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:13.061241Z","caller":"traceutil/trace.go:171","msg":"trace[972530514] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"231.734184ms","start":"2026-05-20T17:23:12.829477Z","end":"2026-05-20T17:23:13.061211Z","steps":["trace[972530514] 'process raft request' (duration: 208.599498ms)","trace[972530514] 'compare' (duration: 22.86983ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:23:13.06131Z","caller":"traceutil/trace.go:171","msg":"trace[347497829] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"188.079801ms","start":"2026-05-20T17:23:12.873206Z","end":"2026-05-20T17:23:13.061285Z","steps":["trace[347497829] 'process raft request' (duration: 187.848126ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:24.597677Z","caller":"traceutil/trace.go:171","msg":"trace[821546450] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"147.371071ms","start":"2026-05-20T17:23:24.450289Z","end":"2026-05-20T17:23:24.59766Z","steps":["trace[821546450] 'process raft request' (duration: 147.240848ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T17:23:27.344732Z","caller":"traceutil/trace.go:171","msg":"trace[1486544895] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"129.442489ms","start":"2026-05-20T17:23:27.215257Z","end":"2026-05-20T17:23:27.344699Z","steps":["trace[1486544895] 'process raft request' (duration: 89.610949ms)","trace[1486544895] 'compare' (duration: 39.522923ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T17:24:43.06327Z","caller":"traceutil/trace.go:171","msg":"trace[253153040] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"134.191768ms","start":"2026-05-20T17:24:42.92905Z","end":"2026-05-20T17:24:43.063242Z","steps":["trace[253153040] 'process raft request' (duration: 134.003713ms)"],"step_count":1}