{"level":"warn","ts":"2026-02-05T22:08:34.394959Z","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-05T22:08:34.395153Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43: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-05T22:08:34.395293Z","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-05T22:08:34.395354Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-02-05T22:08:34.395415Z","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-05T22:08:34.396092Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]} {"level":"info","ts":"2026-02-05T22:08:34.396247Z","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.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43: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-05T22:08:34.400435Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.820812ms"} {"level":"info","ts":"2026-02-05T22:08:34.433459Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"} {"level":"info","ts":"2026-02-05T22:08:34.433588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"} {"level":"info","ts":"2026-02-05T22:08:34.433655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"} {"level":"info","ts":"2026-02-05T22:08:34.433713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-05T22:08:34.433768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"} {"level":"info","ts":"2026-02-05T22:08:34.433848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"warn","ts":"2026-02-05T22:08:34.45201Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-05T22:08:34.45483Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-05T22:08:34.457924Z","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-05T22:08:34.461641Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-05T22:08:34.47119Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-05T22:08:34.472901Z","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-05T22:08:34.472982Z","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-05T22:08:34.473033Z","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-05T22:08:34.47326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"info","ts":"2026-02-05T22:08:34.473947Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-02-05T22:08:34.474759Z","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-05T22:08:34.477187Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-02-05T22:08:34.478679Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-02-05T22:08:34.478868Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-05T22:08:34.481486Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-05T22:08:34.835778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"} {"level":"info","ts":"2026-02-05T22:08:34.835819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"} {"level":"info","ts":"2026-02-05T22:08:34.835833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"} {"level":"info","ts":"2026-02-05T22:08:34.835844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"} {"level":"info","ts":"2026-02-05T22:08:34.83585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-02-05T22:08:34.835858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"} {"level":"info","ts":"2026-02-05T22:08:34.835954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-02-05T22:08:34.853555Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"} {"level":"info","ts":"2026-02-05T22:08:34.853579Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T22:08:34.853734Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T22:08:34.854074Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T22:08:34.858116Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-05T22:08:34.865351Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"} {"level":"info","ts":"2026-02-05T22:08:34.865417Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T22:08:34.86547Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T22:08:34.865485Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T22:08:34.867928Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-05T22:08:34.867943Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-05T22:08:41.233459Z","caller":"traceutil/trace.go:171","msg":"trace[482278373] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"125.050279ms","start":"2026-02-05T22:08:41.108393Z","end":"2026-02-05T22:08:41.233443Z","steps":["trace[482278373] 'process raft request' (duration: 112.390458ms)","trace[482278373] 'compare' (duration: 12.533337ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:08:41.233698Z","caller":"traceutil/trace.go:171","msg":"trace[1359389436] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:307; }","duration":"122.908053ms","start":"2026-02-05T22:08:41.110783Z","end":"2026-02-05T22:08:41.233691Z","steps":["trace[1359389436] 'read index received' (duration: 110.007127ms)","trace[1359389436] 'applied index is now lower than readState.Index' (duration: 12.900116ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:08:41.233504Z","caller":"traceutil/trace.go:171","msg":"trace[1697430775] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"122.672857ms","start":"2026-02-05T22:08:41.110815Z","end":"2026-02-05T22:08:41.233487Z","steps":["trace[1697430775] 'process raft request' (duration: 122.554625ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:41.234249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.830275ms","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-05T22:08:41.234302Z","caller":"traceutil/trace.go:171","msg":"trace[1042589431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:302; }","duration":"110.907077ms","start":"2026-02-05T22:08:41.123383Z","end":"2026-02-05T22:08:41.23429Z","steps":["trace[1042589431] 'agreement among raft nodes before linearized reading' (duration: 110.808785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:41.236396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.889495ms","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-05T22:08:41.236441Z","caller":"traceutil/trace.go:171","msg":"trace[77936659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:302; }","duration":"109.954217ms","start":"2026-02-05T22:08:41.126475Z","end":"2026-02-05T22:08:41.23643Z","steps":["trace[77936659] 'agreement among raft nodes before linearized reading' (duration: 109.888926ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:41.236578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.782224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-05T22:08:41.236819Z","caller":"traceutil/trace.go:171","msg":"trace[1841578300] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:302; }","duration":"126.0623ms","start":"2026-02-05T22:08:41.110745Z","end":"2026-02-05T22:08:41.236808Z","steps":["trace[1841578300] 'agreement among raft nodes before linearized reading' (duration: 123.034966ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T22:08:42.106968Z","caller":"traceutil/trace.go:171","msg":"trace[935296697] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"100.146565ms","start":"2026-02-05T22:08:42.006798Z","end":"2026-02-05T22:08:42.106944Z","steps":["trace[935296697] 'process raft request' (duration: 48.529175ms)","trace[935296697] 'compare' (duration: 51.325403ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:08:42.431995Z","caller":"traceutil/trace.go:171","msg":"trace[807798434] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:326; }","duration":"210.912946ms","start":"2026-02-05T22:08:42.221043Z","end":"2026-02-05T22:08:42.431956Z","steps":["trace[807798434] 'read index received' (duration: 210.702732ms)","trace[807798434] 'applied index is now lower than readState.Index' (duration: 209.184µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:08:42.43212Z","caller":"traceutil/trace.go:171","msg":"trace[2118418813] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"214.302598ms","start":"2026-02-05T22:08:42.217806Z","end":"2026-02-05T22:08:42.432108Z","steps":["trace[2118418813] 'process raft request' (duration: 213.994962ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:42.432206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.337172ms","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-05T22:08:42.432251Z","caller":"traceutil/trace.go:171","msg":"trace[2066909538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:320; }","duration":"110.406843ms","start":"2026-02-05T22:08:42.321832Z","end":"2026-02-05T22:08:42.432239Z","steps":["trace[2066909538] 'agreement among raft nodes before linearized reading' (duration: 110.332842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:42.432376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.333437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-05T22:08:42.43239Z","caller":"traceutil/trace.go:171","msg":"trace[199055408] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:320; }","duration":"211.362377ms","start":"2026-02-05T22:08:42.221023Z","end":"2026-02-05T22:08:42.432385Z","steps":["trace[199055408] 'agreement among raft nodes before linearized reading' (duration: 211.328017ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:54.132483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.393129ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-02-05T22:08:55.560588Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.004965693s","expected-duration":"1s"} {"level":"info","ts":"2026-02-05T22:08:55.561265Z","caller":"traceutil/trace.go:171","msg":"trace[353771109] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:466; }","duration":"219.146877ms","start":"2026-02-05T22:08:55.34209Z","end":"2026-02-05T22:08:55.561237Z","steps":["trace[353771109] 'read index received' (duration: 218.601266ms)","trace[353771109] 'applied index is now lower than readState.Index' (duration: 544.551µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:08:55.562288Z","caller":"traceutil/trace.go:171","msg":"trace[786591628] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"1.006722399s","start":"2026-02-05T22:08:54.555554Z","end":"2026-02-05T22:08:55.562277Z","steps":["trace[786591628] 'process raft request' (duration: 1.005178917s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:55.563656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:08:54.555545Z","time spent":"1.00676946s","remote":"127.0.0.1:53620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T22:08:55.564461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.368975ms","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-02-05T22:08:55.564495Z","caller":"traceutil/trace.go:171","msg":"trace[1000460141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:456; }","duration":"222.429847ms","start":"2026-02-05T22:08:55.342052Z","end":"2026-02-05T22:08:55.564482Z","steps":["trace[1000460141] 'agreement among raft nodes before linearized reading' (duration: 222.376366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:55.564711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.52862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-05T22:08:55.564743Z","caller":"traceutil/trace.go:171","msg":"trace[1562269458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:456; }","duration":"214.600661ms","start":"2026-02-05T22:08:55.35013Z","end":"2026-02-05T22:08:55.56473Z","steps":["trace[1562269458] 'agreement among raft nodes before linearized reading' (duration: 214.472338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:08:55.568221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.461518ms","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-05T22:08:55.568254Z","caller":"traceutil/trace.go:171","msg":"trace[1256505723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:456; }","duration":"205.52637ms","start":"2026-02-05T22:08:55.362719Z","end":"2026-02-05T22:08:55.568245Z","steps":["trace[1256505723] 'agreement among raft nodes before linearized reading' (duration: 205.463789ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T22:09:05.590634Z","caller":"traceutil/trace.go:171","msg":"trace[508173815] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"392.298608ms","start":"2026-02-05T22:09:05.198319Z","end":"2026-02-05T22:09:05.590617Z","steps":["trace[508173815] 'process raft request' (duration: 392.170285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:05.590748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:05.198307Z","time spent":"392.38632ms","remote":"127.0.0.1:53532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4210,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T22:09:13.709126Z","caller":"traceutil/trace.go:171","msg":"trace[55345233] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"643.801967ms","start":"2026-02-05T22:09:13.065311Z","end":"2026-02-05T22:09:13.709113Z","steps":["trace[55345233] 'process raft request' (duration: 643.699874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:13.709209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:13.06529Z","time spent":"643.875949ms","remote":"127.0.0.1:53538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T22:09:14.260823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.984815ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-05T22:09:14.26092Z","caller":"traceutil/trace.go:171","msg":"trace[361473146] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"603.065088ms","start":"2026-02-05T22:09:13.657843Z","end":"2026-02-05T22:09:14.260909Z","steps":["trace[361473146] 'read index received' (duration: 51.603404ms)","trace[361473146] 'applied index is now lower than readState.Index' (duration: 551.460814ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T22:09:14.261056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.205791ms","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-05T22:09:14.261073Z","caller":"traceutil/trace.go:171","msg":"trace[852977760] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"603.251503ms","start":"2026-02-05T22:09:13.657816Z","end":"2026-02-05T22:09:14.261068Z","steps":["trace[852977760] 'agreement among raft nodes before linearized reading' (duration: 603.159681ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:14.261089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:13.657804Z","time spent":"603.281823ms","remote":"127.0.0.1:53620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-05T22:09:14.261293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.317361ms","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-05T22:09:14.261314Z","caller":"traceutil/trace.go:171","msg":"trace[1097312984] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:558; }","duration":"552.360343ms","start":"2026-02-05T22:09:13.708949Z","end":"2026-02-05T22:09:14.261309Z","steps":["trace[1097312984] 'agreement among raft nodes before linearized reading' (duration: 552.315312ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:14.261326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:13.708935Z","time spent":"552.387863ms","remote":"127.0.0.1:53620","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":"warn","ts":"2026-02-05T22:09:14.261458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.81166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-05T22:09:14.261474Z","caller":"traceutil/trace.go:171","msg":"trace[1773833488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:558; }","duration":"288.83467ms","start":"2026-02-05T22:09:13.972636Z","end":"2026-02-05T22:09:14.26147Z","steps":["trace[1773833488] 'agreement among raft nodes before linearized reading' (duration: 288.793699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:14.261548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.918703ms","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-02-05T22:09:14.261564Z","caller":"traceutil/trace.go:171","msg":"trace[1582187359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"288.971104ms","start":"2026-02-05T22:09:13.972589Z","end":"2026-02-05T22:09:14.26156Z","steps":["trace[1582187359] 'agreement among raft nodes before linearized reading' (duration: 288.930973ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T22:09:14.439504Z","caller":"traceutil/trace.go:171","msg":"trace[867168483] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"175.006879ms","start":"2026-02-05T22:09:14.264481Z","end":"2026-02-05T22:09:14.439488Z","steps":["trace[867168483] 'process raft request' (duration: 174.907797ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:16.277785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.926754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T22:09:16.277932Z","caller":"traceutil/trace.go:171","msg":"trace[1694376267] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:574; }","duration":"1.051181411s","start":"2026-02-05T22:09:15.226738Z","end":"2026-02-05T22:09:16.27792Z","steps":["trace[1694376267] 'read index received' (duration: 168.014492ms)","trace[1694376267] 'applied index is now lower than readState.Index' (duration: 883.166339ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T22:09:16.278014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.051286863s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T22:09:16.278028Z","caller":"traceutil/trace.go:171","msg":"trace[975932460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:562; }","duration":"1.051343514s","start":"2026-02-05T22:09:15.226679Z","end":"2026-02-05T22:09:16.278022Z","steps":["trace[975932460] 'agreement among raft nodes before linearized reading' (duration: 1.051273653s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:16.278045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:15.226653Z","time spent":"1.051387065s","remote":"127.0.0.1:53352","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-02-05T22:09:16.27802Z","caller":"traceutil/trace.go:171","msg":"trace[922550782] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"2.011081258s","start":"2026-02-05T22:09:14.266908Z","end":"2026-02-05T22:09:16.277989Z","steps":["trace[922550782] 'process raft request' (duration: 1.127900559s)","trace[922550782] 'compare' (duration: 882.668829ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:09:16.278144Z","caller":"traceutil/trace.go:171","msg":"trace[531876444] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"2.01115762s","start":"2026-02-05T22:09:14.266981Z","end":"2026-02-05T22:09:16.278139Z","steps":["trace[531876444] 'process raft request' (duration: 2.010864573s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:16.278149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:14.26689Z","time spent":"2.01118946s","remote":"127.0.0.1:53620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T22:09:16.278175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:14.266977Z","time spent":"2.01118404s","remote":"127.0.0.1:53620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T22:09:16.278239Z","caller":"traceutil/trace.go:171","msg":"trace[2109489006] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"2.007265808s","start":"2026-02-05T22:09:14.270969Z","end":"2026-02-05T22:09:16.278234Z","steps":["trace[2109489006] 'process raft request' (duration: 2.006928131s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:16.278262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:14.270961Z","time spent":"2.007287138s","remote":"127.0.0.1:53620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T22:09:18.504342Z","caller":"traceutil/trace.go:171","msg":"trace[1559096965] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"212.080254ms","start":"2026-02-05T22:09:18.292239Z","end":"2026-02-05T22:09:18.50432Z","steps":["trace[1559096965] 'process raft request' (duration: 197.60244ms)","trace[1559096965] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/plndr-svcs-lock; req_size:420; } (duration: 11.024021ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:09:18.504457Z","caller":"traceutil/trace.go:171","msg":"trace[1838380427] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"206.592818ms","start":"2026-02-05T22:09:18.297854Z","end":"2026-02-05T22:09:18.504447Z","steps":["trace[1838380427] 'process raft request' (duration: 205.871103ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T22:09:19.613765Z","caller":"traceutil/trace.go:171","msg":"trace[151099497] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"294.35334ms","start":"2026-02-05T22:09:19.319389Z","end":"2026-02-05T22:09:19.613742Z","steps":["trace[151099497] 'read index received' (duration: 294.022883ms)","trace[151099497] 'applied index is now lower than readState.Index' (duration: 329.187µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:09:19.613865Z","caller":"traceutil/trace.go:171","msg":"trace[444706715] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"297.371333ms","start":"2026-02-05T22:09:19.316485Z","end":"2026-02-05T22:09:19.613857Z","steps":["trace[444706715] 'process raft request' (duration: 296.590517ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:19.618094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.657671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T22:09:19.61833Z","caller":"traceutil/trace.go:171","msg":"trace[849962553] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:593; }","duration":"298.880986ms","start":"2026-02-05T22:09:19.31937Z","end":"2026-02-05T22:09:19.618251Z","steps":["trace[849962553] 'agreement among raft nodes before linearized reading' (duration: 294.627986ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T22:09:19.620181Z","caller":"traceutil/trace.go:171","msg":"trace[781915646] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"246.358822ms","start":"2026-02-05T22:09:19.373809Z","end":"2026-02-05T22:09:19.620167Z","steps":["trace[781915646] 'process raft request' (duration: 246.091847ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:19.624783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.987339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T22:09:19.624824Z","caller":"traceutil/trace.go:171","msg":"trace[1763383970] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:595; }","duration":"301.05442ms","start":"2026-02-05T22:09:19.32376Z","end":"2026-02-05T22:09:19.624815Z","steps":["trace[1763383970] 'agreement among raft nodes before linearized reading' (duration: 300.955218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:19.624941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:19.323756Z","time spent":"301.088451ms","remote":"127.0.0.1:53392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-02-05T22:09:19.62568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.336278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T22:09:19.625715Z","caller":"traceutil/trace.go:171","msg":"trace[1216804137] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:595; }","duration":"302.380119ms","start":"2026-02-05T22:09:19.323325Z","end":"2026-02-05T22:09:19.625705Z","steps":["trace[1216804137] 'agreement among raft nodes before linearized reading' (duration: 296.665289ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:19.626064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:19.32332Z","time spent":"302.669305ms","remote":"127.0.0.1:53392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-02-05T22:09:19.62619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.832159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T22:09:19.626228Z","caller":"traceutil/trace.go:171","msg":"trace[86444736] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:595; }","duration":"302.878331ms","start":"2026-02-05T22:09:19.323345Z","end":"2026-02-05T22:09:19.626223Z","steps":["trace[86444736] 'agreement among raft nodes before linearized reading' (duration: 302.828359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:19.626327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T22:09:19.323342Z","time spent":"302.979903ms","remote":"127.0.0.1:53392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-02-05T22:09:29.404771Z","caller":"traceutil/trace.go:171","msg":"trace[1090066964] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"154.757156ms","start":"2026-02-05T22:09:29.249998Z","end":"2026-02-05T22:09:29.404755Z","steps":["trace[1090066964] 'process raft request' (duration: 126.573667ms)","trace[1090066964] 'compare' (duration: 28.041485ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:09:29.40762Z","caller":"traceutil/trace.go:171","msg":"trace[571605419] linearizableReadLoop","detail":"{readStateIndex:740; appliedIndex:737; }","duration":"147.927653ms","start":"2026-02-05T22:09:29.259683Z","end":"2026-02-05T22:09:29.407611Z","steps":["trace[571605419] 'read index received' (duration: 116.897949ms)","trace[571605419] 'applied index is now lower than readState.Index' (duration: 31.029314ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T22:09:29.407785Z","caller":"traceutil/trace.go:171","msg":"trace[595210249] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"157.549289ms","start":"2026-02-05T22:09:29.25023Z","end":"2026-02-05T22:09:29.40778Z","steps":["trace[595210249] 'process raft request' (duration: 157.298811ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T22:09:29.407979Z","caller":"traceutil/trace.go:171","msg":"trace[1592370101] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"157.62186ms","start":"2026-02-05T22:09:29.250351Z","end":"2026-02-05T22:09:29.407973Z","steps":["trace[1592370101] 'process raft request' (duration: 157.237829ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:09:29.40812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.425397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-qz6bs\" ","response":"range_response_count:1 size:4732"} {"level":"info","ts":"2026-02-05T22:09:29.408146Z","caller":"traceutil/trace.go:171","msg":"trace[1242646510] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-qz6bs; range_end:; response_count:1; response_revision:721; }","duration":"148.506849ms","start":"2026-02-05T22:09:29.259635Z","end":"2026-02-05T22:09:29.408141Z","steps":["trace[1242646510] 'agreement among raft nodes before linearized reading' (duration: 148.413837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:10:33.863814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.115447ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-05T22:10:33.863961Z","caller":"traceutil/trace.go:171","msg":"trace[213295601] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:979; }","duration":"201.921771ms","start":"2026-02-05T22:10:33.662012Z","end":"2026-02-05T22:10:33.863934Z","steps":["trace[213295601] 'read index received' (duration: 70.630849ms)","trace[213295601] 'applied index is now lower than readState.Index' (duration: 131.286362ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T22:10:33.864102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.081775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-05T22:10:33.864145Z","caller":"traceutil/trace.go:171","msg":"trace[57165660] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:946; }","duration":"202.146867ms","start":"2026-02-05T22:10:33.661981Z","end":"2026-02-05T22:10:33.864128Z","steps":["trace[57165660] 'agreement among raft nodes before linearized reading' (duration: 202.069825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T22:10:48.51953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.968632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T22:10:48.519704Z","caller":"traceutil/trace.go:171","msg":"trace[1163312129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"294.171008ms","start":"2026-02-05T22:10:48.225515Z","end":"2026-02-05T22:10:48.519686Z","steps":["trace[1163312129] 'range keys from in-memory index tree' (duration: 293.909491ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T22:10:48.790477Z","caller":"traceutil/trace.go:171","msg":"trace[1175843196] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"269.394749ms","start":"2026-02-05T22:10:48.52106Z","end":"2026-02-05T22:10:48.790455Z","steps":["trace[1175843196] 'read index received' (duration: 269.220345ms)","trace[1175843196] 'applied index is now lower than readState.Index' (duration: 173.174µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T22:10:48.791271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.518703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T22:10:48.791388Z","caller":"traceutil/trace.go:171","msg":"trace[824301220] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"270.280211ms","start":"2026-02-05T22:10:48.521026Z","end":"2026-02-05T22:10:48.791306Z","steps":["trace[824301220] 'agreement among raft nodes before linearized reading' (duration: 269.518082ms)"],"step_count":1}