{"level":"warn","ts":"2026-02-05T05:20:14.915855Z","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-05T05:20:14.915919Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-05T05:20:14.915972Z","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-05T05:20:14.915979Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-02-05T05:20:14.915993Z","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-05T05:20:14.916487Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]} {"level":"info","ts":"2026-02-05T05:20:14.916548Z","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.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-05T05:20:14.929938Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"13.211456ms"} {"level":"info","ts":"2026-02-05T05:20:14.96214Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"} {"level":"info","ts":"2026-02-05T05:20:14.962836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"} {"level":"info","ts":"2026-02-05T05:20:14.963224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"} {"level":"info","ts":"2026-02-05T05:20:14.963323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-05T05:20:14.96335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"} {"level":"info","ts":"2026-02-05T05:20:14.963417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"warn","ts":"2026-02-05T05:20:14.971255Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-05T05:20:14.974332Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-05T05:20:14.975855Z","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-05T05:20:14.977918Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-05T05:20:14.983078Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-05T05:20:14.983287Z","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-05T05:20:14.983345Z","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-05T05:20:14.983377Z","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-05T05:20:14.98361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"info","ts":"2026-02-05T05:20:14.983703Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-02-05T05:20:14.995136Z","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-05T05:20:14.998059Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-02-05T05:20:14.998074Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-02-05T05:20:14.99837Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-05T05:20:14.99841Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-05T05:20:15.964559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"} {"level":"info","ts":"2026-02-05T05:20:15.964651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-05T05:20:15.964676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"} {"level":"info","ts":"2026-02-05T05:20:15.9647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"} {"level":"info","ts":"2026-02-05T05:20:15.964732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-02-05T05:20:15.964742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"} {"level":"info","ts":"2026-02-05T05:20:15.964749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-02-05T05:20:15.966188Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"} {"level":"info","ts":"2026-02-05T05:20:15.966429Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T05:20:15.966509Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-05T05:20:15.966532Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-05T05:20:15.966663Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T05:20:15.966439Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T05:20:15.967533Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T05:20:15.967606Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T05:20:15.967625Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T05:20:15.969186Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"} {"level":"info","ts":"2026-02-05T05:20:15.969939Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-05T05:20:17.588324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.812206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-05T05:20:17.595237Z","caller":"traceutil/trace.go:171","msg":"trace[2131828351] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"119.053673ms","start":"2026-02-05T05:20:17.476155Z","end":"2026-02-05T05:20:17.595209Z","steps":["trace[2131828351] 'agreement among raft nodes before linearized reading' (duration: 112.133384ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.712029Z","caller":"traceutil/trace.go:171","msg":"trace[1722455288] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"148.107097ms","start":"2026-02-05T05:20:17.563901Z","end":"2026-02-05T05:20:17.712008Z","steps":["trace[1722455288] 'process raft request' (duration: 96.82084ms)","trace[1722455288] 'compare' (duration: 50.975751ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:17.713096Z","caller":"traceutil/trace.go:171","msg":"trace[150821127] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"147.432528ms","start":"2026-02-05T05:20:17.565646Z","end":"2026-02-05T05:20:17.713079Z","steps":["trace[150821127] 'process raft request' (duration: 146.158028ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.715498Z","caller":"traceutil/trace.go:171","msg":"trace[493562346] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"149.684263ms","start":"2026-02-05T05:20:17.5658Z","end":"2026-02-05T05:20:17.715484Z","steps":["trace[493562346] 'process raft request' (duration: 146.162339ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.716699Z","caller":"traceutil/trace.go:171","msg":"trace[2138215853] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"114.04711ms","start":"2026-02-05T05:20:17.602639Z","end":"2026-02-05T05:20:17.716686Z","steps":["trace[2138215853] 'process raft request' (duration: 113.979144ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.716882Z","caller":"traceutil/trace.go:171","msg":"trace[2011704304] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"116.926888ms","start":"2026-02-05T05:20:17.599943Z","end":"2026-02-05T05:20:17.71687Z","steps":["trace[2011704304] 'process raft request' (duration: 116.580148ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.717831Z","caller":"traceutil/trace.go:171","msg":"trace[354435364] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"151.904155ms","start":"2026-02-05T05:20:17.56591Z","end":"2026-02-05T05:20:17.717814Z","steps":["trace[354435364] 'process raft request' (duration: 149.349204ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.718007Z","caller":"traceutil/trace.go:171","msg":"trace[524476953] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"151.95985ms","start":"2026-02-05T05:20:17.566035Z","end":"2026-02-05T05:20:17.717995Z","steps":["trace[524476953] 'process raft request' (duration: 150.412466ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.718038Z","caller":"traceutil/trace.go:171","msg":"trace[1697319617] linearizableReadLoop","detail":"{readStateIndex:20; appliedIndex:15; }","duration":"130.016151ms","start":"2026-02-05T05:20:17.588014Z","end":"2026-02-05T05:20:17.71803Z","steps":["trace[1697319617] 'read index received' (duration: 72.714113ms)","trace[1697319617] 'applied index is now lower than readState.Index' (duration: 57.300988ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:17.718186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.889461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3179"} {"level":"info","ts":"2026-02-05T05:20:17.720063Z","caller":"traceutil/trace.go:171","msg":"trace[1826349136] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"157.802587ms","start":"2026-02-05T05:20:17.562254Z","end":"2026-02-05T05:20:17.720057Z","steps":["trace[1826349136] 'agreement among raft nodes before linearized reading' (duration: 155.828316ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:17.718297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.631902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-05T05:20:17.720436Z","caller":"traceutil/trace.go:171","msg":"trace[1805893834] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"150.782268ms","start":"2026-02-05T05:20:17.569647Z","end":"2026-02-05T05:20:17.720429Z","steps":["trace[1805893834] 'agreement among raft nodes before linearized reading' (duration: 148.628262ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.718475Z","caller":"traceutil/trace.go:171","msg":"trace[715317285] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"118.134873ms","start":"2026-02-05T05:20:17.60033Z","end":"2026-02-05T05:20:17.718465Z","steps":["trace[715317285] 'process raft request' (duration: 116.232688ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.718585Z","caller":"traceutil/trace.go:171","msg":"trace[1734129682] transaction","detail":"{read_only:false; number_of_response:0; response_revision:19; }","duration":"118.200979ms","start":"2026-02-05T05:20:17.600377Z","end":"2026-02-05T05:20:17.718578Z","steps":["trace[1734129682] 'process raft request' (duration: 116.213366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:17.72396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.046105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-05T05:20:17.724537Z","caller":"traceutil/trace.go:171","msg":"trace[2060499282] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"124.623604ms","start":"2026-02-05T05:20:17.599891Z","end":"2026-02-05T05:20:17.724514Z","steps":["trace[2060499282] 'agreement among raft nodes before linearized reading' (duration: 124.036114ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:17.725273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.116898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-64bzf\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-02-05T05:20:17.725318Z","caller":"traceutil/trace.go:171","msg":"trace[282859397] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-64bzf; range_end:; response_count:1; response_revision:21; }","duration":"125.173983ms","start":"2026-02-05T05:20:17.600138Z","end":"2026-02-05T05:20:17.725312Z","steps":["trace[282859397] 'agreement among raft nodes before linearized reading' (duration: 125.115788ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.868659Z","caller":"traceutil/trace.go:171","msg":"trace[980883623] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"140.408501ms","start":"2026-02-05T05:20:17.72823Z","end":"2026-02-05T05:20:17.868638Z","steps":["trace[980883623] 'process raft request' (duration: 140.27316ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.869109Z","caller":"traceutil/trace.go:171","msg":"trace[1880266005] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"143.461955ms","start":"2026-02-05T05:20:17.725637Z","end":"2026-02-05T05:20:17.869099Z","steps":["trace[1880266005] 'process raft request' (duration: 92.594193ms)","trace[1880266005] 'compare' (duration: 50.118118ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:17.869218Z","caller":"traceutil/trace.go:171","msg":"trace[793359840] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"139.762045ms","start":"2026-02-05T05:20:17.729439Z","end":"2026-02-05T05:20:17.869201Z","steps":["trace[793359840] 'process raft request' (duration: 139.080606ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.869308Z","caller":"traceutil/trace.go:171","msg":"trace[590158313] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"143.587346ms","start":"2026-02-05T05:20:17.725712Z","end":"2026-02-05T05:20:17.8693Z","steps":["trace[590158313] 'process raft request' (duration: 142.734893ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.869496Z","caller":"traceutil/trace.go:171","msg":"trace[1900970041] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"139.326218ms","start":"2026-02-05T05:20:17.730151Z","end":"2026-02-05T05:20:17.869477Z","steps":["trace[1900970041] 'process raft request' (duration: 138.388567ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.869635Z","caller":"traceutil/trace.go:171","msg":"trace[1184112973] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"143.642701ms","start":"2026-02-05T05:20:17.725863Z","end":"2026-02-05T05:20:17.869506Z","steps":["trace[1184112973] 'process raft request' (duration: 142.613272ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.869732Z","caller":"traceutil/trace.go:171","msg":"trace[601097282] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"139.540606ms","start":"2026-02-05T05:20:17.730181Z","end":"2026-02-05T05:20:17.869722Z","steps":["trace[601097282] 'process raft request' (duration: 138.376796ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:17.869893Z","caller":"traceutil/trace.go:171","msg":"trace[1490393733] linearizableReadLoop","detail":"{readStateIndex:28; appliedIndex:27; }","duration":"144.197019ms","start":"2026-02-05T05:20:17.725674Z","end":"2026-02-05T05:20:17.869871Z","steps":["trace[1490393733] 'read index received' (duration: 72.170225ms)","trace[1490393733] 'applied index is now lower than readState.Index' (duration: 72.026014ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:17.870185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.495954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-05T05:20:17.870209Z","caller":"traceutil/trace.go:171","msg":"trace[298555692] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:32; }","duration":"144.542428ms","start":"2026-02-05T05:20:17.72566Z","end":"2026-02-05T05:20:17.870203Z","steps":["trace[298555692] 'agreement among raft nodes before linearized reading' (duration: 144.429599ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:17.870369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.885582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-05T05:20:17.870394Z","caller":"traceutil/trace.go:171","msg":"trace[68944999] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:32; }","duration":"140.919065ms","start":"2026-02-05T05:20:17.729465Z","end":"2026-02-05T05:20:17.870384Z","steps":["trace[68944999] 'agreement among raft nodes before linearized reading' (duration: 140.889242ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:18.754295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.750372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-05T05:20:18.754738Z","caller":"traceutil/trace.go:171","msg":"trace[216137198] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"287.199123ms","start":"2026-02-05T05:20:18.467519Z","end":"2026-02-05T05:20:18.754719Z","steps":["trace[216137198] 'process raft request' (duration: 132.320376ms)","trace[216137198] 'compare' (duration: 152.534943ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:18.756638Z","caller":"traceutil/trace.go:171","msg":"trace[25633390] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"287.441235ms","start":"2026-02-05T05:20:18.469185Z","end":"2026-02-05T05:20:18.756626Z","steps":["trace[25633390] 'process raft request' (duration: 285.495666ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:18.758026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.551465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-05T05:20:18.758311Z","caller":"traceutil/trace.go:171","msg":"trace[1994678201] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:63; }","duration":"290.84797ms","start":"2026-02-05T05:20:18.467449Z","end":"2026-02-05T05:20:18.758297Z","steps":["trace[1994678201] 'agreement among raft nodes before linearized reading' (duration: 290.538363ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:18.758679Z","caller":"traceutil/trace.go:171","msg":"trace[407128449] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"263.120739ms","start":"2026-02-05T05:20:18.495548Z","end":"2026-02-05T05:20:18.758669Z","steps":["trace[407128449] 'process raft request' (duration: 260.745394ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:18.757957Z","caller":"traceutil/trace.go:171","msg":"trace[1135270374] linearizableReadLoop","detail":"{readStateIndex:67; appliedIndex:65; }","duration":"290.402992ms","start":"2026-02-05T05:20:18.467542Z","end":"2026-02-05T05:20:18.757945Z","steps":["trace[1135270374] 'read index received' (duration: 23.566509ms)","trace[1135270374] 'applied index is now lower than readState.Index' (duration: 266.835093ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:18.761311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.007466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1891421b67171277\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-02-05T05:20:18.761709Z","caller":"traceutil/trace.go:171","msg":"trace[1834447286] range","detail":"{range_begin:/registry/events/default/instance.1891421b67171277; range_end:; response_count:1; response_revision:64; }","duration":"294.419173ms","start":"2026-02-05T05:20:18.467279Z","end":"2026-02-05T05:20:18.761699Z","steps":["trace[1834447286] 'agreement among raft nodes before linearized reading' (duration: 293.410874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:18.761469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.335288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-05T05:20:18.761961Z","caller":"traceutil/trace.go:171","msg":"trace[1984367451] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:64; }","duration":"283.81659ms","start":"2026-02-05T05:20:18.478118Z","end":"2026-02-05T05:20:18.761935Z","steps":["trace[1984367451] 'agreement among raft nodes before linearized reading' (duration: 283.330697ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:18.904242Z","caller":"traceutil/trace.go:171","msg":"trace[932316627] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"102.761276ms","start":"2026-02-05T05:20:18.801454Z","end":"2026-02-05T05:20:18.904216Z","steps":["trace[932316627] 'process raft request' (duration: 59.207649ms)","trace[932316627] 'compare' (duration: 42.803052ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:18.904642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.844764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-05T05:20:18.904776Z","caller":"traceutil/trace.go:171","msg":"trace[1412381648] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:73; }","duration":"103.003777ms","start":"2026-02-05T05:20:18.801758Z","end":"2026-02-05T05:20:18.904762Z","steps":["trace[1412381648] 'agreement among raft nodes before linearized reading' (duration: 102.784298ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:19.133156Z","caller":"traceutil/trace.go:171","msg":"trace[1163163165] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"150.244748ms","start":"2026-02-05T05:20:18.982843Z","end":"2026-02-05T05:20:19.133088Z","steps":["trace[1163163165] 'process raft request' (duration: 91.409358ms)","trace[1163163165] 'compare' (duration: 58.616721ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:19.158153Z","caller":"traceutil/trace.go:171","msg":"trace[66833679] linearizableReadLoop","detail":"{readStateIndex:87; appliedIndex:85; }","duration":"169.758395ms","start":"2026-02-05T05:20:18.988369Z","end":"2026-02-05T05:20:19.158127Z","steps":["trace[66833679] 'read index received' (duration: 85.895699ms)","trace[66833679] 'applied index is now lower than readState.Index' (duration: 83.861746ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:19.158652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.246038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/service-accounts\" ","response":"range_response_count:1 size:1100"} {"level":"info","ts":"2026-02-05T05:20:19.159092Z","caller":"traceutil/trace.go:171","msg":"trace[69253302] range","detail":"{range_begin:/registry/flowschemas/service-accounts; range_end:; response_count:1; response_revision:82; }","duration":"170.724369ms","start":"2026-02-05T05:20:18.988357Z","end":"2026-02-05T05:20:19.159081Z","steps":["trace[69253302] 'agreement among raft nodes before linearized reading' (duration: 170.005117ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:19.158759Z","caller":"traceutil/trace.go:171","msg":"trace[1032222907] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"170.448484ms","start":"2026-02-05T05:20:18.988278Z","end":"2026-02-05T05:20:19.158726Z","steps":["trace[1032222907] 'process raft request' (duration: 169.641064ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:19.158963Z","caller":"traceutil/trace.go:171","msg":"trace[1761902027] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"142.755962ms","start":"2026-02-05T05:20:19.016195Z","end":"2026-02-05T05:20:19.158951Z","steps":["trace[1761902027] 'process raft request' (duration: 141.845113ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:19.281236Z","caller":"traceutil/trace.go:171","msg":"trace[302324951] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"104.417251ms","start":"2026-02-05T05:20:19.176797Z","end":"2026-02-05T05:20:19.281214Z","steps":["trace[302324951] 'process raft request' (duration: 62.372238ms)","trace[302324951] 'compare' (duration: 41.583423ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:19.44217Z","caller":"traceutil/trace.go:171","msg":"trace[471680180] linearizableReadLoop","detail":"{readStateIndex:96; appliedIndex:94; }","duration":"122.362009ms","start":"2026-02-05T05:20:19.319786Z","end":"2026-02-05T05:20:19.442148Z","steps":["trace[471680180] 'read index received' (duration: 108.336714ms)","trace[471680180] 'applied index is now lower than readState.Index' (duration: 14.024515ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:19.443377Z","caller":"traceutil/trace.go:171","msg":"trace[278507786] transaction","detail":"{read_only:false; response_revision:89; number_of_response:1; }","duration":"154.99243ms","start":"2026-02-05T05:20:19.288352Z","end":"2026-02-05T05:20:19.443344Z","steps":["trace[278507786] 'process raft request' (duration: 139.762859ms)","trace[278507786] 'compare' (duration: 13.876582ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:19.44424Z","caller":"traceutil/trace.go:171","msg":"trace[830241174] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"155.155784ms","start":"2026-02-05T05:20:19.289069Z","end":"2026-02-05T05:20:19.444225Z","steps":["trace[830241174] 'process raft request' (duration: 153.021347ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:19.444974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.152292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1891421b6717259b\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-02-05T05:20:19.445221Z","caller":"traceutil/trace.go:171","msg":"trace[519141127] range","detail":"{range_begin:/registry/events/default/instance.1891421b6717259b; range_end:; response_count:1; response_revision:90; }","duration":"125.467771ms","start":"2026-02-05T05:20:19.319738Z","end":"2026-02-05T05:20:19.445206Z","steps":["trace[519141127] 'agreement among raft nodes before linearized reading' (duration: 125.164114ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:19.654699Z","caller":"traceutil/trace.go:171","msg":"trace[1215842415] linearizableReadLoop","detail":"{readStateIndex:99; appliedIndex:98; }","duration":"176.339085ms","start":"2026-02-05T05:20:19.478298Z","end":"2026-02-05T05:20:19.654637Z","steps":["trace[1215842415] 'read index received' (duration: 99.066045ms)","trace[1215842415] 'applied index is now lower than readState.Index' (duration: 77.27182ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:19.654719Z","caller":"traceutil/trace.go:171","msg":"trace[731484631] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"201.997807ms","start":"2026-02-05T05:20:19.452681Z","end":"2026-02-05T05:20:19.654679Z","steps":["trace[731484631] 'process raft request' (duration: 133.57894ms)","trace[731484631] 'compare' (duration: 68.203938ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:19.655346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.009355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:public-info-viewer\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-05T05:20:19.655395Z","caller":"traceutil/trace.go:171","msg":"trace[2050767828] range","detail":"{range_begin:/registry/clusterroles/system:public-info-viewer; range_end:; response_count:0; response_revision:93; }","duration":"177.113823ms","start":"2026-02-05T05:20:19.478269Z","end":"2026-02-05T05:20:19.655383Z","steps":["trace[2050767828] 'agreement among raft nodes before linearized reading' (duration: 176.535632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:19.900228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.69106ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-05T05:20:19.90042Z","caller":"traceutil/trace.go:171","msg":"trace[1533481451] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"147.87824ms","start":"2026-02-05T05:20:19.752506Z","end":"2026-02-05T05:20:19.900384Z","steps":["trace[1533481451] 'process raft request' (duration: 32.896774ms)","trace[1533481451] 'compare' (duration: 114.495873ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:19.900611Z","caller":"traceutil/trace.go:171","msg":"trace[912595935] linearizableReadLoop","detail":"{readStateIndex:104; appliedIndex:103; }","duration":"146.507389ms","start":"2026-02-05T05:20:19.754085Z","end":"2026-02-05T05:20:19.900593Z","steps":["trace[912595935] 'read index received' (duration: 31.25667ms)","trace[912595935] 'applied index is now lower than readState.Index' (duration: 115.248539ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:19.900864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.779103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1891421b6717259b\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-02-05T05:20:19.900941Z","caller":"traceutil/trace.go:171","msg":"trace[1218848407] range","detail":"{range_begin:/registry/events/default/instance.1891421b6717259b; range_end:; response_count:1; response_revision:98; }","duration":"146.884542ms","start":"2026-02-05T05:20:19.754046Z","end":"2026-02-05T05:20:19.90093Z","steps":["trace[1218848407] 'agreement among raft nodes before linearized reading' (duration: 146.74048ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:20.065885Z","caller":"traceutil/trace.go:171","msg":"trace[478455182] linearizableReadLoop","detail":"{readStateIndex:108; appliedIndex:107; }","duration":"111.115953ms","start":"2026-02-05T05:20:19.954743Z","end":"2026-02-05T05:20:20.065859Z","steps":["trace[478455182] 'read index received' (duration: 78.898966ms)","trace[478455182] 'applied index is now lower than readState.Index' (duration: 32.215997ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:20.066061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.292729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-05T05:20:20.066281Z","caller":"traceutil/trace.go:171","msg":"trace[501943447] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:102; }","duration":"111.379477ms","start":"2026-02-05T05:20:19.954704Z","end":"2026-02-05T05:20:20.066083Z","steps":["trace[501943447] 'agreement among raft nodes before linearized reading' (duration: 111.250946ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:20.066532Z","caller":"traceutil/trace.go:171","msg":"trace[665905108] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"113.076334ms","start":"2026-02-05T05:20:19.953442Z","end":"2026-02-05T05:20:20.066518Z","steps":["trace[665905108] 'process raft request' (duration: 80.234692ms)","trace[665905108] 'compare' (duration: 32.079515ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:20.07074Z","caller":"traceutil/trace.go:171","msg":"trace[1418173431] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"114.609061ms","start":"2026-02-05T05:20:19.956107Z","end":"2026-02-05T05:20:20.070716Z","steps":["trace[1418173431] 'process raft request' (duration: 114.479399ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:20.248391Z","caller":"traceutil/trace.go:171","msg":"trace[470075470] transaction","detail":"{read_only:false; response_revision:110; number_of_response:1; }","duration":"115.178427ms","start":"2026-02-05T05:20:20.133192Z","end":"2026-02-05T05:20:20.24837Z","steps":["trace[470075470] 'process raft request' (duration: 115.117382ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:20.248774Z","caller":"traceutil/trace.go:171","msg":"trace[794876164] linearizableReadLoop","detail":"{readStateIndex:115; appliedIndex:114; }","duration":"116.417366ms","start":"2026-02-05T05:20:20.132314Z","end":"2026-02-05T05:20:20.248731Z","steps":["trace[794876164] 'read index received' (duration: 112.24942ms)","trace[794876164] 'applied index is now lower than readState.Index' (duration: 4.165425ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:20.249076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.717512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1891421b671733e8\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-02-05T05:20:20.249998Z","caller":"traceutil/trace.go:171","msg":"trace[1633176844] range","detail":"{range_begin:/registry/events/default/instance.1891421b671733e8; range_end:; response_count:1; response_revision:110; }","duration":"117.689777ms","start":"2026-02-05T05:20:20.132297Z","end":"2026-02-05T05:20:20.249987Z","steps":["trace[1633176844] 'agreement among raft nodes before linearized reading' (duration: 116.672667ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:20.249123Z","caller":"traceutil/trace.go:171","msg":"trace[1048066316] transaction","detail":"{read_only:false; response_revision:109; number_of_response:1; }","duration":"118.214844ms","start":"2026-02-05T05:20:20.130896Z","end":"2026-02-05T05:20:20.249111Z","steps":["trace[1048066316] 'process raft request' (duration: 113.653954ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:22.773885Z","caller":"traceutil/trace.go:171","msg":"trace[1501277402] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"104.328964ms","start":"2026-02-05T05:20:22.66954Z","end":"2026-02-05T05:20:22.773869Z","steps":["trace[1501277402] 'process raft request' (duration: 104.295891ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:22.774053Z","caller":"traceutil/trace.go:171","msg":"trace[756703374] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"109.055101ms","start":"2026-02-05T05:20:22.66499Z","end":"2026-02-05T05:20:22.774045Z","steps":["trace[756703374] 'process raft request' (duration: 13.707413ms)","trace[756703374] 'compare' (duration: 95.051942ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:22.774137Z","caller":"traceutil/trace.go:171","msg":"trace[763588877] linearizableReadLoop","detail":"{readStateIndex:277; appliedIndex:276; }","duration":"108.876016ms","start":"2026-02-05T05:20:22.665255Z","end":"2026-02-05T05:20:22.774131Z","steps":["trace[763588877] 'read index received' (duration: 13.448521ms)","trace[763588877] 'applied index is now lower than readState.Index' (duration: 95.426825ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:22.774392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.470738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:20:22.774416Z","caller":"traceutil/trace.go:171","msg":"trace[385994204] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:271; }","duration":"109.515802ms","start":"2026-02-05T05:20:22.664893Z","end":"2026-02-05T05:20:22.774409Z","steps":["trace[385994204] 'agreement among raft nodes before linearized reading' (duration: 109.416704ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:22.813168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.935061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-05T05:20:22.813221Z","caller":"traceutil/trace.go:171","msg":"trace[926564059] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:273; }","duration":"136.010767ms","start":"2026-02-05T05:20:22.677198Z","end":"2026-02-05T05:20:22.813209Z","steps":["trace[926564059] 'agreement among raft nodes before linearized reading' (duration: 135.9245ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:25.813785Z","caller":"traceutil/trace.go:171","msg":"trace[1996900975] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"200.285364ms","start":"2026-02-05T05:20:25.613468Z","end":"2026-02-05T05:20:25.813753Z","steps":["trace[1996900975] 'process raft request' (duration: 200.106638ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:25.819041Z","caller":"traceutil/trace.go:171","msg":"trace[591835274] linearizableReadLoop","detail":"{readStateIndex:333; appliedIndex:331; }","duration":"177.665629ms","start":"2026-02-05T05:20:25.641362Z","end":"2026-02-05T05:20:25.819028Z","steps":["trace[591835274] 'read index received' (duration: 172.238383ms)","trace[591835274] 'applied index is now lower than readState.Index' (duration: 5.426515ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:25.819177Z","caller":"traceutil/trace.go:171","msg":"trace[950970002] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"197.961376ms","start":"2026-02-05T05:20:25.621209Z","end":"2026-02-05T05:20:25.81917Z","steps":["trace[950970002] 'process raft request' (duration: 197.754178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:25.819324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.948745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-05T05:20:25.819352Z","caller":"traceutil/trace.go:171","msg":"trace[1940645816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:319; }","duration":"178.003169ms","start":"2026-02-05T05:20:25.641342Z","end":"2026-02-05T05:20:25.819345Z","steps":["trace[1940645816] 'agreement among raft nodes before linearized reading' (duration: 177.932973ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:27.193242Z","caller":"traceutil/trace.go:171","msg":"trace[538306213] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"114.195788ms","start":"2026-02-05T05:20:27.079027Z","end":"2026-02-05T05:20:27.193222Z","steps":["trace[538306213] 'process raft request' (duration: 71.477946ms)","trace[538306213] 'compare' (duration: 42.270132ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:27.193435Z","caller":"traceutil/trace.go:171","msg":"trace[1620233007] linearizableReadLoop","detail":"{readStateIndex:348; appliedIndex:347; }","duration":"114.166336ms","start":"2026-02-05T05:20:27.079261Z","end":"2026-02-05T05:20:27.193428Z","steps":["trace[1620233007] 'read index received' (duration: 71.250686ms)","trace[1620233007] 'applied index is now lower than readState.Index' (duration: 42.914759ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:27.193558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.279436ms","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-02-05T05:20:27.193582Z","caller":"traceutil/trace.go:171","msg":"trace[1929375880] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:335; }","duration":"114.318859ms","start":"2026-02-05T05:20:27.079258Z","end":"2026-02-05T05:20:27.193577Z","steps":["trace[1929375880] 'agreement among raft nodes before linearized reading' (duration: 114.208129ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:27.58032Z","caller":"traceutil/trace.go:171","msg":"trace[1693662625] linearizableReadLoop","detail":"{readStateIndex:351; appliedIndex:350; }","duration":"261.461718ms","start":"2026-02-05T05:20:27.318815Z","end":"2026-02-05T05:20:27.580277Z","steps":["trace[1693662625] 'read index received' (duration: 261.193534ms)","trace[1693662625] 'applied index is now lower than readState.Index' (duration: 266.974µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:27.580756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.872104ms","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-05T05:20:27.580864Z","caller":"traceutil/trace.go:171","msg":"trace[1051131729] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:337; }","duration":"262.067341ms","start":"2026-02-05T05:20:27.318785Z","end":"2026-02-05T05:20:27.580853Z","steps":["trace[1051131729] 'agreement among raft nodes before linearized reading' (duration: 261.83139ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:27.581428Z","caller":"traceutil/trace.go:171","msg":"trace[44931533] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"295.837058ms","start":"2026-02-05T05:20:27.28558Z","end":"2026-02-05T05:20:27.581417Z","steps":["trace[44931533] 'process raft request' (duration: 294.5381ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:28.400054Z","caller":"traceutil/trace.go:171","msg":"trace[735567295] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"111.005983ms","start":"2026-02-05T05:20:28.289029Z","end":"2026-02-05T05:20:28.400035Z","steps":["trace[735567295] 'process raft request' (duration: 110.896113ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:28.421946Z","caller":"traceutil/trace.go:171","msg":"trace[1548027569] linearizableReadLoop","detail":"{readStateIndex:362; appliedIndex:361; }","duration":"127.303339ms","start":"2026-02-05T05:20:28.294364Z","end":"2026-02-05T05:20:28.421667Z","steps":["trace[1548027569] 'read index received' (duration: 105.668781ms)","trace[1548027569] 'applied index is now lower than readState.Index' (duration: 21.633808ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:28.422394Z","caller":"traceutil/trace.go:171","msg":"trace[102039713] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"131.487366ms","start":"2026-02-05T05:20:28.290893Z","end":"2026-02-05T05:20:28.422381Z","steps":["trace[102039713] 'process raft request' (duration: 130.617848ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:28.423782Z","caller":"traceutil/trace.go:171","msg":"trace[1063411148] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"129.177437ms","start":"2026-02-05T05:20:28.29459Z","end":"2026-02-05T05:20:28.423767Z","steps":["trace[1063411148] 'process raft request' (duration: 127.041824ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:28.424856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.473855ms","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-05T05:20:28.42498Z","caller":"traceutil/trace.go:171","msg":"trace[1726631184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:349; }","duration":"130.614448ms","start":"2026-02-05T05:20:28.29435Z","end":"2026-02-05T05:20:28.424965Z","steps":["trace[1726631184] 'agreement among raft nodes before linearized reading' (duration: 130.450733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:28.425663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.331621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-05T05:20:28.425778Z","caller":"traceutil/trace.go:171","msg":"trace[2117780184] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:349; }","duration":"106.444811ms","start":"2026-02-05T05:20:28.319319Z","end":"2026-02-05T05:20:28.425763Z","steps":["trace[2117780184] 'agreement among raft nodes before linearized reading' (duration: 106.302188ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:29.429567Z","caller":"traceutil/trace.go:171","msg":"trace[325802053] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"149.291981ms","start":"2026-02-05T05:20:29.280255Z","end":"2026-02-05T05:20:29.429547Z","steps":["trace[325802053] 'process raft request' (duration: 149.181941ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:31.482407Z","caller":"traceutil/trace.go:171","msg":"trace[145010442] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"310.867962ms","start":"2026-02-05T05:20:31.171523Z","end":"2026-02-05T05:20:31.482391Z","steps":["trace[145010442] 'read index received' (duration: 310.786484ms)","trace[145010442] 'applied index is now lower than readState.Index' (duration: 80.238µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:31.48253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.990533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-05T05:20:31.482482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:31.080861Z","time spent":"401.61411ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-05T05:20:31.482581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.630926ms","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-02-05T05:20:31.482595Z","caller":"traceutil/trace.go:171","msg":"trace[471253245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"202.67033ms","start":"2026-02-05T05:20:31.27992Z","end":"2026-02-05T05:20:31.482591Z","steps":["trace[471253245] 'agreement among raft nodes before linearized reading' (duration: 202.642768ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:31.48255Z","caller":"traceutil/trace.go:171","msg":"trace[117002605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:407; }","duration":"311.06221ms","start":"2026-02-05T05:20:31.171483Z","end":"2026-02-05T05:20:31.482545Z","steps":["trace[117002605] 'agreement among raft nodes before linearized reading' (duration: 310.997234ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:31.482824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:31.171462Z","time spent":"311.337584ms","remote":"127.0.0.1:56568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T05:20:31.984888Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544457,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:20:32.135257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.496935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:20:32.135354Z","caller":"traceutil/trace.go:171","msg":"trace[276241696] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"650.885991ms","start":"2026-02-05T05:20:31.484451Z","end":"2026-02-05T05:20:32.135337Z","steps":["trace[276241696] 'process raft request' (duration: 518.124031ms)","trace[276241696] 'compare' (duration: 130.025729ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:32.13541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:31.484439Z","time spent":"650.943976ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:20:32.137677Z","caller":"traceutil/trace.go:171","msg":"trace[71345160] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:424; }","duration":"653.137487ms","start":"2026-02-05T05:20:31.484525Z","end":"2026-02-05T05:20:32.137663Z","steps":["trace[71345160] 'read index received' (duration: 518.057745ms)","trace[71345160] 'applied index is now lower than readState.Index' (duration: 135.078842ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:32.138503Z","caller":"traceutil/trace.go:171","msg":"trace[1620672383] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"651.616108ms","start":"2026-02-05T05:20:31.486873Z","end":"2026-02-05T05:20:32.138489Z","steps":["trace[1620672383] 'process raft request' (duration: 650.707765ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:32.139495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.968015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:20:32.139518Z","caller":"traceutil/trace.go:171","msg":"trace[1451719799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"654.991437ms","start":"2026-02-05T05:20:31.484521Z","end":"2026-02-05T05:20:32.139512Z","steps":["trace[1451719799] 'agreement among raft nodes before linearized reading' (duration: 654.959924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:32.139531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:31.48447Z","time spent":"655.057863ms","remote":"127.0.0.1:56570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T05:20:32.139635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:31.486857Z","time spent":"651.687785ms","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:20:32.13988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.690729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-05T05:20:32.139901Z","caller":"traceutil/trace.go:171","msg":"trace[1423204854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:409; }","duration":"143.757136ms","start":"2026-02-05T05:20:31.996139Z","end":"2026-02-05T05:20:32.139896Z","steps":["trace[1423204854] 'agreement among raft nodes before linearized reading' (duration: 143.728183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:32.140105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.558623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-05T05:20:32.140126Z","caller":"traceutil/trace.go:171","msg":"trace[2035387354] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:409; }","duration":"358.608898ms","start":"2026-02-05T05:20:31.781512Z","end":"2026-02-05T05:20:32.14012Z","steps":["trace[2035387354] 'agreement among raft nodes before linearized reading' (duration: 358.567895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:32.140822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:31.781496Z","time spent":"358.641011ms","remote":"127.0.0.1:56744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4284,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-02-05T05:20:33.109885Z","caller":"traceutil/trace.go:171","msg":"trace[908365210] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"439.473622ms","start":"2026-02-05T05:20:32.670384Z","end":"2026-02-05T05:20:33.109857Z","steps":["trace[908365210] 'process raft request' (duration: 439.324588ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:33.110094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:32.670372Z","time spent":"439.639417ms","remote":"127.0.0.1:56744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4583,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:20:33.11065Z","caller":"traceutil/trace.go:171","msg":"trace[1962448829] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"230.06017ms","start":"2026-02-05T05:20:32.880572Z","end":"2026-02-05T05:20:33.110632Z","steps":["trace[1962448829] 'process raft request' (duration: 229.967391ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:42.481422Z","caller":"traceutil/trace.go:171","msg":"trace[52155632] linearizableReadLoop","detail":"{readStateIndex:488; appliedIndex:487; }","duration":"120.412952ms","start":"2026-02-05T05:20:42.360993Z","end":"2026-02-05T05:20:42.481406Z","steps":["trace[52155632] 'read index received' (duration: 120.277499ms)","trace[52155632] 'applied index is now lower than readState.Index' (duration: 134.893µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:42.481531Z","caller":"traceutil/trace.go:171","msg":"trace[1491039346] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"164.134854ms","start":"2026-02-05T05:20:42.317391Z","end":"2026-02-05T05:20:42.481526Z","steps":["trace[1491039346] 'process raft request' (duration: 163.931045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:42.48169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.668026ms","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-02-05T05:20:42.481763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.757504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-05T05:20:42.481756Z","caller":"traceutil/trace.go:171","msg":"trace[171011340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:468; }","duration":"115.750064ms","start":"2026-02-05T05:20:42.36599Z","end":"2026-02-05T05:20:42.48174Z","steps":["trace[171011340] 'agreement among raft nodes before linearized reading' (duration: 115.645624ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:42.481785Z","caller":"traceutil/trace.go:171","msg":"trace[1717243182] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:468; }","duration":"120.814619ms","start":"2026-02-05T05:20:42.360964Z","end":"2026-02-05T05:20:42.481779Z","steps":["trace[1717243182] 'agreement among raft nodes before linearized reading' (duration: 120.764264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:42.690067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.674156ms","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-05T05:20:42.690281Z","caller":"traceutil/trace.go:171","msg":"trace[2122005230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:470; }","duration":"112.923889ms","start":"2026-02-05T05:20:42.577343Z","end":"2026-02-05T05:20:42.690267Z","steps":["trace[2122005230] 'range keys from in-memory index tree' (duration: 112.582287ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:53.776597Z","caller":"traceutil/trace.go:171","msg":"trace[1994105995] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"252.393138ms","start":"2026-02-05T05:20:53.524183Z","end":"2026-02-05T05:20:53.776576Z","steps":["trace[1994105995] 'process raft request' (duration: 252.284598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.300543Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544732,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-05T05:20:54.416319Z","caller":"traceutil/trace.go:171","msg":"trace[753197744] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"686.925288ms","start":"2026-02-05T05:20:53.729357Z","end":"2026-02-05T05:20:54.416282Z","steps":["trace[753197744] 'process raft request' (duration: 686.880264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.41649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:53.729341Z","time spent":"687.062982ms","remote":"127.0.0.1:56740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4365,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:20:54.416796Z","caller":"traceutil/trace.go:171","msg":"trace[935372879] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"852.589291ms","start":"2026-02-05T05:20:53.564201Z","end":"2026-02-05T05:20:54.41679Z","steps":["trace[935372879] 'process raft request' (duration: 851.832529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.416825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:53.564182Z","time spent":"852.626875ms","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:20:54.416945Z","caller":"traceutil/trace.go:171","msg":"trace[1770711968] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"723.590885ms","start":"2026-02-05T05:20:53.693349Z","end":"2026-02-05T05:20:54.41694Z","steps":["trace[1770711968] 'process raft request' (duration: 722.836023ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.416971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:53.693333Z","time spent":"723.622567ms","remote":"127.0.0.1:56626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:20:54.425595Z","caller":"traceutil/trace.go:171","msg":"trace[1428678756] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:571; }","duration":"625.12683ms","start":"2026-02-05T05:20:53.800442Z","end":"2026-02-05T05:20:54.425569Z","steps":["trace[1428678756] 'read index received' (duration: 616.87404ms)","trace[1428678756] 'applied index is now lower than readState.Index' (duration: 8.25146ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:54.425905Z","caller":"traceutil/trace.go:171","msg":"trace[1050847078] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"634.623249ms","start":"2026-02-05T05:20:53.791267Z","end":"2026-02-05T05:20:54.42589Z","steps":["trace[1050847078] 'process raft request' (duration: 634.062584ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.426032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:53.791252Z","time spent":"634.689415ms","remote":"127.0.0.1:56626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13214,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:20:54.426222Z","caller":"traceutil/trace.go:171","msg":"trace[1588506228] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"534.224157ms","start":"2026-02-05T05:20:53.891989Z","end":"2026-02-05T05:20:54.426213Z","steps":["trace[1588506228] 'process raft request' (duration: 533.482405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.426276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:53.891971Z","time spent":"534.278982ms","remote":"127.0.0.1:56626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:20:54.426391Z","caller":"traceutil/trace.go:171","msg":"trace[279596324] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"334.030709ms","start":"2026-02-05T05:20:54.092352Z","end":"2026-02-05T05:20:54.426382Z","steps":["trace[279596324] 'process raft request' (duration: 333.153534ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.426438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:54.092325Z","time spent":"334.091405ms","remote":"127.0.0.1:56626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:20:54.42655Z","caller":"traceutil/trace.go:171","msg":"trace[546273686] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"134.822931ms","start":"2026-02-05T05:20:54.291718Z","end":"2026-02-05T05:20:54.426541Z","steps":["trace[546273686] 'process raft request' (duration: 133.817864ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.426795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.346527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2gl6h\" ","response":"range_response_count:1 size:4822"} {"level":"info","ts":"2026-02-05T05:20:54.426834Z","caller":"traceutil/trace.go:171","msg":"trace[28305397] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2gl6h; range_end:; response_count:1; response_revision:553; }","duration":"626.415873ms","start":"2026-02-05T05:20:53.800408Z","end":"2026-02-05T05:20:54.426824Z","steps":["trace[28305397] 'agreement among raft nodes before linearized reading' (duration: 626.243086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:54.426863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:53.800395Z","time spent":"626.460478ms","remote":"127.0.0.1:56744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4846,"request content":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2gl6h\" "} {"level":"warn","ts":"2026-02-05T05:20:54.427016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.640789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:20:54.427048Z","caller":"traceutil/trace.go:171","msg":"trace[1087680907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"256.707325ms","start":"2026-02-05T05:20:54.170332Z","end":"2026-02-05T05:20:54.42704Z","steps":["trace[1087680907] 'agreement among raft nodes before linearized reading' (duration: 256.66235ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:55.382443Z","caller":"traceutil/trace.go:171","msg":"trace[1727906868] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"422.620102ms","start":"2026-02-05T05:20:54.959807Z","end":"2026-02-05T05:20:55.382427Z","steps":["trace[1727906868] 'process raft request' (duration: 422.531934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:55.382534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:54.959793Z","time spent":"422.693429ms","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:20:55.383217Z","caller":"traceutil/trace.go:171","msg":"trace[1630819293] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:597; }","duration":"411.728379ms","start":"2026-02-05T05:20:54.971478Z","end":"2026-02-05T05:20:55.383207Z","steps":["trace[1630819293] 'read index received' (duration: 411.726168ms)","trace[1630819293] 'applied index is now lower than readState.Index' (duration: 1.771µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:20:55.383274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.792235ms","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-05T05:20:55.383291Z","caller":"traceutil/trace.go:171","msg":"trace[443952315] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:575; }","duration":"411.827858ms","start":"2026-02-05T05:20:54.971457Z","end":"2026-02-05T05:20:55.383285Z","steps":["trace[443952315] 'agreement among raft nodes before linearized reading' (duration: 411.791425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:55.383311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:54.971447Z","time spent":"411.860391ms","remote":"127.0.0.1:56668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-05T05:20:55.401611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.762748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-05T05:20:55.401711Z","caller":"traceutil/trace.go:171","msg":"trace[96790162] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:576; }","duration":"111.885179ms","start":"2026-02-05T05:20:55.289792Z","end":"2026-02-05T05:20:55.401677Z","steps":["trace[96790162] 'agreement among raft nodes before linearized reading' (duration: 111.598402ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:55.40176Z","caller":"traceutil/trace.go:171","msg":"trace[472228146] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"283.441061ms","start":"2026-02-05T05:20:55.118306Z","end":"2026-02-05T05:20:55.401747Z","steps":["trace[472228146] 'process raft request' (duration: 282.926442ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:20:58.630601Z","caller":"traceutil/trace.go:171","msg":"trace[690727452] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"103.832256ms","start":"2026-02-05T05:20:58.526752Z","end":"2026-02-05T05:20:58.630584Z","steps":["trace[690727452] 'process raft request' (duration: 103.676286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:59.202731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544883,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-05T05:20:59.296291Z","caller":"traceutil/trace.go:171","msg":"trace[1954977702] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"593.829991ms","start":"2026-02-05T05:20:58.702444Z","end":"2026-02-05T05:20:59.296274Z","steps":["trace[1954977702] 'read index received' (duration: 593.653034ms)","trace[1954977702] 'applied index is now lower than readState.Index' (duration: 176.197µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:20:59.297124Z","caller":"traceutil/trace.go:171","msg":"trace[1562427755] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"615.325778ms","start":"2026-02-05T05:20:58.681788Z","end":"2026-02-05T05:20:59.297113Z","steps":["trace[1562427755] 'process raft request' (duration: 614.349825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:59.297325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:58.681767Z","time spent":"615.486327ms","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:20:59.297664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.215085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-05T05:20:59.297796Z","caller":"traceutil/trace.go:171","msg":"trace[460639291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:611; }","duration":"595.364645ms","start":"2026-02-05T05:20:58.70242Z","end":"2026-02-05T05:20:59.297785Z","steps":["trace[460639291] 'agreement among raft nodes before linearized reading' (duration: 595.171978ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:59.297944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:58.70241Z","time spent":"595.525073ms","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T05:20:59.298451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.420366ms","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-05T05:20:59.298811Z","caller":"traceutil/trace.go:171","msg":"trace[1305188479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"471.80209ms","start":"2026-02-05T05:20:58.827Z","end":"2026-02-05T05:20:59.298802Z","steps":["trace[1305188479] 'agreement among raft nodes before linearized reading' (duration: 471.343912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:59.298997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:58.826987Z","time spent":"471.999686ms","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-05T05:20:59.299747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.153171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:20:59.299873Z","caller":"traceutil/trace.go:171","msg":"trace[466506778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"128.30352ms","start":"2026-02-05T05:20:59.17156Z","end":"2026-02-05T05:20:59.299863Z","steps":["trace[466506778] 'agreement among raft nodes before linearized reading' (duration: 128.136842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:59.30036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.274381ms","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-05T05:20:59.300521Z","caller":"traceutil/trace.go:171","msg":"trace[121908220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"424.445719ms","start":"2026-02-05T05:20:58.876066Z","end":"2026-02-05T05:20:59.300512Z","steps":["trace[121908220] 'agreement among raft nodes before linearized reading' (duration: 424.130071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:20:59.300617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:20:58.876059Z","time spent":"424.548431ms","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-05T05:21:02.176389Z","caller":"traceutil/trace.go:171","msg":"trace[1859963958] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"339.768233ms","start":"2026-02-05T05:21:01.836605Z","end":"2026-02-05T05:21:02.176374Z","steps":["trace[1859963958] 'process raft request' (duration: 339.628801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:02.17651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:01.836579Z","time spent":"339.867317ms","remote":"127.0.0.1:56744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:21:03.824852Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544922,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:21:04.325511Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544922,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:21:04.826419Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544922,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:21:05.327127Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544922,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:21:05.828206Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544922,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:21:06.167671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999924707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-05T05:21:06.167729Z","caller":"traceutil/trace.go:171","msg":"trace[359373251] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000017782s","start":"2026-02-05T05:21:04.167696Z","end":"2026-02-05T05:21:06.167714Z","steps":["trace[359373251] 'agreement among raft nodes before linearized reading' (duration: 1.999946126s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:06.16777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:04.167682Z","time spent":"2.000074459s","remote":"127.0.0.1:56568","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-05T05:21:06.328889Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976811682407544922,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:21:06.349183Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.02571821s","expected-duration":"1s"} {"level":"info","ts":"2026-02-05T05:21:06.349852Z","caller":"traceutil/trace.go:171","msg":"trace[1450854479] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"3.02644893s","start":"2026-02-05T05:21:03.323382Z","end":"2026-02-05T05:21:06.349831Z","steps":["trace[1450854479] 'process raft request' (duration: 3.026297268s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:06.349981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:03.323368Z","time spent":"3.026543334s","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:21:06.384105Z","caller":"traceutil/trace.go:171","msg":"trace[159673002] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"3.060204237s","start":"2026-02-05T05:21:03.323884Z","end":"2026-02-05T05:21:06.384088Z","steps":["trace[159673002] 'read index received' (duration: 3.02651988s)","trace[159673002] 'applied index is now lower than readState.Index' (duration: 33.683667ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:06.384332Z","caller":"traceutil/trace.go:171","msg":"trace[1038640858] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.58768071s","start":"2026-02-05T05:21:04.796642Z","end":"2026-02-05T05:21:06.384323Z","steps":["trace[1038640858] 'process raft request' (duration: 1.587345538s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:06.384404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:04.796624Z","time spent":"1.587724317s","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:21:06.384562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.06068538s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-05T05:21:06.384578Z","caller":"traceutil/trace.go:171","msg":"trace[389890248] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"3.060716898s","start":"2026-02-05T05:21:03.323856Z","end":"2026-02-05T05:21:06.384573Z","steps":["trace[389890248] 'agreement among raft nodes before linearized reading' (duration: 3.060652712s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:06.384592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:03.323849Z","time spent":"3.060739896s","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T05:21:06.384674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.046532465s","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-05T05:21:06.384689Z","caller":"traceutil/trace.go:171","msg":"trace[203413773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"3.046546704s","start":"2026-02-05T05:21:03.338138Z","end":"2026-02-05T05:21:06.384685Z","steps":["trace[203413773] 'agreement among raft nodes before linearized reading' (duration: 3.046508426s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:06.3847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:03.338122Z","time spent":"3.046575383s","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-05T05:21:06.384803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.444115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:06.384826Z","caller":"traceutil/trace.go:171","msg":"trace[1909859926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"216.486003ms","start":"2026-02-05T05:21:06.168333Z","end":"2026-02-05T05:21:06.384819Z","steps":["trace[1909859926] 'agreement among raft nodes before linearized reading' (duration: 216.449245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:06.384924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.941200783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-05T05:21:06.384937Z","caller":"traceutil/trace.go:171","msg":"trace[1687879900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:627; }","duration":"2.941240681s","start":"2026-02-05T05:21:03.443692Z","end":"2026-02-05T05:21:06.384933Z","steps":["trace[1687879900] 'agreement among raft nodes before linearized reading' (duration: 2.941204063s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:06.384949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:03.443678Z","time spent":"2.941267939s","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-05T05:21:06.385051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.046211047s","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-05T05:21:06.385071Z","caller":"traceutil/trace.go:171","msg":"trace[1510586058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"3.046258054s","start":"2026-02-05T05:21:03.338805Z","end":"2026-02-05T05:21:06.385063Z","steps":["trace[1510586058] 'agreement among raft nodes before linearized reading' (duration: 3.046197597s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:06.385103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:03.338797Z","time spent":"3.046300452s","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-05T05:21:19.501921Z","caller":"traceutil/trace.go:171","msg":"trace[2093960013] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"115.378247ms","start":"2026-02-05T05:21:19.386521Z","end":"2026-02-05T05:21:19.5019Z","steps":["trace[2093960013] 'process raft request' (duration: 115.254131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:26.70728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.587431ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-05T05:21:26.707349Z","caller":"traceutil/trace.go:171","msg":"trace[1214479748] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:822; }","duration":"120.2975ms","start":"2026-02-05T05:21:26.587041Z","end":"2026-02-05T05:21:26.707339Z","steps":["trace[1214479748] 'read index received' (duration: 3.883181ms)","trace[1214479748] 'applied index is now lower than readState.Index' (duration: 116.413399ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:26.707568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.523447ms","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-05T05:21:26.707589Z","caller":"traceutil/trace.go:171","msg":"trace[1098976898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"120.568966ms","start":"2026-02-05T05:21:26.587013Z","end":"2026-02-05T05:21:26.707582Z","steps":["trace[1098976898] 'agreement among raft nodes before linearized reading' (duration: 120.478208ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:26.707688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.386262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:26.707701Z","caller":"traceutil/trace.go:171","msg":"trace[1118446280] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:792; }","duration":"117.415221ms","start":"2026-02-05T05:21:26.590282Z","end":"2026-02-05T05:21:26.707697Z","steps":["trace[1118446280] 'agreement among raft nodes before linearized reading' (duration: 117.390601ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:26.922175Z","caller":"traceutil/trace.go:171","msg":"trace[411439661] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"205.81485ms","start":"2026-02-05T05:21:26.71634Z","end":"2026-02-05T05:21:26.922155Z","steps":["trace[411439661] 'process raft request' (duration: 205.497666ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:26.922849Z","caller":"traceutil/trace.go:171","msg":"trace[1569824923] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"208.073182ms","start":"2026-02-05T05:21:26.714765Z","end":"2026-02-05T05:21:26.922838Z","steps":["trace[1569824923] 'process raft request' (duration: 180.459416ms)","trace[1569824923] 'compare' (duration: 26.511205ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:26.923381Z","caller":"traceutil/trace.go:171","msg":"trace[1032156550] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"205.899011ms","start":"2026-02-05T05:21:26.717473Z","end":"2026-02-05T05:21:26.923372Z","steps":["trace[1032156550] 'process raft request' (duration: 204.397876ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:28.623656Z","caller":"traceutil/trace.go:171","msg":"trace[1079032764] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"107.251976ms","start":"2026-02-05T05:21:28.516385Z","end":"2026-02-05T05:21:28.623637Z","steps":["trace[1079032764] 'process raft request' (duration: 107.133858ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:29.021286Z","caller":"traceutil/trace.go:171","msg":"trace[877379694] transaction","detail":"{read_only:false; number_of_response:1; response_revision:800; }","duration":"102.013316ms","start":"2026-02-05T05:21:28.919261Z","end":"2026-02-05T05:21:29.021274Z","steps":["trace[877379694] 'process raft request' (duration: 98.061297ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:30.067507Z","caller":"traceutil/trace.go:171","msg":"trace[2050318170] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"105.192963ms","start":"2026-02-05T05:21:29.962291Z","end":"2026-02-05T05:21:30.067484Z","steps":["trace[2050318170] 'process raft request' (duration: 105.068334ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:30.752307Z","caller":"traceutil/trace.go:171","msg":"trace[479390520] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"118.989467ms","start":"2026-02-05T05:21:30.633285Z","end":"2026-02-05T05:21:30.752275Z","steps":["trace[479390520] 'process raft request' (duration: 118.836199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:01.238462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.178853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-05T05:22:01.238518Z","caller":"traceutil/trace.go:171","msg":"trace[681216245] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:894; }","duration":"114.258744ms","start":"2026-02-05T05:22:01.124247Z","end":"2026-02-05T05:22:01.238506Z","steps":["trace[681216245] 'range keys from in-memory index tree' (duration: 114.128161ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:01.60027Z","caller":"traceutil/trace.go:171","msg":"trace[499524651] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"126.08047ms","start":"2026-02-05T05:22:01.474172Z","end":"2026-02-05T05:22:01.600253Z","steps":["trace[499524651] 'process raft request' (duration: 35.619045ms)","trace[499524651] 'compare' (duration: 90.378353ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:23.611939Z","caller":"traceutil/trace.go:171","msg":"trace[1531417833] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1026; }","duration":"209.329114ms","start":"2026-02-05T05:22:23.402578Z","end":"2026-02-05T05:22:23.611907Z","steps":["trace[1531417833] 'read index received' (duration: 132.236886ms)","trace[1531417833] 'applied index is now lower than readState.Index' (duration: 77.090958ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:23.612476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.873066ms","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-05T05:22:23.615603Z","caller":"traceutil/trace.go:171","msg":"trace[1518009324] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:983; }","duration":"213.029544ms","start":"2026-02-05T05:22:23.40255Z","end":"2026-02-05T05:22:23.615579Z","steps":["trace[1518009324] 'agreement among raft nodes before linearized reading' (duration: 209.73227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:23.612652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.550531ms","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-02-05T05:22:23.613167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.833043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-05T05:22:23.613268Z","caller":"traceutil/trace.go:171","msg":"trace[1202324167] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"226.786412ms","start":"2026-02-05T05:22:23.386473Z","end":"2026-02-05T05:22:23.613259Z","steps":["trace[1202324167] 'process raft request' (duration: 148.397761ms)","trace[1202324167] 'compare' (duration: 76.908531ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:23.616056Z","caller":"traceutil/trace.go:171","msg":"trace[651023690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:983; }","duration":"123.073564ms","start":"2026-02-05T05:22:23.492972Z","end":"2026-02-05T05:22:23.616046Z","steps":["trace[651023690] 'agreement among raft nodes before linearized reading' (duration: 119.468818ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:23.616078Z","caller":"traceutil/trace.go:171","msg":"trace[2098911378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:983; }","duration":"106.762022ms","start":"2026-02-05T05:22:23.509312Z","end":"2026-02-05T05:22:23.616074Z","steps":["trace[2098911378] 'agreement among raft nodes before linearized reading' (duration: 103.791341ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:27.90495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.979534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-05T05:22:27.905008Z","caller":"traceutil/trace.go:171","msg":"trace[495575233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1000; }","duration":"101.081167ms","start":"2026-02-05T05:22:27.803913Z","end":"2026-02-05T05:22:27.904994Z","steps":["trace[495575233] 'range keys from in-memory index tree' (duration: 100.818036ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:29.83602Z","caller":"traceutil/trace.go:171","msg":"trace[321274081] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"103.422009ms","start":"2026-02-05T05:22:29.732572Z","end":"2026-02-05T05:22:29.835994Z","steps":["trace[321274081] 'process raft request' (duration: 13.096177ms)","trace[321274081] 'compare' (duration: 90.225317ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:30.669668Z","caller":"traceutil/trace.go:171","msg":"trace[570921664] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"107.669487ms","start":"2026-02-05T05:22:30.561979Z","end":"2026-02-05T05:22:30.669648Z","steps":["trace[570921664] 'process raft request' (duration: 107.555342ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:31.575312Z","caller":"traceutil/trace.go:171","msg":"trace[1430545799] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"176.946568ms","start":"2026-02-05T05:22:31.398307Z","end":"2026-02-05T05:22:31.575253Z","steps":["trace[1430545799] 'process raft request' (duration: 176.78965ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:31.920578Z","caller":"traceutil/trace.go:171","msg":"trace[1183990267] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"163.524999ms","start":"2026-02-05T05:22:31.757026Z","end":"2026-02-05T05:22:31.920551Z","steps":["trace[1183990267] 'process raft request' (duration: 143.788936ms)","trace[1183990267] 'compare' (duration: 19.357966ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:32.102066Z","caller":"traceutil/trace.go:171","msg":"trace[1252393595] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"106.124553ms","start":"2026-02-05T05:22:31.995901Z","end":"2026-02-05T05:22:32.102026Z","steps":["trace[1252393595] 'process raft request' (duration: 49.246684ms)","trace[1252393595] 'compare' (duration: 56.740553ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:33.119399Z","caller":"traceutil/trace.go:171","msg":"trace[1601527943] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"137.229897ms","start":"2026-02-05T05:22:32.98214Z","end":"2026-02-05T05:22:33.11937Z","steps":["trace[1601527943] 'process raft request' (duration: 137.07251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:34.759809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.82237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:34.760105Z","caller":"traceutil/trace.go:171","msg":"trace[1159382885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1024; }","duration":"590.086082ms","start":"2026-02-05T05:22:34.169925Z","end":"2026-02-05T05:22:34.760011Z","steps":["trace[1159382885] 'range keys from in-memory index tree' (duration: 589.758837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:34.760233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:34.169918Z","time spent":"590.300332ms","remote":"127.0.0.1:56568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T05:22:34.760753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.352302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-05T05:22:34.760836Z","caller":"traceutil/trace.go:171","msg":"trace[1204439723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1024; }","duration":"653.488359ms","start":"2026-02-05T05:22:34.107327Z","end":"2026-02-05T05:22:34.760816Z","steps":["trace[1204439723] 'range keys from in-memory index tree' (duration: 653.173074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:34.761127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:34.107307Z","time spent":"653.671877ms","remote":"127.0.0.1:56816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-05T05:22:39.787368Z","caller":"traceutil/trace.go:171","msg":"trace[6657388] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"129.987861ms","start":"2026-02-05T05:22:39.657353Z","end":"2026-02-05T05:22:39.787341Z","steps":["trace[6657388] 'process raft request' (duration: 129.884716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:54.168465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.317641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-node-lease/\" range_end:\"/registry/events/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:54.168523Z","caller":"traceutil/trace.go:171","msg":"trace[2092320243] range","detail":"{range_begin:/registry/events/kube-node-lease/; range_end:/registry/events/kube-node-lease0; response_count:0; response_revision:1082; }","duration":"107.405506ms","start":"2026-02-05T05:22:54.061103Z","end":"2026-02-05T05:22:54.168508Z","steps":["trace[2092320243] 'range keys from in-memory index tree' (duration: 107.269718ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:59.110009Z","caller":"traceutil/trace.go:171","msg":"trace[1696938295] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"106.63462ms","start":"2026-02-05T05:22:59.003322Z","end":"2026-02-05T05:22:59.109957Z","steps":["trace[1696938295] 'process raft request' (duration: 54.727597ms)","trace[1696938295] 'compare' (duration: 51.423525ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:59.330202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.205613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:790"} {"level":"info","ts":"2026-02-05T05:22:59.330423Z","caller":"traceutil/trace.go:171","msg":"trace[1630825067] range","detail":"{range_begin:/registry/rolebindings/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:1097; }","duration":"108.433165ms","start":"2026-02-05T05:22:59.221947Z","end":"2026-02-05T05:22:59.33038Z","steps":["trace[1630825067] 'range keys from in-memory index tree' (duration: 107.926516ms)"],"step_count":1}