{"level":"warn","ts":"2026-02-08T21:36:28.69793Z","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-08T21:36:28.698049Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.218: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://162.253.55.218:2380","--initial-cluster=instance=https://162.253.55.218:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.218:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.218: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-08T21:36:28.698145Z","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-08T21:36:28.698208Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-02-08T21:36:28.698258Z","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-08T21:36:28.698933Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"]} {"level":"info","ts":"2026-02-08T21:36:28.699085Z","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":2,"max-cpu-available":2,"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://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.218: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-08T21:36:28.706439Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.087699ms"} {"level":"info","ts":"2026-02-08T21:36:28.726398Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bb7d59f4041c8abe","cluster-id":"5330ca29224af3c4"} {"level":"info","ts":"2026-02-08T21:36:28.726489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=()"} {"level":"info","ts":"2026-02-08T21:36:28.72652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 0"} {"level":"info","ts":"2026-02-08T21:36:28.726555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bb7d59f4041c8abe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-08T21:36:28.72658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 1"} {"level":"info","ts":"2026-02-08T21:36:28.726632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"warn","ts":"2026-02-08T21:36:28.741883Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-08T21:36:28.746758Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-08T21:36:28.749035Z","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-08T21:36:28.755968Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bb7d59f4041c8abe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-08T21:36:28.766595Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bb7d59f4041c8abe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-08T21:36:28.768612Z","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-08T21:36:28.768809Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bb7d59f4041c8abe","initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-08T21:36:28.768851Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-08T21:36:28.768957Z","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-08T21:36:28.768998Z","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-08T21:36:28.769032Z","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-08T21:36:28.769118Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-02-08T21:36:28.769148Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-02-08T21:36:28.77028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"info","ts":"2026-02-08T21:36:28.770571Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","added-peer-id":"bb7d59f4041c8abe","added-peer-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-02-08T21:36:29.427162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe is starting a new election at term 1"} {"level":"info","ts":"2026-02-08T21:36:29.427208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became pre-candidate at term 1"} {"level":"info","ts":"2026-02-08T21:36:29.427252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgPreVoteResp from bb7d59f4041c8abe at term 1"} {"level":"info","ts":"2026-02-08T21:36:29.427268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became candidate at term 2"} {"level":"info","ts":"2026-02-08T21:36:29.427274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgVoteResp from bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-02-08T21:36:29.427282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became leader at term 2"} {"level":"info","ts":"2026-02-08T21:36:29.427289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bb7d59f4041c8abe elected leader bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-02-08T21:36:29.429423Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bb7d59f4041c8abe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.218:2379]}","request-path":"/0/members/bb7d59f4041c8abe/attributes","cluster-id":"5330ca29224af3c4","publish-timeout":"7s"} {"level":"info","ts":"2026-02-08T21:36:29.429949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T21:36:29.430411Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T21:36:29.430593Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T21:36:29.433311Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-08T21:36:29.433371Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-08T21:36:29.434913Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-08T21:36:29.445768Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.218:2379"} {"level":"info","ts":"2026-02-08T21:36:29.451074Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T21:36:29.451184Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T21:36:29.45124Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T21:36:47.369431Z","caller":"traceutil/trace.go:171","msg":"trace[355292022] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"111.028079ms","start":"2026-02-08T21:36:47.258388Z","end":"2026-02-08T21:36:47.369416Z","steps":["trace[355292022] 'process raft request' (duration: 110.946669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:49.328306Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.56128956s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-08T21:36:49.567752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.094876194s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T21:36:49.572073Z","caller":"traceutil/trace.go:171","msg":"trace[1720692659] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"2.311332184s","start":"2026-02-08T21:36:47.260705Z","end":"2026-02-08T21:36:49.572037Z","steps":["trace[1720692659] 'process raft request' (duration: 211.879328ms)","trace[1720692659] 'compare' (duration: 2.094793913s)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:36:49.572224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:47.260698Z","time spent":"2.311447744s","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T21:36:49.572607Z","caller":"traceutil/trace.go:171","msg":"trace[1687625270] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"2.310229526s","start":"2026-02-08T21:36:47.262367Z","end":"2026-02-08T21:36:49.572596Z","steps":["trace[1687625270] 'process raft request' (duration: 2.305446762s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:49.572664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:47.262361Z","time spent":"2.310273526s","remote":"127.0.0.1:44142","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-08T21:36:49.572874Z","caller":"traceutil/trace.go:171","msg":"trace[877338687] linearizableReadLoop","detail":"{readStateIndex:463; appliedIndex:461; }","duration":"2.309660531s","start":"2026-02-08T21:36:47.263203Z","end":"2026-02-08T21:36:49.572864Z","steps":["trace[877338687] 'read index received' (duration: 106.551748ms)","trace[877338687] 'applied index is now lower than readState.Index' (duration: 2.203107503s)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:36:49.945952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000558608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-08T21:36:49.946289Z","caller":"traceutil/trace.go:171","msg":"trace[1461338647] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000944s","start":"2026-02-08T21:36:47.94532Z","end":"2026-02-08T21:36:49.946264Z","steps":["trace[1461338647] 'agreement among raft nodes before linearized reading' (duration: 2.000590178s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:49.94652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:47.945301Z","time spent":"2.001200882s","remote":"127.0.0.1:50472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-08T21:36:50.629792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061929753s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-08T21:36:50.630184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.366965693s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-08T21:36:50.630227Z","caller":"traceutil/trace.go:171","msg":"trace[751221567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:451; }","duration":"3.367016433s","start":"2026-02-08T21:36:47.263192Z","end":"2026-02-08T21:36:50.630209Z","steps":["trace[751221567] 'agreement among raft nodes before linearized reading' (duration: 2.309777822s)","trace[751221567] 'range keys from in-memory index tree' (duration: 1.057170801s)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:36:50.630267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:47.263188Z","time spent":"3.367071363s","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-08T21:36:50.632849Z","caller":"traceutil/trace.go:171","msg":"trace[1301729431] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:463; }","duration":"1.059934169s","start":"2026-02-08T21:36:49.572897Z","end":"2026-02-08T21:36:50.632832Z","steps":["trace[1301729431] 'read index received' (duration: 86.03µs)","trace[1301729431] 'applied index is now lower than readState.Index' (duration: 1.059846399s)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:36:50.634826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26073342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-08T21:36:50.636063Z","caller":"traceutil/trace.go:171","msg":"trace[189316264] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:451; }","duration":"1.262012899s","start":"2026-02-08T21:36:49.374044Z","end":"2026-02-08T21:36:50.636057Z","steps":["trace[189316264] 'agreement among raft nodes before linearized reading' (duration: 1.260738091s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:50.63489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.829200005s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"warn","ts":"2026-02-08T21:36:50.634978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.306354397s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-08T21:36:50.636026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.951297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:36:50.636386Z","caller":"traceutil/trace.go:171","msg":"trace[833972009] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:451; }","duration":"689.34071ms","start":"2026-02-08T21:36:49.947042Z","end":"2026-02-08T21:36:50.636383Z","steps":["trace[833972009] 'agreement among raft nodes before linearized reading' (duration: 688.949467ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:50.636472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:49.947028Z","time spent":"689.438311ms","remote":"127.0.0.1:50474","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-08T21:36:50.63622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:49.374026Z","time spent":"1.262186511s","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-08T21:36:50.636301Z","caller":"traceutil/trace.go:171","msg":"trace[1539810254] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:451; }","duration":"2.830633436s","start":"2026-02-08T21:36:47.805662Z","end":"2026-02-08T21:36:50.636295Z","steps":["trace[1539810254] 'agreement among raft nodes before linearized reading' (duration: 2.829200196s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:50.636829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:47.805649Z","time spent":"2.83117294s","remote":"127.0.0.1:44026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4283,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-02-08T21:36:50.636365Z","caller":"traceutil/trace.go:171","msg":"trace[325196506] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:451; }","duration":"3.307741197s","start":"2026-02-08T21:36:47.328617Z","end":"2026-02-08T21:36:50.636358Z","steps":["trace[325196506] 'agreement among raft nodes before linearized reading' (duration: 3.306348187s)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:36:51.108819Z","caller":"traceutil/trace.go:171","msg":"trace[453480913] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"464.347744ms","start":"2026-02-08T21:36:50.644454Z","end":"2026-02-08T21:36:51.108802Z","steps":["trace[453480913] 'process raft request' (duration: 464.254684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:51.108904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:50.644439Z","time spent":"464.425105ms","remote":"127.0.0.1:50544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-08T21:36:51.352656Z","caller":"traceutil/trace.go:171","msg":"trace[1492761285] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:465; }","duration":"706.11575ms","start":"2026-02-08T21:36:50.64652Z","end":"2026-02-08T21:36:51.352635Z","steps":["trace[1492761285] 'read index received' (duration: 462.787114ms)","trace[1492761285] 'applied index is now lower than readState.Index' (duration: 243.327706ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:36:51.352676Z","caller":"traceutil/trace.go:171","msg":"trace[568879456] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"704.207796ms","start":"2026-02-08T21:36:50.648449Z","end":"2026-02-08T21:36:51.352657Z","steps":["trace[568879456] 'process raft request' (duration: 704.070055ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:51.352786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:50.648443Z","time spent":"704.286716ms","remote":"127.0.0.1:44026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4053,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T21:36:51.352909Z","caller":"traceutil/trace.go:171","msg":"trace[857166388] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"703.282199ms","start":"2026-02-08T21:36:50.649613Z","end":"2026-02-08T21:36:51.352895Z","steps":["trace[857166388] 'process raft request' (duration: 702.983307ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:36:51.352918Z","caller":"traceutil/trace.go:171","msg":"trace[1004303484] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"708.023803ms","start":"2026-02-08T21:36:50.644887Z","end":"2026-02-08T21:36:51.352911Z","steps":["trace[1004303484] 'process raft request' (duration: 707.410218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:51.352956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:50.644879Z","time spent":"708.058003ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:36:51.352992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:50.649608Z","time spent":"703.33121ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:36:51.352784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.246981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:36:51.353109Z","caller":"traceutil/trace.go:171","msg":"trace[2028406875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:455; }","duration":"706.599683ms","start":"2026-02-08T21:36:50.646501Z","end":"2026-02-08T21:36:51.353101Z","steps":["trace[2028406875] 'agreement among raft nodes before linearized reading' (duration: 706.21496ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:36:51.353151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:36:50.646494Z","time spent":"706.649593ms","remote":"127.0.0.1:50472","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-08T21:37:02.149691Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600017999084167,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-08T21:37:02.402351Z","caller":"traceutil/trace.go:171","msg":"trace[1128816257] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"758.742603ms","start":"2026-02-08T21:37:01.643594Z","end":"2026-02-08T21:37:02.402336Z","steps":["trace[1128816257] 'process raft request' (duration: 758.660812ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.402557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:01.643577Z","time spent":"758.818923ms","remote":"127.0.0.1:50512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-08T21:37:02.408907Z","caller":"traceutil/trace.go:171","msg":"trace[215881400] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:563; }","duration":"759.787889ms","start":"2026-02-08T21:37:01.64911Z","end":"2026-02-08T21:37:02.408898Z","steps":["trace[215881400] 'read index received' (duration: 753.167066ms)","trace[215881400] 'applied index is now lower than readState.Index' (duration: 6.598433ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:02.408952Z","caller":"traceutil/trace.go:171","msg":"trace[1808874528] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"562.114417ms","start":"2026-02-08T21:37:01.846833Z","end":"2026-02-08T21:37:02.408948Z","steps":["trace[1808874528] 'process raft request' (duration: 561.927215ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.40902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:01.846814Z","time spent":"562.181967ms","remote":"127.0.0.1:50512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-08T21:37:02.409224Z","caller":"traceutil/trace.go:171","msg":"trace[257768564] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"155.079522ms","start":"2026-02-08T21:37:02.254139Z","end":"2026-02-08T21:37:02.409218Z","steps":["trace[257768564] 'process raft request' (duration: 154.69125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.409397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.285862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:02.409421Z","caller":"traceutil/trace.go:171","msg":"trace[1006496823] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:551; }","duration":"760.329373ms","start":"2026-02-08T21:37:01.649085Z","end":"2026-02-08T21:37:02.409414Z","steps":["trace[1006496823] 'agreement among raft nodes before linearized reading' (duration: 760.289202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.409479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:01.649076Z","time spent":"760.371923ms","remote":"127.0.0.1:50560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-08T21:37:02.415886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.676358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-08T21:37:02.415921Z","caller":"traceutil/trace.go:171","msg":"trace[771935458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:552; }","duration":"725.734638ms","start":"2026-02-08T21:37:01.690178Z","end":"2026-02-08T21:37:02.415912Z","steps":["trace[771935458] 'agreement among raft nodes before linearized reading' (duration: 725.522327ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.415956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:01.690165Z","time spent":"725.785949ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-08T21:37:02.418008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.364738ms","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-08T21:37:02.418025Z","caller":"traceutil/trace.go:171","msg":"trace[28137919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:552; }","duration":"134.405528ms","start":"2026-02-08T21:37:02.283615Z","end":"2026-02-08T21:37:02.41802Z","steps":["trace[28137919] 'agreement among raft nodes before linearized reading' (duration: 134.303827ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.41811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.231029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:02.418164Z","caller":"traceutil/trace.go:171","msg":"trace[74561529] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:552; }","duration":"176.321319ms","start":"2026-02-08T21:37:02.241836Z","end":"2026-02-08T21:37:02.418157Z","steps":["trace[74561529] 'agreement among raft nodes before linearized reading' (duration: 176.261209ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.418246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.692023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:02.418263Z","caller":"traceutil/trace.go:171","msg":"trace[1361385799] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:552; }","duration":"376.708474ms","start":"2026-02-08T21:37:02.041547Z","end":"2026-02-08T21:37:02.418256Z","steps":["trace[1361385799] 'agreement among raft nodes before linearized reading' (duration: 376.684733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.418323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:02.041499Z","time spent":"376.818904ms","remote":"127.0.0.1:50512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-08T21:37:02.418407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.735986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:02.41842Z","caller":"traceutil/trace.go:171","msg":"trace[790899662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"472.777367ms","start":"2026-02-08T21:37:01.945638Z","end":"2026-02-08T21:37:02.418416Z","steps":["trace[790899662] 'agreement among raft nodes before linearized reading' (duration: 472.756656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.418487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:01.945624Z","time spent":"472.858377ms","remote":"127.0.0.1:50472","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-08T21:37:02.418581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.371491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-08T21:37:02.418637Z","caller":"traceutil/trace.go:171","msg":"trace[25698170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"661.417331ms","start":"2026-02-08T21:37:01.757173Z","end":"2026-02-08T21:37:02.41859Z","steps":["trace[25698170] 'agreement among raft nodes before linearized reading' (duration: 661.389091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:02.418654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:01.757156Z","time spent":"661.493411ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-08T21:37:09.875291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.687498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-08T21:37:09.875352Z","caller":"traceutil/trace.go:171","msg":"trace[1738350929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:608; }","duration":"341.782712ms","start":"2026-02-08T21:37:09.533554Z","end":"2026-02-08T21:37:09.875337Z","steps":["trace[1738350929] 'range keys from in-memory index tree' (duration: 341.564574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:09.875341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.796734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-08T21:37:09.875381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:09.533519Z","time spent":"341.857276ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-08T21:37:09.8754Z","caller":"traceutil/trace.go:171","msg":"trace[978534535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:608; }","duration":"342.923459ms","start":"2026-02-08T21:37:09.532463Z","end":"2026-02-08T21:37:09.875386Z","steps":["trace[978534535] 'range keys from in-memory index tree' (duration: 342.662409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:09.875432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:09.532444Z","time spent":"342.980782ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-08T21:37:10.214204Z","caller":"traceutil/trace.go:171","msg":"trace[2086056010] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"270.769598ms","start":"2026-02-08T21:37:09.943413Z","end":"2026-02-08T21:37:10.214182Z","steps":["trace[2086056010] 'read index received' (duration: 230.8628ms)","trace[2086056010] 'applied index is now lower than readState.Index' (duration: 39.905858ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:10.214308Z","caller":"traceutil/trace.go:171","msg":"trace[924103352] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"335.000603ms","start":"2026-02-08T21:37:09.879283Z","end":"2026-02-08T21:37:10.214283Z","steps":["trace[924103352] 'process raft request' (duration: 295.015542ms)","trace[924103352] 'compare' (duration: 39.742701ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:10.214397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:09.879263Z","time spent":"335.086627ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:37:10.214326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.897573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:10.214515Z","caller":"traceutil/trace.go:171","msg":"trace[1510592825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"271.123682ms","start":"2026-02-08T21:37:09.943386Z","end":"2026-02-08T21:37:10.214509Z","steps":["trace[1510592825] 'agreement among raft nodes before linearized reading' (duration: 270.905943ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:10.472728Z","caller":"traceutil/trace.go:171","msg":"trace[1634208372] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"245.367377ms","start":"2026-02-08T21:37:10.227343Z","end":"2026-02-08T21:37:10.47271Z","steps":["trace[1634208372] 'process raft request' (duration: 216.027828ms)","trace[1634208372] 'compare' (duration: 29.108329ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:10.714785Z","caller":"traceutil/trace.go:171","msg":"trace[1645335656] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"155.87966ms","start":"2026-02-08T21:37:10.558892Z","end":"2026-02-08T21:37:10.714771Z","steps":["trace[1645335656] 'read index received' (duration: 146.503209ms)","trace[1645335656] 'applied index is now lower than readState.Index' (duration: 9.375811ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:10.715029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.119969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-08T21:37:10.715081Z","caller":"traceutil/trace.go:171","msg":"trace[406954166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"156.211163ms","start":"2026-02-08T21:37:10.558858Z","end":"2026-02-08T21:37:10.715069Z","steps":["trace[406954166] 'agreement among raft nodes before linearized reading' (duration: 156.026195ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:10.715088Z","caller":"traceutil/trace.go:171","msg":"trace[405903691] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"158.924612ms","start":"2026-02-08T21:37:10.556157Z","end":"2026-02-08T21:37:10.715082Z","steps":["trace[405903691] 'process raft request' (duration: 149.285351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:12.444537Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600017999084344,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-08T21:37:12.671996Z","caller":"traceutil/trace.go:171","msg":"trace[2093290] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"781.972911ms","start":"2026-02-08T21:37:11.890008Z","end":"2026-02-08T21:37:12.671981Z","steps":["trace[2093290] 'process raft request' (duration: 781.868277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:12.672101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:11.889996Z","time spent":"782.045484ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T21:37:12.672335Z","caller":"traceutil/trace.go:171","msg":"trace[1405138252] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:632; }","duration":"728.111484ms","start":"2026-02-08T21:37:11.944217Z","end":"2026-02-08T21:37:12.672329Z","steps":["trace[1405138252] 'read index received' (duration: 728.109504ms)","trace[1405138252] 'applied index is now lower than readState.Index' (duration: 1.52µs)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:12.672379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.167396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:12.672415Z","caller":"traceutil/trace.go:171","msg":"trace[894833345] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"728.228838ms","start":"2026-02-08T21:37:11.944179Z","end":"2026-02-08T21:37:12.672408Z","steps":["trace[894833345] 'agreement among raft nodes before linearized reading' (duration: 728.183947ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:12.672432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:11.944153Z","time spent":"728.27497ms","remote":"127.0.0.1:50472","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-08T21:37:13.107685Z","caller":"traceutil/trace.go:171","msg":"trace[752790269] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"435.317349ms","start":"2026-02-08T21:37:12.672354Z","end":"2026-02-08T21:37:13.107671Z","steps":["trace[752790269] 'read index received' (duration: 435.183544ms)","trace[752790269] 'applied index is now lower than readState.Index' (duration: 133.255µs)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:13.107875Z","caller":"traceutil/trace.go:171","msg":"trace[346423136] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"458.386812ms","start":"2026-02-08T21:37:12.649483Z","end":"2026-02-08T21:37:13.10787Z","steps":["trace[346423136] 'process raft request' (duration: 458.09368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:13.10795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:12.649467Z","time spent":"458.434244ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:37:13.1081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.240509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.218\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-08T21:37:13.10812Z","caller":"traceutil/trace.go:171","msg":"trace[259746754] range","detail":"{range_begin:/registry/masterleases/162.253.55.218; range_end:; response_count:1; response_revision:616; }","duration":"664.30109ms","start":"2026-02-08T21:37:12.443814Z","end":"2026-02-08T21:37:13.108116Z","steps":["trace[259746754] 'agreement among raft nodes before linearized reading' (duration: 664.233908ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:13.108134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:12.44379Z","time spent":"664.341752ms","remote":"127.0.0.1:50498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.218\" "} {"level":"warn","ts":"2026-02-08T21:37:13.108224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.706232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-08T21:37:13.10824Z","caller":"traceutil/trace.go:171","msg":"trace[1186881507] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"889.739783ms","start":"2026-02-08T21:37:12.218496Z","end":"2026-02-08T21:37:13.108236Z","steps":["trace[1186881507] 'agreement among raft nodes before linearized reading' (duration: 889.698372ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:13.108253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:12.218482Z","time spent":"889.768185ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-08T21:37:13.108314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.518297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:13.108329Z","caller":"traceutil/trace.go:171","msg":"trace[214330205] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"434.548058ms","start":"2026-02-08T21:37:12.673778Z","end":"2026-02-08T21:37:13.108326Z","steps":["trace[214330205] 'agreement among raft nodes before linearized reading' (duration: 434.527197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:13.108341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:12.673769Z","time spent":"434.569519ms","remote":"127.0.0.1:50474","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-08T21:37:13.108466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.983654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-08T21:37:13.108483Z","caller":"traceutil/trace.go:171","msg":"trace[1697147801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"274.071067ms","start":"2026-02-08T21:37:12.834408Z","end":"2026-02-08T21:37:13.108479Z","steps":["trace[1697147801] 'agreement among raft nodes before linearized reading' (duration: 274.025675ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:13.108555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.785631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-08T21:37:13.10857Z","caller":"traceutil/trace.go:171","msg":"trace[1950463025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"308.841683ms","start":"2026-02-08T21:37:12.799725Z","end":"2026-02-08T21:37:13.108567Z","steps":["trace[1950463025] 'agreement among raft nodes before linearized reading' (duration: 308.802552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:13.108581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:12.799706Z","time spent":"308.872445ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-08T21:37:13.10865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.970804ms","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-08T21:37:13.108667Z","caller":"traceutil/trace.go:171","msg":"trace[156288221] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:616; }","duration":"388.010656ms","start":"2026-02-08T21:37:12.720653Z","end":"2026-02-08T21:37:13.108664Z","steps":["trace[156288221] 'agreement among raft nodes before linearized reading' (duration: 387.970944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:13.10868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:12.720641Z","time spent":"388.034797ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-08T21:37:17.30315Z","caller":"traceutil/trace.go:171","msg":"trace[1230413451] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"139.584277ms","start":"2026-02-08T21:37:17.16355Z","end":"2026-02-08T21:37:17.303134Z","steps":["trace[1230413451] 'process raft request' (duration: 135.744244ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:17.303345Z","caller":"traceutil/trace.go:171","msg":"trace[1189864848] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"139.488343ms","start":"2026-02-08T21:37:17.163851Z","end":"2026-02-08T21:37:17.30334Z","steps":["trace[1189864848] 'process raft request' (duration: 139.015725ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:17.303459Z","caller":"traceutil/trace.go:171","msg":"trace[262112138] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:663; }","duration":"102.883148ms","start":"2026-02-08T21:37:17.200568Z","end":"2026-02-08T21:37:17.303451Z","steps":["trace[262112138] 'read index received' (duration: 98.739683ms)","trace[262112138] 'applied index is now lower than readState.Index' (duration: 4.141015ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:17.303491Z","caller":"traceutil/trace.go:171","msg":"trace[1215704714] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"137.686436ms","start":"2026-02-08T21:37:17.1658Z","end":"2026-02-08T21:37:17.303486Z","steps":["trace[1215704714] 'process raft request' (duration: 137.24634ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:17.303599Z","caller":"traceutil/trace.go:171","msg":"trace[1116145923] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"101.025928ms","start":"2026-02-08T21:37:17.202568Z","end":"2026-02-08T21:37:17.303594Z","steps":["trace[1116145923] 'process raft request' (duration: 100.497798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:17.303789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.21269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-thxkq\" ","response":"range_response_count:1 size:17670"} {"level":"info","ts":"2026-02-08T21:37:17.303808Z","caller":"traceutil/trace.go:171","msg":"trace[1497760222] range","detail":"{range_begin:/registry/pods/kube-system/cilium-thxkq; range_end:; response_count:1; response_revision:649; }","duration":"103.283253ms","start":"2026-02-08T21:37:17.200518Z","end":"2026-02-08T21:37:17.303801Z","steps":["trace[1497760222] 'agreement among raft nodes before linearized reading' (duration: 103.185149ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:17.458492Z","caller":"traceutil/trace.go:171","msg":"trace[1899424851] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"139.549345ms","start":"2026-02-08T21:37:17.318925Z","end":"2026-02-08T21:37:17.458475Z","steps":["trace[1899424851] 'process raft request' (duration: 104.150905ms)","trace[1899424851] 'compare' (duration: 35.313747ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:17.943268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.16924ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-08T21:37:17.943644Z","caller":"traceutil/trace.go:171","msg":"trace[86223371] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"223.410364ms","start":"2026-02-08T21:37:17.720222Z","end":"2026-02-08T21:37:17.943632Z","steps":["trace[86223371] 'process raft request' (duration: 223.101332ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:20.18136Z","caller":"traceutil/trace.go:171","msg":"trace[1641925644] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"100.210149ms","start":"2026-02-08T21:37:20.081134Z","end":"2026-02-08T21:37:20.181345Z","steps":["trace[1641925644] 'process raft request' (duration: 100.129356ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.316684Z","caller":"traceutil/trace.go:171","msg":"trace[814047603] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"154.136004ms","start":"2026-02-08T21:37:23.162279Z","end":"2026-02-08T21:37:23.316415Z","steps":["trace[814047603] 'process raft request' (duration: 153.895195ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.416336Z","caller":"traceutil/trace.go:171","msg":"trace[1860235846] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:699; }","duration":"240.634374ms","start":"2026-02-08T21:37:23.175683Z","end":"2026-02-08T21:37:23.416317Z","steps":["trace[1860235846] 'read index received' (duration: 140.529861ms)","trace[1860235846] 'applied index is now lower than readState.Index' (duration: 100.103523ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:23.416527Z","caller":"traceutil/trace.go:171","msg":"trace[1934926066] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"249.1388ms","start":"2026-02-08T21:37:23.16738Z","end":"2026-02-08T21:37:23.416519Z","steps":["trace[1934926066] 'process raft request' (duration: 208.550438ms)","trace[1934926066] 'compare' (duration: 40.307832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:23.416733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.036568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-08T21:37:23.416771Z","caller":"traceutil/trace.go:171","msg":"trace[1132595299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:680; }","duration":"241.09216ms","start":"2026-02-08T21:37:23.175663Z","end":"2026-02-08T21:37:23.416755Z","steps":["trace[1132595299] 'agreement among raft nodes before linearized reading' (duration: 240.993577ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.540147Z","caller":"traceutil/trace.go:171","msg":"trace[1496250984] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"111.612573ms","start":"2026-02-08T21:37:23.428519Z","end":"2026-02-08T21:37:23.540132Z","steps":["trace[1496250984] 'process raft request' (duration: 109.634985ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.540476Z","caller":"traceutil/trace.go:171","msg":"trace[650552923] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"111.886344ms","start":"2026-02-08T21:37:23.428566Z","end":"2026-02-08T21:37:23.540452Z","steps":["trace[650552923] 'process raft request' (duration: 111.546572ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.540664Z","caller":"traceutil/trace.go:171","msg":"trace[996274739] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"112.046409ms","start":"2026-02-08T21:37:23.428611Z","end":"2026-02-08T21:37:23.540658Z","steps":["trace[996274739] 'process raft request' (duration: 111.762339ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.54069Z","caller":"traceutil/trace.go:171","msg":"trace[1137878642] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"108.159754ms","start":"2026-02-08T21:37:23.432526Z","end":"2026-02-08T21:37:23.540686Z","steps":["trace[1137878642] 'process raft request' (duration: 108.037909ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.683392Z","caller":"traceutil/trace.go:171","msg":"trace[1404647303] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"123.067862ms","start":"2026-02-08T21:37:23.560306Z","end":"2026-02-08T21:37:23.683374Z","steps":["trace[1404647303] 'process raft request' (duration: 89.615418ms)","trace[1404647303] 'compare' (duration: 33.369782ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:23.879539Z","caller":"traceutil/trace.go:171","msg":"trace[1479424242] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"179.02652ms","start":"2026-02-08T21:37:23.700494Z","end":"2026-02-08T21:37:23.879521Z","steps":["trace[1479424242] 'process raft request' (duration: 164.573827ms)","trace[1479424242] 'compare' (duration: 14.07692ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:23.915983Z","caller":"traceutil/trace.go:171","msg":"trace[404161718] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"120.070518ms","start":"2026-02-08T21:37:23.795897Z","end":"2026-02-08T21:37:23.915968Z","steps":["trace[404161718] 'process raft request' (duration: 120.043677ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.916219Z","caller":"traceutil/trace.go:171","msg":"trace[1410519269] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"125.228938ms","start":"2026-02-08T21:37:23.790986Z","end":"2026-02-08T21:37:23.916215Z","steps":["trace[1410519269] 'process raft request' (duration: 124.819053ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.916274Z","caller":"traceutil/trace.go:171","msg":"trace[1904405675] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"125.203377ms","start":"2026-02-08T21:37:23.791067Z","end":"2026-02-08T21:37:23.91627Z","steps":["trace[1904405675] 'process raft request' (duration: 124.813893ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.916321Z","caller":"traceutil/trace.go:171","msg":"trace[1201311800] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"124.984929ms","start":"2026-02-08T21:37:23.791333Z","end":"2026-02-08T21:37:23.916318Z","steps":["trace[1201311800] 'process raft request' (duration: 124.571425ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:23.916375Z","caller":"traceutil/trace.go:171","msg":"trace[831576898] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"124.657467ms","start":"2026-02-08T21:37:23.791713Z","end":"2026-02-08T21:37:23.91637Z","steps":["trace[831576898] 'process raft request' (duration: 124.212502ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:24.053512Z","caller":"traceutil/trace.go:171","msg":"trace[1515181614] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:714; }","duration":"119.075774ms","start":"2026-02-08T21:37:23.934416Z","end":"2026-02-08T21:37:24.053492Z","steps":["trace[1515181614] 'read index received' (duration: 49.284405ms)","trace[1515181614] 'applied index is now lower than readState.Index' (duration: 69.790629ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:24.053799Z","caller":"traceutil/trace.go:171","msg":"trace[390637324] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"121.128115ms","start":"2026-02-08T21:37:23.932664Z","end":"2026-02-08T21:37:24.053792Z","steps":["trace[390637324] 'process raft request' (duration: 51.167141ms)","trace[390637324] 'compare' (duration: 69.577581ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:24.05414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.711376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-7lxbx\" ","response":"range_response_count:1 size:2858"} {"level":"info","ts":"2026-02-08T21:37:24.054249Z","caller":"traceutil/trace.go:171","msg":"trace[1323020111] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-6f56467975-7lxbx; range_end:; response_count:1; response_revision:694; }","duration":"119.825839ms","start":"2026-02-08T21:37:23.934396Z","end":"2026-02-08T21:37:24.054222Z","steps":["trace[1323020111] 'agreement among raft nodes before linearized reading' (duration: 119.319792ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:24.259759Z","caller":"traceutil/trace.go:171","msg":"trace[1650940511] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:715; }","duration":"134.28201ms","start":"2026-02-08T21:37:24.125461Z","end":"2026-02-08T21:37:24.259743Z","steps":["trace[1650940511] 'read index received' (duration: 96.285303ms)","trace[1650940511] 'applied index is now lower than readState.Index' (duration: 37.996087ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:24.259928Z","caller":"traceutil/trace.go:171","msg":"trace[442830301] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"198.784319ms","start":"2026-02-08T21:37:24.061137Z","end":"2026-02-08T21:37:24.259921Z","steps":["trace[442830301] 'process raft request' (duration: 160.599675ms)","trace[442830301] 'compare' (duration: 37.716868ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:24.2601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.58553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-02-08T21:37:24.260142Z","caller":"traceutil/trace.go:171","msg":"trace[1160985335] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:696; }","duration":"134.645652ms","start":"2026-02-08T21:37:24.125486Z","end":"2026-02-08T21:37:24.260131Z","steps":["trace[1160985335] 'agreement among raft nodes before linearized reading' (duration: 134.507227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:24.260166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.693334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-08T21:37:24.2602Z","caller":"traceutil/trace.go:171","msg":"trace[291595131] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:696; }","duration":"134.749596ms","start":"2026-02-08T21:37:24.125432Z","end":"2026-02-08T21:37:24.260181Z","steps":["trace[291595131] 'agreement among raft nodes before linearized reading' (duration: 134.697824ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:24.260244Z","caller":"traceutil/trace.go:171","msg":"trace[1723165471] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"197.624079ms","start":"2026-02-08T21:37:24.062616Z","end":"2026-02-08T21:37:24.26024Z","steps":["trace[1723165471] 'process raft request' (duration: 197.0874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:24.260294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.762347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-08T21:37:24.260309Z","caller":"traceutil/trace.go:171","msg":"trace[1513636118] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:696; }","duration":"134.795097ms","start":"2026-02-08T21:37:24.12551Z","end":"2026-02-08T21:37:24.260305Z","steps":["trace[1513636118] 'agreement among raft nodes before linearized reading' (duration: 134.765666ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:24.260381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.86126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-08T21:37:24.260393Z","caller":"traceutil/trace.go:171","msg":"trace[450908720] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:696; }","duration":"134.88037ms","start":"2026-02-08T21:37:24.125509Z","end":"2026-02-08T21:37:24.260389Z","steps":["trace[450908720] 'agreement among raft nodes before linearized reading' (duration: 134.859169ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:24.378189Z","caller":"traceutil/trace.go:171","msg":"trace[588543063] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:717; }","duration":"100.990665ms","start":"2026-02-08T21:37:24.277184Z","end":"2026-02-08T21:37:24.378175Z","steps":["trace[588543063] 'read index received' (duration: 99.743192ms)","trace[588543063] 'applied index is now lower than readState.Index' (duration: 1.246783ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:24.37835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.14102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-zk9qm\" ","response":"range_response_count:1 size:3813"} {"level":"info","ts":"2026-02-08T21:37:24.378367Z","caller":"traceutil/trace.go:171","msg":"trace[570354756] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-zk9qm; range_end:; response_count:1; response_revision:697; }","duration":"101.194222ms","start":"2026-02-08T21:37:24.277167Z","end":"2026-02-08T21:37:24.378362Z","steps":["trace[570354756] 'agreement among raft nodes before linearized reading' (duration: 101.062027ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:24.378557Z","caller":"traceutil/trace.go:171","msg":"trace[1573677902] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"102.028031ms","start":"2026-02-08T21:37:24.276524Z","end":"2026-02-08T21:37:24.378552Z","steps":["trace[1573677902] 'process raft request' (duration: 100.436906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:24.60458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.490137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-cwz6k\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-08T21:37:24.604638Z","caller":"traceutil/trace.go:171","msg":"trace[1063082557] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-cwz6k; range_end:; response_count:1; response_revision:699; }","duration":"125.594761ms","start":"2026-02-08T21:37:24.479031Z","end":"2026-02-08T21:37:24.604626Z","steps":["trace[1063082557] 'range keys from in-memory index tree' (duration: 125.229189ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:24.741394Z","caller":"traceutil/trace.go:171","msg":"trace[256732295] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"132.365364ms","start":"2026-02-08T21:37:24.609012Z","end":"2026-02-08T21:37:24.741377Z","steps":["trace[256732295] 'process raft request' (duration: 132.280031ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:25.297006Z","caller":"traceutil/trace.go:171","msg":"trace[435833952] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"131.810213ms","start":"2026-02-08T21:37:25.165176Z","end":"2026-02-08T21:37:25.296986Z","steps":["trace[435833952] 'process raft request' (duration: 45.725425ms)","trace[435833952] 'compare' (duration: 85.988455ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:25.609819Z","caller":"traceutil/trace.go:171","msg":"trace[583658122] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"196.247126ms","start":"2026-02-08T21:37:25.413551Z","end":"2026-02-08T21:37:25.609798Z","steps":["trace[583658122] 'process raft request' (duration: 196.112201ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:25.762179Z","caller":"traceutil/trace.go:171","msg":"trace[521061318] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"226.080751ms","start":"2026-02-08T21:37:25.536082Z","end":"2026-02-08T21:37:25.762163Z","steps":["trace[521061318] 'process raft request' (duration: 226.024729ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:25.76228Z","caller":"traceutil/trace.go:171","msg":"trace[413032944] linearizableReadLoop","detail":"{readStateIndex:728; appliedIndex:726; }","duration":"307.678036ms","start":"2026-02-08T21:37:25.454584Z","end":"2026-02-08T21:37:25.762262Z","steps":["trace[413032944] 'read index received' (duration: 155.118427ms)","trace[413032944] 'applied index is now lower than readState.Index' (duration: 152.557309ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:25.762348Z","caller":"traceutil/trace.go:171","msg":"trace[709336307] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"212.049423ms","start":"2026-02-08T21:37:25.550294Z","end":"2026-02-08T21:37:25.762343Z","steps":["trace[709336307] 'process raft request' (duration: 211.851486ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:25.762396Z","caller":"traceutil/trace.go:171","msg":"trace[1277530989] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"346.572119ms","start":"2026-02-08T21:37:25.415816Z","end":"2026-02-08T21:37:25.762388Z","steps":["trace[1277530989] 'process raft request' (duration: 325.954898ms)","trace[1277530989] 'compare' (duration: 20.239518ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:25.762471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:25.415801Z","time spent":"346.60878ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:37:25.762552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.957995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-08T21:37:25.762575Z","caller":"traceutil/trace.go:171","msg":"trace[487947983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:709; }","duration":"308.014407ms","start":"2026-02-08T21:37:25.454555Z","end":"2026-02-08T21:37:25.76257Z","steps":["trace[487947983] 'agreement among raft nodes before linearized reading' (duration: 307.904244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:25.76259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:37:25.448098Z","time spent":"314.488528ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-08T21:37:25.762683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.25437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-08T21:37:25.762695Z","caller":"traceutil/trace.go:171","msg":"trace[771906122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:709; }","duration":"212.280501ms","start":"2026-02-08T21:37:25.550411Z","end":"2026-02-08T21:37:25.762691Z","steps":["trace[771906122] 'agreement among raft nodes before linearized reading' (duration: 212.24285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:25.762789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.709743ms","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-08T21:37:25.7628Z","caller":"traceutil/trace.go:171","msg":"trace[1673120919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:709; }","duration":"199.743424ms","start":"2026-02-08T21:37:25.563053Z","end":"2026-02-08T21:37:25.762797Z","steps":["trace[1673120919] 'agreement among raft nodes before linearized reading' (duration: 199.707283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:25.76291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.031772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-08T21:37:25.762932Z","caller":"traceutil/trace.go:171","msg":"trace[808677556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:709; }","duration":"207.073573ms","start":"2026-02-08T21:37:25.555852Z","end":"2026-02-08T21:37:25.762926Z","steps":["trace[808677556] 'agreement among raft nodes before linearized reading' (duration: 206.994951ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:29.191851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.05324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:29.191918Z","caller":"traceutil/trace.go:171","msg":"trace[784557507] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"245.155573ms","start":"2026-02-08T21:37:28.946746Z","end":"2026-02-08T21:37:29.191902Z","steps":["trace[784557507] 'range keys from in-memory index tree' (duration: 244.985738ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:37:35.089246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.520535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:37:35.089379Z","caller":"traceutil/trace.go:171","msg":"trace[1093196842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"126.66682ms","start":"2026-02-08T21:37:34.962671Z","end":"2026-02-08T21:37:35.089338Z","steps":["trace[1093196842] 'range keys from in-memory index tree' (duration: 126.459083ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:35.090203Z","caller":"traceutil/trace.go:171","msg":"trace[2137813137] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"127.093913ms","start":"2026-02-08T21:37:34.963093Z","end":"2026-02-08T21:37:35.090187Z","steps":["trace[2137813137] 'process raft request' (duration: 65.710014ms)","trace[2137813137] 'compare' (duration: 60.258635ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:36.018933Z","caller":"traceutil/trace.go:171","msg":"trace[1261383913] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"151.414845ms","start":"2026-02-08T21:37:35.867496Z","end":"2026-02-08T21:37:36.018911Z","steps":["trace[1261383913] 'process raft request' (duration: 151.374874ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:36.019508Z","caller":"traceutil/trace.go:171","msg":"trace[1144599468] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"155.618763ms","start":"2026-02-08T21:37:35.863874Z","end":"2026-02-08T21:37:36.019493Z","steps":["trace[1144599468] 'process raft request' (duration: 56.857421ms)","trace[1144599468] 'compare' (duration: 97.893236ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:36.020046Z","caller":"traceutil/trace.go:171","msg":"trace[313347952] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"153.466567ms","start":"2026-02-08T21:37:35.866565Z","end":"2026-02-08T21:37:36.020032Z","steps":["trace[313347952] 'process raft request' (duration: 152.261901ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:37:36.208853Z","caller":"traceutil/trace.go:171","msg":"trace[2077078147] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"209.858881ms","start":"2026-02-08T21:37:35.99897Z","end":"2026-02-08T21:37:36.208829Z","steps":["trace[2077078147] 'process raft request' (duration: 195.812688ms)","trace[2077078147] 'compare' (duration: 13.516397ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:37:37.884432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.844403ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-08T21:37:38.369737Z","caller":"traceutil/trace.go:171","msg":"trace[558214025] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"286.424896ms","start":"2026-02-08T21:37:38.083296Z","end":"2026-02-08T21:37:38.369721Z","steps":["trace[558214025] 'process raft request' (duration: 201.891583ms)","trace[558214025] 'compare' (duration: 84.196353ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:37:38.369843Z","caller":"traceutil/trace.go:171","msg":"trace[1219795208] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"284.837678ms","start":"2026-02-08T21:37:38.084999Z","end":"2026-02-08T21:37:38.369837Z","steps":["trace[1219795208] 'process raft request' (duration: 284.453597ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:26.923846Z","caller":"traceutil/trace.go:171","msg":"trace[1235266271] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"122.543906ms","start":"2026-02-08T21:38:26.801281Z","end":"2026-02-08T21:38:26.923825Z","steps":["trace[1235266271] 'read index received' (duration: 56.031599ms)","trace[1235266271] 'applied index is now lower than readState.Index' (duration: 66.511517ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:38:26.926266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.965532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-02-08T21:38:26.926473Z","caller":"traceutil/trace.go:171","msg":"trace[100136528] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:965; }","duration":"125.152786ms","start":"2026-02-08T21:38:26.801251Z","end":"2026-02-08T21:38:26.926404Z","steps":["trace[100136528] 'agreement among raft nodes before linearized reading' (duration: 124.892191ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:26.927124Z","caller":"traceutil/trace.go:171","msg":"trace[400850147] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"149.71665ms","start":"2026-02-08T21:38:26.777379Z","end":"2026-02-08T21:38:26.927096Z","steps":["trace[400850147] 'process raft request' (duration: 138.830815ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:27.631301Z","caller":"traceutil/trace.go:171","msg":"trace[1099628256] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"124.7654ms","start":"2026-02-08T21:38:27.50652Z","end":"2026-02-08T21:38:27.631285Z","steps":["trace[1099628256] 'process raft request' (duration: 124.663748ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:27.651474Z","caller":"traceutil/trace.go:171","msg":"trace[518777160] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"138.944796ms","start":"2026-02-08T21:38:27.512515Z","end":"2026-02-08T21:38:27.651459Z","steps":["trace[518777160] 'process raft request' (duration: 138.870675ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:42.640966Z","caller":"traceutil/trace.go:171","msg":"trace[570005303] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"177.728689ms","start":"2026-02-08T21:38:42.463213Z","end":"2026-02-08T21:38:42.640942Z","steps":["trace[570005303] 'process raft request' (duration: 106.413669ms)","trace[570005303] 'compare' (duration: 70.822452ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:38:42.641037Z","caller":"traceutil/trace.go:171","msg":"trace[2136955985] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"177.649818ms","start":"2026-02-08T21:38:42.463366Z","end":"2026-02-08T21:38:42.641016Z","steps":["trace[2136955985] 'process raft request' (duration: 177.285982ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:44.186718Z","caller":"traceutil/trace.go:171","msg":"trace[1730250757] linearizableReadLoop","detail":"{readStateIndex:1061; appliedIndex:1060; }","duration":"240.915403ms","start":"2026-02-08T21:38:43.945785Z","end":"2026-02-08T21:38:44.1867Z","steps":["trace[1730250757] 'read index received' (duration: 240.75373ms)","trace[1730250757] 'applied index is now lower than readState.Index' (duration: 161.073µs)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:38:44.186857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.065245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:38:44.186878Z","caller":"traceutil/trace.go:171","msg":"trace[1253202252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1021; }","duration":"241.137626ms","start":"2026-02-08T21:38:43.945733Z","end":"2026-02-08T21:38:44.186871Z","steps":["trace[1253202252] 'agreement among raft nodes before linearized reading' (duration: 241.041275ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:44.187319Z","caller":"traceutil/trace.go:171","msg":"trace[1666787686] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"330.413978ms","start":"2026-02-08T21:38:43.856879Z","end":"2026-02-08T21:38:44.187293Z","steps":["trace[1666787686] 'process raft request' (duration: 329.705726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:44.18762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:43.856864Z","time spent":"330.633231ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:38:44.692565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.05909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-08T21:38:44.692811Z","caller":"traceutil/trace.go:171","msg":"trace[1836658842] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1021; }","duration":"232.368355ms","start":"2026-02-08T21:38:44.460424Z","end":"2026-02-08T21:38:44.692792Z","steps":["trace[1836658842] 'range keys from in-memory index tree' (duration: 231.914147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:45.229363Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600017999085323,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-08T21:38:45.51279Z","caller":"traceutil/trace.go:171","msg":"trace[628287861] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"863.108345ms","start":"2026-02-08T21:38:44.649658Z","end":"2026-02-08T21:38:45.512766Z","steps":["trace[628287861] 'process raft request' (duration: 862.969173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:45.512937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:44.649635Z","time spent":"863.219947ms","remote":"127.0.0.1:44142","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-02-08T21:38:45.559273Z","caller":"traceutil/trace.go:171","msg":"trace[1273803270] linearizableReadLoop","detail":"{readStateIndex:1063; appliedIndex:1062; }","duration":"830.430818ms","start":"2026-02-08T21:38:44.728828Z","end":"2026-02-08T21:38:45.559259Z","steps":["trace[1273803270] 'read index received' (duration: 784.536491ms)","trace[1273803270] 'applied index is now lower than readState.Index' (duration: 45.893607ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:38:45.559439Z","caller":"traceutil/trace.go:171","msg":"trace[1299357472] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"862.525071ms","start":"2026-02-08T21:38:44.696907Z","end":"2026-02-08T21:38:45.559432Z","steps":["trace[1299357472] 'process raft request' (duration: 862.282287ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:45.559509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:44.696894Z","time spent":"862.566541ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:38:45.559676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.854544ms","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-08T21:38:45.559742Z","caller":"traceutil/trace.go:171","msg":"trace[1818857687] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1023; }","duration":"830.903165ms","start":"2026-02-08T21:38:44.728791Z","end":"2026-02-08T21:38:45.559694Z","steps":["trace[1818857687] 'agreement among raft nodes before linearized reading' (duration: 830.824074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:45.559762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:44.728779Z","time spent":"830.977777ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-08T21:38:45.559799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.233388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-08T21:38:45.559847Z","caller":"traceutil/trace.go:171","msg":"trace[954485693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1023; }","duration":"641.310039ms","start":"2026-02-08T21:38:44.918524Z","end":"2026-02-08T21:38:45.559834Z","steps":["trace[954485693] 'agreement among raft nodes before linearized reading' (duration: 641.180047ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:45.55988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:44.918511Z","time spent":"641.361421ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-08T21:38:45.559992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.956492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-08T21:38:45.56001Z","caller":"traceutil/trace.go:171","msg":"trace[1906029670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1023; }","duration":"459.992452ms","start":"2026-02-08T21:38:45.100012Z","end":"2026-02-08T21:38:45.560004Z","steps":["trace[1906029670] 'agreement among raft nodes before linearized reading' (duration: 459.941551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:45.560026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:45.100004Z","time spent":"460.018442ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-08T21:38:45.560059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.618634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T21:38:45.560091Z","caller":"traceutil/trace.go:171","msg":"trace[1624846735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1023; }","duration":"612.678465ms","start":"2026-02-08T21:38:44.9474Z","end":"2026-02-08T21:38:45.560079Z","steps":["trace[1624846735] 'agreement among raft nodes before linearized reading' (duration: 612.637975ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:45.560121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:44.947385Z","time spent":"612.730226ms","remote":"127.0.0.1:50472","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-08T21:38:46.021443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.426441ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T21:38:46.021753Z","caller":"traceutil/trace.go:171","msg":"trace[653977507] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"454.762994ms","start":"2026-02-08T21:38:45.566969Z","end":"2026-02-08T21:38:46.021732Z","steps":["trace[653977507] 'process raft request' (duration: 213.988247ms)","trace[653977507] 'compare' (duration: 240.241138ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:38:46.02185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:45.566959Z","time spent":"454.836975ms","remote":"127.0.0.1:44142","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-08T21:38:46.021967Z","caller":"traceutil/trace.go:171","msg":"trace[1200057853] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"454.797954ms","start":"2026-02-08T21:38:45.567154Z","end":"2026-02-08T21:38:46.021952Z","steps":["trace[1200057853] 'process raft request' (duration: 454.611041ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:46.022056Z","caller":"traceutil/trace.go:171","msg":"trace[53175067] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"454.926036ms","start":"2026-02-08T21:38:45.567124Z","end":"2026-02-08T21:38:46.02205Z","steps":["trace[53175067] 'process raft request' (duration: 454.5547ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:46.022176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:45.567119Z","time spent":"455.039539ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:38:46.022135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:45.567152Z","time spent":"454.934197ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T21:38:47.043279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.318764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-08T21:38:47.043348Z","caller":"traceutil/trace.go:171","msg":"trace[135239864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1026; }","duration":"851.440827ms","start":"2026-02-08T21:38:46.191893Z","end":"2026-02-08T21:38:47.043334Z","steps":["trace[135239864] 'range keys from in-memory index tree' (duration: 851.111281ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:47.043377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:46.191865Z","time spent":"851.504668ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-08T21:38:48.064164Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600017999085334,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-08T21:38:48.225718Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.177649067s","expected-duration":"1s"} {"level":"info","ts":"2026-02-08T21:38:48.226305Z","caller":"traceutil/trace.go:171","msg":"trace[1680798315] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"1.178283777s","start":"2026-02-08T21:38:47.047996Z","end":"2026-02-08T21:38:48.22628Z","steps":["trace[1680798315] 'process raft request' (duration: 1.177950312s)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:48.227244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:47.047981Z","time spent":"1.178430999s","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T21:38:48.420461Z","caller":"traceutil/trace.go:171","msg":"trace[1298101049] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"613.755742ms","start":"2026-02-08T21:38:47.806596Z","end":"2026-02-08T21:38:48.420352Z","steps":["trace[1298101049] 'process raft request' (duration: 544.539884ms)","trace[1298101049] 'compare' (duration: 68.876633ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:38:48.420596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:47.806567Z","time spent":"613.955135ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T21:38:48.446421Z","caller":"traceutil/trace.go:171","msg":"trace[1034698155] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1066; }","duration":"882.993999ms","start":"2026-02-08T21:38:47.56341Z","end":"2026-02-08T21:38:48.446404Z","steps":["trace[1034698155] 'read index received' (duration: 662.672197ms)","trace[1034698155] 'applied index is now lower than readState.Index' (duration: 220.320772ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T21:38:48.446627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.204532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-08T21:38:48.446665Z","caller":"traceutil/trace.go:171","msg":"trace[2047629055] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1028; }","duration":"883.280163ms","start":"2026-02-08T21:38:47.563374Z","end":"2026-02-08T21:38:48.446655Z","steps":["trace[2047629055] 'agreement among raft nodes before linearized reading' (duration: 883.14803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:48.446699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:47.56336Z","time spent":"883.328314ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-08T21:38:48.447041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.483419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-08T21:38:48.447091Z","caller":"traceutil/trace.go:171","msg":"trace[206707183] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1028; }","duration":"417.564ms","start":"2026-02-08T21:38:48.029511Z","end":"2026-02-08T21:38:48.447075Z","steps":["trace[206707183] 'agreement among raft nodes before linearized reading' (duration: 417.454959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:48.44714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:48.029493Z","time spent":"417.633571ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-08T21:38:48.447698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.069383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:5 size:1780"} {"level":"info","ts":"2026-02-08T21:38:48.447742Z","caller":"traceutil/trace.go:171","msg":"trace[2113094395] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:5; response_revision:1028; }","duration":"362.120394ms","start":"2026-02-08T21:38:48.085611Z","end":"2026-02-08T21:38:48.447732Z","steps":["trace[2113094395] 'agreement among raft nodes before linearized reading' (duration: 361.980062ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:48.447779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:48.085561Z","time spent":"362.208866ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":5,"response size":1803,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 "} {"level":"warn","ts":"2026-02-08T21:38:48.448144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.000817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-08T21:38:48.448253Z","caller":"traceutil/trace.go:171","msg":"trace[609245717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1028; }","duration":"418.128479ms","start":"2026-02-08T21:38:48.030112Z","end":"2026-02-08T21:38:48.44824Z","steps":["trace[609245717] 'agreement among raft nodes before linearized reading' (duration: 417.917086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:48.448732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:48.030109Z","time spent":"418.608577ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-08T21:38:48.449034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.927822ms","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-08T21:38:48.449114Z","caller":"traceutil/trace.go:171","msg":"trace[1820290237] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1028; }","duration":"419.020804ms","start":"2026-02-08T21:38:48.030086Z","end":"2026-02-08T21:38:48.449107Z","steps":["trace[1820290237] 'agreement among raft nodes before linearized reading' (duration: 418.855931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:48.449189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T21:38:48.03008Z","time spent":"419.102375ms","remote":"127.0.0.1:44142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-08T21:38:50.66443Z","caller":"traceutil/trace.go:171","msg":"trace[460235745] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"134.942853ms","start":"2026-02-08T21:38:50.529468Z","end":"2026-02-08T21:38:50.664411Z","steps":["trace[460235745] 'process raft request' (duration: 94.179913ms)","trace[460235745] 'compare' (duration: 40.415735ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T21:38:50.664582Z","caller":"traceutil/trace.go:171","msg":"trace[845702614] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"134.591238ms","start":"2026-02-08T21:38:50.529984Z","end":"2026-02-08T21:38:50.664575Z","steps":["trace[845702614] 'process raft request' (duration: 134.175281ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:38:50.664654Z","caller":"traceutil/trace.go:171","msg":"trace[1830160820] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"133.922597ms","start":"2026-02-08T21:38:50.530725Z","end":"2026-02-08T21:38:50.664648Z","steps":["trace[1830160820] 'process raft request' (duration: 133.46069ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:55.085126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.198725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:728"} {"level":"info","ts":"2026-02-08T21:38:55.085413Z","caller":"traceutil/trace.go:171","msg":"trace[461409261] range","detail":"{range_begin:/registry/clusterroles/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:1052; }","duration":"106.502169ms","start":"2026-02-08T21:38:54.978892Z","end":"2026-02-08T21:38:55.085394Z","steps":["trace[461409261] 'range keys from in-memory index tree' (duration: 106.129113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T21:38:55.085145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.87545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pv-protection-controller\" ","response":"range_response_count:1 size:693"} {"level":"info","ts":"2026-02-08T21:38:55.085615Z","caller":"traceutil/trace.go:171","msg":"trace[403628256] range","detail":"{range_begin:/registry/clusterroles/system:controller:pv-protection-controller; range_end:; response_count:1; response_revision:1052; }","duration":"142.370777ms","start":"2026-02-08T21:38:54.943225Z","end":"2026-02-08T21:38:55.085596Z","steps":["trace[403628256] 'range keys from in-memory index tree' (duration: 141.816379ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T21:39:05.970845Z","caller":"traceutil/trace.go:171","msg":"trace[889767191] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"134.647277ms","start":"2026-02-08T21:39:05.836179Z","end":"2026-02-08T21:39:05.970826Z","steps":["trace[889767191] 'process raft request' (duration: 134.476215ms)"],"step_count":1}