{"level":"warn","ts":"2026-07-09T16:44:22.870725Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T16:44:22.870805Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.177: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.177:2380","--initial-cluster=instance=https://199.204.45.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.177: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-07-09T16:44:22.870869Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T16:44:22.870881Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-07-09T16:44:22.870899Z","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-07-09T16:44:22.871547Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"]} {"level":"info","ts":"2026-07-09T16:44:22.871787Z","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.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.177: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-07-09T16:44:22.874781Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.721738ms"} {"level":"info","ts":"2026-07-09T16:44:22.879384Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7c53a18098324dc9","cluster-id":"4717e8aa221973c8"} {"level":"info","ts":"2026-07-09T16:44:22.879449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T16:44:22.879473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 0"} {"level":"info","ts":"2026-07-09T16:44:22.879484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7c53a18098324dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T16:44:22.879495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 1"} {"level":"info","ts":"2026-07-09T16:44:22.879528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"warn","ts":"2026-07-09T16:44:22.885339Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T16:44:22.886704Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T16:44:22.88782Z","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-07-09T16:44:22.89019Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7c53a18098324dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T16:44:22.893538Z","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-07-09T16:44:22.893734Z","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-07-09T16:44:22.893626Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7c53a18098324dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T16:44:22.893747Z","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-07-09T16:44:22.896517Z","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-07-09T16:44:22.896691Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7c53a18098324dc9","initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T16:44:22.896721Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T16:44:22.89678Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-07-09T16:44:22.896795Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-07-09T16:44:22.89823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"info","ts":"2026-07-09T16:44:22.898434Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","added-peer-id":"7c53a18098324dc9","added-peer-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-07-09T16:44:23.880432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T16:44:23.880495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T16:44:23.880535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgPreVoteResp from 7c53a18098324dc9 at term 1"} {"level":"info","ts":"2026-07-09T16:44:23.880553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became candidate at term 2"} {"level":"info","ts":"2026-07-09T16:44:23.880565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgVoteResp from 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-07-09T16:44:23.880581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became leader at term 2"} {"level":"info","ts":"2026-07-09T16:44:23.880594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7c53a18098324dc9 elected leader 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-07-09T16:44:23.881677Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7c53a18098324dc9","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.177:2379]}","request-path":"/0/members/7c53a18098324dc9/attributes","cluster-id":"4717e8aa221973c8","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T16:44:23.881852Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T16:44:23.881928Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T16:44:23.882017Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:44:23.883255Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T16:44:23.883289Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T16:44:23.883529Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:44:23.883741Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:44:23.883931Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:44:23.886208Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.177:2379"} {"level":"info","ts":"2026-07-09T16:44:23.886427Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-09T16:44:26.57052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-09T16:44:26.570631Z","caller":"traceutil/trace.go:171","msg":"trace[1047031975] linearizableReadLoop","detail":"{readStateIndex:131; appliedIndex:130; }","duration":"356.503791ms","start":"2026-07-09T16:44:26.214111Z","end":"2026-07-09T16:44:26.570615Z","steps":["trace[1047031975] 'read index received' (duration: 62.286724ms)","trace[1047031975] 'applied index is now lower than readState.Index' (duration: 294.215737ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:44:26.570698Z","caller":"traceutil/trace.go:171","msg":"trace[1238340160] transaction","detail":"{read_only:false; response_revision:126; number_of_response:1; }","duration":"356.971843ms","start":"2026-07-09T16:44:26.213693Z","end":"2026-07-09T16:44:26.570665Z","steps":["trace[1238340160] 'process raft request' (duration: 62.820107ms)","trace[1238340160] 'compare' (duration: 293.360366ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T16:44:26.570789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:44:26.213682Z","time spent":"357.062235ms","remote":"127.0.0.1:38354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1473,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-09T16:44:26.570821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.690556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-09T16:44:26.570856Z","caller":"traceutil/trace.go:171","msg":"trace[959176177] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:126; }","duration":"356.774808ms","start":"2026-07-09T16:44:26.214071Z","end":"2026-07-09T16:44:26.570845Z","steps":["trace[959176177] 'agreement among raft nodes before linearized reading' (duration: 356.612014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:44:26.570891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:44:26.214063Z","time spent":"356.820409ms","remote":"127.0.0.1:38020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-09T16:44:26.866785Z","caller":"traceutil/trace.go:171","msg":"trace[410388973] transaction","detail":"{read_only:false; response_revision:128; number_of_response:1; }","duration":"264.031234ms","start":"2026-07-09T16:44:26.602718Z","end":"2026-07-09T16:44:26.86675Z","steps":["trace[410388973] 'process raft request' (duration: 216.300644ms)","trace[410388973] 'compare' (duration: 47.557616ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:44:33.214784Z","caller":"traceutil/trace.go:171","msg":"trace[1297031317] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"110.240529ms","start":"2026-07-09T16:44:33.104503Z","end":"2026-07-09T16:44:33.214744Z","steps":["trace[1297031317] 'read index received' (duration: 103.87952ms)","trace[1297031317] 'applied index is now lower than readState.Index' (duration: 6.359099ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:44:33.214942Z","caller":"traceutil/trace.go:171","msg":"trace[570059878] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"156.225637ms","start":"2026-07-09T16:44:33.058678Z","end":"2026-07-09T16:44:33.214904Z","steps":["trace[570059878] 'process raft request' (duration: 149.825177ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:44:33.21508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.557947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-07-09T16:44:33.21515Z","caller":"traceutil/trace.go:171","msg":"trace[400864876] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:340; }","duration":"110.646619ms","start":"2026-07-09T16:44:33.104478Z","end":"2026-07-09T16:44:33.215125Z","steps":["trace[400864876] 'agreement among raft nodes before linearized reading' (duration: 110.506146ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:45:02.722685Z","caller":"traceutil/trace.go:171","msg":"trace[646559708] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"151.423514ms","start":"2026-07-09T16:45:02.571229Z","end":"2026-07-09T16:45:02.722653Z","steps":["trace[646559708] 'read index received' (duration: 146.37736ms)","trace[646559708] 'applied index is now lower than readState.Index' (duration: 5.045154ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T16:45:02.722888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.638259ms","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-07-09T16:45:02.722924Z","caller":"traceutil/trace.go:171","msg":"trace[234964970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"151.722562ms","start":"2026-07-09T16:45:02.571191Z","end":"2026-07-09T16:45:02.722913Z","steps":["trace[234964970] 'agreement among raft nodes before linearized reading' (duration: 151.565328ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:45:07.596446Z","caller":"traceutil/trace.go:171","msg":"trace[267661138] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"133.044161ms","start":"2026-07-09T16:45:07.46338Z","end":"2026-07-09T16:45:07.596425Z","steps":["trace[267661138] 'read index received' (duration: 107.673537ms)","trace[267661138] 'applied index is now lower than readState.Index' (duration: 25.369254ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T16:45:07.596922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.536334ms","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-07-09T16:45:07.597019Z","caller":"traceutil/trace.go:171","msg":"trace[82123305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"133.717687ms","start":"2026-07-09T16:45:07.463286Z","end":"2026-07-09T16:45:07.597004Z","steps":["trace[82123305] 'agreement among raft nodes before linearized reading' (duration: 133.459701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:45:08.085577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.666529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T16:45:08.085667Z","caller":"traceutil/trace.go:171","msg":"trace[490213221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"275.801523ms","start":"2026-07-09T16:45:07.809848Z","end":"2026-07-09T16:45:08.085649Z","steps":["trace[490213221] 'range keys from in-memory index tree' (duration: 275.566507ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:45:19.606632Z","caller":"traceutil/trace.go:171","msg":"trace[234751483] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"117.661504ms","start":"2026-07-09T16:45:19.488944Z","end":"2026-07-09T16:45:19.606606Z","steps":["trace[234751483] 'process raft request' (duration: 117.311436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:45:22.004129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.712854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T16:45:22.004269Z","caller":"traceutil/trace.go:171","msg":"trace[1916874135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:793; }","duration":"193.900498ms","start":"2026-07-09T16:45:21.810319Z","end":"2026-07-09T16:45:22.004219Z","steps":["trace[1916874135] 'range keys from in-memory index tree' (duration: 193.641332ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:46:18.061246Z","caller":"traceutil/trace.go:171","msg":"trace[1544058704] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"120.079375ms","start":"2026-07-09T16:46:17.941131Z","end":"2026-07-09T16:46:18.06121Z","steps":["trace[1544058704] 'process raft request' (duration: 120.038154ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:46:18.061272Z","caller":"traceutil/trace.go:171","msg":"trace[2128033821] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"120.877045ms","start":"2026-07-09T16:46:17.940367Z","end":"2026-07-09T16:46:18.061244Z","steps":["trace[2128033821] 'process raft request' (duration: 120.6775ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:46:50.433634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.112135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T16:46:50.433724Z","caller":"traceutil/trace.go:171","msg":"trace[472233678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1254; }","duration":"232.231778ms","start":"2026-07-09T16:46:50.201473Z","end":"2026-07-09T16:46:50.433705Z","steps":["trace[472233678] 'range keys from in-memory index tree' (duration: 231.977712ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:46:50.434204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.958012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T16:46:50.434334Z","caller":"traceutil/trace.go:171","msg":"trace[841588625] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"232.005683ms","start":"2026-07-09T16:46:50.202305Z","end":"2026-07-09T16:46:50.434311Z","steps":["trace[841588625] 'process raft request' (duration: 125.432105ms)","trace[841588625] 'compare' (duration: 105.742867ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T16:46:50.979205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.900354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T16:46:50.979274Z","caller":"traceutil/trace.go:171","msg":"trace[1862273781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1257; }","duration":"170.010887ms","start":"2026-07-09T16:46:50.809248Z","end":"2026-07-09T16:46:50.979259Z","steps":["trace[1862273781] 'range keys from in-memory index tree' (duration: 169.802322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:46:51.605879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.63821ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-09T16:46:51.605984Z","caller":"traceutil/trace.go:171","msg":"trace[1111838066] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"249.070105ms","start":"2026-07-09T16:46:51.356892Z","end":"2026-07-09T16:46:51.605962Z","steps":["trace[1111838066] 'process raft request' (duration: 121.287972ms)","trace[1111838066] 'compare' (duration: 127.508006ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:46:51.657386Z","caller":"traceutil/trace.go:171","msg":"trace[189223629] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"279.714902ms","start":"2026-07-09T16:46:51.377643Z","end":"2026-07-09T16:46:51.657358Z","steps":["trace[189223629] 'process raft request' (duration: 279.554309ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:47:02.007946Z","caller":"traceutil/trace.go:171","msg":"trace[599881037] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"143.781158ms","start":"2026-07-09T16:47:01.86414Z","end":"2026-07-09T16:47:02.007921Z","steps":["trace[599881037] 'process raft request' (duration: 143.618524ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:47:02.350034Z","caller":"traceutil/trace.go:171","msg":"trace[2013778346] linearizableReadLoop","detail":"{readStateIndex:1391; appliedIndex:1390; }","duration":"299.649366ms","start":"2026-07-09T16:47:02.050365Z","end":"2026-07-09T16:47:02.350014Z","steps":["trace[2013778346] 'read index received' (duration: 299.558464ms)","trace[2013778346] 'applied index is now lower than readState.Index' (duration: 89.782µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:47:02.350081Z","caller":"traceutil/trace.go:171","msg":"trace[1503323992] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"375.656048ms","start":"2026-07-09T16:47:01.974393Z","end":"2026-07-09T16:47:02.350049Z","steps":["trace[1503323992] 'process raft request' (duration: 375.479044ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:47:02.350227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.852342ms","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:530"} {"level":"warn","ts":"2026-07-09T16:47:02.35025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:47:01.974363Z","time spent":"375.781441ms","remote":"127.0.0.1:38278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T16:47:02.350268Z","caller":"traceutil/trace.go:171","msg":"trace[1174058472] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1339; }","duration":"299.941694ms","start":"2026-07-09T16:47:02.050316Z","end":"2026-07-09T16:47:02.350258Z","steps":["trace[1174058472] 'agreement among raft nodes before linearized reading' (duration: 299.803981ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:47:02.353703Z","caller":"traceutil/trace.go:171","msg":"trace[2123684039] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"273.967271ms","start":"2026-07-09T16:47:02.079708Z","end":"2026-07-09T16:47:02.353675Z","steps":["trace[2123684039] 'process raft request' (duration: 273.760076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:47:02.353894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.493189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-09T16:47:02.353946Z","caller":"traceutil/trace.go:171","msg":"trace[1777176304] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1341; }","duration":"117.57676ms","start":"2026-07-09T16:47:02.236356Z","end":"2026-07-09T16:47:02.353933Z","steps":["trace[1777176304] 'agreement among raft nodes before linearized reading' (duration: 117.422776ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:47:02.354221Z","caller":"traceutil/trace.go:171","msg":"trace[218319063] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"149.639764ms","start":"2026-07-09T16:47:02.204551Z","end":"2026-07-09T16:47:02.354191Z","steps":["trace[218319063] 'process raft request' (duration: 149.0583ms)"],"step_count":1}