{"level":"warn","ts":"2026-04-17T10:34:03.559956Z","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-17T10:34:03.560037Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.250:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.250:2380","--initial-cluster=instance=https://199.19.213.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.250: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-17T10:34:03.560097Z","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-17T10:34:03.560109Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.250:2380"]} {"level":"info","ts":"2026-04-17T10:34:03.560126Z","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-17T10:34:03.560915Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"]} {"level":"info","ts":"2026-04-17T10:34:03.560988Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.250:2380"],"listen-peer-urls":["https://199.19.213.250:2380"],"advertise-client-urls":["https://199.19.213.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.250: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-17T10:34:03.567828Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.583145ms"} {"level":"info","ts":"2026-04-17T10:34:03.573847Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1918dd9317ae83a2","cluster-id":"1b9b645507bfe47a"} {"level":"info","ts":"2026-04-17T10:34:03.573929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T10:34:03.573948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became follower at term 0"} {"level":"info","ts":"2026-04-17T10:34:03.573963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1918dd9317ae83a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T10:34:03.573974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became follower at term 1"} {"level":"info","ts":"2026-04-17T10:34:03.574008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=(1808438874216498082)"} {"level":"warn","ts":"2026-04-17T10:34:03.581944Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T10:34:03.583295Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T10:34:03.58492Z","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-17T10:34:03.586967Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1918dd9317ae83a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T10:34:03.587136Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1918dd9317ae83a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T10:34:03.587359Z","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-17T10:34:03.587458Z","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-17T10:34:03.587466Z","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-17T10:34:03.588794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=(1808438874216498082)"} {"level":"info","ts":"2026-04-17T10:34:03.588895Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1b9b645507bfe47a","local-member-id":"1918dd9317ae83a2","added-peer-id":"1918dd9317ae83a2","added-peer-peer-urls":["https://199.19.213.250:2380"]} {"level":"info","ts":"2026-04-17T10:34:03.590739Z","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-17T10:34:03.591441Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1918dd9317ae83a2","initial-advertise-peer-urls":["https://199.19.213.250:2380"],"listen-peer-urls":["https://199.19.213.250:2380"],"advertise-client-urls":["https://199.19.213.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T10:34:03.59154Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T10:34:03.590983Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.250:2380"} {"level":"info","ts":"2026-04-17T10:34:03.59173Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.250:2380"} {"level":"info","ts":"2026-04-17T10:34:04.074924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T10:34:04.074982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T10:34:04.075005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 received MsgPreVoteResp from 1918dd9317ae83a2 at term 1"} {"level":"info","ts":"2026-04-17T10:34:04.075026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became candidate at term 2"} {"level":"info","ts":"2026-04-17T10:34:04.075046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 received MsgVoteResp from 1918dd9317ae83a2 at term 2"} {"level":"info","ts":"2026-04-17T10:34:04.07508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became leader at term 2"} {"level":"info","ts":"2026-04-17T10:34:04.075098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1918dd9317ae83a2 elected leader 1918dd9317ae83a2 at term 2"} {"level":"info","ts":"2026-04-17T10:34:04.076045Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1918dd9317ae83a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.250:2379]}","request-path":"/0/members/1918dd9317ae83a2/attributes","cluster-id":"1b9b645507bfe47a","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T10:34:04.076962Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T10:34:04.077329Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T10:34:04.077888Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T10:34:04.078007Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T10:34:04.078076Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T10:34:04.079125Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1b9b645507bfe47a","local-member-id":"1918dd9317ae83a2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T10:34:04.079205Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T10:34:04.079226Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T10:34:04.079679Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T10:34:04.079999Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.250:2379"} {"level":"info","ts":"2026-04-17T10:34:25.201517Z","caller":"traceutil/trace.go:171","msg":"trace[1985776602] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"300.424856ms","start":"2026-04-17T10:34:24.901065Z","end":"2026-04-17T10:34:25.20149Z","steps":["trace[1985776602] 'process raft request' (duration: 300.292173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:34:25.20225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:34:24.901049Z","time spent":"300.55612ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T10:34:31.246638Z","caller":"traceutil/trace.go:171","msg":"trace[431908167] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"135.292527ms","start":"2026-04-17T10:34:31.111321Z","end":"2026-04-17T10:34:31.246613Z","steps":["trace[431908167] 'process raft request' (duration: 120.458208ms)","trace[431908167] 'compare' (duration: 14.723166ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:34:31.249819Z","caller":"traceutil/trace.go:171","msg":"trace[2046879132] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"138.208864ms","start":"2026-04-17T10:34:31.111593Z","end":"2026-04-17T10:34:31.249802Z","steps":["trace[2046879132] 'process raft request' (duration: 137.613818ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.250034Z","caller":"traceutil/trace.go:171","msg":"trace[887403698] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"116.994935ms","start":"2026-04-17T10:34:31.133014Z","end":"2026-04-17T10:34:31.250009Z","steps":["trace[887403698] 'process raft request' (duration: 116.81244ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.250308Z","caller":"traceutil/trace.go:171","msg":"trace[1260149960] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"131.072163ms","start":"2026-04-17T10:34:31.119228Z","end":"2026-04-17T10:34:31.2503Z","steps":["trace[1260149960] 'process raft request' (duration: 130.487717ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.250336Z","caller":"traceutil/trace.go:171","msg":"trace[1765857090] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"128.802542ms","start":"2026-04-17T10:34:31.121507Z","end":"2026-04-17T10:34:31.250309Z","steps":["trace[1765857090] 'process raft request' (duration: 128.256857ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.250404Z","caller":"traceutil/trace.go:171","msg":"trace[1184866574] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"131.404912ms","start":"2026-04-17T10:34:31.118991Z","end":"2026-04-17T10:34:31.250396Z","steps":["trace[1184866574] 'process raft request' (duration: 130.386375ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.250496Z","caller":"traceutil/trace.go:171","msg":"trace[1276160340] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"131.464434ms","start":"2026-04-17T10:34:31.119023Z","end":"2026-04-17T10:34:31.250488Z","steps":["trace[1276160340] 'process raft request' (duration: 130.385145ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.250554Z","caller":"traceutil/trace.go:171","msg":"trace[10816202] transaction","detail":"{read_only:false; number_of_response:1; response_revision:475; }","duration":"131.478124ms","start":"2026-04-17T10:34:31.119069Z","end":"2026-04-17T10:34:31.250547Z","steps":["trace[10816202] 'process raft request' (duration: 130.377505ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.250657Z","caller":"traceutil/trace.go:171","msg":"trace[1354823095] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"131.531785ms","start":"2026-04-17T10:34:31.119119Z","end":"2026-04-17T10:34:31.250651Z","steps":["trace[1354823095] 'process raft request' (duration: 130.415655ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.250739Z","caller":"traceutil/trace.go:171","msg":"trace[1532115793] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"131.578766ms","start":"2026-04-17T10:34:31.119154Z","end":"2026-04-17T10:34:31.250732Z","steps":["trace[1532115793] 'process raft request' (duration: 130.511638ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.251294Z","caller":"traceutil/trace.go:171","msg":"trace[221377674] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"139.464218ms","start":"2026-04-17T10:34:31.111822Z","end":"2026-04-17T10:34:31.251287Z","steps":["trace[221377674] 'process raft request' (duration: 137.483025ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:31.252235Z","caller":"traceutil/trace.go:171","msg":"trace[739160994] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"133.294443ms","start":"2026-04-17T10:34:31.118928Z","end":"2026-04-17T10:34:31.252222Z","steps":["trace[739160994] 'process raft request' (duration: 130.422106ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:37.249805Z","caller":"traceutil/trace.go:171","msg":"trace[1143000826] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"124.358334ms","start":"2026-04-17T10:34:37.125415Z","end":"2026-04-17T10:34:37.249773Z","steps":["trace[1143000826] 'read index received' (duration: 124.087597ms)","trace[1143000826] 'applied index is now lower than readState.Index' (duration: 269.057µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:34:37.249969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.5547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T10:34:37.250043Z","caller":"traceutil/trace.go:171","msg":"trace[991837375] range","detail":"{range_begin:/registry/masterleases/199.19.213.250; range_end:; response_count:1; response_revision:567; }","duration":"124.682443ms","start":"2026-04-17T10:34:37.125349Z","end":"2026-04-17T10:34:37.250032Z","steps":["trace[991837375] 'agreement among raft nodes before linearized reading' (duration: 124.5487ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:37.250063Z","caller":"traceutil/trace.go:171","msg":"trace[1383495391] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"178.603016ms","start":"2026-04-17T10:34:37.071418Z","end":"2026-04-17T10:34:37.250021Z","steps":["trace[1383495391] 'process raft request' (duration: 178.187605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:34:37.699242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.48653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T10:34:37.699418Z","caller":"traceutil/trace.go:171","msg":"trace[1370683993] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"422.351888ms","start":"2026-04-17T10:34:37.277053Z","end":"2026-04-17T10:34:37.699405Z","steps":["trace[1370683993] 'process raft request' (duration: 45.424626ms)","trace[1370683993] 'compare' (duration: 376.102271ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:34:37.699485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:34:37.27703Z","time spent":"422.41963ms","remote":"127.0.0.1:43936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T10:34:37.699361Z","caller":"traceutil/trace.go:171","msg":"trace[682005465] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"383.663853ms","start":"2026-04-17T10:34:37.315682Z","end":"2026-04-17T10:34:37.699346Z","steps":["trace[682005465] 'read index received' (duration: 6.421983ms)","trace[682005465] 'applied index is now lower than readState.Index' (duration: 377.24072ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:34:37.699878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.852164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T10:34:37.699993Z","caller":"traceutil/trace.go:171","msg":"trace[423808425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"350.023517ms","start":"2026-04-17T10:34:37.349946Z","end":"2026-04-17T10:34:37.699969Z","steps":["trace[423808425] 'agreement among raft nodes before linearized reading' (duration: 349.855243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:34:37.700782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:34:37.34993Z","time spent":"350.836789ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T10:34:37.700885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.191662ms","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-17T10:34:37.700929Z","caller":"traceutil/trace.go:171","msg":"trace[1872481629] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:569; }","duration":"385.271204ms","start":"2026-04-17T10:34:37.315644Z","end":"2026-04-17T10:34:37.700915Z","steps":["trace[1872481629] 'agreement among raft nodes before linearized reading' (duration: 383.873809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:34:37.700963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:34:37.315601Z","time spent":"385.354316ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T10:34:37.967733Z","caller":"traceutil/trace.go:171","msg":"trace[775494360] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"262.300686ms","start":"2026-04-17T10:34:37.705396Z","end":"2026-04-17T10:34:37.967697Z","steps":["trace[775494360] 'process raft request' (duration: 216.957072ms)","trace[775494360] 'compare' (duration: 44.946894ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:34:37.967945Z","caller":"traceutil/trace.go:171","msg":"trace[395581633] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"194.609103ms","start":"2026-04-17T10:34:37.773324Z","end":"2026-04-17T10:34:37.967933Z","steps":["trace[395581633] 'process raft request' (duration: 194.233733ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:34:37.967902Z","caller":"traceutil/trace.go:171","msg":"trace[1515979479] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:594; }","duration":"129.777883ms","start":"2026-04-17T10:34:37.83809Z","end":"2026-04-17T10:34:37.967868Z","steps":["trace[1515979479] 'read index received' (duration: 84.362077ms)","trace[1515979479] 'applied index is now lower than readState.Index' (duration: 45.412316ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:34:37.968289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.163152ms","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-17T10:34:37.968436Z","caller":"traceutil/trace.go:171","msg":"trace[62305621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:571; }","duration":"130.389498ms","start":"2026-04-17T10:34:37.838008Z","end":"2026-04-17T10:34:37.968397Z","steps":["trace[62305621] 'agreement among raft nodes before linearized reading' (duration: 130.016699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:34:53.553371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.528928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T10:34:53.55349Z","caller":"traceutil/trace.go:171","msg":"trace[535546794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:736; }","duration":"204.705972ms","start":"2026-04-17T10:34:53.34876Z","end":"2026-04-17T10:34:53.553466Z","steps":["trace[535546794] 'range keys from in-memory index tree' (duration: 204.458477ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:35:27.711712Z","caller":"traceutil/trace.go:171","msg":"trace[753225275] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"117.971355ms","start":"2026-04-17T10:35:27.593717Z","end":"2026-04-17T10:35:27.711688Z","steps":["trace[753225275] 'process raft request' (duration: 117.810402ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:35:45.642213Z","caller":"traceutil/trace.go:171","msg":"trace[1903798516] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"179.349397ms","start":"2026-04-17T10:35:45.462846Z","end":"2026-04-17T10:35:45.642196Z","steps":["trace[1903798516] 'process raft request' (duration: 179.234275ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:35:51.368367Z","caller":"traceutil/trace.go:171","msg":"trace[748881972] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"261.836646ms","start":"2026-04-17T10:35:51.106506Z","end":"2026-04-17T10:35:51.368342Z","steps":["trace[748881972] 'process raft request' (duration: 261.687134ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:36:16.714173Z","caller":"traceutil/trace.go:171","msg":"trace[1974013767] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"273.341203ms","start":"2026-04-17T10:36:16.440811Z","end":"2026-04-17T10:36:16.714152Z","steps":["trace[1974013767] 'read index received' (duration: 273.321143ms)","trace[1974013767] 'applied index is now lower than readState.Index' (duration: 19.21µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:36:16.714366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.535265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T10:36:16.714409Z","caller":"traceutil/trace.go:171","msg":"trace[593637490] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1107; }","duration":"273.621476ms","start":"2026-04-17T10:36:16.440775Z","end":"2026-04-17T10:36:16.714397Z","steps":["trace[593637490] 'agreement among raft nodes before linearized reading' (duration: 273.527925ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:36:16.714217Z","caller":"traceutil/trace.go:171","msg":"trace[1133514781] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"287.036684ms","start":"2026-04-17T10:36:16.427152Z","end":"2026-04-17T10:36:16.714189Z","steps":["trace[1133514781] 'process raft request' (duration: 286.880982ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:36:16.86152Z","caller":"traceutil/trace.go:171","msg":"trace[2008491808] linearizableReadLoop","detail":"{readStateIndex:1154; appliedIndex:1153; }","duration":"147.259153ms","start":"2026-04-17T10:36:16.714238Z","end":"2026-04-17T10:36:16.861497Z","steps":["trace[2008491808] 'read index received' (duration: 135.715806ms)","trace[2008491808] 'applied index is now lower than readState.Index' (duration: 11.542417ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:36:16.861698Z","caller":"traceutil/trace.go:171","msg":"trace[806075689] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"331.516754ms","start":"2026-04-17T10:36:16.530105Z","end":"2026-04-17T10:36:16.861621Z","steps":["trace[806075689] 'process raft request' (duration: 319.965347ms)","trace[806075689] 'compare' (duration: 11.316025ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:36:16.861834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.503353ms","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-17T10:36:16.861893Z","caller":"traceutil/trace.go:171","msg":"trace[1313620433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1108; }","duration":"300.591723ms","start":"2026-04-17T10:36:16.561287Z","end":"2026-04-17T10:36:16.861879Z","steps":["trace[1313620433] 'agreement among raft nodes before linearized reading' (duration: 300.230669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:36:16.861896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.55615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-17T10:36:16.861927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:36:16.561277Z","time spent":"300.642624ms","remote":"127.0.0.1:44124","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-17T10:36:16.861954Z","caller":"traceutil/trace.go:171","msg":"trace[1926013818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1108; }","duration":"317.687752ms","start":"2026-04-17T10:36:16.544246Z","end":"2026-04-17T10:36:16.861934Z","steps":["trace[1926013818] 'agreement among raft nodes before linearized reading' (duration: 317.51171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:36:16.861959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:36:16.530069Z","time spent":"331.731256ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T10:36:16.862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:36:16.544233Z","time spent":"317.754452ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T10:36:16.861732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.624174ms","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-17T10:36:16.862127Z","caller":"traceutil/trace.go:171","msg":"trace[1313891473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1108; }","duration":"331.042789ms","start":"2026-04-17T10:36:16.531049Z","end":"2026-04-17T10:36:16.862092Z","steps":["trace[1313891473] 'agreement among raft nodes before linearized reading' (duration: 330.576343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:36:16.862232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:36:16.531038Z","time spent":"331.156851ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-17T10:36:17.035193Z","caller":"traceutil/trace.go:171","msg":"trace[93917667] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"168.315345ms","start":"2026-04-17T10:36:16.866853Z","end":"2026-04-17T10:36:17.035169Z","steps":["trace[93917667] 'process raft request' (duration: 116.432293ms)","trace[93917667] 'compare' (duration: 51.605799ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:36:17.035385Z","caller":"traceutil/trace.go:171","msg":"trace[1090309307] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"168.479456ms","start":"2026-04-17T10:36:16.866887Z","end":"2026-04-17T10:36:17.035366Z","steps":["trace[1090309307] 'process raft request' (duration: 168.214213ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:36:17.035525Z","caller":"traceutil/trace.go:171","msg":"trace[1880228224] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"168.606368ms","start":"2026-04-17T10:36:16.866912Z","end":"2026-04-17T10:36:17.035518Z","steps":["trace[1880228224] 'process raft request' (duration: 168.392146ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:36:17.921683Z","caller":"traceutil/trace.go:171","msg":"trace[1931027935] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"124.33852ms","start":"2026-04-17T10:36:17.797318Z","end":"2026-04-17T10:36:17.921657Z","steps":["trace[1931027935] 'process raft request' (duration: 124.150858ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:36:18.890875Z","caller":"traceutil/trace.go:171","msg":"trace[491064165] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"186.157302ms","start":"2026-04-17T10:36:18.704692Z","end":"2026-04-17T10:36:18.890849Z","steps":["trace[491064165] 'process raft request' (duration: 185.95154ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:36:18.891405Z","caller":"traceutil/trace.go:171","msg":"trace[975632850] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1161; }","duration":"173.579903ms","start":"2026-04-17T10:36:18.717773Z","end":"2026-04-17T10:36:18.891353Z","steps":["trace[975632850] 'read index received' (duration: 173.567243ms)","trace[975632850] 'applied index is now lower than readState.Index' (duration: 11.38µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:36:18.89162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.823856ms","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-17T10:36:18.891721Z","caller":"traceutil/trace.go:171","msg":"trace[1665610440] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1114; }","duration":"173.957327ms","start":"2026-04-17T10:36:18.717747Z","end":"2026-04-17T10:36:18.891704Z","steps":["trace[1665610440] 'agreement among raft nodes before linearized reading' (duration: 173.700034ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:37:38.815431Z","caller":"traceutil/trace.go:171","msg":"trace[281390278] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"217.074522ms","start":"2026-04-17T10:37:38.598309Z","end":"2026-04-17T10:37:38.815383Z","steps":["trace[281390278] 'process raft request' (duration: 216.827006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:37:39.508847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.130635ms","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-17T10:37:39.508994Z","caller":"traceutil/trace.go:171","msg":"trace[1089302214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1378; }","duration":"158.34006ms","start":"2026-04-17T10:37:39.350619Z","end":"2026-04-17T10:37:39.508959Z","steps":["trace[1089302214] 'range keys from in-memory index tree' (duration: 157.865128ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:39:26.541552Z","caller":"traceutil/trace.go:171","msg":"trace[85959938] transaction","detail":"{read_only:false; response_revision:1731; number_of_response:1; }","duration":"102.568486ms","start":"2026-04-17T10:39:26.438957Z","end":"2026-04-17T10:39:26.541526Z","steps":["trace[85959938] 'process raft request' (duration: 102.389192ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:39:26.541504Z","caller":"traceutil/trace.go:171","msg":"trace[507458753] linearizableReadLoop","detail":"{readStateIndex:1815; appliedIndex:1814; }","duration":"101.479299ms","start":"2026-04-17T10:39:26.440001Z","end":"2026-04-17T10:39:26.54148Z","steps":["trace[507458753] 'read index received' (duration: 101.270804ms)","trace[507458753] 'applied index is now lower than readState.Index' (duration: 207.325µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:39:26.541842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.770486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-17T10:39:26.542002Z","caller":"traceutil/trace.go:171","msg":"trace[2097973539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1731; }","duration":"101.985002ms","start":"2026-04-17T10:39:26.439985Z","end":"2026-04-17T10:39:26.54197Z","steps":["trace[2097973539] 'agreement among raft nodes before linearized reading' (duration: 101.620673ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:40:52.570239Z","caller":"traceutil/trace.go:171","msg":"trace[1546412488] linearizableReadLoop","detail":"{readStateIndex:2115; appliedIndex:2114; }","duration":"109.12048ms","start":"2026-04-17T10:40:52.461091Z","end":"2026-04-17T10:40:52.570212Z","steps":["trace[1546412488] 'read index received' (duration: 108.888234ms)","trace[1546412488] 'applied index is now lower than readState.Index' (duration: 230.916µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:40:52.570435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.334646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-17T10:40:52.570474Z","caller":"traceutil/trace.go:171","msg":"trace[1463048059] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2014; }","duration":"109.450129ms","start":"2026-04-17T10:40:52.461014Z","end":"2026-04-17T10:40:52.570464Z","steps":["trace[1463048059] 'agreement among raft nodes before linearized reading' (duration: 109.306295ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:40:52.570511Z","caller":"traceutil/trace.go:171","msg":"trace[1036714391] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"170.577771ms","start":"2026-04-17T10:40:52.399903Z","end":"2026-04-17T10:40:52.570481Z","steps":["trace[1036714391] 'process raft request' (duration: 170.12702ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:40:52.906648Z","caller":"traceutil/trace.go:171","msg":"trace[380631034] linearizableReadLoop","detail":"{readStateIndex:2117; appliedIndex:2115; }","duration":"261.830979ms","start":"2026-04-17T10:40:52.644781Z","end":"2026-04-17T10:40:52.906612Z","steps":["trace[380631034] 'read index received' (duration: 217.267517ms)","trace[380631034] 'applied index is now lower than readState.Index' (duration: 44.562122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:40:52.906854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.010893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T10:40:52.906934Z","caller":"traceutil/trace.go:171","msg":"trace[292048493] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2015; }","duration":"262.179677ms","start":"2026-04-17T10:40:52.644733Z","end":"2026-04-17T10:40:52.906913Z","steps":["trace[292048493] 'agreement among raft nodes before linearized reading' (duration: 262.003603ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:40:52.907007Z","caller":"traceutil/trace.go:171","msg":"trace[1778435874] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"331.917059ms","start":"2026-04-17T10:40:52.57506Z","end":"2026-04-17T10:40:52.906977Z","steps":["trace[1778435874] 'process raft request' (duration: 331.363495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:40:52.907166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:40:52.57504Z","time spent":"332.047282ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T10:41:07.199274Z","caller":"traceutil/trace.go:171","msg":"trace[662842034] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"186.661343ms","start":"2026-04-17T10:41:07.01258Z","end":"2026-04-17T10:41:07.199241Z","steps":["trace[662842034] 'process raft request' (duration: 186.500928ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:41:07.527969Z","caller":"traceutil/trace.go:171","msg":"trace[319026030] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2217; }","duration":"395.491062ms","start":"2026-04-17T10:41:07.132454Z","end":"2026-04-17T10:41:07.527945Z","steps":["trace[319026030] 'read index received' (duration: 66.566901ms)","trace[319026030] 'applied index is now lower than readState.Index' (duration: 328.922671ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:41:07.528237Z","caller":"traceutil/trace.go:171","msg":"trace[2010721705] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"515.212884ms","start":"2026-04-17T10:41:07.01301Z","end":"2026-04-17T10:41:07.528222Z","steps":["trace[2010721705] 'process raft request' (duration: 514.791753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:07.528347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:07.012993Z","time spent":"515.280775ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T10:41:07.528639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.18864ms","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-17T10:41:07.528683Z","caller":"traceutil/trace.go:171","msg":"trace[1854839975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2113; }","duration":"396.269852ms","start":"2026-04-17T10:41:07.132402Z","end":"2026-04-17T10:41:07.528672Z","steps":["trace[1854839975] 'agreement among raft nodes before linearized reading' (duration: 396.138138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:07.528712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:07.132382Z","time spent":"396.324203ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T10:41:07.530057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.718077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T10:41:07.530109Z","caller":"traceutil/trace.go:171","msg":"trace[1157457627] range","detail":"{range_begin:/registry/masterleases/199.19.213.250; range_end:; response_count:1; response_revision:2114; }","duration":"380.79883ms","start":"2026-04-17T10:41:07.149298Z","end":"2026-04-17T10:41:07.530097Z","steps":["trace[1157457627] 'agreement among raft nodes before linearized reading' (duration: 380.670076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:07.530139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:07.149285Z","time spent":"380.847481ms","remote":"127.0.0.1:43868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.250\" "} {"level":"warn","ts":"2026-04-17T10:41:07.530716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.396289ms","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-17T10:41:07.531055Z","caller":"traceutil/trace.go:171","msg":"trace[1196827549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2114; }","duration":"380.733427ms","start":"2026-04-17T10:41:07.15031Z","end":"2026-04-17T10:41:07.531044Z","steps":["trace[1196827549] 'agreement among raft nodes before linearized reading' (duration: 380.345427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:07.531089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:07.150251Z","time spent":"380.82846ms","remote":"127.0.0.1:44124","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-17T10:41:25.933538Z","caller":"traceutil/trace.go:171","msg":"trace[1723780556] linearizableReadLoop","detail":"{readStateIndex:2317; appliedIndex:2316; }","duration":"317.752251ms","start":"2026-04-17T10:41:25.615765Z","end":"2026-04-17T10:41:25.933517Z","steps":["trace[1723780556] 'read index received' (duration: 317.513275ms)","trace[1723780556] 'applied index is now lower than readState.Index' (duration: 238.096µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:41:25.933599Z","caller":"traceutil/trace.go:171","msg":"trace[37423313] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"321.140609ms","start":"2026-04-17T10:41:25.612438Z","end":"2026-04-17T10:41:25.933578Z","steps":["trace[37423313] 'process raft request' (duration: 320.930903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:25.93374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:25.61241Z","time spent":"321.250612ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T10:41:25.933765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.952606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-17T10:41:25.933796Z","caller":"traceutil/trace.go:171","msg":"trace[322190713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2207; }","duration":"318.023658ms","start":"2026-04-17T10:41:25.615764Z","end":"2026-04-17T10:41:25.933787Z","steps":["trace[322190713] 'agreement among raft nodes before linearized reading' (duration: 317.879264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:25.933783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.993137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-17T10:41:25.933835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:25.615746Z","time spent":"318.081249ms","remote":"127.0.0.1:44124","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-17T10:41:25.933862Z","caller":"traceutil/trace.go:171","msg":"trace[1915550756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2207; }","duration":"318.117451ms","start":"2026-04-17T10:41:25.615726Z","end":"2026-04-17T10:41:25.933844Z","steps":["trace[1915550756] 'agreement among raft nodes before linearized reading' (duration: 317.877464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:25.93392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:25.61571Z","time spent":"318.199292ms","remote":"127.0.0.1:44124","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-17T10:41:26.142086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.734367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T10:41:26.142477Z","caller":"traceutil/trace.go:171","msg":"trace[780476919] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"204.574238ms","start":"2026-04-17T10:41:25.937876Z","end":"2026-04-17T10:41:26.142451Z","steps":["trace[780476919] 'process raft request' (duration: 95.360849ms)","trace[780476919] 'compare' (duration: 108.398227ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:41:28.311381Z","caller":"traceutil/trace.go:171","msg":"trace[1463502132] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"163.922881ms","start":"2026-04-17T10:41:28.147432Z","end":"2026-04-17T10:41:28.311355Z","steps":["trace[1463502132] 'process raft request' (duration: 163.799598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:28.44721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.199655ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T10:41:28.447317Z","caller":"traceutil/trace.go:171","msg":"trace[1867444212] linearizableReadLoop","detail":"{readStateIndex:2330; appliedIndex:2328; }","duration":"248.355117ms","start":"2026-04-17T10:41:28.198944Z","end":"2026-04-17T10:41:28.447299Z","steps":["trace[1867444212] 'read index received' (duration: 112.294299ms)","trace[1867444212] 'applied index is now lower than readState.Index' (duration: 136.059297ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:41:28.447418Z","caller":"traceutil/trace.go:171","msg":"trace[441188828] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"294.67454ms","start":"2026-04-17T10:41:28.152728Z","end":"2026-04-17T10:41:28.447403Z","steps":["trace[441188828] 'process raft request' (duration: 194.201278ms)","trace[441188828] 'compare' (duration: 100.060272ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:41:28.447874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.87583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-17T10:41:28.448023Z","caller":"traceutil/trace.go:171","msg":"trace[337498023] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2219; }","duration":"249.099486ms","start":"2026-04-17T10:41:28.198904Z","end":"2026-04-17T10:41:28.448004Z","steps":["trace[337498023] 'agreement among raft nodes before linearized reading' (duration: 248.700045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:28.45435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.242646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T10:41:28.454411Z","caller":"traceutil/trace.go:171","msg":"trace[1407120184] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2220; }","duration":"235.336428ms","start":"2026-04-17T10:41:28.219061Z","end":"2026-04-17T10:41:28.454397Z","steps":["trace[1407120184] 'agreement among raft nodes before linearized reading' (duration: 235.220335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:28.454465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.361692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/test-pvc.18a71ed679d64659\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-04-17T10:41:28.454552Z","caller":"traceutil/trace.go:171","msg":"trace[2093911105] range","detail":"{range_begin:/registry/events/default/test-pvc.18a71ed679d64659; range_end:; response_count:1; response_revision:2220; }","duration":"159.507667ms","start":"2026-04-17T10:41:28.295025Z","end":"2026-04-17T10:41:28.454532Z","steps":["trace[2093911105] 'agreement among raft nodes before linearized reading' (duration: 159.278691ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:41:46.221851Z","caller":"traceutil/trace.go:171","msg":"trace[77760100] transaction","detail":"{read_only:false; response_revision:2350; number_of_response:1; }","duration":"152.272508ms","start":"2026-04-17T10:41:46.069552Z","end":"2026-04-17T10:41:46.221825Z","steps":["trace[77760100] 'process raft request' (duration: 152.022432ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T10:41:46.847268Z","caller":"traceutil/trace.go:171","msg":"trace[1312995787] linearizableReadLoop","detail":"{readStateIndex:2466; appliedIndex:2465; }","duration":"316.558941ms","start":"2026-04-17T10:41:46.530685Z","end":"2026-04-17T10:41:46.847244Z","steps":["trace[1312995787] 'read index received' (duration: 237.998829ms)","trace[1312995787] 'applied index is now lower than readState.Index' (duration: 78.559142ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T10:41:46.847554Z","caller":"traceutil/trace.go:171","msg":"trace[2129776023] transaction","detail":"{read_only:false; response_revision:2352; number_of_response:1; }","duration":"482.134575ms","start":"2026-04-17T10:41:46.365405Z","end":"2026-04-17T10:41:46.84754Z","steps":["trace[2129776023] 'process raft request' (duration: 403.308796ms)","trace[2129776023] 'compare' (duration: 78.395148ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T10:41:46.847663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:46.365379Z","time spent":"482.212857ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T10:41:46.847929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.806734ms","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-17T10:41:46.847987Z","caller":"traceutil/trace.go:171","msg":"trace[986528110] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2352; }","duration":"312.915406ms","start":"2026-04-17T10:41:46.535057Z","end":"2026-04-17T10:41:46.847972Z","steps":["trace[986528110] 'agreement among raft nodes before linearized reading' (duration: 312.715811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:46.848001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.313631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-17T10:41:46.848022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:46.535051Z","time spent":"312.962777ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-17T10:41:46.84805Z","caller":"traceutil/trace.go:171","msg":"trace[935361365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2352; }","duration":"317.396313ms","start":"2026-04-17T10:41:46.530643Z","end":"2026-04-17T10:41:46.848039Z","steps":["trace[935361365] 'agreement among raft nodes before linearized reading' (duration: 317.27976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T10:41:46.848084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T10:41:46.530623Z","time spent":"317.454274ms","remote":"127.0.0.1:44124","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\" "}