{"level":"warn","ts":"2026-04-13T06:10:27.397228Z","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-13T06:10:27.397759Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-13T06:10:27.398307Z","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-13T06:10:27.398327Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-04-13T06:10:27.399374Z","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-13T06:10:27.402589Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-04-13T06:10:27.402703Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-13T06:10:27.408171Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.190894ms"} {"level":"info","ts":"2026-04-13T06:10:27.415979Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-04-13T06:10:27.416047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T06:10:27.416158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-04-13T06:10:27.416174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T06:10:27.416436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-04-13T06:10:27.416562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-04-13T06:10:27.421722Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T06:10:27.423179Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T06:10:27.424413Z","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-13T06:10:27.42649Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T06:10:27.427194Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T06:10:27.426658Z","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-13T06:10:27.427517Z","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-13T06:10:27.427626Z","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-13T06:10:27.427851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-04-13T06:10:27.427997Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-04-13T06:10:27.430492Z","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-13T06:10:27.430536Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-04-13T06:10:27.430559Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-04-13T06:10:27.433071Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T06:10:27.433102Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T06:10:28.117626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T06:10:28.117697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T06:10:28.117722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-04-13T06:10:28.117775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-04-13T06:10:28.117796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-04-13T06:10:28.117875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-04-13T06:10:28.117899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-04-13T06:10:28.119115Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T06:10:28.120041Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T06:10:28.120082Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T06:10:28.12009Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T06:10:28.120336Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T06:10:28.120379Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T06:10:28.120725Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T06:10:28.120849Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T06:10:28.120934Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T06:10:28.123029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T06:10:28.14321Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-04-13T06:10:31.896758Z","caller":"traceutil/trace.go:171","msg":"trace[930170756] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"199.526211ms","start":"2026-04-13T06:10:31.697214Z","end":"2026-04-13T06:10:31.89674Z","steps":["trace[930170756] 'process raft request' (duration: 199.417228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:10:32.400145Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872038927718969,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T06:10:32.453981Z","caller":"traceutil/trace.go:171","msg":"trace[728196994] linearizableReadLoop","detail":"{readStateIndex:255; appliedIndex:253; }","duration":"553.916281ms","start":"2026-04-13T06:10:31.900041Z","end":"2026-04-13T06:10:32.453957Z","steps":["trace[728196994] 'read index received' (duration: 547.795932ms)","trace[728196994] 'applied index is now lower than readState.Index' (duration: 6.117349ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:10:32.454126Z","caller":"traceutil/trace.go:171","msg":"trace[907582140] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"552.520802ms","start":"2026-04-13T06:10:31.901567Z","end":"2026-04-13T06:10:32.454088Z","steps":["trace[907582140] 'process raft request' (duration: 552.337987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:10:32.454218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.152097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-13T06:10:32.454225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.944241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:10:32.454301Z","caller":"traceutil/trace.go:171","msg":"trace[1666411215] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:249; }","duration":"554.284271ms","start":"2026-04-13T06:10:31.900003Z","end":"2026-04-13T06:10:32.454287Z","steps":["trace[1666411215] 'agreement among raft nodes before linearized reading' (duration: 554.083295ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:32.454317Z","caller":"traceutil/trace.go:171","msg":"trace[1939280833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:249; }","duration":"554.057494ms","start":"2026-04-13T06:10:31.900241Z","end":"2026-04-13T06:10:32.454298Z","steps":["trace[1939280833] 'agreement among raft nodes before linearized reading' (duration: 553.92227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:10:32.45438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:10:31.900234Z","time spent":"554.130736ms","remote":"127.0.0.1:60564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T06:10:32.454355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:10:31.899983Z","time spent":"554.349742ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T06:10:32.454688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:10:31.901553Z","time spent":"552.649535ms","remote":"127.0.0.1:60648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T06:10:32.454709Z","caller":"traceutil/trace.go:171","msg":"trace[1045863125] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"757.371629ms","start":"2026-04-13T06:10:31.697325Z","end":"2026-04-13T06:10:32.454697Z","steps":["trace[1045863125] 'process raft request' (duration: 750.570102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:10:32.454797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:10:31.697316Z","time spent":"757.435212ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11440,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T06:10:44.196029Z","caller":"traceutil/trace.go:171","msg":"trace[1224087928] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"292.783598ms","start":"2026-04-13T06:10:43.903136Z","end":"2026-04-13T06:10:44.19592Z","steps":["trace[1224087928] 'read index received' (duration: 291.778999ms)","trace[1224087928] 'applied index is now lower than readState.Index' (duration: 1.003368ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:10:44.19609Z","caller":"traceutil/trace.go:171","msg":"trace[1993604880] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"315.724762ms","start":"2026-04-13T06:10:43.880306Z","end":"2026-04-13T06:10:44.19603Z","steps":["trace[1993604880] 'process raft request' (duration: 314.731783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:10:44.197287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:10:43.88029Z","time spent":"316.479451ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T06:10:44.197367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.219047ms","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-13T06:10:44.197541Z","caller":"traceutil/trace.go:171","msg":"trace[1669865864] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:413; }","duration":"294.30815ms","start":"2026-04-13T06:10:43.903088Z","end":"2026-04-13T06:10:44.197396Z","steps":["trace[1669865864] 'agreement among raft nodes before linearized reading' (duration: 293.001194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:10:44.197903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.821073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-04-13T06:10:44.197977Z","caller":"traceutil/trace.go:171","msg":"trace[2059224271] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:413; }","duration":"143.905405ms","start":"2026-04-13T06:10:44.054035Z","end":"2026-04-13T06:10:44.197941Z","steps":["trace[2059224271] 'agreement among raft nodes before linearized reading' (duration: 143.646528ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.403618Z","caller":"traceutil/trace.go:171","msg":"trace[1507760838] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"212.267123ms","start":"2026-04-13T06:10:59.191334Z","end":"2026-04-13T06:10:59.403601Z","steps":["trace[1507760838] 'process raft request' (duration: 212.172001ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.413999Z","caller":"traceutil/trace.go:171","msg":"trace[476174658] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"161.271186ms","start":"2026-04-13T06:10:59.252707Z","end":"2026-04-13T06:10:59.413978Z","steps":["trace[476174658] 'process raft request' (duration: 160.660588ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.414113Z","caller":"traceutil/trace.go:171","msg":"trace[1979805454] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"160.590536ms","start":"2026-04-13T06:10:59.253516Z","end":"2026-04-13T06:10:59.414107Z","steps":["trace[1979805454] 'process raft request' (duration: 159.934668ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.414182Z","caller":"traceutil/trace.go:171","msg":"trace[325246989] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"156.085542ms","start":"2026-04-13T06:10:59.25809Z","end":"2026-04-13T06:10:59.414176Z","steps":["trace[325246989] 'process raft request' (duration: 155.385412ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.414236Z","caller":"traceutil/trace.go:171","msg":"trace[979365559] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"148.43344ms","start":"2026-04-13T06:10:59.265797Z","end":"2026-04-13T06:10:59.41423Z","steps":["trace[979365559] 'process raft request' (duration: 147.71104ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.414285Z","caller":"traceutil/trace.go:171","msg":"trace[2008217785] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"148.370309ms","start":"2026-04-13T06:10:59.265909Z","end":"2026-04-13T06:10:59.41428Z","steps":["trace[2008217785] 'process raft request' (duration: 147.624469ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.414324Z","caller":"traceutil/trace.go:171","msg":"trace[739517144] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"148.357479ms","start":"2026-04-13T06:10:59.265962Z","end":"2026-04-13T06:10:59.414319Z","steps":["trace[739517144] 'process raft request' (duration: 147.597618ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.414366Z","caller":"traceutil/trace.go:171","msg":"trace[187576961] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"147.556286ms","start":"2026-04-13T06:10:59.266805Z","end":"2026-04-13T06:10:59.414361Z","steps":["trace[187576961] 'process raft request' (duration: 146.779424ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.414409Z","caller":"traceutil/trace.go:171","msg":"trace[99259084] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"144.928724ms","start":"2026-04-13T06:10:59.269476Z","end":"2026-04-13T06:10:59.414405Z","steps":["trace[99259084] 'process raft request' (duration: 144.151022ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.414462Z","caller":"traceutil/trace.go:171","msg":"trace[124490127] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"139.704928ms","start":"2026-04-13T06:10:59.274747Z","end":"2026-04-13T06:10:59.414452Z","steps":["trace[124490127] 'process raft request' (duration: 138.907627ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.41451Z","caller":"traceutil/trace.go:171","msg":"trace[755512304] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"133.741164ms","start":"2026-04-13T06:10:59.280765Z","end":"2026-04-13T06:10:59.414506Z","steps":["trace[755512304] 'process raft request' (duration: 132.935332ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.912657Z","caller":"traceutil/trace.go:171","msg":"trace[184313341] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"131.275026ms","start":"2026-04-13T06:10:59.781358Z","end":"2026-04-13T06:10:59.912633Z","steps":["trace[184313341] 'process raft request' (duration: 131.04627ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:10:59.913392Z","caller":"traceutil/trace.go:171","msg":"trace[1350218960] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"142.194877ms","start":"2026-04-13T06:10:59.771181Z","end":"2026-04-13T06:10:59.913376Z","steps":["trace[1350218960] 'process raft request' (duration: 94.597242ms)","trace[1350218960] 'compare' (duration: 46.431173ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T06:11:05.403808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.398209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-13T06:11:05.403882Z","caller":"traceutil/trace.go:171","msg":"trace[2146376972] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:619; }","duration":"211.514653ms","start":"2026-04-13T06:11:05.192352Z","end":"2026-04-13T06:11:05.403867Z","steps":["trace[2146376972] 'range keys from in-memory index tree' (duration: 211.290947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:11:05.82599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.538081ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T06:11:05.826094Z","caller":"traceutil/trace.go:171","msg":"trace[1490396888] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"292.109798ms","start":"2026-04-13T06:11:05.533967Z","end":"2026-04-13T06:11:05.826077Z","steps":["trace[1490396888] 'read index received' (duration: 29.277569ms)","trace[1490396888] 'applied index is now lower than readState.Index' (duration: 262.831109ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:11:05.826176Z","caller":"traceutil/trace.go:171","msg":"trace[1816679292] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"353.889616ms","start":"2026-04-13T06:11:05.472277Z","end":"2026-04-13T06:11:05.826167Z","steps":["trace[1816679292] 'process raft request' (duration: 90.963053ms)","trace[1816679292] 'compare' (duration: 262.282365ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T06:11:05.826229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:11:05.472258Z","time spent":"353.948816ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T06:11:05.826519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.552101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l2vm9\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-13T06:11:05.826557Z","caller":"traceutil/trace.go:171","msg":"trace[1051091058] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l2vm9; range_end:; response_count:1; response_revision:623; }","duration":"292.632254ms","start":"2026-04-13T06:11:05.533915Z","end":"2026-04-13T06:11:05.826547Z","steps":["trace[1051091058] 'agreement among raft nodes before linearized reading' (duration: 292.466278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:11:05.826573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.259402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:11:05.826662Z","caller":"traceutil/trace.go:171","msg":"trace[695541908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"137.358624ms","start":"2026-04-13T06:11:05.689278Z","end":"2026-04-13T06:11:05.826637Z","steps":["trace[695541908] 'agreement among raft nodes before linearized reading' (duration: 137.145379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:11:06.46429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.508506ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T06:11:06.471242Z","caller":"traceutil/trace.go:171","msg":"trace[1629854773] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:647; }","duration":"140.398238ms","start":"2026-04-13T06:11:06.329756Z","end":"2026-04-13T06:11:06.470155Z","steps":["trace[1629854773] 'read index received' (duration: 5.0695ms)","trace[1629854773] 'applied index is now lower than readState.Index' (duration: 135.326968ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T06:11:06.471437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.672054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T06:11:06.471482Z","caller":"traceutil/trace.go:171","msg":"trace[1846068812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"141.745725ms","start":"2026-04-13T06:11:06.329715Z","end":"2026-04-13T06:11:06.471461Z","steps":["trace[1846068812] 'agreement among raft nodes before linearized reading' (duration: 140.509842ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:11:06.471181Z","caller":"traceutil/trace.go:171","msg":"trace[1299659336] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"250.50711ms","start":"2026-04-13T06:11:06.220646Z","end":"2026-04-13T06:11:06.471153Z","steps":["trace[1299659336] 'process raft request' (duration: 244.791722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:11:06.472683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.189196ms","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-13T06:11:06.47299Z","caller":"traceutil/trace.go:171","msg":"trace[2029495611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"109.31849ms","start":"2026-04-13T06:11:06.363436Z","end":"2026-04-13T06:11:06.472755Z","steps":["trace[2029495611] 'agreement among raft nodes before linearized reading' (duration: 107.921352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:11:07.792854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.080635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:11:07.792908Z","caller":"traceutil/trace.go:171","msg":"trace[1951441080] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:646; }","duration":"117.156227ms","start":"2026-04-13T06:11:07.675741Z","end":"2026-04-13T06:11:07.792897Z","steps":["trace[1951441080] 'range keys from in-memory index tree' (duration: 117.020513ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:11:20.803382Z","caller":"traceutil/trace.go:171","msg":"trace[1770776113] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"114.006359ms","start":"2026-04-13T06:11:20.689353Z","end":"2026-04-13T06:11:20.803359Z","steps":["trace[1770776113] 'read index received' (duration: 113.811264ms)","trace[1770776113] 'applied index is now lower than readState.Index' (duration: 193.705µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:11:20.803517Z","caller":"traceutil/trace.go:171","msg":"trace[919758192] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"171.206529ms","start":"2026-04-13T06:11:20.6323Z","end":"2026-04-13T06:11:20.803507Z","steps":["trace[919758192] 'process raft request' (duration: 170.89541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:11:20.803847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.462562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:11:20.803936Z","caller":"traceutil/trace.go:171","msg":"trace[1989053270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:784; }","duration":"114.565165ms","start":"2026-04-13T06:11:20.689345Z","end":"2026-04-13T06:11:20.803911Z","steps":["trace[1989053270] 'agreement among raft nodes before linearized reading' (duration: 114.41375ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:11:21.047405Z","caller":"traceutil/trace.go:171","msg":"trace[1061567595] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"134.411714ms","start":"2026-04-13T06:11:20.912964Z","end":"2026-04-13T06:11:21.047375Z","steps":["trace[1061567595] 'read index received' (duration: 83.812306ms)","trace[1061567595] 'applied index is now lower than readState.Index' (duration: 50.598428ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T06:11:21.047711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.697311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T06:11:21.047719Z","caller":"traceutil/trace.go:171","msg":"trace[1797149892] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"238.444017ms","start":"2026-04-13T06:11:20.809237Z","end":"2026-04-13T06:11:21.047681Z","steps":["trace[1797149892] 'process raft request' (duration: 187.728677ms)","trace[1797149892] 'compare' (duration: 50.083763ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:11:21.047753Z","caller":"traceutil/trace.go:171","msg":"trace[1516025113] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:785; }","duration":"134.787884ms","start":"2026-04-13T06:11:20.912954Z","end":"2026-04-13T06:11:21.047742Z","steps":["trace[1516025113] 'agreement among raft nodes before linearized reading' (duration: 134.529827ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:11:55.275856Z","caller":"traceutil/trace.go:171","msg":"trace[661051959] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"141.185209ms","start":"2026-04-13T06:11:55.134637Z","end":"2026-04-13T06:11:55.275823Z","steps":["trace[661051959] 'process raft request' (duration: 141.013534ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:11:55.858659Z","caller":"traceutil/trace.go:171","msg":"trace[1568618738] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"578.810349ms","start":"2026-04-13T06:11:55.279822Z","end":"2026-04-13T06:11:55.858632Z","steps":["trace[1568618738] 'process raft request' (duration: 578.667065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:11:55.858811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:11:55.279796Z","time spent":"578.938752ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T06:11:55.89425Z","caller":"traceutil/trace.go:171","msg":"trace[363471468] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"204.214537ms","start":"2026-04-13T06:11:55.690001Z","end":"2026-04-13T06:11:55.894216Z","steps":["trace[363471468] 'read index received' (duration: 169.224763ms)","trace[363471468] 'applied index is now lower than readState.Index' (duration: 34.988734ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:11:55.894354Z","caller":"traceutil/trace.go:171","msg":"trace[1724809797] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"243.839637ms","start":"2026-04-13T06:11:55.650485Z","end":"2026-04-13T06:11:55.894325Z","steps":["trace[1724809797] 'process raft request' (duration: 243.602521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:11:55.894543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.466654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T06:11:55.894573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.499525ms","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-13T06:11:55.89462Z","caller":"traceutil/trace.go:171","msg":"trace[117950565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"204.650379ms","start":"2026-04-13T06:11:55.689948Z","end":"2026-04-13T06:11:55.894599Z","steps":["trace[117950565] 'agreement among raft nodes before linearized reading' (duration: 204.422753ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:11:55.894636Z","caller":"traceutil/trace.go:171","msg":"trace[2090836226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:999; }","duration":"131.61216ms","start":"2026-04-13T06:11:55.763006Z","end":"2026-04-13T06:11:55.894618Z","steps":["trace[2090836226] 'agreement among raft nodes before linearized reading' (duration: 131.412134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:18.576058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.751292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:12:18.576319Z","caller":"traceutil/trace.go:171","msg":"trace[1673416820] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1073; }","duration":"209.069939ms","start":"2026-04-13T06:12:18.367228Z","end":"2026-04-13T06:12:18.576298Z","steps":["trace[1673416820] 'count revisions from in-memory index tree' (duration: 208.645158ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:12:20.995613Z","caller":"traceutil/trace.go:171","msg":"trace[1150337306] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1120; }","duration":"120.076363ms","start":"2026-04-13T06:12:20.875512Z","end":"2026-04-13T06:12:20.995588Z","steps":["trace[1150337306] 'read index received' (duration: 119.825226ms)","trace[1150337306] 'applied index is now lower than readState.Index' (duration: 243.257µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:12:20.995656Z","caller":"traceutil/trace.go:171","msg":"trace[1735976651] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"130.012444ms","start":"2026-04-13T06:12:20.865618Z","end":"2026-04-13T06:12:20.99563Z","steps":["trace[1735976651] 'process raft request' (duration: 129.820309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:20.99586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.32548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T06:12:20.996172Z","caller":"traceutil/trace.go:171","msg":"trace[365873594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1080; }","duration":"120.695871ms","start":"2026-04-13T06:12:20.875461Z","end":"2026-04-13T06:12:20.996157Z","steps":["trace[365873594] 'agreement among raft nodes before linearized reading' (duration: 120.256959ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:12:28.594486Z","caller":"traceutil/trace.go:171","msg":"trace[644114600] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"240.21964ms","start":"2026-04-13T06:12:28.354236Z","end":"2026-04-13T06:12:28.594455Z","steps":["trace[644114600] 'process raft request' (duration: 240.049095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:28.831551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.926799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:12:28.831628Z","caller":"traceutil/trace.go:171","msg":"trace[1816805763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1106; }","duration":"142.055463ms","start":"2026-04-13T06:12:28.689557Z","end":"2026-04-13T06:12:28.831612Z","steps":["trace[1816805763] 'range keys from in-memory index tree' (duration: 141.859947ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:12:34.387373Z","caller":"traceutil/trace.go:171","msg":"trace[1280787722] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"319.526771ms","start":"2026-04-13T06:12:34.067822Z","end":"2026-04-13T06:12:34.387348Z","steps":["trace[1280787722] 'process raft request' (duration: 319.386787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:34.387522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:34.067805Z","time spent":"319.641634ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T06:12:34.573214Z","caller":"traceutil/trace.go:171","msg":"trace[1895675816] linearizableReadLoop","detail":"{readStateIndex:1221; appliedIndex:1219; }","duration":"450.911253ms","start":"2026-04-13T06:12:34.122277Z","end":"2026-04-13T06:12:34.573188Z","steps":["trace[1895675816] 'read index received' (duration: 264.926372ms)","trace[1895675816] 'applied index is now lower than readState.Index' (duration: 185.982071ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:12:34.573301Z","caller":"traceutil/trace.go:171","msg":"trace[269810785] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"498.618783ms","start":"2026-04-13T06:12:34.074643Z","end":"2026-04-13T06:12:34.573262Z","steps":["trace[269810785] 'process raft request' (duration: 429.130609ms)","trace[269810785] 'compare' (duration: 69.220967ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T06:12:34.573433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.214652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T06:12:34.573427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.141949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-13T06:12:34.573452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:34.074626Z","time spent":"498.738366ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T06:12:34.573478Z","caller":"traceutil/trace.go:171","msg":"trace[165695830] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1176; }","duration":"396.270684ms","start":"2026-04-13T06:12:34.177192Z","end":"2026-04-13T06:12:34.573463Z","steps":["trace[165695830] 'agreement among raft nodes before linearized reading' (duration: 396.176731ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:12:34.573485Z","caller":"traceutil/trace.go:171","msg":"trace[918486828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1176; }","duration":"451.241762ms","start":"2026-04-13T06:12:34.122229Z","end":"2026-04-13T06:12:34.573471Z","steps":["trace[918486828] 'agreement among raft nodes before linearized reading' (duration: 451.089538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:34.573526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:34.177156Z","time spent":"396.357565ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":11,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-13T06:12:34.573584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:34.122213Z","time spent":"451.314214ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T06:12:51.076143Z","caller":"traceutil/trace.go:171","msg":"trace[558626885] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"475.378101ms","start":"2026-04-13T06:12:50.600738Z","end":"2026-04-13T06:12:51.076116Z","steps":["trace[558626885] 'process raft request' (duration: 475.210777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:51.077022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:50.600714Z","time spent":"475.532655ms","remote":"127.0.0.1:60758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T06:12:51.175931Z","caller":"traceutil/trace.go:171","msg":"trace[866444762] linearizableReadLoop","detail":"{readStateIndex:1299; appliedIndex:1297; }","duration":"530.125189ms","start":"2026-04-13T06:12:50.645785Z","end":"2026-04-13T06:12:51.17591Z","steps":["trace[866444762] 'read index received' (duration: 430.047349ms)","trace[866444762] 'applied index is now lower than readState.Index' (duration: 100.07703ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:12:51.176025Z","caller":"traceutil/trace.go:171","msg":"trace[272206657] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"549.570877ms","start":"2026-04-13T06:12:50.626445Z","end":"2026-04-13T06:12:51.176016Z","steps":["trace[272206657] 'process raft request' (duration: 519.180912ms)","trace[272206657] 'compare' (duration: 30.049516ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T06:12:51.17612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:50.62643Z","time spent":"549.624598ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T06:12:51.176331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.544961ms","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-13T06:12:51.176374Z","caller":"traceutil/trace.go:171","msg":"trace[477000231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1250; }","duration":"530.628293ms","start":"2026-04-13T06:12:50.645739Z","end":"2026-04-13T06:12:51.176367Z","steps":["trace[477000231] 'agreement among raft nodes before linearized reading' (duration: 530.52013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:51.176395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:50.645721Z","time spent":"530.668193ms","remote":"127.0.0.1:60842","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-04-13T06:12:51.176398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.299796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T06:12:51.176409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.139347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T06:12:51.176514Z","caller":"traceutil/trace.go:171","msg":"trace[369288826] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1250; }","duration":"302.425049ms","start":"2026-04-13T06:12:50.874044Z","end":"2026-04-13T06:12:51.176469Z","steps":["trace[369288826] 'agreement among raft nodes before linearized reading' (duration: 302.309026ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:12:51.17652Z","caller":"traceutil/trace.go:171","msg":"trace[682106140] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1250; }","duration":"421.306151ms","start":"2026-04-13T06:12:50.755193Z","end":"2026-04-13T06:12:51.176499Z","steps":["trace[682106140] 'agreement among raft nodes before linearized reading' (duration: 421.127517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:51.176572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:50.874027Z","time spent":"302.529982ms","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T06:12:51.176627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.595031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-13T06:12:51.176634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.715961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-wg7r6\" ","response":"range_response_count:1 size:11061"} {"level":"info","ts":"2026-04-13T06:12:51.17665Z","caller":"traceutil/trace.go:171","msg":"trace[2068925624] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1250; }","duration":"477.641131ms","start":"2026-04-13T06:12:50.699002Z","end":"2026-04-13T06:12:51.176643Z","steps":["trace[2068925624] 'agreement among raft nodes before linearized reading' (duration: 477.581369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:51.176679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:50.69899Z","time spent":"477.683833ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-13T06:12:51.176682Z","caller":"traceutil/trace.go:171","msg":"trace[644761356] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-wg7r6; range_end:; response_count:1; response_revision:1250; }","duration":"237.807353ms","start":"2026-04-13T06:12:50.938861Z","end":"2026-04-13T06:12:51.176669Z","steps":["trace[644761356] 'agreement among raft nodes before linearized reading' (duration: 237.68295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:51.176488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.486062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T06:12:51.176768Z","caller":"traceutil/trace.go:171","msg":"trace[1477071314] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:1250; }","duration":"259.812512ms","start":"2026-04-13T06:12:50.916948Z","end":"2026-04-13T06:12:51.17676Z","steps":["trace[1477071314] 'agreement among raft nodes before linearized reading' (duration: 259.3633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:51.176574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:50.755174Z","time spent":"421.388304ms","remote":"127.0.0.1:59302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-13T06:12:51.177115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.797351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:12:51.177163Z","caller":"traceutil/trace.go:171","msg":"trace[1792885389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1250; }","duration":"487.655545ms","start":"2026-04-13T06:12:50.689494Z","end":"2026-04-13T06:12:51.17715Z","steps":["trace[1792885389] 'agreement among raft nodes before linearized reading' (duration: 486.804362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:51.1772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:50.68948Z","time spent":"487.709606ms","remote":"127.0.0.1:60564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T06:12:53.011687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.623073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:12:53.011771Z","caller":"traceutil/trace.go:171","msg":"trace[1018425975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1269; }","duration":"321.733475ms","start":"2026-04-13T06:12:52.690009Z","end":"2026-04-13T06:12:53.011743Z","steps":["trace[1018425975] 'range keys from in-memory index tree' (duration: 321.542681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:12:53.01181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:12:52.689993Z","time spent":"321.808837ms","remote":"127.0.0.1:60564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T06:13:37.318147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.556747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-13T06:13:37.318244Z","caller":"traceutil/trace.go:171","msg":"trace[16617707] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1493; }","duration":"400.67694ms","start":"2026-04-13T06:13:36.917539Z","end":"2026-04-13T06:13:37.318216Z","steps":["trace[16617707] 'count revisions from in-memory index tree' (duration: 400.481476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:37.318312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:36.917481Z","time spent":"400.811164ms","remote":"127.0.0.1:60648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":162,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-13T06:13:38.100022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.511905ms","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-13T06:13:38.100099Z","caller":"traceutil/trace.go:171","msg":"trace[779459178] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1494; }","duration":"564.643948ms","start":"2026-04-13T06:13:37.535443Z","end":"2026-04-13T06:13:38.100087Z","steps":["trace[779459178] 'range keys from in-memory index tree' (duration: 564.331219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.100123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:37.535423Z","time spent":"564.69427ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T06:13:38.100286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.575176ms","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-13T06:13:38.100312Z","caller":"traceutil/trace.go:171","msg":"trace[1806022382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1494; }","duration":"511.624246ms","start":"2026-04-13T06:13:37.588682Z","end":"2026-04-13T06:13:38.100306Z","steps":["trace[1806022382] 'range keys from in-memory index tree' (duration: 511.511314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.100331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:37.58867Z","time spent":"511.655867ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T06:13:38.100513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.280958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-13T06:13:38.100578Z","caller":"traceutil/trace.go:171","msg":"trace[694777589] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1494; }","duration":"500.377542ms","start":"2026-04-13T06:13:37.600185Z","end":"2026-04-13T06:13:38.100562Z","steps":["trace[694777589] 'range keys from in-memory index tree' (duration: 500.034092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.100606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:37.600175Z","time spent":"500.423143ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-13T06:13:38.100933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.977145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-13T06:13:38.100958Z","caller":"traceutil/trace.go:171","msg":"trace[2106200377] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1494; }","duration":"412.998446ms","start":"2026-04-13T06:13:37.687949Z","end":"2026-04-13T06:13:38.100947Z","steps":["trace[2106200377] 'range keys from in-memory index tree' (duration: 412.916554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.100976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:37.687941Z","time spent":"413.028767ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-13T06:13:38.610605Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872038927721686,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T06:13:38.879565Z","caller":"traceutil/trace.go:171","msg":"trace[431192021] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"772.461375ms","start":"2026-04-13T06:13:38.107074Z","end":"2026-04-13T06:13:38.879535Z","steps":["trace[431192021] 'process raft request' (duration: 772.27232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.880034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:38.107058Z","time spent":"772.64976ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T06:13:38.881867Z","caller":"traceutil/trace.go:171","msg":"trace[356672973] transaction","detail":"{read_only:false; response_revision:1496; number_of_response:1; }","duration":"774.779917ms","start":"2026-04-13T06:13:38.107074Z","end":"2026-04-13T06:13:38.881854Z","steps":["trace[356672973] 'process raft request' (duration: 774.674665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.881948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:38.10706Z","time spent":"774.848339ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T06:13:38.882121Z","caller":"traceutil/trace.go:171","msg":"trace[2142195116] transaction","detail":"{read_only:false; response_revision:1497; number_of_response:1; }","duration":"771.558871ms","start":"2026-04-13T06:13:38.110543Z","end":"2026-04-13T06:13:38.882102Z","steps":["trace[2142195116] 'process raft request' (duration: 771.281013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.882254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:38.110535Z","time spent":"771.649393ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T06:13:38.882469Z","caller":"traceutil/trace.go:171","msg":"trace[1622579260] linearizableReadLoop","detail":"{readStateIndex:1558; appliedIndex:1553; }","duration":"771.93542ms","start":"2026-04-13T06:13:38.110516Z","end":"2026-04-13T06:13:38.882451Z","steps":["trace[1622579260] 'read index received' (duration: 768.99045ms)","trace[1622579260] 'applied index is now lower than readState.Index' (duration: 2.94432ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T06:13:38.88252Z","caller":"traceutil/trace.go:171","msg":"trace[1233926326] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"771.92371ms","start":"2026-04-13T06:13:38.110585Z","end":"2026-04-13T06:13:38.882509Z","steps":["trace[1233926326] 'process raft request' (duration: 771.450197ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:13:38.882553Z","caller":"traceutil/trace.go:171","msg":"trace[588116879] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"711.830938ms","start":"2026-04-13T06:13:38.170714Z","end":"2026-04-13T06:13:38.882545Z","steps":["trace[588116879] 'process raft request' (duration: 711.650993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.882586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:38.110574Z","time spent":"771.980661ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T06:13:38.882622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:38.170685Z","time spent":"711.887269ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T06:13:38.882669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.110516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-13T06:13:38.882691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.646345ms","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-13T06:13:38.882725Z","caller":"traceutil/trace.go:171","msg":"trace[89035100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1499; }","duration":"772.185597ms","start":"2026-04-13T06:13:38.110527Z","end":"2026-04-13T06:13:38.882712Z","steps":["trace[89035100] 'agreement among raft nodes before linearized reading' (duration: 772.038683ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:13:38.882728Z","caller":"traceutil/trace.go:171","msg":"trace[634626112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1499; }","duration":"171.707287ms","start":"2026-04-13T06:13:38.71101Z","end":"2026-04-13T06:13:38.882717Z","steps":["trace[634626112] 'agreement among raft nodes before linearized reading' (duration: 171.604995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.882759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:38.110515Z","time spent":"772.236409ms","remote":"127.0.0.1:60842","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-04-13T06:13:38.882796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.217587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-13T06:13:38.882727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.212248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T06:13:38.882815Z","caller":"traceutil/trace.go:171","msg":"trace[801309553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1499; }","duration":"772.253739ms","start":"2026-04-13T06:13:38.110555Z","end":"2026-04-13T06:13:38.882809Z","steps":["trace[801309553] 'agreement among raft nodes before linearized reading' (duration: 772.190897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.882833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:38.11054Z","time spent":"772.289971ms","remote":"127.0.0.1:60842","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-04-13T06:13:38.882828Z","caller":"traceutil/trace.go:171","msg":"trace[819736312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1499; }","duration":"772.335511ms","start":"2026-04-13T06:13:38.110483Z","end":"2026-04-13T06:13:38.882818Z","steps":["trace[819736312] 'agreement among raft nodes before linearized reading' (duration: 772.207987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T06:13:38.88286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T06:13:38.110467Z","time spent":"772.383782ms","remote":"127.0.0.1:60564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T06:13:39.010142Z","caller":"traceutil/trace.go:171","msg":"trace[1701977575] transaction","detail":"{read_only:false; response_revision:1502; number_of_response:1; }","duration":"122.580192ms","start":"2026-04-13T06:13:38.887543Z","end":"2026-04-13T06:13:39.010123Z","steps":["trace[1701977575] 'process raft request' (duration: 122.527401ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:13:39.010433Z","caller":"traceutil/trace.go:171","msg":"trace[163006552] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"123.515367ms","start":"2026-04-13T06:13:38.88691Z","end":"2026-04-13T06:13:39.010425Z","steps":["trace[163006552] 'process raft request' (duration: 118.481241ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T06:13:39.010583Z","caller":"traceutil/trace.go:171","msg":"trace[1010523912] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"123.083176ms","start":"2026-04-13T06:13:38.88749Z","end":"2026-04-13T06:13:39.010524Z","steps":["trace[1010523912] 'process raft request' (duration: 122.544041ms)"],"step_count":1}