{"level":"warn","ts":"2026-04-07T15:26:16.002193Z","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-07T15:26:16.002281Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.87: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.87:2380","--initial-cluster=instance=https://199.19.213.87:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.87:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.87: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-07T15:26:16.002348Z","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-07T15:26:16.002359Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.87:2380"]} {"level":"info","ts":"2026-04-07T15:26:16.002375Z","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-07T15:26:16.00331Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.87:2379"]} {"level":"info","ts":"2026-04-07T15:26:16.003387Z","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.87:2380"],"listen-peer-urls":["https://199.19.213.87:2380"],"advertise-client-urls":["https://199.19.213.87:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.87:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.87: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-07T15:26:16.007529Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.931701ms"} {"level":"info","ts":"2026-04-07T15:26:16.019561Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bc3cb673a921c717","cluster-id":"f315f77360ac6549"} {"level":"info","ts":"2026-04-07T15:26:16.019673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T15:26:16.01971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became follower at term 0"} {"level":"info","ts":"2026-04-07T15:26:16.019729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bc3cb673a921c717 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T15:26:16.019789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became follower at term 1"} {"level":"info","ts":"2026-04-07T15:26:16.019829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 switched to configuration voters=(13563916785608148759)"} {"level":"warn","ts":"2026-04-07T15:26:16.026223Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T15:26:16.028644Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T15:26:16.029784Z","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-07T15:26:16.031971Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bc3cb673a921c717","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T15:26:16.033185Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bc3cb673a921c717","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T15:26:16.033411Z","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-07T15:26:16.033471Z","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-07T15:26:16.033503Z","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-07T15:26:16.034177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 switched to configuration voters=(13563916785608148759)"} {"level":"info","ts":"2026-04-07T15:26:16.034337Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f315f77360ac6549","local-member-id":"bc3cb673a921c717","added-peer-id":"bc3cb673a921c717","added-peer-peer-urls":["https://199.19.213.87:2380"]} {"level":"info","ts":"2026-04-07T15:26:16.034787Z","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-07T15:26:16.0349Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.87:2380"} {"level":"info","ts":"2026-04-07T15:26:16.034917Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.87:2380"} {"level":"info","ts":"2026-04-07T15:26:16.035108Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bc3cb673a921c717","initial-advertise-peer-urls":["https://199.19.213.87:2380"],"listen-peer-urls":["https://199.19.213.87:2380"],"advertise-client-urls":["https://199.19.213.87:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.87:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T15:26:16.035153Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T15:26:16.82048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T15:26:16.820582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T15:26:16.820608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 received MsgPreVoteResp from bc3cb673a921c717 at term 1"} {"level":"info","ts":"2026-04-07T15:26:16.820628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became candidate at term 2"} {"level":"info","ts":"2026-04-07T15:26:16.820639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 received MsgVoteResp from bc3cb673a921c717 at term 2"} {"level":"info","ts":"2026-04-07T15:26:16.820655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became leader at term 2"} {"level":"info","ts":"2026-04-07T15:26:16.820676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bc3cb673a921c717 elected leader bc3cb673a921c717 at term 2"} {"level":"info","ts":"2026-04-07T15:26:16.822075Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bc3cb673a921c717","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.87:2379]}","request-path":"/0/members/bc3cb673a921c717/attributes","cluster-id":"f315f77360ac6549","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T15:26:16.822105Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:26:16.822247Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T15:26:16.822277Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T15:26:16.822331Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T15:26:16.822637Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T15:26:16.823313Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f315f77360ac6549","local-member-id":"bc3cb673a921c717","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:26:16.823444Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:26:16.823619Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:26:16.825706Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.87:2379"} {"level":"info","ts":"2026-04-07T15:26:16.826709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T15:26:46.339415Z","caller":"traceutil/trace.go:171","msg":"trace[1150766213] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"117.705687ms","start":"2026-04-07T15:26:46.221644Z","end":"2026-04-07T15:26:46.339349Z","steps":["trace[1150766213] 'process raft request' (duration: 63.007755ms)","trace[1150766213] 'compare' (duration: 54.354313ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:26:46.339786Z","caller":"traceutil/trace.go:171","msg":"trace[1570746612] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"106.748601ms","start":"2026-04-07T15:26:46.233016Z","end":"2026-04-07T15:26:46.339765Z","steps":["trace[1570746612] 'process raft request' (duration: 106.519194ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:26:46.339798Z","caller":"traceutil/trace.go:171","msg":"trace[1190150163] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"110.200457ms","start":"2026-04-07T15:26:46.22957Z","end":"2026-04-07T15:26:46.33977Z","steps":["trace[1190150163] 'process raft request' (duration: 109.896808ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:26:52.217113Z","caller":"traceutil/trace.go:171","msg":"trace[446146653] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"105.968708ms","start":"2026-04-07T15:26:52.111118Z","end":"2026-04-07T15:26:52.217086Z","steps":["trace[446146653] 'process raft request' (duration: 105.364051ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:26:52.709327Z","caller":"traceutil/trace.go:171","msg":"trace[1408262881] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"209.513989ms","start":"2026-04-07T15:26:52.499789Z","end":"2026-04-07T15:26:52.709303Z","steps":["trace[1408262881] 'read index received' (duration: 209.339234ms)","trace[1408262881] 'applied index is now lower than readState.Index' (duration: 173.925µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:26:52.709423Z","caller":"traceutil/trace.go:171","msg":"trace[1380897345] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"432.784322ms","start":"2026-04-07T15:26:52.276605Z","end":"2026-04-07T15:26:52.709389Z","steps":["trace[1380897345] 'process raft request' (duration: 432.573797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:26:52.709578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.9968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:26:52.709664Z","caller":"traceutil/trace.go:171","msg":"trace[1193380291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"151.130784ms","start":"2026-04-07T15:26:52.558514Z","end":"2026-04-07T15:26:52.709645Z","steps":["trace[1193380291] 'agreement among raft nodes before linearized reading' (duration: 150.981289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:26:52.709601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.790127ms","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-07T15:26:52.71009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:26:52.27658Z","time spent":"433.068151ms","remote":"127.0.0.1:40588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T15:26:52.710143Z","caller":"traceutil/trace.go:171","msg":"trace[1883436731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"210.395524ms","start":"2026-04-07T15:26:52.499738Z","end":"2026-04-07T15:26:52.710133Z","steps":["trace[1883436731] 'agreement among raft nodes before linearized reading' (duration: 209.694075ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:28:02.619422Z","caller":"traceutil/trace.go:171","msg":"trace[1453935805] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"143.506061ms","start":"2026-04-07T15:28:02.475872Z","end":"2026-04-07T15:28:02.619378Z","steps":["trace[1453935805] 'process raft request' (duration: 143.301194ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:28:03.804135Z","caller":"traceutil/trace.go:171","msg":"trace[1577150424] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"149.133521ms","start":"2026-04-07T15:28:03.654979Z","end":"2026-04-07T15:28:03.804112Z","steps":["trace[1577150424] 'process raft request' (duration: 149.019768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:28:04.333981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.210782ms","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-07T15:28:04.334061Z","caller":"traceutil/trace.go:171","msg":"trace[357136497] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1031; }","duration":"343.344286ms","start":"2026-04-07T15:28:03.9907Z","end":"2026-04-07T15:28:04.334044Z","steps":["trace[357136497] 'range keys from in-memory index tree' (duration: 343.023596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:28:04.334104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:28:03.990679Z","time spent":"343.416018ms","remote":"127.0.0.1:40378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T15:28:05.322727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.590046ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-07T15:28:05.323229Z","caller":"traceutil/trace.go:171","msg":"trace[213617449] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"143.49229ms","start":"2026-04-07T15:28:05.179705Z","end":"2026-04-07T15:28:05.323198Z","steps":["trace[213617449] 'process raft request' (duration: 143.264563ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:28:05.323238Z","caller":"traceutil/trace.go:171","msg":"trace[970291235] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1072; }","duration":"147.348237ms","start":"2026-04-07T15:28:05.175857Z","end":"2026-04-07T15:28:05.323205Z","steps":["trace[970291235] 'read index received' (duration: 11.058129ms)","trace[970291235] 'applied index is now lower than readState.Index' (duration: 136.286288ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:28:05.323481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.880245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-07T15:28:05.323515Z","caller":"traceutil/trace.go:171","msg":"trace[452190112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1036; }","duration":"165.986928ms","start":"2026-04-07T15:28:05.157516Z","end":"2026-04-07T15:28:05.323503Z","steps":["trace[452190112] 'agreement among raft nodes before linearized reading' (duration: 165.806093ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:28:18.869959Z","caller":"traceutil/trace.go:171","msg":"trace[922078522] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1176; }","duration":"160.673825ms","start":"2026-04-07T15:28:18.70926Z","end":"2026-04-07T15:28:18.869934Z","steps":["trace[922078522] 'read index received' (duration: 160.440638ms)","trace[922078522] 'applied index is now lower than readState.Index' (duration: 232.307µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:28:18.870078Z","caller":"traceutil/trace.go:171","msg":"trace[1012495756] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"391.820981ms","start":"2026-04-07T15:28:18.478244Z","end":"2026-04-07T15:28:18.870065Z","steps":["trace[1012495756] 'process raft request' (duration: 391.519152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:28:18.870372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:28:18.478228Z","time spent":"391.880733ms","remote":"127.0.0.1:40378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:28:18.870418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.1418ms","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-07T15:28:18.870488Z","caller":"traceutil/trace.go:171","msg":"trace[1912801021] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1135; }","duration":"161.248113ms","start":"2026-04-07T15:28:18.709221Z","end":"2026-04-07T15:28:18.870469Z","steps":["trace[1912801021] 'agreement among raft nodes before linearized reading' (duration: 161.063668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:28:19.05089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.696508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T15:28:19.050997Z","caller":"traceutil/trace.go:171","msg":"trace[1097888173] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"176.072678ms","start":"2026-04-07T15:28:18.874904Z","end":"2026-04-07T15:28:19.050977Z","steps":["trace[1097888173] 'process raft request' (duration: 43.179984ms)","trace[1097888173] 'compare' (duration: 132.600795ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:28:34.01228Z","caller":"traceutil/trace.go:171","msg":"trace[1533957561] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"123.531757ms","start":"2026-04-07T15:28:33.888723Z","end":"2026-04-07T15:28:34.012255Z","steps":["trace[1533957561] 'process raft request' (duration: 105.554995ms)","trace[1533957561] 'compare' (duration: 17.58936ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:28:34.534236Z","caller":"traceutil/trace.go:171","msg":"trace[566843610] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"105.399272ms","start":"2026-04-07T15:28:34.428811Z","end":"2026-04-07T15:28:34.534211Z","steps":["trace[566843610] 'process raft request' (duration: 105.249487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:28:34.753976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.609418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T15:28:34.754124Z","caller":"traceutil/trace.go:171","msg":"trace[81343041] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"302.034879ms","start":"2026-04-07T15:28:34.452061Z","end":"2026-04-07T15:28:34.754096Z","steps":["trace[81343041] 'process raft request' (duration: 195.221044ms)","trace[81343041] 'compare' (duration: 106.262338ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:28:34.754225Z","caller":"traceutil/trace.go:171","msg":"trace[725650886] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"160.061038ms","start":"2026-04-07T15:28:34.594146Z","end":"2026-04-07T15:28:34.754207Z","steps":["trace[725650886] 'process raft request' (duration: 159.961215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:28:34.754257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:28:34.452038Z","time spent":"302.145903ms","remote":"127.0.0.1:40378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:28:34.754421Z","caller":"traceutil/trace.go:171","msg":"trace[1365654050] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1253; }","duration":"195.752171ms","start":"2026-04-07T15:28:34.558659Z","end":"2026-04-07T15:28:34.754412Z","steps":["trace[1365654050] 'read index received' (duration: 88.633866ms)","trace[1365654050] 'applied index is now lower than readState.Index' (duration: 107.117025ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:28:34.754612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.954928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:28:34.754664Z","caller":"traceutil/trace.go:171","msg":"trace[1781055569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1210; }","duration":"196.04644ms","start":"2026-04-07T15:28:34.558607Z","end":"2026-04-07T15:28:34.754654Z","steps":["trace[1781055569] 'agreement among raft nodes before linearized reading' (duration: 195.934337ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:28:35.331822Z","caller":"traceutil/trace.go:171","msg":"trace[729825459] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1261; }","duration":"145.631155ms","start":"2026-04-07T15:28:35.186176Z","end":"2026-04-07T15:28:35.331807Z","steps":["trace[729825459] 'read index received' (duration: 48.749175ms)","trace[729825459] 'applied index is now lower than readState.Index' (duration: 96.88127ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:28:35.331912Z","caller":"traceutil/trace.go:171","msg":"trace[1754067646] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"145.859492ms","start":"2026-04-07T15:28:35.186045Z","end":"2026-04-07T15:28:35.331905Z","steps":["trace[1754067646] 'process raft request' (duration: 145.675746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:28:35.47784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.63053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:28:35.477928Z","caller":"traceutil/trace.go:171","msg":"trace[779141533] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1217; }","duration":"291.736533ms","start":"2026-04-07T15:28:35.186171Z","end":"2026-04-07T15:28:35.477907Z","steps":["trace[779141533] 'agreement among raft nodes before linearized reading' (duration: 145.884372ms)","trace[779141533] 'count revisions from in-memory index tree' (duration: 145.727308ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:28:35.478099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.294987ms","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-07T15:28:35.478146Z","caller":"traceutil/trace.go:171","msg":"trace[720306432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1217; }","duration":"180.367879ms","start":"2026-04-07T15:28:35.297764Z","end":"2026-04-07T15:28:35.478132Z","steps":["trace[720306432] 'agreement among raft nodes before linearized reading' (duration: 34.281631ms)","trace[720306432] 'range keys from in-memory index tree' (duration: 145.947454ms)"],"step_count":2}