{"level":"warn","ts":"2026-02-11T01:47:53.783185Z","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-11T01:47:53.783288Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-11T01:47:53.784074Z","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-11T01:47:53.784089Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-02-11T01:47:53.784147Z","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-11T01:47:53.785835Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]} {"level":"info","ts":"2026-02-11T01:47:53.785959Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-11T01:47:53.800114Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"13.842644ms"} {"level":"info","ts":"2026-02-11T01:47:53.815094Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"} {"level":"info","ts":"2026-02-11T01:47:53.815189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T01:47:53.815211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"} {"level":"info","ts":"2026-02-11T01:47:53.815305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-11T01:47:53.815316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"} {"level":"info","ts":"2026-02-11T01:47:53.815349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"warn","ts":"2026-02-11T01:47:53.83635Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T01:47:53.841995Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T01:47:53.845033Z","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-11T01:47:53.850246Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-11T01:47:53.856505Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-11T01:47:53.869042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"info","ts":"2026-02-11T01:47:53.869239Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-02-11T01:47:53.86853Z","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-11T01:47:53.869365Z","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-11T01:47:53.86941Z","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-11T01:47:53.872293Z","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-11T01:47:53.876472Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-11T01:47:53.876566Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T01:47:53.873555Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-02-11T01:47:53.8801Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-02-11T01:47:54.416447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T01:47:54.416529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T01:47:54.416563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"} {"level":"info","ts":"2026-02-11T01:47:54.416586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"} {"level":"info","ts":"2026-02-11T01:47:54.416606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-02-11T01:47:54.416638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"} {"level":"info","ts":"2026-02-11T01:47:54.416663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-02-11T01:47:54.439833Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:47:54.477247Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"} {"level":"info","ts":"2026-02-11T01:47:54.477395Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T01:47:54.477528Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T01:47:54.478402Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T01:47:54.478436Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T01:47:54.479975Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"} {"level":"info","ts":"2026-02-11T01:47:54.480283Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-11T01:47:54.520693Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:47:54.520751Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:47:54.520769Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:48:00.064304Z","caller":"traceutil/trace.go:171","msg":"trace[191897754] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:249; }","duration":"106.928258ms","start":"2026-02-11T01:47:59.957351Z","end":"2026-02-11T01:48:00.064279Z","steps":["trace[191897754] 'read index received' (duration: 65.914887ms)","trace[191897754] 'applied index is now lower than readState.Index' (duration: 41.012441ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:00.064349Z","caller":"traceutil/trace.go:171","msg":"trace[625124505] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"121.409727ms","start":"2026-02-11T01:47:59.942913Z","end":"2026-02-11T01:48:00.064323Z","steps":["trace[625124505] 'process raft request' (duration: 121.173742ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:00.064476Z","caller":"traceutil/trace.go:171","msg":"trace[1838964675] transaction","detail":"{read_only:false; number_of_response:0; response_revision:244; }","duration":"121.334454ms","start":"2026-02-11T01:47:59.943131Z","end":"2026-02-11T01:48:00.064466Z","steps":["trace[1838964675] 'process raft request' (duration: 121.015558ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:00.064649Z","caller":"traceutil/trace.go:171","msg":"trace[1154859746] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"121.893328ms","start":"2026-02-11T01:47:59.942741Z","end":"2026-02-11T01:48:00.064635Z","steps":["trace[1154859746] 'process raft request' (duration: 121.06595ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:00.064732Z","caller":"traceutil/trace.go:171","msg":"trace[1502641792] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"121.870388ms","start":"2026-02-11T01:47:59.942853Z","end":"2026-02-11T01:48:00.064723Z","steps":["trace[1502641792] 'process raft request' (duration: 121.181393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:00.065142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.754837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:48:00.06643Z","caller":"traceutil/trace.go:171","msg":"trace[1392713371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:245; }","duration":"109.092877ms","start":"2026-02-11T01:47:59.957295Z","end":"2026-02-11T01:48:00.066388Z","steps":["trace[1392713371] 'agreement among raft nodes before linearized reading' (duration: 107.734217ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:00.247549Z","caller":"traceutil/trace.go:171","msg":"trace[493147112] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"140.616119ms","start":"2026-02-11T01:48:00.106907Z","end":"2026-02-11T01:48:00.247524Z","steps":["trace[493147112] 'process raft request' (duration: 90.018778ms)","trace[493147112] 'compare' (duration: 50.393246ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:00.663178Z","caller":"traceutil/trace.go:171","msg":"trace[1059473630] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"170.705639ms","start":"2026-02-11T01:48:00.492449Z","end":"2026-02-11T01:48:00.663155Z","steps":["trace[1059473630] 'process raft request' (duration: 94.660458ms)","trace[1059473630] 'compare' (duration: 75.527599ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:00.663607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.323116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:48:00.663629Z","caller":"traceutil/trace.go:171","msg":"trace[784054496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:256; }","duration":"167.389738ms","start":"2026-02-11T01:48:00.496232Z","end":"2026-02-11T01:48:00.663622Z","steps":["trace[784054496] 'agreement among raft nodes before linearized reading' (duration: 167.341997ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:00.664769Z","caller":"traceutil/trace.go:171","msg":"trace[35840706] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:264; }","duration":"166.592749ms","start":"2026-02-11T01:48:00.496273Z","end":"2026-02-11T01:48:00.662866Z","steps":["trace[35840706] 'read index received' (duration: 21.061033ms)","trace[35840706] 'applied index is now lower than readState.Index' (duration: 145.530526ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:01.008662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.987938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-02-11T01:48:01.008739Z","caller":"traceutil/trace.go:171","msg":"trace[1601734482] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:257; }","duration":"233.112151ms","start":"2026-02-11T01:48:00.775611Z","end":"2026-02-11T01:48:01.008723Z","steps":["trace[1601734482] 'range keys from in-memory index tree' (duration: 232.913416ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:01.056655Z","caller":"traceutil/trace.go:171","msg":"trace[4024234] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"267.699241ms","start":"2026-02-11T01:48:00.788931Z","end":"2026-02-11T01:48:01.05663Z","steps":["trace[4024234] 'process raft request' (duration: 267.554558ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:10.129058Z","caller":"traceutil/trace.go:171","msg":"trace[509861621] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:388; }","duration":"143.623132ms","start":"2026-02-11T01:48:09.985393Z","end":"2026-02-11T01:48:10.129016Z","steps":["trace[509861621] 'read index received' (duration: 143.51938ms)","trace[509861621] 'applied index is now lower than readState.Index' (duration: 102.872µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:10.129175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.763915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4256"} {"level":"info","ts":"2026-02-11T01:48:10.129206Z","caller":"traceutil/trace.go:171","msg":"trace[39531657] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:378; }","duration":"143.831496ms","start":"2026-02-11T01:48:09.985366Z","end":"2026-02-11T01:48:10.129197Z","steps":["trace[39531657] 'agreement among raft nodes before linearized reading' (duration: 143.760354ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:10.129278Z","caller":"traceutil/trace.go:171","msg":"trace[1255161917] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"158.033394ms","start":"2026-02-11T01:48:09.971222Z","end":"2026-02-11T01:48:10.129255Z","steps":["trace[1255161917] 'process raft request' (duration: 157.674706ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:10.142435Z","caller":"traceutil/trace.go:171","msg":"trace[181786633] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"108.7358ms","start":"2026-02-11T01:48:10.033676Z","end":"2026-02-11T01:48:10.142412Z","steps":["trace[181786633] 'process raft request' (duration: 105.300773ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:20.570365Z","caller":"traceutil/trace.go:171","msg":"trace[1081604584] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"172.105579ms","start":"2026-02-11T01:48:20.398243Z","end":"2026-02-11T01:48:20.570349Z","steps":["trace[1081604584] 'process raft request' (duration: 74.050057ms)","trace[1081604584] 'compare' (duration: 97.922639ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:20.570523Z","caller":"traceutil/trace.go:171","msg":"trace[242724847] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"170.122754ms","start":"2026-02-11T01:48:20.400393Z","end":"2026-02-11T01:48:20.570516Z","steps":["trace[242724847] 'process raft request' (duration: 169.927109ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:20.570612Z","caller":"traceutil/trace.go:171","msg":"trace[1283168650] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"168.915447ms","start":"2026-02-11T01:48:20.401692Z","end":"2026-02-11T01:48:20.570608Z","steps":["trace[1283168650] 'process raft request' (duration: 168.804494ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:22.469361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.96981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:48:22.469439Z","caller":"traceutil/trace.go:171","msg":"trace[171391378] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"432.93845ms","start":"2026-02-11T01:48:22.036488Z","end":"2026-02-11T01:48:22.469426Z","steps":["trace[171391378] 'process raft request' (duration: 173.52758ms)","trace[171391378] 'compare' (duration: 258.810137ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:22.469474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:22.036473Z","time spent":"432.987541ms","remote":"127.0.0.1:41676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4155,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T01:48:22.495448Z","caller":"traceutil/trace.go:171","msg":"trace[1627952485] linearizableReadLoop","detail":"{readStateIndex:465; appliedIndex:463; }","duration":"214.6896ms","start":"2026-02-11T01:48:22.280734Z","end":"2026-02-11T01:48:22.495424Z","steps":["trace[1627952485] 'read index received' (duration: 211.518279ms)","trace[1627952485] 'applied index is now lower than readState.Index' (duration: 3.169951ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:22.495788Z","caller":"traceutil/trace.go:171","msg":"trace[1806880313] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"384.816633ms","start":"2026-02-11T01:48:22.110957Z","end":"2026-02-11T01:48:22.495774Z","steps":["trace[1806880313] 'process raft request' (duration: 382.293026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:22.496257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:22.110929Z","time spent":"384.916706ms","remote":"127.0.0.1:41282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317259,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:48:22.496694Z","caller":"traceutil/trace.go:171","msg":"trace[1119468590] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"455.428042ms","start":"2026-02-11T01:48:22.041246Z","end":"2026-02-11T01:48:22.496674Z","steps":["trace[1119468590] 'process raft request' (duration: 450.912151ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:22.496895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.02146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:48:22.497022Z","caller":"traceutil/trace.go:171","msg":"trace[248332173] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:452; }","duration":"216.236345ms","start":"2026-02-11T01:48:22.280697Z","end":"2026-02-11T01:48:22.496933Z","steps":["trace[248332173] 'agreement among raft nodes before linearized reading' (duration: 216.02305ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:22.498393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:22.041231Z","time spent":"455.545655ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14860,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T01:48:22.549257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.630548ms","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-11T01:48:22.549306Z","caller":"traceutil/trace.go:171","msg":"trace[1088030739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:455; }","duration":"150.72035ms","start":"2026-02-11T01:48:22.398574Z","end":"2026-02-11T01:48:22.549294Z","steps":["trace[1088030739] 'agreement among raft nodes before linearized reading' (duration: 150.652429ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:25.1049Z","caller":"traceutil/trace.go:171","msg":"trace[1400856572] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"491.811297ms","start":"2026-02-11T01:48:24.613067Z","end":"2026-02-11T01:48:25.104878Z","steps":["trace[1400856572] 'read index received' (duration: 491.590621ms)","trace[1400856572] 'applied index is now lower than readState.Index' (duration: 219.516µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:25.105024Z","caller":"traceutil/trace.go:171","msg":"trace[1443346588] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"688.411012ms","start":"2026-02-11T01:48:24.416603Z","end":"2026-02-11T01:48:25.105014Z","steps":["trace[1443346588] 'process raft request' (duration: 688.116074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:25.105134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:24.416585Z","time spent":"688.464974ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4253,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:48:25.105203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.983675ms","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-11T01:48:25.10525Z","caller":"traceutil/trace.go:171","msg":"trace[809169049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:475; }","duration":"473.037316ms","start":"2026-02-11T01:48:24.6322Z","end":"2026-02-11T01:48:25.105237Z","steps":["trace[809169049] 'agreement among raft nodes before linearized reading' (duration: 472.908993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:25.105272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:24.632166Z","time spent":"473.102137ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:48:25.105373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.308568ms","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-11T01:48:25.105388Z","caller":"traceutil/trace.go:171","msg":"trace[1302166602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:475; }","duration":"492.356938ms","start":"2026-02-11T01:48:24.613026Z","end":"2026-02-11T01:48:25.105383Z","steps":["trace[1302166602] 'agreement among raft nodes before linearized reading' (duration: 492.330867ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:25.105403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:24.613008Z","time spent":"492.390079ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-11T01:48:25.105479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.42653ms","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-11T01:48:25.105494Z","caller":"traceutil/trace.go:171","msg":"trace[27242268] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"195.510741ms","start":"2026-02-11T01:48:24.909979Z","end":"2026-02-11T01:48:25.105489Z","steps":["trace[27242268] 'agreement among raft nodes before linearized reading' (duration: 195.47291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:25.105556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.892295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-11T01:48:25.105567Z","caller":"traceutil/trace.go:171","msg":"trace[2105612875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:475; }","duration":"451.927185ms","start":"2026-02-11T01:48:24.653636Z","end":"2026-02-11T01:48:25.105563Z","steps":["trace[2105612875] 'agreement among raft nodes before linearized reading' (duration: 451.890434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:25.105578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:24.653624Z","time spent":"451.950965ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-11T01:48:31.18041Z","caller":"traceutil/trace.go:171","msg":"trace[232045043] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"220.290184ms","start":"2026-02-11T01:48:30.960102Z","end":"2026-02-11T01:48:31.180392Z","steps":["trace[232045043] 'process raft request' (duration: 220.148231ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:31.380825Z","caller":"traceutil/trace.go:171","msg":"trace[2140208224] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"191.304616ms","start":"2026-02-11T01:48:31.189501Z","end":"2026-02-11T01:48:31.380806Z","steps":["trace[2140208224] 'process raft request' (duration: 191.273246ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:31.381181Z","caller":"traceutil/trace.go:171","msg":"trace[774705803] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"193.783092ms","start":"2026-02-11T01:48:31.187386Z","end":"2026-02-11T01:48:31.381169Z","steps":["trace[774705803] 'process raft request' (duration: 141.476723ms)","trace[774705803] 'compare' (duration: 50.902558ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:31.381293Z","caller":"traceutil/trace.go:171","msg":"trace[1783296643] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"193.776802ms","start":"2026-02-11T01:48:31.187508Z","end":"2026-02-11T01:48:31.381285Z","steps":["trace[1783296643] 'process raft request' (duration: 193.143868ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:31.38163Z","caller":"traceutil/trace.go:171","msg":"trace[1355102235] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"192.32766ms","start":"2026-02-11T01:48:31.18929Z","end":"2026-02-11T01:48:31.381618Z","steps":["trace[1355102235] 'process raft request' (duration: 191.453631ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:34.252056Z","caller":"traceutil/trace.go:171","msg":"trace[2054403129] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"260.613477ms","start":"2026-02-11T01:48:33.991419Z","end":"2026-02-11T01:48:34.252033Z","steps":["trace[2054403129] 'process raft request' (duration: 259.079952ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:34.255611Z","caller":"traceutil/trace.go:171","msg":"trace[2019161806] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"104.710541ms","start":"2026-02-11T01:48:34.150885Z","end":"2026-02-11T01:48:34.255596Z","steps":["trace[2019161806] 'process raft request' (duration: 104.681021ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:34.256471Z","caller":"traceutil/trace.go:171","msg":"trace[1488163380] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"264.79929ms","start":"2026-02-11T01:48:33.991658Z","end":"2026-02-11T01:48:34.256458Z","steps":["trace[1488163380] 'process raft request' (duration: 263.740147ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:34.2566Z","caller":"traceutil/trace.go:171","msg":"trace[1866866221] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"263.138434ms","start":"2026-02-11T01:48:33.993453Z","end":"2026-02-11T01:48:34.256591Z","steps":["trace[1866866221] 'process raft request' (duration: 262.02272ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:34.256702Z","caller":"traceutil/trace.go:171","msg":"trace[1057293017] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"261.155339ms","start":"2026-02-11T01:48:33.995539Z","end":"2026-02-11T01:48:34.256694Z","steps":["trace[1057293017] 'process raft request' (duration: 259.964953ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:34.256868Z","caller":"traceutil/trace.go:171","msg":"trace[824952784] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"258.546231ms","start":"2026-02-11T01:48:33.998313Z","end":"2026-02-11T01:48:34.256859Z","steps":["trace[824952784] 'process raft request' (duration: 257.215342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:36.108133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.377759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-02-11T01:48:36.108293Z","caller":"traceutil/trace.go:171","msg":"trace[1655251932] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:557; }","duration":"157.510681ms","start":"2026-02-11T01:48:35.950694Z","end":"2026-02-11T01:48:36.108205Z","steps":["trace[1655251932] 'range keys from in-memory index tree' (duration: 157.230815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:36.108431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.514378ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:48:36.108525Z","caller":"traceutil/trace.go:171","msg":"trace[1490103902] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:557; }","duration":"134.6145ms","start":"2026-02-11T01:48:35.973899Z","end":"2026-02-11T01:48:36.108513Z","steps":["trace[1490103902] 'range keys from in-memory index tree' (duration: 134.502988ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:45.140951Z","caller":"traceutil/trace.go:171","msg":"trace[131324139] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"209.700568ms","start":"2026-02-11T01:48:44.931225Z","end":"2026-02-11T01:48:45.140926Z","steps":["trace[131324139] 'process raft request' (duration: 131.347556ms)","trace[131324139] 'compare' (duration: 78.26599ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:46.09082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.149188ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:48:46.090892Z","caller":"traceutil/trace.go:171","msg":"trace[496559854] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:648; }","duration":"116.230909ms","start":"2026-02-11T01:48:45.974651Z","end":"2026-02-11T01:48:46.090882Z","steps":["trace[496559854] 'range keys from in-memory index tree' (duration: 116.140377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.091058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.149489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:48:46.091089Z","caller":"traceutil/trace.go:171","msg":"trace[1893186613] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"945.013269ms","start":"2026-02-11T01:48:45.14607Z","end":"2026-02-11T01:48:46.091083Z","steps":["trace[1893186613] 'read index received' (duration: 331.801179ms)","trace[1893186613] 'applied index is now lower than readState.Index' (duration: 613.21156ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:46.091188Z","caller":"traceutil/trace.go:171","msg":"trace[566198770] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.153339487s","start":"2026-02-11T01:48:44.937842Z","end":"2026-02-11T01:48:46.091181Z","steps":["trace[566198770] 'process raft request' (duration: 540.022804ms)","trace[566198770] 'compare' (duration: 612.70727ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:46.091219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:44.937827Z","time spent":"1.153377588s","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4832,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:48:46.091372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.303865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-7tpgl\" ","response":"range_response_count:1 size:4808"} {"level":"info","ts":"2026-02-11T01:48:46.091389Z","caller":"traceutil/trace.go:171","msg":"trace[347810809] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-7tpgl; range_end:; response_count:1; response_revision:649; }","duration":"945.344646ms","start":"2026-02-11T01:48:45.14604Z","end":"2026-02-11T01:48:46.091385Z","steps":["trace[347810809] 'agreement among raft nodes before linearized reading' (duration: 945.287094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.091403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:45.146028Z","time spent":"945.372296ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4830,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-7tpgl\" "} {"level":"warn","ts":"2026-02-11T01:48:46.302963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.104764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:48:46.303092Z","caller":"traceutil/trace.go:171","msg":"trace[1444665947] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:668; }","duration":"211.98395ms","start":"2026-02-11T01:48:46.091098Z","end":"2026-02-11T01:48:46.303082Z","steps":["trace[1444665947] 'read index received' (duration: 100.714042ms)","trace[1444665947] 'applied index is now lower than readState.Index' (duration: 111.269368ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:46.303132Z","caller":"traceutil/trace.go:171","msg":"trace[470605398] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.156379065s","start":"2026-02-11T01:48:45.146748Z","end":"2026-02-11T01:48:46.303127Z","steps":["trace[470605398] 'process raft request' (duration: 1.045056856s)","trace[470605398] 'compare' (duration: 110.980821ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:46.303158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:45.146736Z","time spent":"1.156408606s","remote":"127.0.0.1:41262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T01:48:46.303414Z","caller":"traceutil/trace.go:171","msg":"trace[283178097] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"1.153797737s","start":"2026-02-11T01:48:45.14961Z","end":"2026-02-11T01:48:46.303408Z","steps":["trace[283178097] 'process raft request' (duration: 1.153418239s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.303457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:45.1496Z","time spent":"1.153829568s","remote":"127.0.0.1:41642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4191,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:48:46.303566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.05485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-11T01:48:46.30362Z","caller":"traceutil/trace.go:171","msg":"trace[1931240719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:651; }","duration":"775.122431ms","start":"2026-02-11T01:48:45.528493Z","end":"2026-02-11T01:48:46.303615Z","steps":["trace[1931240719] 'agreement among raft nodes before linearized reading' (duration: 775.025979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.303638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:45.528484Z","time spent":"775.150891ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T01:48:46.30373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.545146ms","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-11T01:48:46.303746Z","caller":"traceutil/trace.go:171","msg":"trace[973091745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:651; }","duration":"803.581457ms","start":"2026-02-11T01:48:45.500161Z","end":"2026-02-11T01:48:46.303743Z","steps":["trace[973091745] 'agreement among raft nodes before linearized reading' (duration: 803.542506ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.30376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:45.500149Z","time spent":"803.607598ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:48:46.303861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.423194ms","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-11T01:48:46.303879Z","caller":"traceutil/trace.go:171","msg":"trace[2090998470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:651; }","duration":"829.450085ms","start":"2026-02-11T01:48:45.474424Z","end":"2026-02-11T01:48:46.303874Z","steps":["trace[2090998470] 'agreement among raft nodes before linearized reading' (duration: 829.391833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.303894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:45.474418Z","time spent":"829.473186ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T01:48:46.303987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.737118ms","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-11T01:48:46.304003Z","caller":"traceutil/trace.go:171","msg":"trace[240882008] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:651; }","duration":"832.775869ms","start":"2026-02-11T01:48:45.471223Z","end":"2026-02-11T01:48:46.303999Z","steps":["trace[240882008] 'agreement among raft nodes before linearized reading' (duration: 832.729858ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.304015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:45.471198Z","time spent":"832.8133ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-11T01:48:46.422411Z","caller":"traceutil/trace.go:171","msg":"trace[965391648] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:670; }","duration":"119.286016ms","start":"2026-02-11T01:48:46.303106Z","end":"2026-02-11T01:48:46.422392Z","steps":["trace[965391648] 'read index received' (duration: 118.130161ms)","trace[965391648] 'applied index is now lower than readState.Index' (duration: 1.155105ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:46.422677Z","caller":"traceutil/trace.go:171","msg":"trace[835438530] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"328.733229ms","start":"2026-02-11T01:48:46.093933Z","end":"2026-02-11T01:48:46.422666Z","steps":["trace[835438530] 'process raft request' (duration: 327.294598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.422775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:46.093893Z","time spent":"328.815861ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4805,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:48:46.423017Z","caller":"traceutil/trace.go:171","msg":"trace[83775872] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"326.633072ms","start":"2026-02-11T01:48:46.096374Z","end":"2026-02-11T01:48:46.423007Z","steps":["trace[83775872] 'process raft request' (duration: 325.898556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.423075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:46.096363Z","time spent":"326.683444ms","remote":"127.0.0.1:41348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1017,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:48:46.423273Z","caller":"traceutil/trace.go:171","msg":"trace[1056810784] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"323.916671ms","start":"2026-02-11T01:48:46.099347Z","end":"2026-02-11T01:48:46.423264Z","steps":["trace[1056810784] 'process raft request' (duration: 322.971301ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.423981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:46.099338Z","time spent":"324.602757ms","remote":"127.0.0.1:41676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3866,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:48:46.424309Z","caller":"traceutil/trace.go:171","msg":"trace[670329786] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"322.635093ms","start":"2026-02-11T01:48:46.101663Z","end":"2026-02-11T01:48:46.424298Z","steps":["trace[670329786] 'process raft request' (duration: 320.692279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.424387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:46.101655Z","time spent":"322.687554ms","remote":"127.0.0.1:41460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1612,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:48:46.424465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.133625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:48:46.42448Z","caller":"traceutil/trace.go:171","msg":"trace[1208337148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"276.170455ms","start":"2026-02-11T01:48:46.148306Z","end":"2026-02-11T01:48:46.424476Z","steps":["trace[1208337148] 'agreement among raft nodes before linearized reading' (duration: 276.145185ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:46.425589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.321301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4206"} {"level":"info","ts":"2026-02-11T01:48:46.425607Z","caller":"traceutil/trace.go:171","msg":"trace[1744575031] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:659; }","duration":"112.350772ms","start":"2026-02-11T01:48:46.313252Z","end":"2026-02-11T01:48:46.425603Z","steps":["trace[1744575031] 'agreement among raft nodes before linearized reading' (duration: 112.27804ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:46.425719Z","caller":"traceutil/trace.go:171","msg":"trace[470167574] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"116.123485ms","start":"2026-02-11T01:48:46.309591Z","end":"2026-02-11T01:48:46.425715Z","steps":["trace[470167574] 'process raft request' (duration: 115.86085ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:46.425773Z","caller":"traceutil/trace.go:171","msg":"trace[1006815277] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"115.587244ms","start":"2026-02-11T01:48:46.310181Z","end":"2026-02-11T01:48:46.425768Z","steps":["trace[1006815277] 'process raft request' (duration: 115.304397ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:46.425822Z","caller":"traceutil/trace.go:171","msg":"trace[1602185246] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"111.535563ms","start":"2026-02-11T01:48:46.314283Z","end":"2026-02-11T01:48:46.425818Z","steps":["trace[1602185246] 'process raft request' (duration: 111.218966ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:48:46.425872Z","caller":"traceutil/trace.go:171","msg":"trace[275563646] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"110.830288ms","start":"2026-02-11T01:48:46.315038Z","end":"2026-02-11T01:48:46.425868Z","steps":["trace[275563646] 'process raft request' (duration: 110.47656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:53.642624Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349462101286078,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T01:48:53.958999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.522871ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-11T01:48:53.959062Z","caller":"traceutil/trace.go:171","msg":"trace[519232292] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:707; }","duration":"817.466968ms","start":"2026-02-11T01:48:53.141579Z","end":"2026-02-11T01:48:53.959046Z","steps":["trace[519232292] 'read index received' (duration: 583.857394ms)","trace[519232292] 'applied index is now lower than readState.Index' (duration: 233.608694ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:53.959123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.540579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:48:53.959137Z","caller":"traceutil/trace.go:171","msg":"trace[1011285076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:687; }","duration":"817.58029ms","start":"2026-02-11T01:48:53.141551Z","end":"2026-02-11T01:48:53.959131Z","steps":["trace[1011285076] 'agreement among raft nodes before linearized reading' (duration: 817.541099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:53.959155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:53.141539Z","time spent":"817.61255ms","remote":"127.0.0.1:60870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T01:48:55.639062Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349462101286091,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T01:48:55.662825Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.115676515s","expected-duration":"1s"} {"level":"info","ts":"2026-02-11T01:48:55.726273Z","caller":"traceutil/trace.go:171","msg":"trace[543722347] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"587.319941ms","start":"2026-02-11T01:48:55.138932Z","end":"2026-02-11T01:48:55.726252Z","steps":["trace[543722347] 'read index received' (duration: 523.996906ms)","trace[543722347] 'applied index is now lower than readState.Index' (duration: 63.321975ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:55.726385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.434943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:48:55.726414Z","caller":"traceutil/trace.go:171","msg":"trace[1724757372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:692; }","duration":"587.498905ms","start":"2026-02-11T01:48:55.138906Z","end":"2026-02-11T01:48:55.726405Z","steps":["trace[1724757372] 'agreement among raft nodes before linearized reading' (duration: 587.422934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:55.726443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:55.138895Z","time spent":"587.541576ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-11T01:48:55.726626Z","caller":"traceutil/trace.go:171","msg":"trace[480482408] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"1.179514712s","start":"2026-02-11T01:48:54.547089Z","end":"2026-02-11T01:48:55.726604Z","steps":["trace[480482408] 'process raft request' (duration: 1.115864209s)","trace[480482408] 'compare' (duration: 62.198221ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:48:55.726722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:48:54.547077Z","time spent":"1.179584685s","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:48:56.647336Z","caller":"traceutil/trace.go:171","msg":"trace[284773998] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:713; }","duration":"156.022448ms","start":"2026-02-11T01:48:56.491288Z","end":"2026-02-11T01:48:56.64731Z","steps":["trace[284773998] 'read index received' (duration: 155.916176ms)","trace[284773998] 'applied index is now lower than readState.Index' (duration: 105.732µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:48:56.647418Z","caller":"traceutil/trace.go:171","msg":"trace[954574796] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"161.00216ms","start":"2026-02-11T01:48:56.486411Z","end":"2026-02-11T01:48:56.647413Z","steps":["trace[954574796] 'process raft request' (duration: 160.797485ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:56.647556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.254343ms","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-11T01:48:56.647571Z","caller":"traceutil/trace.go:171","msg":"trace[1199266609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:693; }","duration":"156.295165ms","start":"2026-02-11T01:48:56.491271Z","end":"2026-02-11T01:48:56.647567Z","steps":["trace[1199266609] 'agreement among raft nodes before linearized reading' (duration: 156.220953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:56.647633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.164351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-11T01:48:56.647644Z","caller":"traceutil/trace.go:171","msg":"trace[166444091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:693; }","duration":"101.198963ms","start":"2026-02-11T01:48:56.546442Z","end":"2026-02-11T01:48:56.64764Z","steps":["trace[166444091] 'agreement among raft nodes before linearized reading' (duration: 101.166802ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:48:56.647765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.212973ms","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-11T01:48:56.647806Z","caller":"traceutil/trace.go:171","msg":"trace[1701089458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:693; }","duration":"101.271204ms","start":"2026-02-11T01:48:56.546524Z","end":"2026-02-11T01:48:56.647795Z","steps":["trace[1701089458] 'agreement among raft nodes before linearized reading' (duration: 101.155342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:09.12718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.446946ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:49:09.127286Z","caller":"traceutil/trace.go:171","msg":"trace[1641247199] linearizableReadLoop","detail":"{readStateIndex:759; appliedIndex:758; }","duration":"363.643551ms","start":"2026-02-11T01:49:08.763627Z","end":"2026-02-11T01:49:09.127271Z","steps":["trace[1641247199] 'read index received' (duration: 12.988421ms)","trace[1641247199] 'applied index is now lower than readState.Index' (duration: 350.65402ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:49:09.127501Z","caller":"traceutil/trace.go:171","msg":"trace[1173661777] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"409.27645ms","start":"2026-02-11T01:49:08.718212Z","end":"2026-02-11T01:49:09.127489Z","steps":["trace[1173661777] 'process raft request' (duration: 58.429846ms)","trace[1173661777] 'compare' (duration: 350.364044ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:49:09.127559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:08.718203Z","time spent":"409.325231ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:49:09.127631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.063371ms","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-11T01:49:09.127707Z","caller":"traceutil/trace.go:171","msg":"trace[1278727259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:735; }","duration":"352.174454ms","start":"2026-02-11T01:49:08.775513Z","end":"2026-02-11T01:49:09.127688Z","steps":["trace[1278727259] 'agreement among raft nodes before linearized reading' (duration: 351.944779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:09.12775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:08.775506Z","time spent":"352.235505ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:49:09.127933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.310385ms","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-11T01:49:09.127986Z","caller":"traceutil/trace.go:171","msg":"trace[1875884271] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:735; }","duration":"364.392557ms","start":"2026-02-11T01:49:08.763583Z","end":"2026-02-11T01:49:09.127976Z","steps":["trace[1875884271] 'agreement among raft nodes before linearized reading' (duration: 364.258204ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:09.128016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:08.763566Z","time spent":"364.442808ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-11T01:49:13.330359Z","caller":"traceutil/trace.go:171","msg":"trace[969472633] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"113.095209ms","start":"2026-02-11T01:49:13.217243Z","end":"2026-02-11T01:49:13.330338Z","steps":["trace[969472633] 'process raft request' (duration: 113.049758ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:13.330909Z","caller":"traceutil/trace.go:171","msg":"trace[370723807] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"113.698434ms","start":"2026-02-11T01:49:13.217202Z","end":"2026-02-11T01:49:13.3309Z","steps":["trace[370723807] 'process raft request' (duration: 112.970976ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:25.457099Z","caller":"traceutil/trace.go:171","msg":"trace[1320071261] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:859; }","duration":"112.156058ms","start":"2026-02-11T01:49:25.344926Z","end":"2026-02-11T01:49:25.457082Z","steps":["trace[1320071261] 'read index received' (duration: 112.035096ms)","trace[1320071261] 'applied index is now lower than readState.Index' (duration: 120.132µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:49:25.457333Z","caller":"traceutil/trace.go:171","msg":"trace[1105785428] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"188.677067ms","start":"2026-02-11T01:49:25.268651Z","end":"2026-02-11T01:49:25.457328Z","steps":["trace[1105785428] 'process raft request' (duration: 188.327199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:25.457453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.525886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:49:25.457471Z","caller":"traceutil/trace.go:171","msg":"trace[1035033559] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:831; }","duration":"112.557917ms","start":"2026-02-11T01:49:25.344907Z","end":"2026-02-11T01:49:25.457465Z","steps":["trace[1035033559] 'agreement among raft nodes before linearized reading' (duration: 112.512516ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:25.978726Z","caller":"traceutil/trace.go:171","msg":"trace[1269403383] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"516.283461ms","start":"2026-02-11T01:49:25.462426Z","end":"2026-02-11T01:49:25.978709Z","steps":["trace[1269403383] 'process raft request' (duration: 457.563817ms)","trace[1269403383] 'compare' (duration: 58.621421ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:49:25.978794Z","caller":"traceutil/trace.go:171","msg":"trace[962748116] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"516.186179ms","start":"2026-02-11T01:49:25.462593Z","end":"2026-02-11T01:49:25.978779Z","steps":["trace[962748116] 'process raft request' (duration: 516.095897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:25.978815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:25.462404Z","time spent":"516.361814ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:49:25.978891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:25.462585Z","time spent":"516.249281ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:49:34.227624Z","caller":"traceutil/trace.go:171","msg":"trace[460259294] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"217.213025ms","start":"2026-02-11T01:49:34.010397Z","end":"2026-02-11T01:49:34.22761Z","steps":["trace[460259294] 'process raft request' (duration: 217.118753ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:34.279828Z","caller":"traceutil/trace.go:171","msg":"trace[500592107] linearizableReadLoop","detail":"{readStateIndex:887; appliedIndex:886; }","duration":"250.135054ms","start":"2026-02-11T01:49:34.029678Z","end":"2026-02-11T01:49:34.279813Z","steps":["trace[500592107] 'read index received' (duration: 198.178043ms)","trace[500592107] 'applied index is now lower than readState.Index' (duration: 51.956291ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:49:34.279986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.292108ms","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-11T01:49:34.280021Z","caller":"traceutil/trace.go:171","msg":"trace[395111717] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:856; }","duration":"250.344529ms","start":"2026-02-11T01:49:34.029656Z","end":"2026-02-11T01:49:34.280001Z","steps":["trace[395111717] 'agreement among raft nodes before linearized reading' (duration: 250.222326ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:34.280101Z","caller":"traceutil/trace.go:171","msg":"trace[1405973302] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"268.703115ms","start":"2026-02-11T01:49:34.01138Z","end":"2026-02-11T01:49:34.280083Z","steps":["trace[1405973302] 'process raft request' (duration: 264.672284ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:39.64067Z","caller":"traceutil/trace.go:171","msg":"trace[335912466] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"118.39301ms","start":"2026-02-11T01:49:39.522247Z","end":"2026-02-11T01:49:39.64064Z","steps":["trace[335912466] 'process raft request' (duration: 118.203655ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:41.789469Z","caller":"traceutil/trace.go:171","msg":"trace[943325262] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"143.609413ms","start":"2026-02-11T01:49:41.645845Z","end":"2026-02-11T01:49:41.789455Z","steps":["trace[943325262] 'process raft request' (duration: 143.525761ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:42.544635Z","caller":"traceutil/trace.go:171","msg":"trace[465815050] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"183.277383ms","start":"2026-02-11T01:49:42.361341Z","end":"2026-02-11T01:49:42.544619Z","steps":["trace[465815050] 'process raft request' (duration: 183.184191ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:42.563132Z","caller":"traceutil/trace.go:171","msg":"trace[1862562798] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:909; }","duration":"168.52981ms","start":"2026-02-11T01:49:42.394584Z","end":"2026-02-11T01:49:42.563114Z","steps":["trace[1862562798] 'read index received' (duration: 149.886386ms)","trace[1862562798] 'applied index is now lower than readState.Index' (duration: 18.642764ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:49:42.563212Z","caller":"traceutil/trace.go:171","msg":"trace[688051378] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"199.392172ms","start":"2026-02-11T01:49:42.363814Z","end":"2026-02-11T01:49:42.563206Z","steps":["trace[688051378] 'process raft request' (duration: 199.180517ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:42.563322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.723695ms","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-11T01:49:42.563358Z","caller":"traceutil/trace.go:171","msg":"trace[1095024723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:880; }","duration":"168.793686ms","start":"2026-02-11T01:49:42.394555Z","end":"2026-02-11T01:49:42.563349Z","steps":["trace[1095024723] 'agreement among raft nodes before linearized reading' (duration: 168.680643ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:42.563449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.086505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:49:42.563472Z","caller":"traceutil/trace.go:171","msg":"trace[1315547593] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"145.358033ms","start":"2026-02-11T01:49:42.418108Z","end":"2026-02-11T01:49:42.563466Z","steps":["trace[1315547593] 'process raft request' (duration: 144.979955ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:42.563476Z","caller":"traceutil/trace.go:171","msg":"trace[917477881] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:880; }","duration":"111.188187ms","start":"2026-02-11T01:49:42.45228Z","end":"2026-02-11T01:49:42.563468Z","steps":["trace[917477881] 'agreement among raft nodes before linearized reading' (duration: 111.093015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:42.563604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.281826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:49:42.563623Z","caller":"traceutil/trace.go:171","msg":"trace[337824939] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:880; }","duration":"110.303328ms","start":"2026-02-11T01:49:42.453313Z","end":"2026-02-11T01:49:42.563617Z","steps":["trace[337824939] 'agreement among raft nodes before linearized reading' (duration: 110.270597ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:54.321734Z","caller":"traceutil/trace.go:171","msg":"trace[1288908549] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"179.669072ms","start":"2026-02-11T01:49:54.142041Z","end":"2026-02-11T01:49:54.32171Z","steps":["trace[1288908549] 'read index received' (duration: 179.477578ms)","trace[1288908549] 'applied index is now lower than readState.Index' (duration: 190.534µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:49:54.321883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.819586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:49:54.321914Z","caller":"traceutil/trace.go:171","msg":"trace[358453294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:968; }","duration":"179.887508ms","start":"2026-02-11T01:49:54.142017Z","end":"2026-02-11T01:49:54.321905Z","steps":["trace[358453294] 'agreement among raft nodes before linearized reading' (duration: 179.786365ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:54.322162Z","caller":"traceutil/trace.go:171","msg":"trace[818196937] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"187.653044ms","start":"2026-02-11T01:49:54.134498Z","end":"2026-02-11T01:49:54.322151Z","steps":["trace[818196937] 'process raft request' (duration: 187.088661ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:54.892843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.35488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:49:54.89308Z","caller":"traceutil/trace.go:171","msg":"trace[256575286] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1003; }","duration":"306.056724ms","start":"2026-02-11T01:49:54.587006Z","end":"2026-02-11T01:49:54.893063Z","steps":["trace[256575286] 'read index received' (duration: 171.790853ms)","trace[256575286] 'applied index is now lower than readState.Index' (duration: 134.264911ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:49:54.893269Z","caller":"traceutil/trace.go:171","msg":"trace[1998232660] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"559.013001ms","start":"2026-02-11T01:49:54.334244Z","end":"2026-02-11T01:49:54.893257Z","steps":["trace[1998232660] 'process raft request' (duration: 182.1687ms)","trace[1998232660] 'compare' (duration: 376.168016ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:49:54.893331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:54.334228Z","time spent":"559.067722ms","remote":"127.0.0.1:41348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":929,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:49:54.893571Z","caller":"traceutil/trace.go:171","msg":"trace[325849247] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"556.358311ms","start":"2026-02-11T01:49:54.337202Z","end":"2026-02-11T01:49:54.89356Z","steps":["trace[325849247] 'process raft request' (duration: 555.731367ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:54.893623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:54.337196Z","time spent":"556.399062ms","remote":"127.0.0.1:41460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1524,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:49:54.893833Z","caller":"traceutil/trace.go:171","msg":"trace[1609991020] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"554.97303ms","start":"2026-02-11T01:49:54.338849Z","end":"2026-02-11T01:49:54.893822Z","steps":["trace[1609991020] 'process raft request' (duration: 554.137281ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:54.893882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:54.338843Z","time spent":"555.012981ms","remote":"127.0.0.1:41676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10772,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:49:54.894075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.069766ms","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-11T01:49:54.894103Z","caller":"traceutil/trace.go:171","msg":"trace[533273691] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"307.127957ms","start":"2026-02-11T01:49:54.586967Z","end":"2026-02-11T01:49:54.894095Z","steps":["trace[533273691] 'agreement among raft nodes before linearized reading' (duration: 307.026885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:54.89413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:54.586947Z","time spent":"307.176589ms","remote":"127.0.0.1:41454","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-11T01:49:54.894295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.685417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-11T01:49:54.894321Z","caller":"traceutil/trace.go:171","msg":"trace[1218620684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:971; }","duration":"273.750319ms","start":"2026-02-11T01:49:54.620563Z","end":"2026-02-11T01:49:54.894313Z","steps":["trace[1218620684] 'agreement among raft nodes before linearized reading' (duration: 273.680437ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:54.894707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.451923ms","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-11T01:49:54.894735Z","caller":"traceutil/trace.go:171","msg":"trace[2037362060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:971; }","duration":"273.509334ms","start":"2026-02-11T01:49:54.621218Z","end":"2026-02-11T01:49:54.894727Z","steps":["trace[2037362060] 'agreement among raft nodes before linearized reading' (duration: 273.431622ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:53:02.273265Z","caller":"traceutil/trace.go:171","msg":"trace[44570592] transaction","detail":"{read_only:false; response_revision:1764; number_of_response:1; }","duration":"190.585707ms","start":"2026-02-11T01:53:02.08266Z","end":"2026-02-11T01:53:02.273245Z","steps":["trace[44570592] 'process raft request' (duration: 159.650036ms)","trace[44570592] 'compare' (duration: 30.861379ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:53:02.274504Z","caller":"traceutil/trace.go:171","msg":"trace[1346134873] linearizableReadLoop","detail":"{readStateIndex:1838; appliedIndex:1836; }","duration":"171.342616ms","start":"2026-02-11T01:53:02.103151Z","end":"2026-02-11T01:53:02.274494Z","steps":["trace[1346134873] 'read index received' (duration: 139.167138ms)","trace[1346134873] 'applied index is now lower than readState.Index' (duration: 32.174858ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:53:02.274598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.428358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:53:02.274616Z","caller":"traceutil/trace.go:171","msg":"trace[945968727] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1765; }","duration":"171.47609ms","start":"2026-02-11T01:53:02.103135Z","end":"2026-02-11T01:53:02.274611Z","steps":["trace[945968727] 'agreement among raft nodes before linearized reading' (duration: 171.394218ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:53:02.27479Z","caller":"traceutil/trace.go:171","msg":"trace[1814756571] transaction","detail":"{read_only:false; response_revision:1765; number_of_response:1; }","duration":"190.671238ms","start":"2026-02-11T01:53:02.084109Z","end":"2026-02-11T01:53:02.274781Z","steps":["trace[1814756571] 'process raft request' (duration: 190.335171ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:53:24.55898Z","caller":"traceutil/trace.go:171","msg":"trace[108348724] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1946; }","duration":"147.494704ms","start":"2026-02-11T01:53:24.411464Z","end":"2026-02-11T01:53:24.558959Z","steps":["trace[108348724] 'read index received' (duration: 106.911438ms)","trace[108348724] 'applied index is now lower than readState.Index' (duration: 40.582386ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:53:24.559123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.634447ms","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-11T01:53:24.559155Z","caller":"traceutil/trace.go:171","msg":"trace[1164188120] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:1868; }","duration":"147.693659ms","start":"2026-02-11T01:53:24.41145Z","end":"2026-02-11T01:53:24.559144Z","steps":["trace[1164188120] 'agreement among raft nodes before linearized reading' (duration: 147.600097ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:53:24.55947Z","caller":"traceutil/trace.go:171","msg":"trace[485037006] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"148.303262ms","start":"2026-02-11T01:53:24.411153Z","end":"2026-02-11T01:53:24.559456Z","steps":["trace[485037006] 'process raft request' (duration: 107.298657ms)","trace[485037006] 'compare' (duration: 40.414032ms)"],"step_count":2}