{"level":"warn","ts":"2026-02-05T17:33:30.795192Z","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-05T17:33:30.795285Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.186: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.186:2380","--initial-cluster=instance=https://162.253.55.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.186: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-05T17:33:30.79535Z","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-05T17:33:30.795358Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-02-05T17:33:30.795373Z","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-05T17:33:30.795984Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"]} {"level":"info","ts":"2026-02-05T17:33:30.79605Z","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.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.186: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-05T17:33:30.801456Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.994463ms"} {"level":"info","ts":"2026-02-05T17:33:30.828895Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"612d5169b08bb96b","cluster-id":"20ec8eafba602517"} {"level":"info","ts":"2026-02-05T17:33:30.829011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=()"} {"level":"info","ts":"2026-02-05T17:33:30.829052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 0"} {"level":"info","ts":"2026-02-05T17:33:30.829114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 612d5169b08bb96b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-05T17:33:30.829173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 1"} {"level":"info","ts":"2026-02-05T17:33:30.829249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"warn","ts":"2026-02-05T17:33:30.844174Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-05T17:33:30.850425Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-05T17:33:30.861892Z","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-05T17:33:30.867719Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"612d5169b08bb96b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-05T17:33:30.869651Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"612d5169b08bb96b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-05T17:33:30.869824Z","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-05T17:33:30.869863Z","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-05T17:33:30.869873Z","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-05T17:33:30.871762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"info","ts":"2026-02-05T17:33:30.872764Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","added-peer-id":"612d5169b08bb96b","added-peer-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-02-05T17:33:30.87517Z","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-05T17:33:30.875325Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"612d5169b08bb96b","initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-05T17:33:30.875344Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-05T17:33:30.87539Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-02-05T17:33:30.875398Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-02-05T17:33:31.33034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b is starting a new election at term 1"} {"level":"info","ts":"2026-02-05T17:33:31.330517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became pre-candidate at term 1"} {"level":"info","ts":"2026-02-05T17:33:31.330642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgPreVoteResp from 612d5169b08bb96b at term 1"} {"level":"info","ts":"2026-02-05T17:33:31.330743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became candidate at term 2"} {"level":"info","ts":"2026-02-05T17:33:31.330816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgVoteResp from 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-02-05T17:33:31.330888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became leader at term 2"} {"level":"info","ts":"2026-02-05T17:33:31.330952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 612d5169b08bb96b elected leader 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-02-05T17:33:31.331821Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"612d5169b08bb96b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.186:2379]}","request-path":"/0/members/612d5169b08bb96b/attributes","cluster-id":"20ec8eafba602517","publish-timeout":"7s"} {"level":"info","ts":"2026-02-05T17:33:31.332007Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T17:33:31.332163Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T17:33:31.332621Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T17:33:31.332711Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-05T17:33:31.332729Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-05T17:33:31.334154Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.186:2379"} {"level":"info","ts":"2026-02-05T17:33:31.337161Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-05T17:33:31.337416Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T17:33:31.337552Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T17:33:31.337595Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T17:33:40.391177Z","caller":"traceutil/trace.go:171","msg":"trace[860090844] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"152.213425ms","start":"2026-02-05T17:33:40.23894Z","end":"2026-02-05T17:33:40.391153Z","steps":["trace[860090844] 'read index received' (duration: 80.84483ms)","trace[860090844] 'applied index is now lower than readState.Index' (duration: 71.367685ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:33:40.39154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.569011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-05T17:33:40.39176Z","caller":"traceutil/trace.go:171","msg":"trace[663789478] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:301; }","duration":"152.826422ms","start":"2026-02-05T17:33:40.238918Z","end":"2026-02-05T17:33:40.391744Z","steps":["trace[663789478] 'agreement among raft nodes before linearized reading' (duration: 152.494537ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:33:40.391944Z","caller":"traceutil/trace.go:171","msg":"trace[720564712] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"172.679164ms","start":"2026-02-05T17:33:40.219234Z","end":"2026-02-05T17:33:40.391913Z","steps":["trace[720564712] 'process raft request' (duration: 100.615138ms)","trace[720564712] 'compare' (duration: 71.206857ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:33:46.890361Z","caller":"traceutil/trace.go:171","msg":"trace[1440760754] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"596.946302ms","start":"2026-02-05T17:33:46.293384Z","end":"2026-02-05T17:33:46.89033Z","steps":["trace[1440760754] 'process raft request' (duration: 596.809206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:46.891058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:46.293364Z","time spent":"597.217093ms","remote":"127.0.0.1:55116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4583,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:33:46.893851Z","caller":"traceutil/trace.go:171","msg":"trace[2145086504] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:384; }","duration":"477.25442ms","start":"2026-02-05T17:33:46.416541Z","end":"2026-02-05T17:33:46.893795Z","steps":["trace[2145086504] 'read index received' (duration: 477.24578ms)","trace[2145086504] 'applied index is now lower than readState.Index' (duration: 6.94µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:33:46.894011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.434638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-05T17:33:46.894052Z","caller":"traceutil/trace.go:171","msg":"trace[1822992838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:370; }","duration":"477.50225ms","start":"2026-02-05T17:33:46.416537Z","end":"2026-02-05T17:33:46.894039Z","steps":["trace[1822992838] 'agreement among raft nodes before linearized reading' (duration: 477.375615ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:46.894099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:46.416481Z","time spent":"477.604135ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T17:33:47.458492Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13360944444627570777,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-05T17:33:47.718431Z","caller":"traceutil/trace.go:171","msg":"trace[1931726052] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"1.248073695s","start":"2026-02-05T17:33:46.47033Z","end":"2026-02-05T17:33:47.718403Z","steps":["trace[1931726052] 'process raft request' (duration: 1.24481711s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:47.718742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:46.470304Z","time spent":"1.248209521s","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:33:47.719532Z","caller":"traceutil/trace.go:171","msg":"trace[1504358987] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:384; }","duration":"761.063925ms","start":"2026-02-05T17:33:46.958456Z","end":"2026-02-05T17:33:47.71952Z","steps":["trace[1504358987] 'read index received' (duration: 756.701484ms)","trace[1504358987] 'applied index is now lower than readState.Index' (duration: 4.361771ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:33:47.720074Z","caller":"traceutil/trace.go:171","msg":"trace[595248891] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"822.309194ms","start":"2026-02-05T17:33:46.897751Z","end":"2026-02-05T17:33:47.72006Z","steps":["trace[595248891] 'process raft request' (duration: 821.71756ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:47.720148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:46.897731Z","time spent":"822.379557ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:33:47.720509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.046666ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:33:47.720592Z","caller":"traceutil/trace.go:171","msg":"trace[2050225351] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:372; }","duration":"762.12951ms","start":"2026-02-05T17:33:46.958449Z","end":"2026-02-05T17:33:47.720578Z","steps":["trace[2050225351] 'agreement among raft nodes before linearized reading' (duration: 762.031546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:47.722047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.755516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-05T17:33:47.722103Z","caller":"traceutil/trace.go:171","msg":"trace[798514870] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:372; }","duration":"528.814578ms","start":"2026-02-05T17:33:47.193277Z","end":"2026-02-05T17:33:47.722092Z","steps":["trace[798514870] 'agreement among raft nodes before linearized reading' (duration: 528.651842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:47.722235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:47.19326Z","time spent":"528.924833ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-05T17:33:47.722921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.128521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-05T17:33:47.722965Z","caller":"traceutil/trace.go:171","msg":"trace[650171484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:372; }","duration":"468.210554ms","start":"2026-02-05T17:33:47.254743Z","end":"2026-02-05T17:33:47.722953Z","steps":["trace[650171484] 'agreement among raft nodes before linearized reading' (duration: 468.148022ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:47.723097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:47.254723Z","time spent":"468.328709ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-05T17:33:47.723376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.828339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-05T17:33:47.723428Z","caller":"traceutil/trace.go:171","msg":"trace[1515279084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:372; }","duration":"474.908132ms","start":"2026-02-05T17:33:47.24851Z","end":"2026-02-05T17:33:47.723418Z","steps":["trace[1515279084] 'agreement among raft nodes before linearized reading' (duration: 474.810428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:47.723577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:47.24847Z","time spent":"475.094459ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-05T17:33:49.608498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.348661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:33:49.60925Z","caller":"traceutil/trace.go:171","msg":"trace[1093356798] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"411.615513ms","start":"2026-02-05T17:33:49.197616Z","end":"2026-02-05T17:33:49.609232Z","steps":["trace[1093356798] 'process raft request' (duration: 411.5552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:49.609368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:49.19761Z","time spent":"411.702876ms","remote":"127.0.0.1:55356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:33:49.609744Z","caller":"traceutil/trace.go:171","msg":"trace[2131713904] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"411.251648ms","start":"2026-02-05T17:33:49.197334Z","end":"2026-02-05T17:33:49.608586Z","steps":["trace[2131713904] 'process raft request' (duration: 260.632626ms)","trace[2131713904] 'compare' (duration: 150.179794ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:33:49.609804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:49.19733Z","time spent":"412.447096ms","remote":"127.0.0.1:55116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3541,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T17:33:49.610088Z","caller":"traceutil/trace.go:171","msg":"trace[1317193931] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"412.743318ms","start":"2026-02-05T17:33:49.197299Z","end":"2026-02-05T17:33:49.610042Z","steps":["trace[1317193931] 'process raft request' (duration: 411.796259ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:49.61019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:49.197273Z","time spent":"412.882343ms","remote":"127.0.0.1:55028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T17:33:59.94538Z","caller":"traceutil/trace.go:171","msg":"trace[932090748] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"119.549316ms","start":"2026-02-05T17:33:59.825813Z","end":"2026-02-05T17:33:59.945362Z","steps":["trace[932090748] 'process raft request' (duration: 119.450432ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:33:59.945514Z","caller":"traceutil/trace.go:171","msg":"trace[740776892] linearizableReadLoop","detail":"{readStateIndex:450; appliedIndex:450; }","duration":"104.106063ms","start":"2026-02-05T17:33:59.841399Z","end":"2026-02-05T17:33:59.945505Z","steps":["trace[740776892] 'read index received' (duration: 104.101603ms)","trace[740776892] 'applied index is now lower than readState.Index' (duration: 3.54µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:33:59.945602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.185166ms","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-05T17:33:59.945873Z","caller":"traceutil/trace.go:171","msg":"trace[2078027540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:432; }","duration":"104.468276ms","start":"2026-02-05T17:33:59.841395Z","end":"2026-02-05T17:33:59.945863Z","steps":["trace[2078027540] 'agreement among raft nodes before linearized reading' (duration: 104.133494ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:33:59.963949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.274721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T17:33:59.964054Z","caller":"traceutil/trace.go:171","msg":"trace[304198132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:432; }","duration":"109.386326ms","start":"2026-02-05T17:33:59.854624Z","end":"2026-02-05T17:33:59.96401Z","steps":["trace[304198132] 'agreement among raft nodes before linearized reading' (duration: 109.24214ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:04.238946Z","caller":"traceutil/trace.go:171","msg":"trace[1060799325] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"368.065412ms","start":"2026-02-05T17:34:03.870859Z","end":"2026-02-05T17:34:04.238925Z","steps":["trace[1060799325] 'process raft request' (duration: 367.939527ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:04.239102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:03.870842Z","time spent":"368.176826ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:34:04.239702Z","caller":"traceutil/trace.go:171","msg":"trace[1988980708] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:494; }","duration":"283.193695ms","start":"2026-02-05T17:34:03.956441Z","end":"2026-02-05T17:34:04.239635Z","steps":["trace[1988980708] 'read index received' (duration: 282.268653ms)","trace[1988980708] 'applied index is now lower than readState.Index' (duration: 923.862µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:04.241031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.572433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-05T17:34:04.241075Z","caller":"traceutil/trace.go:171","msg":"trace[887322405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"284.667706ms","start":"2026-02-05T17:34:03.956396Z","end":"2026-02-05T17:34:04.241064Z","steps":["trace[887322405] 'agreement among raft nodes before linearized reading' (duration: 284.569322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:04.241475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.621912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T17:34:04.241544Z","caller":"traceutil/trace.go:171","msg":"trace[369155184] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:475; }","duration":"241.721525ms","start":"2026-02-05T17:34:03.999812Z","end":"2026-02-05T17:34:04.241533Z","steps":["trace[369155184] 'agreement among raft nodes before linearized reading' (duration: 241.633222ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:04.241666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.346196ms","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-05T17:34:04.241695Z","caller":"traceutil/trace.go:171","msg":"trace[585552600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:475; }","duration":"254.399548ms","start":"2026-02-05T17:34:03.987286Z","end":"2026-02-05T17:34:04.241686Z","steps":["trace[585552600] 'agreement among raft nodes before linearized reading' (duration: 254.076627ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:04.242361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.678548ms","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-05T17:34:04.242525Z","caller":"traceutil/trace.go:171","msg":"trace[1607821822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:475; }","duration":"242.869705ms","start":"2026-02-05T17:34:03.99961Z","end":"2026-02-05T17:34:04.24248Z","steps":["trace[1607821822] 'agreement among raft nodes before linearized reading' (duration: 242.672298ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:06.677993Z","caller":"traceutil/trace.go:171","msg":"trace[1897747125] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:500; }","duration":"408.755288ms","start":"2026-02-05T17:34:06.269218Z","end":"2026-02-05T17:34:06.677974Z","steps":["trace[1897747125] 'read index received' (duration: 408.651975ms)","trace[1897747125] 'applied index is now lower than readState.Index' (duration: 102.733µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:06.678072Z","caller":"traceutil/trace.go:171","msg":"trace[1134253476] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"414.552845ms","start":"2026-02-05T17:34:06.263512Z","end":"2026-02-05T17:34:06.678065Z","steps":["trace[1134253476] 'process raft request' (duration: 414.356159ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:06.678142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:06.263488Z","time spent":"414.603466ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:34:06.67821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.466365ms","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-05T17:34:06.678255Z","caller":"traceutil/trace.go:171","msg":"trace[1976701568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:481; }","duration":"402.503057ms","start":"2026-02-05T17:34:06.275725Z","end":"2026-02-05T17:34:06.678229Z","steps":["trace[1976701568] 'agreement among raft nodes before linearized reading' (duration: 402.451855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:06.678279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:06.275718Z","time spent":"402.554248ms","remote":"127.0.0.1:55170","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-05T17:34:06.678341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.672436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:06.678363Z","caller":"traceutil/trace.go:171","msg":"trace[939015878] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:481; }","duration":"106.727658ms","start":"2026-02-05T17:34:06.571628Z","end":"2026-02-05T17:34:06.678355Z","steps":["trace[939015878] 'agreement among raft nodes before linearized reading' (duration: 106.694047ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:06.678392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.631911ms","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-05T17:34:06.67843Z","caller":"traceutil/trace.go:171","msg":"trace[567993716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:481; }","duration":"402.677933ms","start":"2026-02-05T17:34:06.275746Z","end":"2026-02-05T17:34:06.678424Z","steps":["trace[567993716] 'agreement among raft nodes before linearized reading' (duration: 402.622131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:06.67845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:06.275744Z","time spent":"402.700793ms","remote":"127.0.0.1:55170","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-05T17:34:06.678472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.249075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T17:34:06.678492Z","caller":"traceutil/trace.go:171","msg":"trace[607402233] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:481; }","duration":"409.283967ms","start":"2026-02-05T17:34:06.269202Z","end":"2026-02-05T17:34:06.678486Z","steps":["trace[607402233] 'agreement among raft nodes before linearized reading' (duration: 409.244175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:06.678509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:06.269195Z","time spent":"409.309167ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-05T17:34:10.951493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.847956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-05T17:34:10.951892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.049072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-05T17:34:10.951952Z","caller":"traceutil/trace.go:171","msg":"trace[99028566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"233.148006ms","start":"2026-02-05T17:34:10.718786Z","end":"2026-02-05T17:34:10.951934Z","steps":["trace[99028566] 'range keys from in-memory index tree' (duration: 232.866236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:10.952655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.880025ms","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-05T17:34:10.952705Z","caller":"traceutil/trace.go:171","msg":"trace[2042377349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"208.941596ms","start":"2026-02-05T17:34:10.743751Z","end":"2026-02-05T17:34:10.952693Z","steps":["trace[2042377349] 'range keys from in-memory index tree' (duration: 208.787402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:10.952904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.317377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T17:34:10.95294Z","caller":"traceutil/trace.go:171","msg":"trace[2035560799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"216.369428ms","start":"2026-02-05T17:34:10.736561Z","end":"2026-02-05T17:34:10.952931Z","steps":["trace[2035560799] 'range keys from in-memory index tree' (duration: 216.228514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:10.953276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.524005ms","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-05T17:34:10.953316Z","caller":"traceutil/trace.go:171","msg":"trace[1657116511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"201.574416ms","start":"2026-02-05T17:34:10.751732Z","end":"2026-02-05T17:34:10.953307Z","steps":["trace[1657116511] 'range keys from in-memory index tree' (duration: 201.455963ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:10.956299Z","caller":"traceutil/trace.go:171","msg":"trace[1549209915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"113.084104ms","start":"2026-02-05T17:34:10.838544Z","end":"2026-02-05T17:34:10.951628Z","steps":["trace[1549209915] 'range keys from in-memory index tree' (duration: 112.745863ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:11.105288Z","caller":"traceutil/trace.go:171","msg":"trace[291618019] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"143.890995ms","start":"2026-02-05T17:34:10.961375Z","end":"2026-02-05T17:34:11.105266Z","steps":["trace[291618019] 'process raft request' (duration: 143.739341ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:12.273362Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.168123946s","expected-duration":"1s"} {"level":"info","ts":"2026-02-05T17:34:12.273651Z","caller":"traceutil/trace.go:171","msg":"trace[948502956] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.309951573s","start":"2026-02-05T17:34:10.963682Z","end":"2026-02-05T17:34:12.273634Z","steps":["trace[948502956] 'process raft request' (duration: 1.309928552s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:12.273736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:10.963676Z","time spent":"1.310003716s","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:34:12.274018Z","caller":"traceutil/trace.go:171","msg":"trace[1920612825] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.31138094s","start":"2026-02-05T17:34:10.96263Z","end":"2026-02-05T17:34:12.274011Z","steps":["trace[1920612825] 'process raft request' (duration: 1.310869584s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:12.274059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:10.962604Z","time spent":"1.311435682s","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:34:12.274141Z","caller":"traceutil/trace.go:171","msg":"trace[1529955732] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.311426231s","start":"2026-02-05T17:34:10.962708Z","end":"2026-02-05T17:34:12.274134Z","steps":["trace[1529955732] 'process raft request' (duration: 1.310880234s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:12.274176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:10.962704Z","time spent":"1.311455512s","remote":"127.0.0.1:55170","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-05T17:34:12.616411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.805072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:12.616469Z","caller":"traceutil/trace.go:171","msg":"trace[1236237249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"173.896645ms","start":"2026-02-05T17:34:12.442559Z","end":"2026-02-05T17:34:12.616455Z","steps":["trace[1236237249] 'range keys from in-memory index tree' (duration: 173.72776ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:14.336121Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13360944444627571070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T17:34:14.837083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13360944444627571070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T17:34:14.899392Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.785862363s","expected-duration":"1s"} {"level":"info","ts":"2026-02-05T17:34:14.899857Z","caller":"traceutil/trace.go:171","msg":"trace[1153808750] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"1.78637503s","start":"2026-02-05T17:34:13.113464Z","end":"2026-02-05T17:34:14.899839Z","steps":["trace[1153808750] 'process raft request' (duration: 1.786257226s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:14.899975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:13.113441Z","time spent":"1.786471953s","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:34:15.836637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001047166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-05T17:34:15.836717Z","caller":"traceutil/trace.go:171","msg":"trace[657934302] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001134038s","start":"2026-02-05T17:34:13.835569Z","end":"2026-02-05T17:34:15.836703Z","steps":["trace[657934302] 'agreement among raft nodes before linearized reading' (duration: 2.001046036s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:15.836768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:13.835507Z","time spent":"2.001253062s","remote":"127.0.0.1:54910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/05 17:34:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-05T17:34:16.389794Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.490257581s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-05T17:34:16.428911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.264477ms","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-05T17:34:16.429013Z","caller":"traceutil/trace.go:171","msg":"trace[1289819600] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:520; }","duration":"722.381731ms","start":"2026-02-05T17:34:15.706618Z","end":"2026-02-05T17:34:16.429Z","steps":["trace[1289819600] 'range keys from in-memory index tree' (duration: 722.252387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:16.429159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:15.813223Z","time spent":"615.931587ms","remote":"127.0.0.1:41992","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-05T17:34:16.429429Z","caller":"traceutil/trace.go:171","msg":"trace[1748940055] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:540; }","duration":"2.593840905s","start":"2026-02-05T17:34:13.835574Z","end":"2026-02-05T17:34:16.429415Z","steps":["trace[1748940055] 'read index received' (duration: 1.064149552s)","trace[1748940055] 'applied index is now lower than readState.Index' (duration: 1.529690503s)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:16.429492Z","caller":"traceutil/trace.go:171","msg":"trace[1801202995] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"2.14813934s","start":"2026-02-05T17:34:14.281346Z","end":"2026-02-05T17:34:16.429486Z","steps":["trace[1801202995] 'process raft request' (duration: 2.108554273s)","trace[1801202995] 'compare' (duration: 38.926466ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:16.429559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:14.28133Z","time spent":"2.148177571s","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:34:16.429563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.151435573s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-05T17:34:16.42959Z","caller":"traceutil/trace.go:171","msg":"trace[1606088389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:521; }","duration":"2.151486215s","start":"2026-02-05T17:34:14.278096Z","end":"2026-02-05T17:34:16.429582Z","steps":["trace[1606088389] 'agreement among raft nodes before linearized reading' (duration: 2.151441323s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:16.429611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:14.278059Z","time spent":"2.151547286s","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T17:34:16.429735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.14974326s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-05T17:34:16.429754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.150962968s","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-05T17:34:16.42976Z","caller":"traceutil/trace.go:171","msg":"trace[1397214618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"2.149805362s","start":"2026-02-05T17:34:14.279949Z","end":"2026-02-05T17:34:16.429754Z","steps":["trace[1397214618] 'agreement among raft nodes before linearized reading' (duration: 2.14975129s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:16.42978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:14.27993Z","time spent":"2.149846513s","remote":"127.0.0.1:55170","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-05T17:34:16.429863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.826514603s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.186\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-05T17:34:16.429777Z","caller":"traceutil/trace.go:171","msg":"trace[673622124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:521; }","duration":"2.150983778s","start":"2026-02-05T17:34:14.278786Z","end":"2026-02-05T17:34:16.429769Z","steps":["trace[673622124] 'agreement among raft nodes before linearized reading' (duration: 2.150946787s)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:16.429882Z","caller":"traceutil/trace.go:171","msg":"trace[1443485701] range","detail":"{range_begin:/registry/masterleases/162.253.55.186; range_end:; response_count:1; response_revision:521; }","duration":"1.826560435s","start":"2026-02-05T17:34:14.603317Z","end":"2026-02-05T17:34:16.429877Z","steps":["trace[1443485701] 'agreement among raft nodes before linearized reading' (duration: 1.826526064s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:16.429901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:14.603302Z","time spent":"1.826595705s","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.186\" "} {"level":"warn","ts":"2026-02-05T17:34:16.429905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:14.278769Z","time spent":"2.151127933s","remote":"127.0.0.1:55170","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-05T17:34:16.429995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.414409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:16.430013Z","caller":"traceutil/trace.go:171","msg":"trace[1640644043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"593.478371ms","start":"2026-02-05T17:34:15.836529Z","end":"2026-02-05T17:34:16.430008Z","steps":["trace[1640644043] 'agreement among raft nodes before linearized reading' (duration: 593.44917ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:16.430031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:15.836517Z","time spent":"593.511121ms","remote":"127.0.0.1:54924","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-05T17:34:19.349856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.896963ms","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-05T17:34:19.349915Z","caller":"traceutil/trace.go:171","msg":"trace[1569039383] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:542; }","duration":"714.962985ms","start":"2026-02-05T17:34:18.634938Z","end":"2026-02-05T17:34:19.349901Z","steps":["trace[1569039383] 'range keys from in-memory index tree' (duration: 714.819262ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:19.349942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:18.634882Z","time spent":"715.054118ms","remote":"127.0.0.1:55068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-05T17:34:19.350127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.562802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:19.350146Z","caller":"traceutil/trace.go:171","msg":"trace[687420093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"511.618273ms","start":"2026-02-05T17:34:18.838522Z","end":"2026-02-05T17:34:19.35014Z","steps":["trace[687420093] 'range keys from in-memory index tree' (duration: 511.464689ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:19.350161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:18.838498Z","time spent":"511.659735ms","remote":"127.0.0.1:54910","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-05T17:34:19.350248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.308742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T17:34:19.350264Z","caller":"traceutil/trace.go:171","msg":"trace[619678990] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:542; }","duration":"439.324743ms","start":"2026-02-05T17:34:18.910934Z","end":"2026-02-05T17:34:19.350259Z","steps":["trace[619678990] 'range keys from in-memory index tree' (duration: 439.206849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:19.350279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:18.91086Z","time spent":"439.415425ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-05T17:34:20.719577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.560372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:34:20.71971Z","caller":"traceutil/trace.go:171","msg":"trace[1187166902] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"230.696609ms","start":"2026-02-05T17:34:20.488994Z","end":"2026-02-05T17:34:20.71969Z","steps":["trace[1187166902] 'process raft request' (duration: 66.956722ms)","trace[1187166902] 'compare' (duration: 163.424058ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:20.743449Z","caller":"traceutil/trace.go:171","msg":"trace[2128524718] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:594; }","duration":"213.519071ms","start":"2026-02-05T17:34:20.529908Z","end":"2026-02-05T17:34:20.743427Z","steps":["trace[2128524718] 'read index received' (duration: 26.049761ms)","trace[2128524718] 'applied index is now lower than readState.Index' (duration: 187.46843ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:20.743783Z","caller":"traceutil/trace.go:171","msg":"trace[442964807] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"251.569897ms","start":"2026-02-05T17:34:20.492198Z","end":"2026-02-05T17:34:20.743768Z","steps":["trace[442964807] 'process raft request' (duration: 250.99914ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:20.744033Z","caller":"traceutil/trace.go:171","msg":"trace[1555486190] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"246.781196ms","start":"2026-02-05T17:34:20.497242Z","end":"2026-02-05T17:34:20.744023Z","steps":["trace[1555486190] 'process raft request' (duration: 246.122206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:20.744216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.290774ms","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-05T17:34:20.744301Z","caller":"traceutil/trace.go:171","msg":"trace[1858475860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"214.408577ms","start":"2026-02-05T17:34:20.529881Z","end":"2026-02-05T17:34:20.74429Z","steps":["trace[1858475860] 'agreement among raft nodes before linearized reading' (duration: 214.280744ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:20.752974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.446235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-05T17:34:20.753023Z","caller":"traceutil/trace.go:171","msg":"trace[1803693299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"222.513577ms","start":"2026-02-05T17:34:20.530499Z","end":"2026-02-05T17:34:20.753012Z","steps":["trace[1803693299] 'agreement among raft nodes before linearized reading' (duration: 222.406444ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:20.753214Z","caller":"traceutil/trace.go:171","msg":"trace[1669561062] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"152.848125ms","start":"2026-02-05T17:34:20.600359Z","end":"2026-02-05T17:34:20.753207Z","steps":["trace[1669561062] 'process raft request' (duration: 152.490054ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:20.753307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.207921ms","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-05T17:34:20.753329Z","caller":"traceutil/trace.go:171","msg":"trace[786777200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"213.256483ms","start":"2026-02-05T17:34:20.540068Z","end":"2026-02-05T17:34:20.753324Z","steps":["trace[786777200] 'agreement among raft nodes before linearized reading' (duration: 213.214912ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:20.937482Z","caller":"traceutil/trace.go:171","msg":"trace[1227090284] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"182.341378ms","start":"2026-02-05T17:34:20.755119Z","end":"2026-02-05T17:34:20.937461Z","steps":["trace[1227090284] 'process raft request' (duration: 83.390259ms)","trace[1227090284] 'compare' (duration: 98.866816ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:20.954234Z","caller":"traceutil/trace.go:171","msg":"trace[168383944] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:598; }","duration":"120.471516ms","start":"2026-02-05T17:34:20.833746Z","end":"2026-02-05T17:34:20.954217Z","steps":["trace[168383944] 'read index received' (duration: 5.057149ms)","trace[168383944] 'applied index is now lower than readState.Index' (duration: 115.413787ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:20.954356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.59363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:20.954373Z","caller":"traceutil/trace.go:171","msg":"trace[2131531593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"120.654531ms","start":"2026-02-05T17:34:20.833714Z","end":"2026-02-05T17:34:20.954368Z","steps":["trace[2131531593] 'agreement among raft nodes before linearized reading' (duration: 120.566909ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:20.954607Z","caller":"traceutil/trace.go:171","msg":"trace[2040289184] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"193.983942ms","start":"2026-02-05T17:34:20.760617Z","end":"2026-02-05T17:34:20.954601Z","steps":["trace[2040289184] 'process raft request' (duration: 193.412865ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:20.954671Z","caller":"traceutil/trace.go:171","msg":"trace[441847068] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"192.433736ms","start":"2026-02-05T17:34:20.762232Z","end":"2026-02-05T17:34:20.954666Z","steps":["trace[441847068] 'process raft request' (duration: 191.88899ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:20.954769Z","caller":"traceutil/trace.go:171","msg":"trace[1238265710] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"192.084486ms","start":"2026-02-05T17:34:20.762679Z","end":"2026-02-05T17:34:20.954763Z","steps":["trace[1238265710] 'process raft request' (duration: 191.466668ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:20.954844Z","caller":"traceutil/trace.go:171","msg":"trace[1547719396] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"190.902991ms","start":"2026-02-05T17:34:20.763936Z","end":"2026-02-05T17:34:20.954839Z","steps":["trace[1547719396] 'process raft request' (duration: 190.234752ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:20.954902Z","caller":"traceutil/trace.go:171","msg":"trace[661298175] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"153.120503ms","start":"2026-02-05T17:34:20.801776Z","end":"2026-02-05T17:34:20.954896Z","steps":["trace[661298175] 'process raft request' (duration: 152.422492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:21.235058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.656518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:34:21.235527Z","caller":"traceutil/trace.go:171","msg":"trace[172052093] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"270.204836ms","start":"2026-02-05T17:34:20.965306Z","end":"2026-02-05T17:34:21.235511Z","steps":["trace[172052093] 'process raft request' (duration: 147.032023ms)","trace[172052093] 'compare' (duration: 122.585996ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:21.262079Z","caller":"traceutil/trace.go:171","msg":"trace[1701455383] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:604; }","duration":"262.806579ms","start":"2026-02-05T17:34:20.99924Z","end":"2026-02-05T17:34:21.262046Z","steps":["trace[1701455383] 'read index received' (duration: 113.16837ms)","trace[1701455383] 'applied index is now lower than readState.Index' (duration: 149.636859ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:21.262452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.193841ms","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-05T17:34:21.262663Z","caller":"traceutil/trace.go:171","msg":"trace[2045555401] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:583; }","duration":"263.439418ms","start":"2026-02-05T17:34:20.999205Z","end":"2026-02-05T17:34:21.262644Z","steps":["trace[2045555401] 'agreement among raft nodes before linearized reading' (duration: 263.16015ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:21.263123Z","caller":"traceutil/trace.go:171","msg":"trace[198466540] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"295.672302ms","start":"2026-02-05T17:34:20.967434Z","end":"2026-02-05T17:34:21.263106Z","steps":["trace[198466540] 'process raft request' (duration: 294.484007ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:21.389786Z","caller":"traceutil/trace.go:171","msg":"trace[1683260040] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"184.733548ms","start":"2026-02-05T17:34:21.205039Z","end":"2026-02-05T17:34:21.389773Z","steps":["trace[1683260040] 'process raft request' (duration: 176.655721ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:21.661518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.539801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:34:21.66164Z","caller":"traceutil/trace.go:171","msg":"trace[796018428] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:606; }","duration":"287.184053ms","start":"2026-02-05T17:34:21.374444Z","end":"2026-02-05T17:34:21.661628Z","steps":["trace[796018428] 'read index received' (duration: 7.255363ms)","trace[796018428] 'applied index is now lower than readState.Index' (duration: 279.92803ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:21.661687Z","caller":"traceutil/trace.go:171","msg":"trace[821886252] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"389.388371ms","start":"2026-02-05T17:34:21.272291Z","end":"2026-02-05T17:34:21.66168Z","steps":["trace[821886252] 'process raft request' (duration: 232.624193ms)","trace[821886252] 'compare' (duration: 156.455809ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:21.661725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:21.272275Z","time spent":"389.428403ms","remote":"127.0.0.1:54996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:34:21.661751Z","caller":"traceutil/trace.go:171","msg":"trace[1219677001] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"329.278848ms","start":"2026-02-05T17:34:21.332452Z","end":"2026-02-05T17:34:21.661731Z","steps":["trace[1219677001] 'process raft request' (duration: 329.133654ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:21.661833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:21.332414Z","time spent":"329.378331ms","remote":"127.0.0.1:55028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-05T17:34:21.661898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.452261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T17:34:21.661919Z","caller":"traceutil/trace.go:171","msg":"trace[495585629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"287.496883ms","start":"2026-02-05T17:34:21.374416Z","end":"2026-02-05T17:34:21.661912Z","steps":["trace[495585629] 'agreement among raft nodes before linearized reading' (duration: 287.439641ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:21.695785Z","caller":"traceutil/trace.go:171","msg":"trace[410100563] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"284.652239ms","start":"2026-02-05T17:34:21.411099Z","end":"2026-02-05T17:34:21.695751Z","steps":["trace[410100563] 'process raft request' (duration: 284.448493ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:21.696416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.448025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:21.696462Z","caller":"traceutil/trace.go:171","msg":"trace[1745998494] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:587; }","duration":"297.495676ms","start":"2026-02-05T17:34:21.398954Z","end":"2026-02-05T17:34:21.696449Z","steps":["trace[1745998494] 'agreement among raft nodes before linearized reading' (duration: 297.431234ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:21.696835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.129559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xpmwq\" ","response":"range_response_count:1 size:17670"} {"level":"info","ts":"2026-02-05T17:34:21.696864Z","caller":"traceutil/trace.go:171","msg":"trace[1409266463] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xpmwq; range_end:; response_count:1; response_revision:587; }","duration":"202.17397ms","start":"2026-02-05T17:34:21.494682Z","end":"2026-02-05T17:34:21.696856Z","steps":["trace[1409266463] 'agreement among raft nodes before linearized reading' (duration: 202.094037ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:21.696999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.797412ms","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-05T17:34:21.697025Z","caller":"traceutil/trace.go:171","msg":"trace[1246832504] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:587; }","duration":"212.858834ms","start":"2026-02-05T17:34:21.484158Z","end":"2026-02-05T17:34:21.697017Z","steps":["trace[1246832504] 'agreement among raft nodes before linearized reading' (duration: 212.816492ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:22.135072Z","caller":"traceutil/trace.go:171","msg":"trace[1402206008] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:612; }","duration":"335.904506ms","start":"2026-02-05T17:34:21.799136Z","end":"2026-02-05T17:34:22.135041Z","steps":["trace[1402206008] 'read index received' (duration: 335.35509ms)","trace[1402206008] 'applied index is now lower than readState.Index' (duration: 548.566µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:22.135189Z","caller":"traceutil/trace.go:171","msg":"trace[1824872665] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"415.12716ms","start":"2026-02-05T17:34:21.720051Z","end":"2026-02-05T17:34:22.135178Z","steps":["trace[1824872665] 'process raft request' (duration: 414.871293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:22.135278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:21.720045Z","time spent":"415.172261ms","remote":"127.0.0.1:55116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17817,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:34:22.135353Z","caller":"traceutil/trace.go:171","msg":"trace[1361073805] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"416.316455ms","start":"2026-02-05T17:34:21.719019Z","end":"2026-02-05T17:34:22.135335Z","steps":["trace[1361073805] 'process raft request' (duration: 415.545712ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:22.135447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:21.719003Z","time spent":"416.389737ms","remote":"127.0.0.1:54996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:34:22.135543Z","caller":"traceutil/trace.go:171","msg":"trace[1268233038] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"414.063639ms","start":"2026-02-05T17:34:21.721469Z","end":"2026-02-05T17:34:22.135533Z","steps":["trace[1268233038] 'process raft request' (duration: 413.534403ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:22.135599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:21.721462Z","time spent":"414.106711ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:34:22.135787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.656259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-05T17:34:22.135809Z","caller":"traceutil/trace.go:171","msg":"trace[2056389854] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:592; }","duration":"336.701809ms","start":"2026-02-05T17:34:21.799101Z","end":"2026-02-05T17:34:22.135803Z","steps":["trace[2056389854] 'agreement among raft nodes before linearized reading' (duration: 336.624537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:22.135826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:21.799074Z","time spent":"336.748851ms","remote":"127.0.0.1:54996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5608,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:34:22.135895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.969762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:22.135906Z","caller":"traceutil/trace.go:171","msg":"trace[1852667817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"300.004733ms","start":"2026-02-05T17:34:21.835897Z","end":"2026-02-05T17:34:22.135902Z","steps":["trace[1852667817] 'agreement among raft nodes before linearized reading' (duration: 299.987483ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:22.135917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:21.835884Z","time spent":"300.030924ms","remote":"127.0.0.1:54910","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-05T17:34:22.136036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.397745ms","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-05T17:34:22.136073Z","caller":"traceutil/trace.go:171","msg":"trace[499731536] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:592; }","duration":"136.469137ms","start":"2026-02-05T17:34:21.999593Z","end":"2026-02-05T17:34:22.136062Z","steps":["trace[499731536] 'agreement among raft nodes before linearized reading' (duration: 136.342543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:22.626375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.271051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xpmwq\" ","response":"range_response_count:1 size:17832"} {"level":"info","ts":"2026-02-05T17:34:22.626427Z","caller":"traceutil/trace.go:171","msg":"trace[1020562463] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xpmwq; range_end:; response_count:1; response_revision:592; }","duration":"125.359443ms","start":"2026-02-05T17:34:22.501057Z","end":"2026-02-05T17:34:22.626416Z","steps":["trace[1020562463] 'range keys from in-memory index tree' (duration: 125.215789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:22.626786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.549674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-05T17:34:22.626803Z","caller":"traceutil/trace.go:171","msg":"trace[1520203652] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:592; }","duration":"227.588534ms","start":"2026-02-05T17:34:22.399209Z","end":"2026-02-05T17:34:22.626797Z","steps":["trace[1520203652] 'range keys from in-memory index tree' (duration: 227.462401ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:22.626959Z","caller":"traceutil/trace.go:171","msg":"trace[1009058229] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"123.472459ms","start":"2026-02-05T17:34:22.50348Z","end":"2026-02-05T17:34:22.626952Z","steps":["trace[1009058229] 'process raft request' (duration: 123.007165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:23.399761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.290368ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:34:23.399825Z","caller":"traceutil/trace.go:171","msg":"trace[1168802697] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"600.999742ms","start":"2026-02-05T17:34:22.798815Z","end":"2026-02-05T17:34:23.399815Z","steps":["trace[1168802697] 'read index received' (duration: 135.537559ms)","trace[1168802697] 'applied index is now lower than readState.Index' (duration: 465.461293ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:23.399968Z","caller":"traceutil/trace.go:171","msg":"trace[1861511691] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"756.092439ms","start":"2026-02-05T17:34:22.643868Z","end":"2026-02-05T17:34:23.39996Z","steps":["trace[1861511691] 'process raft request' (duration: 290.542324ms)","trace[1861511691] 'compare' (duration: 465.180055ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:23.40001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:22.643846Z","time spent":"756.144461ms","remote":"127.0.0.1:55116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17903,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:34:23.40018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.360862ms","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-05T17:34:23.4002Z","caller":"traceutil/trace.go:171","msg":"trace[1151070846] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:594; }","duration":"601.407794ms","start":"2026-02-05T17:34:22.798785Z","end":"2026-02-05T17:34:23.400193Z","steps":["trace[1151070846] 'agreement among raft nodes before linearized reading' (duration: 601.322382ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:23.400218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:22.798771Z","time spent":"601.443135ms","remote":"127.0.0.1:54996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4105,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:34:23.438035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.413004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-05T17:34:23.43813Z","caller":"traceutil/trace.go:171","msg":"trace[386157018] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:595; }","duration":"239.539758ms","start":"2026-02-05T17:34:23.19858Z","end":"2026-02-05T17:34:23.43812Z","steps":["trace[386157018] 'agreement among raft nodes before linearized reading' (duration: 239.392724ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:23.438149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.404377ms","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-05T17:34:23.438178Z","caller":"traceutil/trace.go:171","msg":"trace[518682028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"480.441669ms","start":"2026-02-05T17:34:22.957728Z","end":"2026-02-05T17:34:23.43817Z","steps":["trace[518682028] 'agreement among raft nodes before linearized reading' (duration: 480.387587ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:23.438219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:22.95772Z","time spent":"480.49325ms","remote":"127.0.0.1:55170","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":"info","ts":"2026-02-05T17:34:23.438416Z","caller":"traceutil/trace.go:171","msg":"trace[2042864107] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"412.568972ms","start":"2026-02-05T17:34:23.025841Z","end":"2026-02-05T17:34:23.43841Z","steps":["trace[2042864107] 'process raft request' (duration: 411.945664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:23.43848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:23.025815Z","time spent":"412.637623ms","remote":"127.0.0.1:54996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-05T17:34:23.438035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.860426ms","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-05T17:34:23.438659Z","caller":"traceutil/trace.go:171","msg":"trace[32182650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"496.524726ms","start":"2026-02-05T17:34:22.942128Z","end":"2026-02-05T17:34:23.438652Z","steps":["trace[32182650] 'agreement among raft nodes before linearized reading' (duration: 495.799985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:23.438688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:22.942113Z","time spent":"496.569087ms","remote":"127.0.0.1:55170","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-05T17:34:23.438095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.624149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-05T17:34:23.438799Z","caller":"traceutil/trace.go:171","msg":"trace[391627173] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"476.338009ms","start":"2026-02-05T17:34:22.962456Z","end":"2026-02-05T17:34:23.438794Z","steps":["trace[391627173] 'agreement among raft nodes before linearized reading' (duration: 475.604728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:23.438828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:22.962451Z","time spent":"476.36993ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-05T17:34:23.628753Z","caller":"traceutil/trace.go:171","msg":"trace[437374026] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"201.985927ms","start":"2026-02-05T17:34:23.426751Z","end":"2026-02-05T17:34:23.628737Z","steps":["trace[437374026] 'process raft request' (duration: 198.315451ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:23.719678Z","caller":"traceutil/trace.go:171","msg":"trace[681869437] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"275.585946ms","start":"2026-02-05T17:34:23.444077Z","end":"2026-02-05T17:34:23.719663Z","steps":["trace[681869437] 'process raft request' (duration: 274.401002ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:23.719921Z","caller":"traceutil/trace.go:171","msg":"trace[1950154774] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"275.783502ms","start":"2026-02-05T17:34:23.444133Z","end":"2026-02-05T17:34:23.719916Z","steps":["trace[1950154774] 'process raft request' (duration: 275.446152ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:23.720117Z","caller":"traceutil/trace.go:171","msg":"trace[587828130] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"272.202039ms","start":"2026-02-05T17:34:23.447909Z","end":"2026-02-05T17:34:23.720111Z","steps":["trace[587828130] 'process raft request' (duration: 271.824948ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:23.720236Z","caller":"traceutil/trace.go:171","msg":"trace[1446089559] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:618; }","duration":"107.639529ms","start":"2026-02-05T17:34:23.612583Z","end":"2026-02-05T17:34:23.720222Z","steps":["trace[1446089559] 'read index received' (duration: 12.49303ms)","trace[1446089559] 'applied index is now lower than readState.Index' (duration: 95.145629ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:23.720397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.796774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-05T17:34:23.720426Z","caller":"traceutil/trace.go:171","msg":"trace[415168397] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:600; }","duration":"107.859986ms","start":"2026-02-05T17:34:23.612557Z","end":"2026-02-05T17:34:23.720417Z","steps":["trace[415168397] 'agreement among raft nodes before linearized reading' (duration: 107.711782ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:23.725943Z","caller":"traceutil/trace.go:171","msg":"trace[1310336302] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"142.182094ms","start":"2026-02-05T17:34:23.583726Z","end":"2026-02-05T17:34:23.725908Z","steps":["trace[1310336302] 'process raft request' (duration: 136.178571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:24.006477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.823191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T17:34:24.006564Z","caller":"traceutil/trace.go:171","msg":"trace[1504006548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"243.944814ms","start":"2026-02-05T17:34:23.762602Z","end":"2026-02-05T17:34:24.006546Z","steps":["trace[1504006548] 'range keys from in-memory index tree' (duration: 243.740229ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:24.015475Z","caller":"traceutil/trace.go:171","msg":"trace[1793677122] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"111.048475ms","start":"2026-02-05T17:34:23.90441Z","end":"2026-02-05T17:34:24.015459Z","steps":["trace[1793677122] 'process raft request' (duration: 110.949072ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:24.015684Z","caller":"traceutil/trace.go:171","msg":"trace[310464047] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"194.19868ms","start":"2026-02-05T17:34:23.821479Z","end":"2026-02-05T17:34:24.015678Z","steps":["trace[310464047] 'process raft request' (duration: 193.377867ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:24.015756Z","caller":"traceutil/trace.go:171","msg":"trace[1782911686] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"171.488255ms","start":"2026-02-05T17:34:23.844262Z","end":"2026-02-05T17:34:24.01575Z","steps":["trace[1782911686] 'read index received' (duration: 170.522908ms)","trace[1782911686] 'applied index is now lower than readState.Index' (duration: 963.977µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:24.016042Z","caller":"traceutil/trace.go:171","msg":"trace[1987754143] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"171.610349ms","start":"2026-02-05T17:34:23.844413Z","end":"2026-02-05T17:34:24.016023Z","steps":["trace[1987754143] 'process raft request' (duration: 170.809626ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:24.016171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.897078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:24.016195Z","caller":"traceutil/trace.go:171","msg":"trace[1132434920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"171.952869ms","start":"2026-02-05T17:34:23.844235Z","end":"2026-02-05T17:34:24.016188Z","steps":["trace[1132434920] 'agreement among raft nodes before linearized reading' (duration: 171.906797ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:24.325001Z","caller":"traceutil/trace.go:171","msg":"trace[624816631] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"246.241907ms","start":"2026-02-05T17:34:24.078741Z","end":"2026-02-05T17:34:24.324983Z","steps":["trace[624816631] 'process raft request' (duration: 226.323139ms)","trace[624816631] 'compare' (duration: 19.096065ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:24.326834Z","caller":"traceutil/trace.go:171","msg":"trace[1091301027] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"183.650931ms","start":"2026-02-05T17:34:24.143171Z","end":"2026-02-05T17:34:24.326822Z","steps":["trace[1091301027] 'read index received' (duration: 161.90108ms)","trace[1091301027] 'applied index is now lower than readState.Index' (duration: 21.748181ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:24.327133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.94748ms","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-05T17:34:24.327165Z","caller":"traceutil/trace.go:171","msg":"trace[707765990] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:605; }","duration":"184.011551ms","start":"2026-02-05T17:34:24.143146Z","end":"2026-02-05T17:34:24.327158Z","steps":["trace[707765990] 'agreement among raft nodes before linearized reading' (duration: 183.867677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:24.331126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.203301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-05T17:34:24.331157Z","caller":"traceutil/trace.go:171","msg":"trace[1414157637] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:606; }","duration":"147.261133ms","start":"2026-02-05T17:34:24.183887Z","end":"2026-02-05T17:34:24.331148Z","steps":["trace[1414157637] 'agreement among raft nodes before linearized reading' (duration: 146.776219ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:24.331621Z","caller":"traceutil/trace.go:171","msg":"trace[1902187254] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"129.560027ms","start":"2026-02-05T17:34:24.202046Z","end":"2026-02-05T17:34:24.331606Z","steps":["trace[1902187254] 'process raft request' (duration: 122.379532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:34:32.125901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.957396ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-05T17:34:32.126891Z","caller":"traceutil/trace.go:171","msg":"trace[1098298406] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"146.925514ms","start":"2026-02-05T17:34:31.979919Z","end":"2026-02-05T17:34:32.126844Z","steps":["trace[1098298406] 'process raft request' (duration: 146.39512ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:32.276938Z","caller":"traceutil/trace.go:171","msg":"trace[179779566] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"140.879438ms","start":"2026-02-05T17:34:32.136034Z","end":"2026-02-05T17:34:32.276913Z","steps":["trace[179779566] 'process raft request' (duration: 115.943174ms)","trace[179779566] 'compare' (duration: 24.822101ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:34:32.322627Z","caller":"traceutil/trace.go:171","msg":"trace[909811373] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"185.067063ms","start":"2026-02-05T17:34:32.137543Z","end":"2026-02-05T17:34:32.32261Z","steps":["trace[909811373] 'process raft request' (duration: 184.96235ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:32.808659Z","caller":"traceutil/trace.go:171","msg":"trace[205386964] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"157.366006ms","start":"2026-02-05T17:34:32.651271Z","end":"2026-02-05T17:34:32.808637Z","steps":["trace[205386964] 'process raft request' (duration: 157.211882ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:32.968131Z","caller":"traceutil/trace.go:171","msg":"trace[355289543] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"151.965432ms","start":"2026-02-05T17:34:32.816143Z","end":"2026-02-05T17:34:32.968109Z","steps":["trace[355289543] 'process raft request' (duration: 151.789347ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:32.98865Z","caller":"traceutil/trace.go:171","msg":"trace[1967876264] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:709; }","duration":"151.194002ms","start":"2026-02-05T17:34:32.837439Z","end":"2026-02-05T17:34:32.988633Z","steps":["trace[1967876264] 'read index received' (duration: 131.20833ms)","trace[1967876264] 'applied index is now lower than readState.Index' (duration: 19.984722ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:32.988867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.416358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:34:32.988951Z","caller":"traceutil/trace.go:171","msg":"trace[624057504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:685; }","duration":"151.535161ms","start":"2026-02-05T17:34:32.837407Z","end":"2026-02-05T17:34:32.988942Z","steps":["trace[624057504] 'agreement among raft nodes before linearized reading' (duration: 151.386447ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:32.989329Z","caller":"traceutil/trace.go:171","msg":"trace[88020958] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"172.964981ms","start":"2026-02-05T17:34:32.816355Z","end":"2026-02-05T17:34:32.98932Z","steps":["trace[88020958] 'process raft request' (duration: 172.035346ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:32.991436Z","caller":"traceutil/trace.go:171","msg":"trace[1809007985] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"169.301123ms","start":"2026-02-05T17:34:32.822119Z","end":"2026-02-05T17:34:32.99142Z","steps":["trace[1809007985] 'process raft request' (duration: 166.462007ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.139425Z","caller":"traceutil/trace.go:171","msg":"trace[1660904791] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"141.286687ms","start":"2026-02-05T17:34:32.998124Z","end":"2026-02-05T17:34:33.139411Z","steps":["trace[1660904791] 'process raft request' (duration: 139.448568ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.270913Z","caller":"traceutil/trace.go:171","msg":"trace[600550179] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:711; }","duration":"267.463743ms","start":"2026-02-05T17:34:33.003431Z","end":"2026-02-05T17:34:33.270895Z","steps":["trace[600550179] 'read index received' (duration: 134.149537ms)","trace[600550179] 'applied index is now lower than readState.Index' (duration: 133.313506ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:33.271041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.596526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-k2q2d\" ","response":"range_response_count:1 size:5026"} {"level":"info","ts":"2026-02-05T17:34:33.271058Z","caller":"traceutil/trace.go:171","msg":"trace[871074371] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-k2q2d; range_end:; response_count:1; response_revision:688; }","duration":"267.643868ms","start":"2026-02-05T17:34:33.003408Z","end":"2026-02-05T17:34:33.271052Z","steps":["trace[871074371] 'agreement among raft nodes before linearized reading' (duration: 267.541365ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.271215Z","caller":"traceutil/trace.go:171","msg":"trace[73275117] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"271.813939ms","start":"2026-02-05T17:34:32.999395Z","end":"2026-02-05T17:34:33.271209Z","steps":["trace[73275117] 'process raft request' (duration: 271.403458ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.271337Z","caller":"traceutil/trace.go:171","msg":"trace[1896732116] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"269.643411ms","start":"2026-02-05T17:34:33.001685Z","end":"2026-02-05T17:34:33.271329Z","steps":["trace[1896732116] 'process raft request' (duration: 269.182599ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.450757Z","caller":"traceutil/trace.go:171","msg":"trace[95894705] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"304.256024ms","start":"2026-02-05T17:34:33.146485Z","end":"2026-02-05T17:34:33.450741Z","steps":["trace[95894705] 'process raft request' (duration: 292.363881ms)","trace[95894705] 'compare' (duration: 11.816621ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:34:33.450858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:33.14647Z","time spent":"304.330447ms","remote":"127.0.0.1:55390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:34:33.476634Z","caller":"traceutil/trace.go:171","msg":"trace[1300383788] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"194.744817ms","start":"2026-02-05T17:34:33.281875Z","end":"2026-02-05T17:34:33.476619Z","steps":["trace[1300383788] 'process raft request' (duration: 194.658285ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.837681Z","caller":"traceutil/trace.go:171","msg":"trace[830701545] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"264.014404ms","start":"2026-02-05T17:34:33.573655Z","end":"2026-02-05T17:34:33.837669Z","steps":["trace[830701545] 'process raft request' (duration: 263.984673ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.837969Z","caller":"traceutil/trace.go:171","msg":"trace[52994686] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"266.364555ms","start":"2026-02-05T17:34:33.571597Z","end":"2026-02-05T17:34:33.837962Z","steps":["trace[52994686] 'process raft request' (duration: 265.875112ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.837995Z","caller":"traceutil/trace.go:171","msg":"trace[1594337578] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"266.322004ms","start":"2026-02-05T17:34:33.571669Z","end":"2026-02-05T17:34:33.837991Z","steps":["trace[1594337578] 'process raft request' (duration: 265.893363ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.838076Z","caller":"traceutil/trace.go:171","msg":"trace[1347611512] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"266.376325ms","start":"2026-02-05T17:34:33.571694Z","end":"2026-02-05T17:34:33.83807Z","steps":["trace[1347611512] 'process raft request' (duration: 265.895453ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.838146Z","caller":"traceutil/trace.go:171","msg":"trace[124895483] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"266.350545ms","start":"2026-02-05T17:34:33.57179Z","end":"2026-02-05T17:34:33.838141Z","steps":["trace[124895483] 'process raft request' (duration: 265.826261ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:34:33.890581Z","caller":"traceutil/trace.go:171","msg":"trace[1205445635] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"248.774591ms","start":"2026-02-05T17:34:33.641781Z","end":"2026-02-05T17:34:33.890556Z","steps":["trace[1205445635] 'process raft request' (duration: 248.607267ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:35:21.046561Z","caller":"traceutil/trace.go:171","msg":"trace[1100893544] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"132.061208ms","start":"2026-02-05T17:35:20.914483Z","end":"2026-02-05T17:35:21.046544Z","steps":["trace[1100893544] 'process raft request' (duration: 131.972937ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:35:24.713281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.686007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.186\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-05T17:35:24.71333Z","caller":"traceutil/trace.go:171","msg":"trace[1192165589] range","detail":"{range_begin:/registry/masterleases/162.253.55.186; range_end:; response_count:1; response_revision:863; }","duration":"106.772329ms","start":"2026-02-05T17:35:24.606544Z","end":"2026-02-05T17:35:24.713316Z","steps":["trace[1192165589] 'range keys from in-memory index tree' (duration: 106.577265ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:35:24.713454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.400176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T17:35:24.713473Z","caller":"traceutil/trace.go:171","msg":"trace[1601903377] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:863; }","duration":"103.445317ms","start":"2026-02-05T17:35:24.610023Z","end":"2026-02-05T17:35:24.713469Z","steps":["trace[1601903377] 'range keys from in-memory index tree' (duration: 103.311375ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:35:45.415244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.457896ms","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-05T17:35:45.415322Z","caller":"traceutil/trace.go:171","msg":"trace[839733047] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:959; }","duration":"255.594528ms","start":"2026-02-05T17:35:45.159709Z","end":"2026-02-05T17:35:45.415303Z","steps":["trace[839733047] 'range keys from in-memory index tree' (duration: 255.157291ms)"],"step_count":1}