{"level":"warn","ts":"2026-02-25T15:02:37.443425Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T15:02:37.4435Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25: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.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-02-25T15:02:37.443567Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T15:02:37.443579Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-02-25T15:02:37.443599Z","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-02-25T15:02:37.444803Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-02-25T15:02:37.444896Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-02-25T15:02:37.449425Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.326328ms"} {"level":"info","ts":"2026-02-25T15:02:37.453773Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-02-25T15:02:37.453818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T15:02:37.453834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-02-25T15:02:37.453841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T15:02:37.453847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-02-25T15:02:37.453875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-02-25T15:02:37.463305Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T15:02:37.464643Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T15:02:37.465582Z","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-02-25T15:02:37.467431Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T15:02:37.467928Z","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-02-25T15:02:37.467966Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T15:02:37.468086Z","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-02-25T15:02:37.468104Z","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-02-25T15:02:37.468905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-02-25T15:02:37.469784Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-02-25T15:02:37.471621Z","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-02-25T15:02:37.471861Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T15:02:37.471895Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T15:02:37.472057Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-02-25T15:02:37.472077Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-02-25T15:02:38.254246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T15:02:38.254312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T15:02:38.254415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-02-25T15:02:38.254467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-02-25T15:02:38.254486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-02-25T15:02:38.254538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-02-25T15:02:38.254556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-02-25T15:02:38.25572Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T15:02:38.255769Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T15:02:38.255703Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:02:38.256274Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T15:02:38.256353Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T15:02:38.256981Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:02:38.257213Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:02:38.257342Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:02:38.259227Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T15:02:38.259403Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-02-25T15:02:38.255676Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T15:02:44.062774Z","caller":"traceutil/trace.go:171","msg":"trace[198526196] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"107.800674ms","start":"2026-02-25T15:02:43.954953Z","end":"2026-02-25T15:02:44.062753Z","steps":["trace[198526196] 'process raft request' (duration: 107.6779ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:02:44.231099Z","caller":"traceutil/trace.go:171","msg":"trace[70640752] linearizableReadLoop","detail":"{readStateIndex:266; appliedIndex:265; }","duration":"151.252528ms","start":"2026-02-25T15:02:44.079824Z","end":"2026-02-25T15:02:44.231077Z","steps":["trace[70640752] 'read index received' (duration: 139.228036ms)","trace[70640752] 'applied index is now lower than readState.Index' (duration: 12.023602ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:02:44.231192Z","caller":"traceutil/trace.go:171","msg":"trace[1528538051] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"164.011041ms","start":"2026-02-25T15:02:44.06714Z","end":"2026-02-25T15:02:44.231151Z","steps":["trace[1528538051] 'process raft request' (duration: 151.767843ms)","trace[1528538051] 'compare' (duration: 11.907648ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:02:44.23126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.399062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:02:44.231477Z","caller":"traceutil/trace.go:171","msg":"trace[754241236] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:0; response_revision:259; }","duration":"151.653379ms","start":"2026-02-25T15:02:44.079797Z","end":"2026-02-25T15:02:44.231451Z","steps":["trace[754241236] 'agreement among raft nodes before linearized reading' (duration: 151.371792ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:02:44.231666Z","caller":"traceutil/trace.go:171","msg":"trace[457931726] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"150.667391ms","start":"2026-02-25T15:02:44.080986Z","end":"2026-02-25T15:02:44.231654Z","steps":["trace[457931726] 'process raft request' (duration: 150.441045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:44.231691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.839099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5868"} {"level":"info","ts":"2026-02-25T15:02:44.231771Z","caller":"traceutil/trace.go:171","msg":"trace[1085372905] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"114.446932ms","start":"2026-02-25T15:02:44.117311Z","end":"2026-02-25T15:02:44.231758Z","steps":["trace[1085372905] 'process raft request' (duration: 114.247596ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:02:44.231772Z","caller":"traceutil/trace.go:171","msg":"trace[1364342641] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:260; }","duration":"116.961753ms","start":"2026-02-25T15:02:44.114793Z","end":"2026-02-25T15:02:44.231754Z","steps":["trace[1364342641] 'agreement among raft nodes before linearized reading' (duration: 116.800158ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:05.348723Z","caller":"traceutil/trace.go:171","msg":"trace[1698418598] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"418.103849ms","start":"2026-02-25T15:03:04.930591Z","end":"2026-02-25T15:03:05.348695Z","steps":["trace[1698418598] 'process raft request' (duration: 417.896954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:05.3494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:04.930544Z","time spent":"418.260385ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:05.350127Z","caller":"traceutil/trace.go:171","msg":"trace[1445597389] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"418.961115ms","start":"2026-02-25T15:03:04.931142Z","end":"2026-02-25T15:03:05.350103Z","steps":["trace[1445597389] 'process raft request' (duration: 418.80793ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:05.350257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:04.931119Z","time spent":"419.058497ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:14.428827Z","caller":"traceutil/trace.go:171","msg":"trace[2030617554] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"134.44686ms","start":"2026-02-25T15:03:14.294355Z","end":"2026-02-25T15:03:14.428802Z","steps":["trace[2030617554] 'read index received' (duration: 134.279456ms)","trace[2030617554] 'applied index is now lower than readState.Index' (duration: 166.314µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:14.428938Z","caller":"traceutil/trace.go:171","msg":"trace[2057339205] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"216.945574ms","start":"2026-02-25T15:03:14.211932Z","end":"2026-02-25T15:03:14.428878Z","steps":["trace[2057339205] 'process raft request' (duration: 216.710227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:14.429009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.635756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:03:14.429117Z","caller":"traceutil/trace.go:171","msg":"trace[1681623076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"134.798071ms","start":"2026-02-25T15:03:14.29429Z","end":"2026-02-25T15:03:14.429088Z","steps":["trace[1681623076] 'agreement among raft nodes before linearized reading' (duration: 134.609825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:14.594098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.404844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T15:03:14.594221Z","caller":"traceutil/trace.go:171","msg":"trace[751305842] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"157.801485ms","start":"2026-02-25T15:03:14.436397Z","end":"2026-02-25T15:03:14.594198Z","steps":["trace[751305842] 'process raft request' (duration: 26.083501ms)","trace[751305842] 'compare' (duration: 131.281681ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:16.021992Z","caller":"traceutil/trace.go:171","msg":"trace[1293589075] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"626.226644ms","start":"2026-02-25T15:03:15.39574Z","end":"2026-02-25T15:03:16.021967Z","steps":["trace[1293589075] 'process raft request' (duration: 626.05044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.022163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.395725Z","time spent":"626.344467ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:16.030327Z","caller":"traceutil/trace.go:171","msg":"trace[1807899612] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"632.963085ms","start":"2026-02-25T15:03:15.39735Z","end":"2026-02-25T15:03:16.030313Z","steps":["trace[1807899612] 'process raft request' (duration: 632.878732ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.030618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.397329Z","time spent":"633.223242ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:16.309297Z","caller":"traceutil/trace.go:171","msg":"trace[1191744671] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"254.343567ms","start":"2026-02-25T15:03:16.054923Z","end":"2026-02-25T15:03:16.309267Z","steps":["trace[1191744671] 'process raft request' (duration: 175.338161ms)","trace[1191744671] 'compare' (duration: 78.900313ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:18.696588Z","caller":"traceutil/trace.go:171","msg":"trace[1797152708] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"277.554346ms","start":"2026-02-25T15:03:18.418995Z","end":"2026-02-25T15:03:18.69655Z","steps":["trace[1797152708] 'process raft request' (duration: 277.127685ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:35.081385Z","caller":"traceutil/trace.go:171","msg":"trace[1389746114] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"302.945849ms","start":"2026-02-25T15:03:34.778416Z","end":"2026-02-25T15:03:35.081361Z","steps":["trace[1389746114] 'process raft request' (duration: 302.811765ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:35.081524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:34.778398Z","time spent":"303.056351ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:03:35.537402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.003143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:03:35.537466Z","caller":"traceutil/trace.go:171","msg":"trace[992061148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:674; }","duration":"244.106226ms","start":"2026-02-25T15:03:35.293347Z","end":"2026-02-25T15:03:35.537453Z","steps":["trace[992061148] 'range keys from in-memory index tree' (duration: 243.89371ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:36.430545Z","caller":"traceutil/trace.go:171","msg":"trace[277102922] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:695; }","duration":"314.395274ms","start":"2026-02-25T15:03:36.116095Z","end":"2026-02-25T15:03:36.43049Z","steps":["trace[277102922] 'read index received' (duration: 314.230859ms)","trace[277102922] 'applied index is now lower than readState.Index' (duration: 163.765µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:36.430761Z","caller":"traceutil/trace.go:171","msg":"trace[291707173] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"315.760662ms","start":"2026-02-25T15:03:36.114993Z","end":"2026-02-25T15:03:36.430753Z","steps":["trace[291707173] 'process raft request' (duration: 315.383502ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:36.43085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:36.114981Z","time spent":"315.806854ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:03:36.43102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.555148ms","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":"warn","ts":"2026-02-25T15:03:36.431549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.429973ms","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-02-25T15:03:36.431803Z","caller":"traceutil/trace.go:171","msg":"trace[670151207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:675; }","duration":"315.554127ms","start":"2026-02-25T15:03:36.116058Z","end":"2026-02-25T15:03:36.431612Z","steps":["trace[670151207] 'agreement among raft nodes before linearized reading' (duration: 314.94172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:36.431854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:36.116044Z","time spent":"315.800003ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T15:03:36.435764Z","caller":"traceutil/trace.go:171","msg":"trace[1105976126] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:675; }","duration":"132.6487ms","start":"2026-02-25T15:03:36.298412Z","end":"2026-02-25T15:03:36.431061Z","steps":["trace[1105976126] 'agreement among raft nodes before linearized reading' (duration: 132.494546ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:59.448895Z","caller":"traceutil/trace.go:171","msg":"trace[2144135617] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"197.116953ms","start":"2026-02-25T15:03:59.251746Z","end":"2026-02-25T15:03:59.448863Z","steps":["trace[2144135617] 'process raft request' (duration: 196.887767ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:04:00.812558Z","caller":"traceutil/trace.go:171","msg":"trace[1690327718] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"211.50227ms","start":"2026-02-25T15:04:00.601028Z","end":"2026-02-25T15:04:00.81253Z","steps":["trace[1690327718] 'process raft request' (duration: 210.978605ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:04:00.840104Z","caller":"traceutil/trace.go:171","msg":"trace[396386256] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:774; }","duration":"226.257099ms","start":"2026-02-25T15:04:00.61382Z","end":"2026-02-25T15:04:00.840077Z","steps":["trace[396386256] 'read index received' (duration: 198.239152ms)","trace[396386256] 'applied index is now lower than readState.Index' (duration: 28.016277ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:04:00.840188Z","caller":"traceutil/trace.go:171","msg":"trace[1957950749] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"237.1002ms","start":"2026-02-25T15:04:00.603062Z","end":"2026-02-25T15:04:00.840162Z","steps":["trace[1957950749] 'process raft request' (duration: 236.778432ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:00.840592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.744432ms","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-02-25T15:04:00.840652Z","caller":"traceutil/trace.go:171","msg":"trace[857271676] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:749; }","duration":"226.851636ms","start":"2026-02-25T15:04:00.613785Z","end":"2026-02-25T15:04:00.840637Z","steps":["trace[857271676] 'agreement among raft nodes before linearized reading' (duration: 226.400493ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:01.027535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.899711ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T15:04:01.027662Z","caller":"traceutil/trace.go:171","msg":"trace[2100332694] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"181.699535ms","start":"2026-02-25T15:04:00.845943Z","end":"2026-02-25T15:04:01.027643Z","steps":["trace[2100332694] 'process raft request' (duration: 60.600379ms)","trace[2100332694] 'compare' (duration: 120.757486ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:04:11.532487Z","caller":"traceutil/trace.go:171","msg":"trace[2096505727] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"136.090491ms","start":"2026-02-25T15:04:11.396374Z","end":"2026-02-25T15:04:11.532464Z","steps":["trace[2096505727] 'process raft request' (duration: 94.277222ms)","trace[2096505727] 'compare' (duration: 41.718806ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:04:15.868428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.51427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:04:15.868531Z","caller":"traceutil/trace.go:171","msg":"trace[1936796533] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:839; }","duration":"974.656824ms","start":"2026-02-25T15:04:14.893851Z","end":"2026-02-25T15:04:15.868508Z","steps":["trace[1936796533] 'count revisions from in-memory index tree' (duration: 974.412538ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:15.868602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:14.893837Z","time spent":"974.744737ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-02-25T15:04:15.868688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.70866ms","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-02-25T15:04:15.868785Z","caller":"traceutil/trace.go:171","msg":"trace[362057137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:839; }","duration":"911.846275ms","start":"2026-02-25T15:04:14.956913Z","end":"2026-02-25T15:04:15.86876Z","steps":["trace[362057137] 'range keys from in-memory index tree' (duration: 911.510815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:15.868774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.724335ms","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-02-25T15:04:15.868846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:14.956899Z","time spent":"911.935877ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T15:04:15.868879Z","caller":"traceutil/trace.go:171","msg":"trace[27169112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:839; }","duration":"251.875469ms","start":"2026-02-25T15:04:15.616978Z","end":"2026-02-25T15:04:15.868854Z","steps":["trace[27169112] 'range keys from in-memory index tree' (duration: 251.55551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:15.868923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.183797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:04:15.868994Z","caller":"traceutil/trace.go:171","msg":"trace[411307979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:839; }","duration":"575.288479ms","start":"2026-02-25T15:04:15.293684Z","end":"2026-02-25T15:04:15.868972Z","steps":["trace[411307979] 'range keys from in-memory index tree' (duration: 575.090474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:15.869038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:15.293665Z","time spent":"575.362752ms","remote":"127.0.0.1:50552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T15:04:15.869384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.272137ms","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-02-25T15:04:15.869421Z","caller":"traceutil/trace.go:171","msg":"trace[800598110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:839; }","duration":"881.324839ms","start":"2026-02-25T15:04:14.988085Z","end":"2026-02-25T15:04:15.86941Z","steps":["trace[800598110] 'range keys from in-memory index tree' (duration: 881.180974ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:15.86945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:14.988075Z","time spent":"881.36697ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T15:04:15.869583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.986162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-25T15:04:15.869635Z","caller":"traceutil/trace.go:171","msg":"trace[206904786] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:839; }","duration":"784.071255ms","start":"2026-02-25T15:04:15.085552Z","end":"2026-02-25T15:04:15.869623Z","steps":["trace[206904786] 'range keys from in-memory index tree' (duration: 783.862699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:15.869665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:15.085536Z","time spent":"784.122115ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-25T15:04:32.085419Z","caller":"traceutil/trace.go:171","msg":"trace[580875122] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"113.730501ms","start":"2026-02-25T15:04:31.971661Z","end":"2026-02-25T15:04:32.085392Z","steps":["trace[580875122] 'process raft request' (duration: 113.579377ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:04:32.468256Z","caller":"traceutil/trace.go:171","msg":"trace[542138936] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"378.440756ms","start":"2026-02-25T15:04:32.08979Z","end":"2026-02-25T15:04:32.468231Z","steps":["trace[542138936] 'process raft request' (duration: 282.334764ms)","trace[542138936] 'compare' (duration: 95.824335ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:04:32.468384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:32.089776Z","time spent":"378.535338ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:04:32.643083Z","caller":"traceutil/trace.go:171","msg":"trace[722506901] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"552.982312ms","start":"2026-02-25T15:04:32.090078Z","end":"2026-02-25T15:04:32.64306Z","steps":["trace[722506901] 'process raft request' (duration: 543.499538ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:04:32.643122Z","caller":"traceutil/trace.go:171","msg":"trace[1166985112] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"134.22663ms","start":"2026-02-25T15:04:32.508871Z","end":"2026-02-25T15:04:32.643098Z","steps":["trace[1166985112] 'process raft request' (duration: 134.183349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:32.643207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:32.090071Z","time spent":"553.066314ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:04:32.6433Z","caller":"traceutil/trace.go:171","msg":"trace[109292127] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"553.121536ms","start":"2026-02-25T15:04:32.090137Z","end":"2026-02-25T15:04:32.643259Z","steps":["trace[109292127] 'process raft request' (duration: 552.866509ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:04:32.643373Z","caller":"traceutil/trace.go:171","msg":"trace[147292680] linearizableReadLoop","detail":"{readStateIndex:944; appliedIndex:941; }","duration":"420.161491ms","start":"2026-02-25T15:04:32.223174Z","end":"2026-02-25T15:04:32.643336Z","steps":["trace[147292680] 'read index received' (duration: 148.963207ms)","trace[147292680] 'applied index is now lower than readState.Index' (duration: 271.192074ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:04:32.643528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.352267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-25T15:04:32.643538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:32.090133Z","time spent":"553.28498ms","remote":"127.0.0.1:50834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:04:32.64357Z","caller":"traceutil/trace.go:171","msg":"trace[668477906] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:909; }","duration":"420.434829ms","start":"2026-02-25T15:04:32.223124Z","end":"2026-02-25T15:04:32.643559Z","steps":["trace[668477906] 'agreement among raft nodes before linearized reading' (duration: 420.323286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:32.643597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:32.223102Z","time spent":"420.48913ms","remote":"127.0.0.1:51026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-02-25T15:04:32.643603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.6265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T15:04:32.643592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.670147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:04:32.643647Z","caller":"traceutil/trace.go:171","msg":"trace[1520088912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:909; }","duration":"348.740453ms","start":"2026-02-25T15:04:32.294896Z","end":"2026-02-25T15:04:32.643636Z","steps":["trace[1520088912] 'agreement among raft nodes before linearized reading' (duration: 348.62601ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:04:32.643672Z","caller":"traceutil/trace.go:171","msg":"trace[42820287] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:909; }","duration":"171.801901ms","start":"2026-02-25T15:04:32.471854Z","end":"2026-02-25T15:04:32.643656Z","steps":["trace[42820287] 'agreement among raft nodes before linearized reading' (duration: 171.679397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:04:32.643686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:04:32.294876Z","time spent":"348.802465ms","remote":"127.0.0.1:50552","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-02-25T15:04:32.88686Z","caller":"traceutil/trace.go:171","msg":"trace[680363498] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"100.948747ms","start":"2026-02-25T15:04:32.785761Z","end":"2026-02-25T15:04:32.886709Z","steps":["trace[680363498] 'process raft request' (duration: 76.658284ms)","trace[680363498] 'compare' (duration: 23.981844ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:04:33.184329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.301049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:04:33.184422Z","caller":"traceutil/trace.go:171","msg":"trace[101934442] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:916; }","duration":"139.451133ms","start":"2026-02-25T15:04:33.044951Z","end":"2026-02-25T15:04:33.184402Z","steps":["trace[101934442] 'count revisions from in-memory index tree' (duration: 139.222338ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:04:34.330111Z","caller":"traceutil/trace.go:171","msg":"trace[95136827] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"236.539892ms","start":"2026-02-25T15:04:34.093551Z","end":"2026-02-25T15:04:34.330091Z","steps":["trace[95136827] 'process raft request' (duration: 236.211074ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:04:34.594255Z","caller":"traceutil/trace.go:171","msg":"trace[407682580] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"118.830933ms","start":"2026-02-25T15:04:34.475392Z","end":"2026-02-25T15:04:34.594223Z","steps":["trace[407682580] 'process raft request' (duration: 118.602626ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:05:41.124743Z","caller":"traceutil/trace.go:171","msg":"trace[978692834] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"135.554039ms","start":"2026-02-25T15:05:40.98916Z","end":"2026-02-25T15:05:41.124714Z","steps":["trace[978692834] 'process raft request' (duration: 106.783329ms)","trace[978692834] 'compare' (duration: 28.606745ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:05:41.12488Z","caller":"traceutil/trace.go:171","msg":"trace[940622087] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"135.670211ms","start":"2026-02-25T15:05:40.989183Z","end":"2026-02-25T15:05:41.124854Z","steps":["trace[940622087] 'process raft request' (duration: 135.491037ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:05:49.26624Z","caller":"traceutil/trace.go:171","msg":"trace[215664589] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"105.993587ms","start":"2026-02-25T15:05:49.160212Z","end":"2026-02-25T15:05:49.266205Z","steps":["trace[215664589] 'process raft request' (duration: 65.195728ms)","trace[215664589] 'compare' (duration: 40.246235ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:07:51.877448Z","caller":"traceutil/trace.go:171","msg":"trace[943386780] linearizableReadLoop","detail":"{readStateIndex:1845; appliedIndex:1844; }","duration":"142.281487ms","start":"2026-02-25T15:07:51.735144Z","end":"2026-02-25T15:07:51.877426Z","steps":["trace[943386780] 'read index received' (duration: 142.091051ms)","trace[943386780] 'applied index is now lower than readState.Index' (duration: 189.706µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:07:51.877509Z","caller":"traceutil/trace.go:171","msg":"trace[736904328] transaction","detail":"{read_only:false; response_revision:1768; number_of_response:1; }","duration":"191.696089ms","start":"2026-02-25T15:07:51.68579Z","end":"2026-02-25T15:07:51.877486Z","steps":["trace[736904328] 'process raft request' (duration: 191.509574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:51.877807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.567614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-02-25T15:07:51.877872Z","caller":"traceutil/trace.go:171","msg":"trace[963132716] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1768; }","duration":"142.750618ms","start":"2026-02-25T15:07:51.73509Z","end":"2026-02-25T15:07:51.877841Z","steps":["trace[963132716] 'agreement among raft nodes before linearized reading' (duration: 142.449271ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:52.329571Z","caller":"traceutil/trace.go:171","msg":"trace[960437999] transaction","detail":"{read_only:false; response_revision:1772; number_of_response:1; }","duration":"238.113685ms","start":"2026-02-25T15:07:52.091426Z","end":"2026-02-25T15:07:52.329539Z","steps":["trace[960437999] 'process raft request' (duration: 237.972481ms)"],"step_count":1}