{"level":"warn","ts":"2026-02-11T02:20:28.100415Z","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-11T02:20:28.100501Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.229:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.229:2380","--initial-cluster=instance=https://199.19.213.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.229: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-11T02:20:28.100702Z","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-11T02:20:28.100718Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.229:2380"]} {"level":"info","ts":"2026-02-11T02:20:28.100794Z","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-11T02:20:28.101528Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.229:2379"]} {"level":"info","ts":"2026-02-11T02:20:28.101652Z","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://199.19.213.229:2380"],"listen-peer-urls":["https://199.19.213.229:2380"],"advertise-client-urls":["https://199.19.213.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.229: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-11T02:20:28.107567Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.634305ms"} {"level":"info","ts":"2026-02-11T02:20:28.119337Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"98aaa0557ab926b1","cluster-id":"250cc9bd258bffbf"} {"level":"info","ts":"2026-02-11T02:20:28.121027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T02:20:28.12106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 became follower at term 0"} {"level":"info","ts":"2026-02-11T02:20:28.12447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 98aaa0557ab926b1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-11T02:20:28.124555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 became follower at term 1"} {"level":"info","ts":"2026-02-11T02:20:28.124641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 switched to configuration voters=(11000781328797476529)"} {"level":"warn","ts":"2026-02-11T02:20:28.201736Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T02:20:28.211491Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T02:20:28.266739Z","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-11T02:20:28.317983Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"98aaa0557ab926b1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-11T02:20:28.318129Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"98aaa0557ab926b1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-11T02:20:28.318514Z","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-11T02:20:28.318566Z","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-11T02:20:28.318589Z","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-11T02:20:28.331798Z","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-11T02:20:28.332041Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"98aaa0557ab926b1","initial-advertise-peer-urls":["https://199.19.213.229:2380"],"listen-peer-urls":["https://199.19.213.229:2380"],"advertise-client-urls":["https://199.19.213.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-11T02:20:28.33208Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T02:20:28.33216Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.229:2380"} {"level":"info","ts":"2026-02-11T02:20:28.332185Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.229:2380"} {"level":"info","ts":"2026-02-11T02:20:28.333058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 switched to configuration voters=(11000781328797476529)"} {"level":"info","ts":"2026-02-11T02:20:28.333173Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"250cc9bd258bffbf","local-member-id":"98aaa0557ab926b1","added-peer-id":"98aaa0557ab926b1","added-peer-peer-urls":["https://199.19.213.229:2380"]} {"level":"info","ts":"2026-02-11T02:20:28.826722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T02:20:28.826811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T02:20:28.826844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 received MsgPreVoteResp from 98aaa0557ab926b1 at term 1"} {"level":"info","ts":"2026-02-11T02:20:28.826864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 became candidate at term 2"} {"level":"info","ts":"2026-02-11T02:20:28.826894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 received MsgVoteResp from 98aaa0557ab926b1 at term 2"} {"level":"info","ts":"2026-02-11T02:20:28.826917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"98aaa0557ab926b1 became leader at term 2"} {"level":"info","ts":"2026-02-11T02:20:28.826933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 98aaa0557ab926b1 elected leader 98aaa0557ab926b1 at term 2"} {"level":"info","ts":"2026-02-11T02:20:28.838759Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:20:28.842531Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"98aaa0557ab926b1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.229:2379]}","request-path":"/0/members/98aaa0557ab926b1/attributes","cluster-id":"250cc9bd258bffbf","publish-timeout":"7s"} {"level":"info","ts":"2026-02-11T02:20:28.842658Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T02:20:28.842819Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T02:20:28.842945Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"250cc9bd258bffbf","local-member-id":"98aaa0557ab926b1","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:20:28.843001Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:20:28.843018Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:20:28.843064Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T02:20:28.843075Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T02:20:28.846672Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-11T02:20:28.846759Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.229:2379"} {"level":"info","ts":"2026-02-11T02:20:34.054623Z","caller":"traceutil/trace.go:171","msg":"trace[1117458186] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"116.133711ms","start":"2026-02-11T02:20:33.938464Z","end":"2026-02-11T02:20:34.054598Z","steps":["trace[1117458186] 'process raft request' (duration: 115.927324ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:34.054829Z","caller":"traceutil/trace.go:171","msg":"trace[1039293189] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"141.631802ms","start":"2026-02-11T02:20:33.913189Z","end":"2026-02-11T02:20:34.054821Z","steps":["trace[1039293189] 'process raft request' (duration: 87.549928ms)","trace[1039293189] 'compare' (duration: 53.525453ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:34.055004Z","caller":"traceutil/trace.go:171","msg":"trace[47717178] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:248; }","duration":"118.937457ms","start":"2026-02-11T02:20:33.936058Z","end":"2026-02-11T02:20:34.054995Z","steps":["trace[47717178] 'read index received' (duration: 23.267086ms)","trace[47717178] 'applied index is now lower than readState.Index' (duration: 95.669081ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:34.055154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.070202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-11T02:20:34.055178Z","caller":"traceutil/trace.go:171","msg":"trace[1027742225] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:245; }","duration":"119.144435ms","start":"2026-02-11T02:20:33.936027Z","end":"2026-02-11T02:20:34.055172Z","steps":["trace[1027742225] 'agreement among raft nodes before linearized reading' (duration: 119.0127ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:34.119865Z","caller":"traceutil/trace.go:171","msg":"trace[1723935231] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"107.267673ms","start":"2026-02-11T02:20:34.012565Z","end":"2026-02-11T02:20:34.119833Z","steps":["trace[1723935231] 'process raft request' (duration: 107.200741ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:34.120086Z","caller":"traceutil/trace.go:171","msg":"trace[825253855] transaction","detail":"{read_only:false; number_of_response:0; response_revision:245; }","duration":"108.806771ms","start":"2026-02-11T02:20:34.011252Z","end":"2026-02-11T02:20:34.120058Z","steps":["trace[825253855] 'process raft request' (duration: 108.459718ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:34.120266Z","caller":"traceutil/trace.go:171","msg":"trace[286696300] transaction","detail":"{read_only:false; number_of_response:0; response_revision:245; }","duration":"117.404561ms","start":"2026-02-11T02:20:34.00285Z","end":"2026-02-11T02:20:34.120255Z","steps":["trace[286696300] 'process raft request' (duration: 116.793268ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:34.250728Z","caller":"traceutil/trace.go:171","msg":"trace[1344464372] transaction","detail":"{read_only:false; number_of_response:0; response_revision:246; }","duration":"235.932123ms","start":"2026-02-11T02:20:34.014732Z","end":"2026-02-11T02:20:34.250664Z","steps":["trace[1344464372] 'process raft request' (duration: 173.311442ms)","trace[1344464372] 'compare' (duration: 62.464945ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:34.250994Z","caller":"traceutil/trace.go:171","msg":"trace[35655994] linearizableReadLoop","detail":"{readStateIndex:258; appliedIndex:252; }","duration":"195.774999ms","start":"2026-02-11T02:20:34.055018Z","end":"2026-02-11T02:20:34.250793Z","steps":["trace[35655994] 'read index received' (duration: 64.563804ms)","trace[35655994] 'applied index is now lower than readState.Index' (duration: 131.210565ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:34.25132Z","caller":"traceutil/trace.go:171","msg":"trace[1423616460] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"235.530889ms","start":"2026-02-11T02:20:34.015779Z","end":"2026-02-11T02:20:34.25131Z","steps":["trace[1423616460] 'process raft request' (duration: 234.824973ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:34.251731Z","caller":"traceutil/trace.go:171","msg":"trace[2131493946] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"191.488189ms","start":"2026-02-11T02:20:34.060193Z","end":"2026-02-11T02:20:34.251681Z","steps":["trace[2131493946] 'process raft request' (duration: 190.568135ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:34.251591Z","caller":"traceutil/trace.go:171","msg":"trace[1509449246] transaction","detail":"{read_only:false; number_of_response:0; response_revision:247; }","duration":"235.334312ms","start":"2026-02-11T02:20:34.016236Z","end":"2026-02-11T02:20:34.251571Z","steps":["trace[1509449246] 'process raft request' (duration: 234.430068ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:34.251887Z","caller":"traceutil/trace.go:171","msg":"trace[1699967826] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"192.318952ms","start":"2026-02-11T02:20:34.059554Z","end":"2026-02-11T02:20:34.251873Z","steps":["trace[1699967826] 'process raft request' (duration: 191.160928ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:34.25202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.479216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:34.253417Z","caller":"traceutil/trace.go:171","msg":"trace[1467349796] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:0; response_revision:249; }","duration":"193.916059ms","start":"2026-02-11T02:20:34.05949Z","end":"2026-02-11T02:20:34.253406Z","steps":["trace[1467349796] 'agreement among raft nodes before linearized reading' (duration: 192.429234ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:34.25209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.639031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3705"} {"level":"info","ts":"2026-02-11T02:20:34.253755Z","caller":"traceutil/trace.go:171","msg":"trace[97418220] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:249; }","duration":"317.308733ms","start":"2026-02-11T02:20:33.936434Z","end":"2026-02-11T02:20:34.253743Z","steps":["trace[97418220] 'agreement among raft nodes before linearized reading' (duration: 315.60644ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:34.254903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:33.936428Z","time spent":"318.462476ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3728,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-11T02:20:34.25213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.192968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3705"} {"level":"info","ts":"2026-02-11T02:20:34.255527Z","caller":"traceutil/trace.go:171","msg":"trace[624727203] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:249; }","duration":"133.596055ms","start":"2026-02-11T02:20:34.12192Z","end":"2026-02-11T02:20:34.255517Z","steps":["trace[624727203] 'agreement among raft nodes before linearized reading' (duration: 130.183577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:34.252167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.342483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3444"} {"level":"info","ts":"2026-02-11T02:20:34.255764Z","caller":"traceutil/trace.go:171","msg":"trace[1290704287] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:249; }","duration":"133.956707ms","start":"2026-02-11T02:20:34.121798Z","end":"2026-02-11T02:20:34.255755Z","steps":["trace[1290704287] 'agreement among raft nodes before linearized reading' (duration: 130.342834ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:35.117916Z","caller":"traceutil/trace.go:171","msg":"trace[539229491] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"102.863325ms","start":"2026-02-11T02:20:35.01503Z","end":"2026-02-11T02:20:35.117894Z","steps":["trace[539229491] 'process raft request' (duration: 70.868178ms)","trace[539229491] 'compare' (duration: 31.792141ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:35.280895Z","caller":"traceutil/trace.go:171","msg":"trace[447567132] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"113.570039ms","start":"2026-02-11T02:20:35.167309Z","end":"2026-02-11T02:20:35.280879Z","steps":["trace[447567132] 'process raft request' (duration: 51.831307ms)","trace[447567132] 'compare' (duration: 61.466442ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:36.339619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.277174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:36.339725Z","caller":"traceutil/trace.go:171","msg":"trace[1435487369] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:0; response_revision:289; }","duration":"176.42262ms","start":"2026-02-11T02:20:36.163284Z","end":"2026-02-11T02:20:36.339707Z","steps":["trace[1435487369] 'range keys from in-memory index tree' (duration: 176.221672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:38.875188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.832093ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:20:38.875589Z","caller":"traceutil/trace.go:171","msg":"trace[643602655] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"219.723145ms","start":"2026-02-11T02:20:38.65584Z","end":"2026-02-11T02:20:38.875563Z","steps":["trace[643602655] 'process raft request' (duration: 82.341148ms)","trace[643602655] 'compare' (duration: 135.687817ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:38.879368Z","caller":"traceutil/trace.go:171","msg":"trace[809334357] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"223.395466ms","start":"2026-02-11T02:20:38.655956Z","end":"2026-02-11T02:20:38.879351Z","steps":["trace[809334357] 'process raft request' (duration: 222.085989ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:38.880905Z","caller":"traceutil/trace.go:171","msg":"trace[1060679352] linearizableReadLoop","detail":"{readStateIndex:333; appliedIndex:330; }","duration":"216.538422ms","start":"2026-02-11T02:20:38.664352Z","end":"2026-02-11T02:20:38.880891Z","steps":["trace[1060679352] 'read index received' (duration: 73.930769ms)","trace[1060679352] 'applied index is now lower than readState.Index' (duration: 142.606623ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:38.881417Z","caller":"traceutil/trace.go:171","msg":"trace[1929275128] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"225.343855ms","start":"2026-02-11T02:20:38.656062Z","end":"2026-02-11T02:20:38.881406Z","steps":["trace[1929275128] 'process raft request' (duration: 224.725712ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:38.881484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.135383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-11T02:20:38.886278Z","caller":"traceutil/trace.go:171","msg":"trace[468594792] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:322; }","duration":"221.957114ms","start":"2026-02-11T02:20:38.66431Z","end":"2026-02-11T02:20:38.886268Z","steps":["trace[468594792] 'agreement among raft nodes before linearized reading' (duration: 217.132313ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:38.881737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.588581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-11T02:20:38.886365Z","caller":"traceutil/trace.go:171","msg":"trace[403977478] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:322; }","duration":"172.251957ms","start":"2026-02-11T02:20:38.714106Z","end":"2026-02-11T02:20:38.886358Z","steps":["trace[403977478] 'agreement among raft nodes before linearized reading' (duration: 167.55747ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:38.882195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.840876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-11T02:20:38.886508Z","caller":"traceutil/trace.go:171","msg":"trace[1711104102] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:322; }","duration":"121.19144ms","start":"2026-02-11T02:20:38.765308Z","end":"2026-02-11T02:20:38.886499Z","steps":["trace[1711104102] 'agreement among raft nodes before linearized reading' (duration: 116.853646ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:42.515003Z","caller":"traceutil/trace.go:171","msg":"trace[710997506] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"277.755238ms","start":"2026-02-11T02:20:42.237225Z","end":"2026-02-11T02:20:42.51498Z","steps":["trace[710997506] 'process raft request' (duration: 277.603292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:48.547373Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2788181488107937668,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T02:20:48.643749Z","caller":"traceutil/trace.go:171","msg":"trace[671104429] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"916.822556ms","start":"2026-02-11T02:20:47.726902Z","end":"2026-02-11T02:20:48.643724Z","steps":["trace[671104429] 'process raft request' (duration: 916.652141ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:48.643904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:47.726882Z","time spent":"916.94284ms","remote":"127.0.0.1:35016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:48.644443Z","caller":"traceutil/trace.go:171","msg":"trace[1868154545] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:431; }","duration":"597.580623ms","start":"2026-02-11T02:20:48.046849Z","end":"2026-02-11T02:20:48.644429Z","steps":["trace[1868154545] 'read index received' (duration: 597.576163ms)","trace[1868154545] 'applied index is now lower than readState.Index' (duration: 3.6µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:48.644561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.703557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:48.644593Z","caller":"traceutil/trace.go:171","msg":"trace[1599908077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:415; }","duration":"597.768979ms","start":"2026-02-11T02:20:48.046812Z","end":"2026-02-11T02:20:48.644581Z","steps":["trace[1599908077] 'agreement among raft nodes before linearized reading' (duration: 597.698167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:48.644621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:48.046794Z","time spent":"597.820621ms","remote":"127.0.0.1:34738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-11T02:20:58.722807Z","caller":"traceutil/trace.go:171","msg":"trace[213015579] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"115.251885ms","start":"2026-02-11T02:20:58.607541Z","end":"2026-02-11T02:20:58.722793Z","steps":["trace[213015579] 'process raft request' (duration: 115.120711ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:59.463268Z","caller":"traceutil/trace.go:171","msg":"trace[600830622] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"114.993114ms","start":"2026-02-11T02:20:59.348232Z","end":"2026-02-11T02:20:59.463225Z","steps":["trace[600830622] 'process raft request' (duration: 101.165792ms)","trace[600830622] 'compare' (duration: 13.424711ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:59.843192Z","caller":"traceutil/trace.go:171","msg":"trace[2069601007] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"144.178032ms","start":"2026-02-11T02:20:59.698992Z","end":"2026-02-11T02:20:59.84317Z","steps":["trace[2069601007] 'process raft request' (duration: 144.10442ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:59.843237Z","caller":"traceutil/trace.go:171","msg":"trace[1697847543] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"144.706037ms","start":"2026-02-11T02:20:59.698511Z","end":"2026-02-11T02:20:59.843217Z","steps":["trace[1697847543] 'process raft request' (duration: 124.283708ms)","trace[1697847543] 'compare' (duration: 20.134111ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:21:01.198271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.941354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-11T02:21:01.198333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.907433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T02:21:01.198381Z","caller":"traceutil/trace.go:171","msg":"trace[1398072396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:514; }","duration":"205.057277ms","start":"2026-02-11T02:21:00.993275Z","end":"2026-02-11T02:21:01.198332Z","steps":["trace[1398072396] 'range keys from in-memory index tree' (duration: 204.696107ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:01.198398Z","caller":"traceutil/trace.go:171","msg":"trace[804269023] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"204.989216ms","start":"2026-02-11T02:21:00.993391Z","end":"2026-02-11T02:21:01.19838Z","steps":["trace[804269023] 'range keys from in-memory index tree' (duration: 204.7851ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:01.198879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.52275ms","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-11T02:21:01.198919Z","caller":"traceutil/trace.go:171","msg":"trace[612073610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"205.568151ms","start":"2026-02-11T02:21:00.993342Z","end":"2026-02-11T02:21:01.19891Z","steps":["trace[612073610] 'range keys from in-memory index tree' (duration: 205.438087ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:01.201107Z","caller":"traceutil/trace.go:171","msg":"trace[1110746900] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"145.154558ms","start":"2026-02-11T02:21:01.055942Z","end":"2026-02-11T02:21:01.201097Z","steps":["trace[1110746900] 'read index received' (duration: 144.127609ms)","trace[1110746900] 'applied index is now lower than readState.Index' (duration: 1.026399ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:21:01.201601Z","caller":"traceutil/trace.go:171","msg":"trace[1863235131] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"158.996722ms","start":"2026-02-11T02:21:01.042477Z","end":"2026-02-11T02:21:01.201474Z","steps":["trace[1863235131] 'process raft request' (duration: 158.293603ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:01.201704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.755824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:21:01.201727Z","caller":"traceutil/trace.go:171","msg":"trace[1672426621] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:515; }","duration":"145.799795ms","start":"2026-02-11T02:21:01.055919Z","end":"2026-02-11T02:21:01.201719Z","steps":["trace[1672426621] 'agreement among raft nodes before linearized reading' (duration: 145.762454ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:01.668173Z","caller":"traceutil/trace.go:171","msg":"trace[1730460872] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"337.744404ms","start":"2026-02-11T02:21:01.330415Z","end":"2026-02-11T02:21:01.668159Z","steps":["trace[1730460872] 'process raft request' (duration: 331.690226ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:01.668248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:21:01.330387Z","time spent":"337.825096ms","remote":"127.0.0.1:34768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T02:21:01.668415Z","caller":"traceutil/trace.go:171","msg":"trace[1433262477] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:537; }","duration":"138.652927ms","start":"2026-02-11T02:21:01.529736Z","end":"2026-02-11T02:21:01.668389Z","steps":["trace[1433262477] 'read index received' (duration: 132.618399ms)","trace[1433262477] 'applied index is now lower than readState.Index' (duration: 6.033878ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:21:01.66848Z","caller":"traceutil/trace.go:171","msg":"trace[136648303] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"118.197557ms","start":"2026-02-11T02:21:01.550277Z","end":"2026-02-11T02:21:01.668474Z","steps":["trace[136648303] 'process raft request' (duration: 117.898359ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:01.668541Z","caller":"traceutil/trace.go:171","msg":"trace[985474513] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"262.622155ms","start":"2026-02-11T02:21:01.405915Z","end":"2026-02-11T02:21:01.668537Z","steps":["trace[985474513] 'process raft request' (duration: 262.170602ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:01.668754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.010346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-11T02:21:01.668781Z","caller":"traceutil/trace.go:171","msg":"trace[859334206] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:522; }","duration":"139.073858ms","start":"2026-02-11T02:21:01.529699Z","end":"2026-02-11T02:21:01.668773Z","steps":["trace[859334206] 'agreement among raft nodes before linearized reading' (duration: 138.965175ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:07.632792Z","caller":"traceutil/trace.go:171","msg":"trace[465944078] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"177.759508ms","start":"2026-02-11T02:21:07.455019Z","end":"2026-02-11T02:21:07.632779Z","steps":["trace[465944078] 'read index received' (duration: 167.965892ms)","trace[465944078] 'applied index is now lower than readState.Index' (duration: 9.793076ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:21:07.632872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.84668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T02:21:07.632889Z","caller":"traceutil/trace.go:171","msg":"trace[686264101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:566; }","duration":"177.872661ms","start":"2026-02-11T02:21:07.45501Z","end":"2026-02-11T02:21:07.632883Z","steps":["trace[686264101] 'agreement among raft nodes before linearized reading' (duration: 177.82041ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:07.633008Z","caller":"traceutil/trace.go:171","msg":"trace[1101695223] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"256.254366ms","start":"2026-02-11T02:21:07.376748Z","end":"2026-02-11T02:21:07.633003Z","steps":["trace[1101695223] 'process raft request' (duration: 246.273085ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:09.53475Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2788181488107938010,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T02:21:10.03535Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2788181488107938010,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T02:21:10.275172Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.417870834s","expected-duration":"1s"} {"level":"info","ts":"2026-02-11T02:21:10.275564Z","caller":"traceutil/trace.go:171","msg":"trace[1761879497] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"1.241617445s","start":"2026-02-11T02:21:09.033928Z","end":"2026-02-11T02:21:10.275545Z","steps":["trace[1761879497] 'read index received' (duration: 1.241358868s)","trace[1761879497] 'applied index is now lower than readState.Index' (duration: 257.787µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:21:10.27568Z","caller":"traceutil/trace.go:171","msg":"trace[1749014456] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"1.418428788s","start":"2026-02-11T02:21:08.85723Z","end":"2026-02-11T02:21:10.275659Z","steps":["trace[1749014456] 'process raft request' (duration: 1.418162101s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:10.275774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:21:08.85722Z","time spent":"1.41848059s","remote":"127.0.0.1:35016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:21:10.275878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23015946s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:21:10.275914Z","caller":"traceutil/trace.go:171","msg":"trace[696500652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"1.230215792s","start":"2026-02-11T02:21:09.045685Z","end":"2026-02-11T02:21:10.275901Z","steps":["trace[696500652] 'agreement among raft nodes before linearized reading' (duration: 1.23015089s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:10.275942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:21:09.045677Z","time spent":"1.230260683s","remote":"127.0.0.1:34738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T02:21:10.276115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242173969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p7k7r\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-11T02:21:10.276136Z","caller":"traceutil/trace.go:171","msg":"trace[794725134] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p7k7r; range_end:; response_count:1; response_revision:572; }","duration":"1.242223431s","start":"2026-02-11T02:21:09.033905Z","end":"2026-02-11T02:21:10.276129Z","steps":["trace[794725134] 'agreement among raft nodes before linearized reading' (duration: 1.242169179s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:10.276153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:21:09.033882Z","time spent":"1.242267241s","remote":"127.0.0.1:34922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-p7k7r\" "} {"level":"warn","ts":"2026-02-11T02:21:10.276192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.328901ms","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-11T02:21:10.276233Z","caller":"traceutil/trace.go:171","msg":"trace[248969288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:572; }","duration":"639.378863ms","start":"2026-02-11T02:21:09.636832Z","end":"2026-02-11T02:21:10.276211Z","steps":["trace[248969288] 'agreement among raft nodes before linearized reading' (duration: 639.26624ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:10.276257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:21:09.636819Z","time spent":"639.432574ms","remote":"127.0.0.1:35016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T02:21:10.276324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.905743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T02:21:10.276344Z","caller":"traceutil/trace.go:171","msg":"trace[294988467] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"945.973764ms","start":"2026-02-11T02:21:09.330365Z","end":"2026-02-11T02:21:10.276339Z","steps":["trace[294988467] 'agreement among raft nodes before linearized reading' (duration: 945.893942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:10.276361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:21:09.330344Z","time spent":"946.012976ms","remote":"127.0.0.1:35016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-11T02:21:10.276435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.591235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T02:21:10.276472Z","caller":"traceutil/trace.go:171","msg":"trace[337424300] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:572; }","duration":"572.651657ms","start":"2026-02-11T02:21:09.703814Z","end":"2026-02-11T02:21:10.276466Z","steps":["trace[337424300] 'agreement among raft nodes before linearized reading' (duration: 572.549205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:10.276501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:21:09.703807Z","time spent":"572.689568ms","remote":"127.0.0.1:35016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-11T02:21:10.276667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.696185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T02:21:10.276688Z","caller":"traceutil/trace.go:171","msg":"trace[926493001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"584.752727ms","start":"2026-02-11T02:21:09.691929Z","end":"2026-02-11T02:21:10.276682Z","steps":["trace[926493001] 'agreement among raft nodes before linearized reading' (duration: 584.696496ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:10.276706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:21:09.691919Z","time spent":"584.782378ms","remote":"127.0.0.1:35016","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-11T02:21:10.507117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.212641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:21:10.507196Z","caller":"traceutil/trace.go:171","msg":"trace[329539601] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"214.914073ms","start":"2026-02-11T02:21:10.292271Z","end":"2026-02-11T02:21:10.507185Z","steps":["trace[329539601] 'read index received' (duration: 19.580649ms)","trace[329539601] 'applied index is now lower than readState.Index' (duration: 195.332323ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:21:10.507277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.005615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:21:10.507296Z","caller":"traceutil/trace.go:171","msg":"trace[1202381824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"215.045525ms","start":"2026-02-11T02:21:10.292243Z","end":"2026-02-11T02:21:10.507288Z","steps":["trace[1202381824] 'agreement among raft nodes before linearized reading' (duration: 214.972693ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:10.507388Z","caller":"traceutil/trace.go:171","msg":"trace[934850974] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"215.439995ms","start":"2026-02-11T02:21:10.29193Z","end":"2026-02-11T02:21:10.50737Z","steps":["trace[934850974] 'process raft request' (duration: 19.906427ms)","trace[934850974] 'compare' (duration: 195.105968ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:21:10.516215Z","caller":"traceutil/trace.go:171","msg":"trace[1959699099] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"218.941145ms","start":"2026-02-11T02:21:10.29726Z","end":"2026-02-11T02:21:10.516202Z","steps":["trace[1959699099] 'process raft request' (duration: 218.896404ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:10.516586Z","caller":"traceutil/trace.go:171","msg":"trace[1447318914] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"221.053118ms","start":"2026-02-11T02:21:10.295522Z","end":"2026-02-11T02:21:10.516575Z","steps":["trace[1447318914] 'process raft request' (duration: 220.573046ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:10.516894Z","caller":"traceutil/trace.go:171","msg":"trace[823940532] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"224.548628ms","start":"2026-02-11T02:21:10.292336Z","end":"2026-02-11T02:21:10.516884Z","steps":["trace[823940532] 'process raft request' (duration: 223.656405ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:10.517125Z","caller":"traceutil/trace.go:171","msg":"trace[1577625239] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"219.90347ms","start":"2026-02-11T02:21:10.297211Z","end":"2026-02-11T02:21:10.517115Z","steps":["trace[1577625239] 'process raft request' (duration: 218.913084ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:22.021409Z","caller":"traceutil/trace.go:171","msg":"trace[211615474] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"107.256035ms","start":"2026-02-11T02:21:21.914138Z","end":"2026-02-11T02:21:22.021394Z","steps":["trace[211615474] 'process raft request' (duration: 71.27238ms)","trace[211615474] 'compare' (duration: 35.77302ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:21:42.835595Z","caller":"traceutil/trace.go:171","msg":"trace[595348840] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:803; }","duration":"165.858671ms","start":"2026-02-11T02:21:42.669718Z","end":"2026-02-11T02:21:42.835577Z","steps":["trace[595348840] 'read index received' (duration: 128.212502ms)","trace[595348840] 'applied index is now lower than readState.Index' (duration: 37.634789ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:21:42.835687Z","caller":"traceutil/trace.go:171","msg":"trace[446086315] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"173.286674ms","start":"2026-02-11T02:21:42.662391Z","end":"2026-02-11T02:21:42.835678Z","steps":["trace[446086315] 'process raft request' (duration: 135.612184ms)","trace[446086315] 'compare' (duration: 37.480776ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:21:42.835747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.693352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T02:21:42.83579Z","caller":"traceutil/trace.go:171","msg":"trace[620486346] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:775; }","duration":"143.749613ms","start":"2026-02-11T02:21:42.692029Z","end":"2026-02-11T02:21:42.835778Z","steps":["trace[620486346] 'agreement among raft nodes before linearized reading' (duration: 143.659561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:42.835862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.146396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T02:21:42.835873Z","caller":"traceutil/trace.go:171","msg":"trace[724392670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:775; }","duration":"166.193158ms","start":"2026-02-11T02:21:42.669676Z","end":"2026-02-11T02:21:42.835869Z","steps":["trace[724392670] 'agreement among raft nodes before linearized reading' (duration: 166.160227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:42.835924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.910025ms","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-11T02:21:42.835934Z","caller":"traceutil/trace.go:171","msg":"trace[349907815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"130.930595ms","start":"2026-02-11T02:21:42.705001Z","end":"2026-02-11T02:21:42.835931Z","steps":["trace[349907815] 'agreement among raft nodes before linearized reading' (duration: 130.899154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:21:42.836785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.855023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T02:21:42.836821Z","caller":"traceutil/trace.go:171","msg":"trace[743061946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:775; }","duration":"132.611306ms","start":"2026-02-11T02:21:42.704201Z","end":"2026-02-11T02:21:42.836812Z","steps":["trace[743061946] 'agreement among raft nodes before linearized reading' (duration: 131.792161ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:22:27.381982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.79998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-30bb733a-9bfd-466e-a9db-0e5f0d789919\" ","response":"range_response_count:1 size:3827"} {"level":"info","ts":"2026-02-11T02:22:27.382064Z","caller":"traceutil/trace.go:171","msg":"trace[1013768483] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-30bb733a-9bfd-466e-a9db-0e5f0d789919; range_end:; response_count:1; response_revision:922; }","duration":"125.919421ms","start":"2026-02-11T02:22:27.256126Z","end":"2026-02-11T02:22:27.382046Z","steps":["trace[1013768483] 'range keys from in-memory index tree' (duration: 125.647667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:22:33.447023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.422588ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:22:33.447153Z","caller":"traceutil/trace.go:171","msg":"trace[2065155363] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"193.750914ms","start":"2026-02-11T02:22:33.253381Z","end":"2026-02-11T02:22:33.447132Z","steps":["trace[2065155363] 'process raft request' (duration: 69.114673ms)","trace[2065155363] 'compare' (duration: 124.257035ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:22:33.48868Z","caller":"traceutil/trace.go:171","msg":"trace[1117269708] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"193.590672ms","start":"2026-02-11T02:22:33.295068Z","end":"2026-02-11T02:22:33.488658Z","steps":["trace[1117269708] 'process raft request' (duration: 193.527351ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:22:33.488845Z","caller":"traceutil/trace.go:171","msg":"trace[313424342] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"235.261314ms","start":"2026-02-11T02:22:33.253559Z","end":"2026-02-11T02:22:33.48882Z","steps":["trace[313424342] 'process raft request' (duration: 234.821858ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:22:33.489129Z","caller":"traceutil/trace.go:171","msg":"trace[2126067037] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"235.501568ms","start":"2026-02-11T02:22:33.253615Z","end":"2026-02-11T02:22:33.489116Z","steps":["trace[2126067037] 'process raft request' (duration: 234.873109ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:22:37.188903Z","caller":"traceutil/trace.go:171","msg":"trace[382385001] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"122.630792ms","start":"2026-02-11T02:22:37.066252Z","end":"2026-02-11T02:22:37.188883Z","steps":["trace[382385001] 'process raft request' (duration: 122.120715ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:22:37.294366Z","caller":"traceutil/trace.go:171","msg":"trace[2104479201] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"130.597783ms","start":"2026-02-11T02:22:37.163745Z","end":"2026-02-11T02:22:37.294343Z","steps":["trace[2104479201] 'process raft request' (duration: 67.584223ms)","trace[2104479201] 'compare' (duration: 62.409691ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:22:38.133784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.195559ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-11T02:22:38.1339Z","caller":"traceutil/trace.go:171","msg":"trace[926673877] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"658.785698ms","start":"2026-02-11T02:22:37.475092Z","end":"2026-02-11T02:22:38.133878Z","steps":["trace[926673877] 'read index received' (duration: 39.591µs)","trace[926673877] 'applied index is now lower than readState.Index' (duration: 658.743997ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:22:38.134551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.453147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T02:22:38.134653Z","caller":"traceutil/trace.go:171","msg":"trace[32261984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:967; }","duration":"659.528168ms","start":"2026-02-11T02:22:37.475052Z","end":"2026-02-11T02:22:38.13458Z","steps":["trace[32261984] 'agreement among raft nodes before linearized reading' (duration: 659.381156ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:22:38.134906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:22:37.475037Z","time spent":"659.851262ms","remote":"127.0.0.1:35016","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-11T02:22:38.135343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.374183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T02:22:38.135522Z","caller":"traceutil/trace.go:171","msg":"trace[30572354] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"623.596566ms","start":"2026-02-11T02:22:37.511904Z","end":"2026-02-11T02:22:38.135501Z","steps":["trace[30572354] 'agreement among raft nodes before linearized reading' (duration: 623.225982ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:22:38.135702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:22:37.511878Z","time spent":"623.808299ms","remote":"127.0.0.1:35016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-11T02:22:38.136212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.662674ms","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-11T02:22:38.136269Z","caller":"traceutil/trace.go:171","msg":"trace[2058094083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"592.750555ms","start":"2026-02-11T02:22:37.543505Z","end":"2026-02-11T02:22:38.136255Z","steps":["trace[2058094083] 'agreement among raft nodes before linearized reading' (duration: 592.602043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:22:38.1363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:22:37.543491Z","time spent":"592.800706ms","remote":"127.0.0.1:35016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}