{"level":"warn","ts":"2026-10-13T11:05:00.242588Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T11:05:00.242677Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-10-13T11:05:00.242752Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T11:05:00.242764Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-10-13T11:05:00.242783Z","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-10-13T11:05:00.243396Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-10-13T11:05:00.243486Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-10-13T11:05:00.249025Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.287207ms"} {"level":"info","ts":"2026-10-13T11:05:00.263906Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-10-13T11:05:00.264048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T11:05:00.264071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-10-13T11:05:00.264081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T11:05:00.264098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-10-13T11:05:00.264138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-10-13T11:05:00.2746Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T11:05:00.275925Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T11:05:00.277551Z","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-10-13T11:05:00.279804Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T11:05:00.279984Z","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-10-13T11:05:00.280081Z","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-10-13T11:05:00.280115Z","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-10-13T11:05:00.279911Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T11:05:00.282984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-10-13T11:05:00.283108Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-10-13T11:05:00.284303Z","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-10-13T11:05:00.284441Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-10-13T11:05:00.284514Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-10-13T11:05:00.284662Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T11:05:00.284685Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T11:05:01.064989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T11:05:01.065033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T11:05:01.065058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-10-13T11:05:01.06507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-10-13T11:05:01.065076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-10-13T11:05:01.065086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-10-13T11:05:01.065094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-10-13T11:05:01.066099Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:05:01.066961Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T11:05:01.067153Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T11:05:01.066941Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T11:05:01.067471Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T11:05:01.067532Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T11:05:01.067661Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:05:01.067793Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:05:01.067825Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:05:01.069282Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T11:05:01.070612Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-10-13T11:05:02.445764Z","caller":"traceutil/trace.go:171","msg":"trace[1555729513] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"114.200419ms","start":"2026-10-13T11:05:02.331501Z","end":"2026-10-13T11:05:02.445702Z","steps":["trace[1555729513] 'process raft request' (duration: 113.880999ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:02.445999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.370875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:02.446131Z","caller":"traceutil/trace.go:171","msg":"trace[2010611497] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"114.531371ms","start":"2026-10-13T11:05:02.331552Z","end":"2026-10-13T11:05:02.446084Z","steps":["trace[2010611497] 'agreement among raft nodes before linearized reading' (duration: 114.238031ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.445718Z","caller":"traceutil/trace.go:171","msg":"trace[2046937322] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"114.031904ms","start":"2026-10-13T11:05:02.331606Z","end":"2026-10-13T11:05:02.445638Z","steps":["trace[2046937322] 'read index received' (duration: 113.682624ms)","trace[2046937322] 'applied index is now lower than readState.Index' (duration: 347.93µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:02.660308Z","caller":"traceutil/trace.go:171","msg":"trace[972815188] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"214.046057ms","start":"2026-10-13T11:05:02.446241Z","end":"2026-10-13T11:05:02.660287Z","steps":["trace[972815188] 'read index received' (duration: 213.612813ms)","trace[972815188] 'applied index is now lower than readState.Index' (duration: 432.424µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:02.660402Z","caller":"traceutil/trace.go:171","msg":"trace[1198776628] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"328.397141ms","start":"2026-10-13T11:05:02.331984Z","end":"2026-10-13T11:05:02.660381Z","steps":["trace[1198776628] 'process raft request' (duration: 327.877965ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.660474Z","caller":"traceutil/trace.go:171","msg":"trace[538217851] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"252.931883ms","start":"2026-10-13T11:05:02.407532Z","end":"2026-10-13T11:05:02.660464Z","steps":["trace[538217851] 'process raft request' (duration: 252.504759ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.660879Z","caller":"traceutil/trace.go:171","msg":"trace[2031396003] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"254.327587ms","start":"2026-10-13T11:05:02.406523Z","end":"2026-10-13T11:05:02.660851Z","steps":["trace[2031396003] 'process raft request' (duration: 253.47096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:02.661126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.174448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:02.661207Z","caller":"traceutil/trace.go:171","msg":"trace[1564299775] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"253.607734ms","start":"2026-10-13T11:05:02.407588Z","end":"2026-10-13T11:05:02.661196Z","steps":["trace[1564299775] 'process raft request' (duration: 252.476878ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.66123Z","caller":"traceutil/trace.go:171","msg":"trace[1214805689] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"252.328183ms","start":"2026-10-13T11:05:02.408873Z","end":"2026-10-13T11:05:02.661201Z","steps":["trace[1214805689] 'agreement among raft nodes before linearized reading' (duration: 252.011203ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.66129Z","caller":"traceutil/trace.go:171","msg":"trace[1493861769] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"252.892751ms","start":"2026-10-13T11:05:02.408372Z","end":"2026-10-13T11:05:02.661265Z","steps":["trace[1493861769] 'process raft request' (duration: 251.773806ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:02.66147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.984478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:02.661495Z","caller":"traceutil/trace.go:171","msg":"trace[1967211936] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"240.761898ms","start":"2026-10-13T11:05:02.420711Z","end":"2026-10-13T11:05:02.661473Z","steps":["trace[1967211936] 'process raft request' (duration: 239.54081ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.661513Z","caller":"traceutil/trace.go:171","msg":"trace[895402681] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"275.06838ms","start":"2026-10-13T11:05:02.386434Z","end":"2026-10-13T11:05:02.661503Z","steps":["trace[895402681] 'agreement among raft nodes before linearized reading' (duration: 274.987508ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.661398Z","caller":"traceutil/trace.go:171","msg":"trace[1226490041] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"253.697507ms","start":"2026-10-13T11:05:02.407693Z","end":"2026-10-13T11:05:02.661391Z","steps":["trace[1226490041] 'process raft request' (duration: 252.412396ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.661143Z","caller":"traceutil/trace.go:171","msg":"trace[1477645833] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"252.870801ms","start":"2026-10-13T11:05:02.408237Z","end":"2026-10-13T11:05:02.661108Z","steps":["trace[1477645833] 'process raft request' (duration: 251.88807ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:02.661714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.044196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:02.661754Z","caller":"traceutil/trace.go:171","msg":"trace[1697313858] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"253.112868ms","start":"2026-10-13T11:05:02.408631Z","end":"2026-10-13T11:05:02.661744Z","steps":["trace[1697313858] 'agreement among raft nodes before linearized reading' (duration: 253.045576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:02.661851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.518396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-13T11:05:02.661886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.455563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:02.661892Z","caller":"traceutil/trace.go:171","msg":"trace[421135311] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"329.580098ms","start":"2026-10-13T11:05:02.332301Z","end":"2026-10-13T11:05:02.661881Z","steps":["trace[421135311] 'agreement among raft nodes before linearized reading' (duration: 329.521426ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:02.661926Z","caller":"traceutil/trace.go:171","msg":"trace[1855221939] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:0; response_revision:10; }","duration":"256.521935ms","start":"2026-10-13T11:05:02.405396Z","end":"2026-10-13T11:05:02.661918Z","steps":["trace[1855221939] 'agreement among raft nodes before linearized reading' (duration: 256.468084ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:02.661935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.332291Z","time spent":"329.63581ms","remote":"127.0.0.1:60526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-10-13T11:05:02.66201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.034551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:02.662081Z","caller":"traceutil/trace.go:171","msg":"trace[1067702667] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"276.132994ms","start":"2026-10-13T11:05:02.385923Z","end":"2026-10-13T11:05:02.662056Z","steps":["trace[1067702667] 'agreement among raft nodes before linearized reading' (duration: 275.987289ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:02.662222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.173667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-10-13T11:05:02.66226Z","caller":"traceutil/trace.go:171","msg":"trace[659826366] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"330.228629ms","start":"2026-10-13T11:05:02.332022Z","end":"2026-10-13T11:05:02.662251Z","steps":["trace[659826366] 'agreement among raft nodes before linearized reading' (duration: 330.155227ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:02.662288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.332013Z","time spent":"330.26712ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-10-13T11:05:02.662618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.331963Z","time spent":"328.528825ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:05:03.043736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.765956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-10-13T11:05:03.043813Z","caller":"traceutil/trace.go:171","msg":"trace[1469416785] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:13; }","duration":"383.364323ms","start":"2026-10-13T11:05:02.660437Z","end":"2026-10-13T11:05:03.043802Z","steps":["trace[1469416785] 'read index received' (duration: 163.345708ms)","trace[1469416785] 'applied index is now lower than readState.Index' (duration: 220.017785ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:03.043864Z","caller":"traceutil/trace.go:171","msg":"trace[357060443] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"596.46668ms","start":"2026-10-13T11:05:02.447389Z","end":"2026-10-13T11:05:03.043855Z","steps":["trace[357060443] 'process raft request' (duration: 376.317381ms)","trace[357060443] 'compare' (duration: 219.672063ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:05:03.043908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.447372Z","time spent":"596.514101ms","remote":"127.0.0.1:60232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:05:03.044042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.16707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:03.044143Z","caller":"traceutil/trace.go:171","msg":"trace[684320494] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"576.311565ms","start":"2026-10-13T11:05:02.467816Z","end":"2026-10-13T11:05:03.044128Z","steps":["trace[684320494] 'agreement among raft nodes before linearized reading' (duration: 576.101038ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.044194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.467793Z","time spent":"576.392247ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-13T11:05:03.044105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.193166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:03.044279Z","caller":"traceutil/trace.go:171","msg":"trace[733612878] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"586.397153ms","start":"2026-10-13T11:05:02.457874Z","end":"2026-10-13T11:05:03.044271Z","steps":["trace[733612878] 'agreement among raft nodes before linearized reading' (duration: 586.206107ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.044313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.457854Z","time spent":"586.450895ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-13T11:05:03.047365Z","caller":"traceutil/trace.go:171","msg":"trace[939148777] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"379.222753ms","start":"2026-10-13T11:05:02.668124Z","end":"2026-10-13T11:05:03.047347Z","steps":["trace[939148777] 'process raft request' (duration: 379.005016ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:03.047404Z","caller":"traceutil/trace.go:171","msg":"trace[980251305] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"379.208132ms","start":"2026-10-13T11:05:02.668181Z","end":"2026-10-13T11:05:03.047389Z","steps":["trace[980251305] 'process raft request' (duration: 379.084098ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.047461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.668154Z","time spent":"379.285474ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T11:05:03.047491Z","caller":"traceutil/trace.go:171","msg":"trace[199965340] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"379.213893ms","start":"2026-10-13T11:05:02.668261Z","end":"2026-10-13T11:05:03.047475Z","steps":["trace[199965340] 'process raft request' (duration: 379.041577ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.047519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.668105Z","time spent":"379.348517ms","remote":"127.0.0.1:45094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:05:03.047589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.66824Z","time spent":"379.312525ms","remote":"127.0.0.1:45172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T11:05:03.047663Z","caller":"traceutil/trace.go:171","msg":"trace[1824540354] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"379.341286ms","start":"2026-10-13T11:05:02.668309Z","end":"2026-10-13T11:05:03.04765Z","steps":["trace[1824540354] 'process raft request' (duration: 379.106839ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:03.047688Z","caller":"traceutil/trace.go:171","msg":"trace[202839651] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"379.400408ms","start":"2026-10-13T11:05:02.668281Z","end":"2026-10-13T11:05:03.047681Z","steps":["trace[202839651] 'process raft request' (duration: 379.115159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.047733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.66827Z","time spent":"379.445539ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:05:03.047744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.80158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:03.04771Z","caller":"traceutil/trace.go:171","msg":"trace[1440873032] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"379.262554ms","start":"2026-10-13T11:05:02.668279Z","end":"2026-10-13T11:05:03.047542Z","steps":["trace[1440873032] 'process raft request' (duration: 379.082938ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:03.047846Z","caller":"traceutil/trace.go:171","msg":"trace[574211872] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"379.386878ms","start":"2026-10-13T11:05:02.668451Z","end":"2026-10-13T11:05:03.047838Z","steps":["trace[574211872] 'process raft request' (duration: 379.011146ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.047889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.943405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-84rk2\" ","response":"range_response_count:1 size:861"} {"level":"warn","ts":"2026-10-13T11:05:03.04789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.903034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"warn","ts":"2026-10-13T11:05:03.047905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.668438Z","time spent":"379.436589ms","remote":"127.0.0.1:45172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T11:05:03.047918Z","caller":"traceutil/trace.go:171","msg":"trace[1890292541] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-84rk2; range_end:; response_count:1; response_revision:19; }","duration":"379.983676ms","start":"2026-10-13T11:05:02.667926Z","end":"2026-10-13T11:05:03.04791Z","steps":["trace[1890292541] 'agreement among raft nodes before linearized reading' (duration: 379.938115ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:03.047922Z","caller":"traceutil/trace.go:171","msg":"trace[855063873] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"379.962535ms","start":"2026-10-13T11:05:02.66795Z","end":"2026-10-13T11:05:03.047913Z","steps":["trace[855063873] 'agreement among raft nodes before linearized reading' (duration: 379.904673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.047949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.667934Z","time spent":"380.010867ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-10-13T11:05:03.047955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.667858Z","time spent":"380.088309ms","remote":"127.0.0.1:60404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-84rk2\" "} {"level":"warn","ts":"2026-10-13T11:05:03.04797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.668264Z","time spent":"379.583584ms","remote":"127.0.0.1:45172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:05:03.047849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.63228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T11:05:03.048103Z","caller":"traceutil/trace.go:171","msg":"trace[240881813] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"379.611225ms","start":"2026-10-13T11:05:02.668475Z","end":"2026-10-13T11:05:03.048087Z","steps":["trace[240881813] 'process raft request' (duration: 379.105499ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:03.048126Z","caller":"traceutil/trace.go:171","msg":"trace[1930113297] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:19; }","duration":"329.96411ms","start":"2026-10-13T11:05:02.718154Z","end":"2026-10-13T11:05:03.048119Z","steps":["trace[1930113297] 'agreement among raft nodes before linearized reading' (duration: 329.676641ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.048154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.718133Z","time spent":"330.013272ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-node-lease\" "} {"level":"warn","ts":"2026-10-13T11:05:03.048156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.668465Z","time spent":"379.664406ms","remote":"127.0.0.1:45172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T11:05:03.047809Z","caller":"traceutil/trace.go:171","msg":"trace[1594691558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"379.912635ms","start":"2026-10-13T11:05:02.667882Z","end":"2026-10-13T11:05:03.047795Z","steps":["trace[1594691558] 'agreement among raft nodes before linearized reading' (duration: 379.797141ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.048245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.667858Z","time spent":"380.378619ms","remote":"127.0.0.1:60172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-13T11:05:03.047814Z","caller":"traceutil/trace.go:171","msg":"trace[776728536] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"369.760805ms","start":"2026-10-13T11:05:02.678042Z","end":"2026-10-13T11:05:03.047803Z","steps":["trace[776728536] 'process raft request' (duration: 369.576209ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:03.047744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.668291Z","time spent":"379.413009ms","remote":"127.0.0.1:45172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:05:03.04855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:02.678019Z","time spent":"370.390724ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:05:47.532436Z","caller":"traceutil/trace.go:171","msg":"trace[1182401373] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"187.446538ms","start":"2026-10-13T11:05:47.344961Z","end":"2026-10-13T11:05:47.532407Z","steps":["trace[1182401373] 'process raft request' (duration: 187.265673ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.541327Z","caller":"traceutil/trace.go:171","msg":"trace[1274140040] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"183.094993ms","start":"2026-10-13T11:05:47.358217Z","end":"2026-10-13T11:05:47.541312Z","steps":["trace[1274140040] 'process raft request' (duration: 182.935348ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.541599Z","caller":"traceutil/trace.go:171","msg":"trace[341102205] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"176.230078ms","start":"2026-10-13T11:05:47.365345Z","end":"2026-10-13T11:05:47.541575Z","steps":["trace[341102205] 'process raft request' (duration: 175.890457ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.541813Z","caller":"traceutil/trace.go:171","msg":"trace[1349465512] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"160.117984ms","start":"2026-10-13T11:05:47.381688Z","end":"2026-10-13T11:05:47.541806Z","steps":["trace[1349465512] 'process raft request' (duration: 159.905648ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.541875Z","caller":"traceutil/trace.go:171","msg":"trace[2055354503] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"160.045612ms","start":"2026-10-13T11:05:47.381793Z","end":"2026-10-13T11:05:47.541839Z","steps":["trace[2055354503] 'process raft request' (duration: 159.884867ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.54193Z","caller":"traceutil/trace.go:171","msg":"trace[1300991811] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"169.579571ms","start":"2026-10-13T11:05:47.372344Z","end":"2026-10-13T11:05:47.541924Z","steps":["trace[1300991811] 'process raft request' (duration: 168.998043ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.541974Z","caller":"traceutil/trace.go:171","msg":"trace[1766078325] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"144.685142ms","start":"2026-10-13T11:05:47.397285Z","end":"2026-10-13T11:05:47.54197Z","steps":["trace[1766078325] 'process raft request' (duration: 144.479246ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.542Z","caller":"traceutil/trace.go:171","msg":"trace[1157097416] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:530; }","duration":"121.613951ms","start":"2026-10-13T11:05:47.420363Z","end":"2026-10-13T11:05:47.541977Z","steps":["trace[1157097416] 'read index received' (duration: 111.252717ms)","trace[1157097416] 'applied index is now lower than readState.Index' (duration: 10.360274ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:47.542031Z","caller":"traceutil/trace.go:171","msg":"trace[1257164839] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"121.276111ms","start":"2026-10-13T11:05:47.420737Z","end":"2026-10-13T11:05:47.542013Z","steps":["trace[1257164839] 'process raft request' (duration: 121.109426ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.542037Z","caller":"traceutil/trace.go:171","msg":"trace[35985984] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"102.030859ms","start":"2026-10-13T11:05:47.44Z","end":"2026-10-13T11:05:47.542031Z","steps":["trace[35985984] 'process raft request' (duration: 101.914026ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.541988Z","caller":"traceutil/trace.go:171","msg":"trace[1660268343] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"160.210908ms","start":"2026-10-13T11:05:47.381579Z","end":"2026-10-13T11:05:47.54179Z","steps":["trace[1660268343] 'process raft request' (duration: 159.808615ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:47.542256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.88202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-13T11:05:47.541273Z","caller":"traceutil/trace.go:171","msg":"trace[1157393535] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"187.996216ms","start":"2026-10-13T11:05:47.353248Z","end":"2026-10-13T11:05:47.541244Z","steps":["trace[1157393535] 'process raft request' (duration: 187.80731ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:47.542281Z","caller":"traceutil/trace.go:171","msg":"trace[28717894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:522; }","duration":"121.943791ms","start":"2026-10-13T11:05:47.420331Z","end":"2026-10-13T11:05:47.542275Z","steps":["trace[28717894] 'agreement among raft nodes before linearized reading' (duration: 121.724504ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:51.480545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.555383ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:05:51.481074Z","caller":"traceutil/trace.go:171","msg":"trace[1621666578] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"171.357574ms","start":"2026-10-13T11:05:51.309647Z","end":"2026-10-13T11:05:51.481005Z","steps":["trace[1621666578] 'process raft request' (duration: 20.16376ms)","trace[1621666578] 'compare' (duration: 150.13194ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:54.046217Z","caller":"traceutil/trace.go:171","msg":"trace[1411348561] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"160.910775ms","start":"2026-10-13T11:05:53.885272Z","end":"2026-10-13T11:05:54.046183Z","steps":["trace[1411348561] 'process raft request' (duration: 160.210823ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:54.433369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:54.064124Z","time spent":"369.23838ms","remote":"127.0.0.1:60192","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-10-13T11:05:54.443438Z","caller":"traceutil/trace.go:171","msg":"trace[100144437] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"271.88065ms","start":"2026-10-13T11:05:54.171526Z","end":"2026-10-13T11:05:54.443407Z","steps":["trace[100144437] 'read index received' (duration: 261.755164ms)","trace[100144437] 'applied index is now lower than readState.Index' (duration: 10.124206ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:05:54.443867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.301503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:05:54.443997Z","caller":"traceutil/trace.go:171","msg":"trace[699110900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"272.456568ms","start":"2026-10-13T11:05:54.17152Z","end":"2026-10-13T11:05:54.443977Z","steps":["trace[699110900] 'agreement among raft nodes before linearized reading' (duration: 272.146098ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:54.443642Z","caller":"traceutil/trace.go:171","msg":"trace[1200855813] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"325.35363ms","start":"2026-10-13T11:05:54.118231Z","end":"2026-10-13T11:05:54.443585Z","steps":["trace[1200855813] 'process raft request' (duration: 324.952717ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:54.444253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:54.118209Z","time spent":"325.882597ms","remote":"127.0.0.1:45154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:05:54.51938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.138581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8lm7d\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-13T11:05:54.519492Z","caller":"traceutil/trace.go:171","msg":"trace[856792761] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8lm7d; range_end:; response_count:1; response_revision:619; }","duration":"265.326266ms","start":"2026-10-13T11:05:54.254136Z","end":"2026-10-13T11:05:54.519462Z","steps":["trace[856792761] 'agreement among raft nodes before linearized reading' (duration: 209.047418ms)","trace[856792761] 'range keys from in-memory index tree' (duration: 55.992049ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:55.004934Z","caller":"traceutil/trace.go:171","msg":"trace[1089358459] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"461.570775ms","start":"2026-10-13T11:05:54.543321Z","end":"2026-10-13T11:05:55.004892Z","steps":["trace[1089358459] 'process raft request' (duration: 461.238444ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:55.005205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:54.543286Z","time spent":"461.767391ms","remote":"127.0.0.1:60356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:05:55.162021Z","caller":"traceutil/trace.go:171","msg":"trace[78976779] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"438.188554ms","start":"2026-10-13T11:05:54.723793Z","end":"2026-10-13T11:05:55.161981Z","steps":["trace[78976779] 'process raft request' (duration: 436.78254ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:55.162197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:54.723647Z","time spent":"438.463683ms","remote":"127.0.0.1:60410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:05:55.168415Z","caller":"traceutil/trace.go:171","msg":"trace[235281336] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"436.096439ms","start":"2026-10-13T11:05:54.732267Z","end":"2026-10-13T11:05:55.168363Z","steps":["trace[235281336] 'read index received' (duration: 273.167582ms)","trace[235281336] 'applied index is now lower than readState.Index' (duration: 162.928127ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:55.168804Z","caller":"traceutil/trace.go:171","msg":"trace[783430632] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"203.511805ms","start":"2026-10-13T11:05:54.965267Z","end":"2026-10-13T11:05:55.168779Z","steps":["trace[783430632] 'process raft request' (duration: 201.172482ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:55.168796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.498722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:05:55.168896Z","caller":"traceutil/trace.go:171","msg":"trace[751326599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"436.684217ms","start":"2026-10-13T11:05:54.732195Z","end":"2026-10-13T11:05:55.168879Z","steps":["trace[751326599] 'agreement among raft nodes before linearized reading' (duration: 436.518942ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:55.169012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:54.732172Z","time spent":"436.826451ms","remote":"127.0.0.1:60172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-13T11:05:56.555254Z","caller":"traceutil/trace.go:171","msg":"trace[1359574210] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"118.341965ms","start":"2026-10-13T11:05:56.436876Z","end":"2026-10-13T11:05:56.555218Z","steps":["trace[1359574210] 'process raft request' (duration: 118.116488ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:56.558845Z","caller":"traceutil/trace.go:171","msg":"trace[648633285] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"117.060485ms","start":"2026-10-13T11:05:56.441742Z","end":"2026-10-13T11:05:56.558802Z","steps":["trace[648633285] 'process raft request' (duration: 116.433065ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:06:09.849251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.651562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-13T11:06:09.84941Z","caller":"traceutil/trace.go:171","msg":"trace[1788302472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:780; }","duration":"179.896329ms","start":"2026-10-13T11:06:09.669483Z","end":"2026-10-13T11:06:09.84938Z","steps":["trace[1788302472] 'range keys from in-memory index tree' (duration: 179.313231ms)"],"step_count":1}