{"level":"warn","ts":"2026-05-18T00:36:15.962615Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-18T00:36:15.96273Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-05-18T00:36:15.962812Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-18T00:36:15.962827Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-18T00:36:15.962848Z","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-05-18T00:36:15.963727Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-05-18T00:36:15.963826Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-05-18T00:36:16.008072Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"29.291151ms"} {"level":"info","ts":"2026-05-18T00:36:16.155657Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-05-18T00:36:16.155801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-05-18T00:36:16.155905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-05-18T00:36:16.155966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-18T00:36:16.155987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-05-18T00:36:16.156067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-05-18T00:36:16.17886Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-18T00:36:16.180522Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-18T00:36:16.1818Z","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-05-18T00:36:16.184509Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-18T00:36:16.18546Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-18T00:36:16.185531Z","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-05-18T00:36:16.185733Z","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-05-18T00:36:16.185798Z","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-05-18T00:36:16.187769Z","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-05-18T00:36:16.187944Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-18T00:36:16.187976Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-18T00:36:16.188071Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-18T00:36:16.188087Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-18T00:36:16.188866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-05-18T00:36:16.189004Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-18T00:36:16.465869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-05-18T00:36:16.465941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-05-18T00:36:16.465963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-05-18T00:36:16.465995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-05-18T00:36:16.466017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-18T00:36:16.466033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-05-18T00:36:16.466046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-18T00:36:16.467244Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-05-18T00:36:16.467351Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-18T00:36:16.467535Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-18T00:36:16.46795Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-18T00:36:16.467975Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-18T00:36:16.468064Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-18T00:36:16.470693Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-18T00:36:16.47515Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-05-18T00:36:16.475176Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-05-18T00:36:16.475304Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-18T00:36:16.475511Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-18T00:36:21.614297Z","caller":"traceutil/trace.go:171","msg":"trace[1402506394] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:249; }","duration":"364.620272ms","start":"2026-05-18T00:36:21.24965Z","end":"2026-05-18T00:36:21.61427Z","steps":["trace[1402506394] 'read index received' (duration: 364.450018ms)","trace[1402506394] 'applied index is now lower than readState.Index' (duration: 169.224µs)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:36:21.614451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.782795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:36:21.614478Z","caller":"traceutil/trace.go:171","msg":"trace[1646487863] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"365.40608ms","start":"2026-05-18T00:36:21.24903Z","end":"2026-05-18T00:36:21.614437Z","steps":["trace[1646487863] 'process raft request' (duration: 365.082502ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:21.614547Z","caller":"traceutil/trace.go:171","msg":"trace[171586980] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:241; }","duration":"364.910158ms","start":"2026-05-18T00:36:21.249595Z","end":"2026-05-18T00:36:21.614505Z","steps":["trace[171586980] 'agreement among raft nodes before linearized reading' (duration: 364.786035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:21.614587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:21.249538Z","time spent":"365.039172ms","remote":"127.0.0.1:48968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-18T00:36:21.615147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:21.249002Z","time spent":"365.565714ms","remote":"127.0.0.1:48912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":170,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-18T00:36:21.884436Z","caller":"traceutil/trace.go:171","msg":"trace[332571854] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:252; }","duration":"232.992519ms","start":"2026-05-18T00:36:21.651419Z","end":"2026-05-18T00:36:21.884411Z","steps":["trace[332571854] 'read index received' (duration: 163.828461ms)","trace[332571854] 'applied index is now lower than readState.Index' (duration: 69.163038ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:36:21.884553Z","caller":"traceutil/trace.go:171","msg":"trace[53618227] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"240.390691ms","start":"2026-05-18T00:36:21.644136Z","end":"2026-05-18T00:36:21.884527Z","steps":["trace[53618227] 'process raft request' (duration: 171.049059ms)","trace[53618227] 'compare' (duration: 69.068445ms)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:36:21.884727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.284496ms","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-05-18T00:36:21.884812Z","caller":"traceutil/trace.go:171","msg":"trace[1128079551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:244; }","duration":"233.408478ms","start":"2026-05-18T00:36:21.651383Z","end":"2026-05-18T00:36:21.884791Z","steps":["trace[1128079551] 'agreement among raft nodes before linearized reading' (duration: 233.202983ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:21.968153Z","caller":"traceutil/trace.go:171","msg":"trace[1685616104] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"316.088431ms","start":"2026-05-18T00:36:21.652038Z","end":"2026-05-18T00:36:21.968126Z","steps":["trace[1685616104] 'process raft request' (duration: 315.833216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:21.968448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:21.652018Z","time spent":"316.202195ms","remote":"127.0.0.1:48792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-18T00:36:21.968452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.916071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:36:21.969337Z","caller":"traceutil/trace.go:171","msg":"trace[817313632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:245; }","duration":"317.801722ms","start":"2026-05-18T00:36:21.651503Z","end":"2026-05-18T00:36:21.969305Z","steps":["trace[817313632] 'agreement among raft nodes before linearized reading' (duration: 316.734747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:21.969422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:21.651497Z","time spent":"317.900384ms","remote":"127.0.0.1:48732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-18T00:36:45.25505Z","caller":"traceutil/trace.go:171","msg":"trace[1629681039] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"120.181288ms","start":"2026-05-18T00:36:45.134844Z","end":"2026-05-18T00:36:45.255025Z","steps":["trace[1629681039] 'process raft request' (duration: 56.620743ms)","trace[1629681039] 'compare' (duration: 63.450993ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:36:45.260585Z","caller":"traceutil/trace.go:171","msg":"trace[1555980199] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"123.069816ms","start":"2026-05-18T00:36:45.137496Z","end":"2026-05-18T00:36:45.260566Z","steps":["trace[1555980199] 'process raft request' (duration: 122.975713ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.260764Z","caller":"traceutil/trace.go:171","msg":"trace[1571493386] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"120.503776ms","start":"2026-05-18T00:36:45.140235Z","end":"2026-05-18T00:36:45.260739Z","steps":["trace[1571493386] 'process raft request' (duration: 120.284411ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.26117Z","caller":"traceutil/trace.go:171","msg":"trace[839211834] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"123.163808ms","start":"2026-05-18T00:36:45.137445Z","end":"2026-05-18T00:36:45.260609Z","steps":["trace[839211834] 'process raft request' (duration: 122.941463ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.261252Z","caller":"traceutil/trace.go:171","msg":"trace[1632569626] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"119.128623ms","start":"2026-05-18T00:36:45.142112Z","end":"2026-05-18T00:36:45.261241Z","steps":["trace[1632569626] 'process raft request' (duration: 118.429717ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.261765Z","caller":"traceutil/trace.go:171","msg":"trace[1077139172] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"119.110462ms","start":"2026-05-18T00:36:45.142645Z","end":"2026-05-18T00:36:45.261755Z","steps":["trace[1077139172] 'process raft request' (duration: 118.471418ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.26183Z","caller":"traceutil/trace.go:171","msg":"trace[986773739] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"118.213772ms","start":"2026-05-18T00:36:45.143589Z","end":"2026-05-18T00:36:45.261802Z","steps":["trace[986773739] 'process raft request' (duration: 118.076958ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.262224Z","caller":"traceutil/trace.go:171","msg":"trace[1580921583] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"118.427217ms","start":"2026-05-18T00:36:45.143774Z","end":"2026-05-18T00:36:45.262201Z","steps":["trace[1580921583] 'process raft request' (duration: 117.922085ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.262733Z","caller":"traceutil/trace.go:171","msg":"trace[693207952] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"118.826836ms","start":"2026-05-18T00:36:45.143898Z","end":"2026-05-18T00:36:45.262725Z","steps":["trace[693207952] 'process raft request' (duration: 118.677853ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.263834Z","caller":"traceutil/trace.go:171","msg":"trace[1161189643] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"118.793526ms","start":"2026-05-18T00:36:45.145029Z","end":"2026-05-18T00:36:45.263823Z","steps":["trace[1161189643] 'process raft request' (duration: 118.496109ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.263969Z","caller":"traceutil/trace.go:171","msg":"trace[1719939767] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"109.673452ms","start":"2026-05-18T00:36:45.154288Z","end":"2026-05-18T00:36:45.263961Z","steps":["trace[1719939767] 'process raft request' (duration: 109.323524ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:45.264871Z","caller":"traceutil/trace.go:171","msg":"trace[1464899373] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"106.248622ms","start":"2026-05-18T00:36:45.15857Z","end":"2026-05-18T00:36:45.264818Z","steps":["trace[1464899373] 'process raft request' (duration: 105.083705ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:51.17949Z","caller":"traceutil/trace.go:171","msg":"trace[1479597945] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"134.573484ms","start":"2026-05-18T00:36:51.044894Z","end":"2026-05-18T00:36:51.179468Z","steps":["trace[1479597945] 'read index received' (duration: 133.791596ms)","trace[1479597945] 'applied index is now lower than readState.Index' (duration: 781.088µs)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:36:51.179692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.780109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-shn2q\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-18T00:36:51.17973Z","caller":"traceutil/trace.go:171","msg":"trace[732325533] range","detail":"{range_begin:/registry/pods/kube-system/cilium-shn2q; range_end:; response_count:1; response_revision:574; }","duration":"134.856241ms","start":"2026-05-18T00:36:51.04486Z","end":"2026-05-18T00:36:51.179716Z","steps":["trace[732325533] 'agreement among raft nodes before linearized reading' (duration: 134.716498ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:51.17999Z","caller":"traceutil/trace.go:171","msg":"trace[1115971407] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"180.18864ms","start":"2026-05-18T00:36:50.999791Z","end":"2026-05-18T00:36:51.179979Z","steps":["trace[1115971407] 'process raft request' (duration: 179.157896ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:51.305489Z","caller":"traceutil/trace.go:171","msg":"trace[1006541415] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"106.949568ms","start":"2026-05-18T00:36:51.198009Z","end":"2026-05-18T00:36:51.304958Z","steps":["trace[1006541415] 'process raft request' (duration: 106.697993ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:51.722891Z","caller":"traceutil/trace.go:171","msg":"trace[845432724] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"417.507275ms","start":"2026-05-18T00:36:51.305357Z","end":"2026-05-18T00:36:51.722865Z","steps":["trace[845432724] 'read index received' (duration: 409.111279ms)","trace[845432724] 'applied index is now lower than readState.Index' (duration: 8.394766ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:36:51.722949Z","caller":"traceutil/trace.go:171","msg":"trace[1499659439] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"495.56213ms","start":"2026-05-18T00:36:51.227363Z","end":"2026-05-18T00:36:51.722925Z","steps":["trace[1499659439] 'process raft request' (duration: 487.152293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:51.723136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.765462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-18T00:36:51.723178Z","caller":"traceutil/trace.go:171","msg":"trace[1234389873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"417.860973ms","start":"2026-05-18T00:36:51.305305Z","end":"2026-05-18T00:36:51.723166Z","steps":["trace[1234389873] 'agreement among raft nodes before linearized reading' (duration: 417.666919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:51.723217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:51.305284Z","time spent":"417.924895ms","remote":"127.0.0.1:48968","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-05-18T00:36:51.723219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:51.227333Z","time spent":"495.761293ms","remote":"127.0.0.1:49208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-18T00:36:52.368288Z","caller":"traceutil/trace.go:171","msg":"trace[762057000] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"592.685949ms","start":"2026-05-18T00:36:51.775581Z","end":"2026-05-18T00:36:52.368267Z","steps":["trace[762057000] 'process raft request' (duration: 592.577416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:52.36856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:51.775558Z","time spent":"592.784002ms","remote":"127.0.0.1:48890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4538,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:36:52.379225Z","caller":"traceutil/trace.go:171","msg":"trace[1602451015] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"593.484667ms","start":"2026-05-18T00:36:51.785714Z","end":"2026-05-18T00:36:52.379199Z","steps":["trace[1602451015] 'process raft request' (duration: 593.005946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:52.379383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:51.785696Z","time spent":"593.601541ms","remote":"127.0.0.1:48968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:36:52.385077Z","caller":"traceutil/trace.go:171","msg":"trace[1670553506] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"450.376194ms","start":"2026-05-18T00:36:51.934656Z","end":"2026-05-18T00:36:52.385032Z","steps":["trace[1670553506] 'read index received' (duration: 433.649433ms)","trace[1670553506] 'applied index is now lower than readState.Index' (duration: 16.725831ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:36:52.385582Z","caller":"traceutil/trace.go:171","msg":"trace[513875512] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"273.257985ms","start":"2026-05-18T00:36:52.112305Z","end":"2026-05-18T00:36:52.385563Z","steps":["trace[513875512] 'process raft request' (duration: 267.859169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:52.385599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.915416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-18T00:36:52.385772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.841076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-18T00:36:52.385799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.001169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-18T00:36:52.385822Z","caller":"traceutil/trace.go:171","msg":"trace[954789444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"263.902357ms","start":"2026-05-18T00:36:52.121905Z","end":"2026-05-18T00:36:52.385807Z","steps":["trace[954789444] 'agreement among raft nodes before linearized reading' (duration: 263.758843ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:52.385828Z","caller":"traceutil/trace.go:171","msg":"trace[1529345674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"264.05603ms","start":"2026-05-18T00:36:52.121762Z","end":"2026-05-18T00:36:52.385819Z","steps":["trace[1529345674] 'agreement among raft nodes before linearized reading' (duration: 263.970418ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:36:52.38588Z","caller":"traceutil/trace.go:171","msg":"trace[1694900783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"451.163082ms","start":"2026-05-18T00:36:51.934625Z","end":"2026-05-18T00:36:52.385788Z","steps":["trace[1694900783] 'agreement among raft nodes before linearized reading' (duration: 450.879376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:36:52.386055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.825571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-05-18T00:36:52.386054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:36:51.934612Z","time spent":"451.426418ms","remote":"127.0.0.1:48732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-18T00:36:52.38613Z","caller":"traceutil/trace.go:171","msg":"trace[770445843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"238.921643ms","start":"2026-05-18T00:36:52.147193Z","end":"2026-05-18T00:36:52.386115Z","steps":["trace[770445843] 'agreement among raft nodes before linearized reading' (duration: 238.462682ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:37:07.890045Z","caller":"traceutil/trace.go:171","msg":"trace[1935095235] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"203.736291ms","start":"2026-05-18T00:37:07.68628Z","end":"2026-05-18T00:37:07.890016Z","steps":["trace[1935095235] 'process raft request' (duration: 203.531216ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:37:22.650604Z","caller":"traceutil/trace.go:171","msg":"trace[1252402493] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"103.626351ms","start":"2026-05-18T00:37:22.546926Z","end":"2026-05-18T00:37:22.650552Z","steps":["trace[1252402493] 'process raft request' (duration: 80.113522ms)","trace[1252402493] 'compare' (duration: 23.322675ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:37:35.679377Z","caller":"traceutil/trace.go:171","msg":"trace[1747606421] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"111.306992ms","start":"2026-05-18T00:37:35.568055Z","end":"2026-05-18T00:37:35.679363Z","steps":["trace[1747606421] 'process raft request' (duration: 111.183989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:38:04.43491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.503855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-18T00:38:04.435038Z","caller":"traceutil/trace.go:171","msg":"trace[1967349848] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1028; }","duration":"128.655029ms","start":"2026-05-18T00:38:04.30636Z","end":"2026-05-18T00:38:04.435015Z","steps":["trace[1967349848] 'count revisions from in-memory index tree' (duration: 128.374113ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:06.379578Z","caller":"traceutil/trace.go:171","msg":"trace[861192418] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"173.412379ms","start":"2026-05-18T00:38:06.206139Z","end":"2026-05-18T00:38:06.379551Z","steps":["trace[861192418] 'process raft request' (duration: 123.929728ms)","trace[861192418] 'compare' (duration: 49.379869ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:38:18.545068Z","caller":"traceutil/trace.go:171","msg":"trace[2000270633] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"296.197761ms","start":"2026-05-18T00:38:18.248828Z","end":"2026-05-18T00:38:18.545026Z","steps":["trace[2000270633] 'process raft request' (duration: 295.629618ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:18.827497Z","caller":"traceutil/trace.go:171","msg":"trace[500679547] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"278.171509ms","start":"2026-05-18T00:38:18.549294Z","end":"2026-05-18T00:38:18.827465Z","steps":["trace[500679547] 'process raft request' (duration: 267.396886ms)","trace[500679547] 'compare' (duration: 10.313852ms)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:38:35.171226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.644149ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-18T00:38:35.171304Z","caller":"traceutil/trace.go:171","msg":"trace[418183495] linearizableReadLoop","detail":"{readStateIndex:1238; appliedIndex:1237; }","duration":"284.108717ms","start":"2026-05-18T00:38:34.887185Z","end":"2026-05-18T00:38:35.171293Z","steps":["trace[418183495] 'read index received' (duration: 106.205512ms)","trace[418183495] 'applied index is now lower than readState.Index' (duration: 177.902445ms)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:38:35.171428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.246751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-18T00:38:35.171511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.575992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:38:35.171594Z","caller":"traceutil/trace.go:171","msg":"trace[1800299308] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1195; }","duration":"236.711065ms","start":"2026-05-18T00:38:34.934865Z","end":"2026-05-18T00:38:35.171576Z","steps":["trace[1800299308] 'agreement among raft nodes before linearized reading' (duration: 236.561281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:38:35.171608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.056765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-18T00:38:35.171703Z","caller":"traceutil/trace.go:171","msg":"trace[295370010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1195; }","duration":"102.151337ms","start":"2026-05-18T00:38:35.069514Z","end":"2026-05-18T00:38:35.171665Z","steps":["trace[295370010] 'agreement among raft nodes before linearized reading' (duration: 101.940502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:38:35.171709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.28451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-18T00:38:35.171802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.448024ms","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-05-18T00:38:35.171796Z","caller":"traceutil/trace.go:171","msg":"trace[497256883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1195; }","duration":"105.397504ms","start":"2026-05-18T00:38:35.066381Z","end":"2026-05-18T00:38:35.171778Z","steps":["trace[497256883] 'agreement among raft nodes before linearized reading' (duration: 105.117957ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:35.171828Z","caller":"traceutil/trace.go:171","msg":"trace[1600836042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1195; }","duration":"105.472445ms","start":"2026-05-18T00:38:35.066348Z","end":"2026-05-18T00:38:35.171821Z","steps":["trace[1600836042] 'agreement among raft nodes before linearized reading' (duration: 105.420503ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:35.171444Z","caller":"traceutil/trace.go:171","msg":"trace[252996627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1195; }","duration":"284.312073ms","start":"2026-05-18T00:38:34.887127Z","end":"2026-05-18T00:38:35.171439Z","steps":["trace[252996627] 'agreement among raft nodes before linearized reading' (duration: 284.222341ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:35.342338Z","caller":"traceutil/trace.go:171","msg":"trace[268692653] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"165.019823ms","start":"2026-05-18T00:38:35.177295Z","end":"2026-05-18T00:38:35.342315Z","steps":["trace[268692653] 'process raft request' (duration: 164.843049ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:35.367298Z","caller":"traceutil/trace.go:171","msg":"trace[1271399993] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"189.378165ms","start":"2026-05-18T00:38:35.177898Z","end":"2026-05-18T00:38:35.367277Z","steps":["trace[1271399993] 'process raft request' (duration: 189.216511ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:35.367307Z","caller":"traceutil/trace.go:171","msg":"trace[1081427420] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"189.303923ms","start":"2026-05-18T00:38:35.177988Z","end":"2026-05-18T00:38:35.367292Z","steps":["trace[1081427420] 'process raft request' (duration: 189.238242ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:35.367579Z","caller":"traceutil/trace.go:171","msg":"trace[1931437131] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"188.053304ms","start":"2026-05-18T00:38:35.179512Z","end":"2026-05-18T00:38:35.367565Z","steps":["trace[1931437131] 'process raft request' (duration: 187.748336ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:35.367572Z","caller":"traceutil/trace.go:171","msg":"trace[1436911416] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"186.164709ms","start":"2026-05-18T00:38:35.181384Z","end":"2026-05-18T00:38:35.367548Z","steps":["trace[1436911416] 'process raft request' (duration: 186.062457ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:36.626097Z","caller":"traceutil/trace.go:171","msg":"trace[350494424] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"171.035633ms","start":"2026-05-18T00:38:36.455024Z","end":"2026-05-18T00:38:36.62606Z","steps":["trace[350494424] 'process raft request' (duration: 170.822128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:38:36.912505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.511813ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-18T00:38:36.912579Z","caller":"traceutil/trace.go:171","msg":"trace[1624624795] linearizableReadLoop","detail":"{readStateIndex:1247; appliedIndex:1246; }","duration":"175.203581ms","start":"2026-05-18T00:38:36.737363Z","end":"2026-05-18T00:38:36.912566Z","steps":["trace[1624624795] 'read index received' (duration: 39.071µs)","trace[1624624795] 'applied index is now lower than readState.Index' (duration: 175.16385ms)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:38:36.912658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.300053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:38:36.912676Z","caller":"traceutil/trace.go:171","msg":"trace[1271254894] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1204; }","duration":"175.357945ms","start":"2026-05-18T00:38:36.737311Z","end":"2026-05-18T00:38:36.912669Z","steps":["trace[1271254894] 'agreement among raft nodes before linearized reading' (duration: 175.286413ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:38:36.91293Z","caller":"traceutil/trace.go:171","msg":"trace[1584256597] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"282.610112ms","start":"2026-05-18T00:38:36.630213Z","end":"2026-05-18T00:38:36.912823Z","steps":["trace[1584256597] 'process raft request' (duration: 99.71669ms)","trace[1584256597] 'compare' (duration: 182.423221ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:41:58.600547Z","caller":"traceutil/trace.go:171","msg":"trace[1000242462] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2276; }","duration":"142.18447ms","start":"2026-05-18T00:41:58.45834Z","end":"2026-05-18T00:41:58.600525Z","steps":["trace[1000242462] 'read index received' (duration: 126.356078ms)","trace[1000242462] 'applied index is now lower than readState.Index' (duration: 15.827762ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:41:58.600683Z","caller":"traceutil/trace.go:171","msg":"trace[1595912429] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"256.792732ms","start":"2026-05-18T00:41:58.343868Z","end":"2026-05-18T00:41:58.600661Z","steps":["trace[1595912429] 'process raft request' (duration: 240.917409ms)","trace[1595912429] 'compare' (duration: 15.637617ms)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:41:58.600886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.19684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-18T00:41:58.600924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.573158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-18T00:41:58.600965Z","caller":"traceutil/trace.go:171","msg":"trace[2059597264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2193; }","duration":"142.310363ms","start":"2026-05-18T00:41:58.458646Z","end":"2026-05-18T00:41:58.600956Z","steps":["trace[2059597264] 'agreement among raft nodes before linearized reading' (duration: 142.086908ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:41:58.601005Z","caller":"traceutil/trace.go:171","msg":"trace[1790798673] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2193; }","duration":"142.661671ms","start":"2026-05-18T00:41:58.458324Z","end":"2026-05-18T00:41:58.600986Z","steps":["trace[1790798673] 'agreement among raft nodes before linearized reading' (duration: 142.357483ms)"],"step_count":1}