{"level":"warn","ts":"2026-10-17T11:24:45.094531Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T11:24:45.094652Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.205: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.205:2380","--initial-cluster=instance=https://162.253.55.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.205: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-10-17T11:24:45.094723Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T11:24:45.094732Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.205:2380"]} {"level":"info","ts":"2026-10-17T11:24:45.094751Z","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-10-17T11:24:45.09543Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"]} {"level":"info","ts":"2026-10-17T11:24:45.095522Z","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":8,"max-cpu-available":8,"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.205:2380"],"listen-peer-urls":["https://162.253.55.205:2380"],"advertise-client-urls":["https://162.253.55.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.205: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-10-17T11:24:45.099542Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.781986ms"} {"level":"info","ts":"2026-10-17T11:24:45.105612Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f1f73ead33f822e","cluster-id":"eaba2551c55d0fa5"} {"level":"info","ts":"2026-10-17T11:24:45.105683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T11:24:45.105705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became follower at term 0"} {"level":"info","ts":"2026-10-17T11:24:45.105716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f1f73ead33f822e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T11:24:45.105725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became follower at term 1"} {"level":"info","ts":"2026-10-17T11:24:45.105762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=(6854324610284880430)"} {"level":"warn","ts":"2026-10-17T11:24:45.117166Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T11:24:45.123394Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T11:24:45.125326Z","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-10-17T11:24:45.128499Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f1f73ead33f822e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T11:24:45.128676Z","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-10-17T11:24:45.128761Z","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-10-17T11:24:45.128773Z","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-10-17T11:24:45.128791Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f1f73ead33f822e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T11:24:45.131867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=(6854324610284880430)"} {"level":"info","ts":"2026-10-17T11:24:45.132174Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"eaba2551c55d0fa5","local-member-id":"5f1f73ead33f822e","added-peer-id":"5f1f73ead33f822e","added-peer-peer-urls":["https://162.253.55.205:2380"]} {"level":"info","ts":"2026-10-17T11:24:45.14117Z","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-10-17T11:24:45.14149Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f1f73ead33f822e","initial-advertise-peer-urls":["https://162.253.55.205:2380"],"listen-peer-urls":["https://162.253.55.205:2380"],"advertise-client-urls":["https://162.253.55.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T11:24:45.141531Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T11:24:45.141873Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.205:2380"} {"level":"info","ts":"2026-10-17T11:24:45.141951Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.205:2380"} {"level":"info","ts":"2026-10-17T11:24:45.407449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T11:24:45.407527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T11:24:45.40766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e received MsgPreVoteResp from 5f1f73ead33f822e at term 1"} {"level":"info","ts":"2026-10-17T11:24:45.407722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became candidate at term 2"} {"level":"info","ts":"2026-10-17T11:24:45.407742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e received MsgVoteResp from 5f1f73ead33f822e at term 2"} {"level":"info","ts":"2026-10-17T11:24:45.407792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became leader at term 2"} {"level":"info","ts":"2026-10-17T11:24:45.407814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f1f73ead33f822e elected leader 5f1f73ead33f822e at term 2"} {"level":"info","ts":"2026-10-17T11:24:45.409382Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f1f73ead33f822e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.205:2379]}","request-path":"/0/members/5f1f73ead33f822e/attributes","cluster-id":"eaba2551c55d0fa5","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T11:24:45.409488Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T11:24:45.40962Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T11:24:45.409717Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:24:45.41102Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"eaba2551c55d0fa5","local-member-id":"5f1f73ead33f822e","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:24:45.411174Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:24:45.411233Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:24:45.412974Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T11:24:45.413019Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T11:24:45.414377Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T11:24:45.414759Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.205:2379"} {"level":"warn","ts":"2026-10-17T11:25:10.004479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.826143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T11:25:10.004625Z","caller":"traceutil/trace.go:171","msg":"trace[223481255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:430; }","duration":"121.038527ms","start":"2026-10-17T11:25:09.883565Z","end":"2026-10-17T11:25:10.004604Z","steps":["trace[223481255] 'range keys from in-memory index tree' (duration: 120.612849ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:25:36.238584Z","caller":"traceutil/trace.go:171","msg":"trace[835002598] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"112.274948ms","start":"2026-10-17T11:25:36.126272Z","end":"2026-10-17T11:25:36.238547Z","steps":["trace[835002598] 'process raft request' (duration: 112.021794ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:25:36.670146Z","caller":"traceutil/trace.go:171","msg":"trace[1914351655] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"247.782794ms","start":"2026-10-17T11:25:36.422302Z","end":"2026-10-17T11:25:36.670084Z","steps":["trace[1914351655] 'read index received' (duration: 240.406147ms)","trace[1914351655] 'applied index is now lower than readState.Index' (duration: 7.375527ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:25:36.670271Z","caller":"traceutil/trace.go:171","msg":"trace[1860054268] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"328.317518ms","start":"2026-10-17T11:25:36.341887Z","end":"2026-10-17T11:25:36.670204Z","steps":["trace[1860054268] 'process raft request' (duration: 321.5009ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:25:36.670403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.075678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-17T11:25:36.670451Z","caller":"traceutil/trace.go:171","msg":"trace[78958378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"248.171869ms","start":"2026-10-17T11:25:36.422265Z","end":"2026-10-17T11:25:36.670437Z","steps":["trace[78958378] 'agreement among raft nodes before linearized reading' (duration: 247.993956ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:25:36.671054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:25:36.341853Z","time spent":"328.565782ms","remote":"127.0.0.1:55906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:25:36.941451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.647789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:25:36.941564Z","caller":"traceutil/trace.go:171","msg":"trace[1798261194] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"261.313188ms","start":"2026-10-17T11:25:36.680229Z","end":"2026-10-17T11:25:36.941542Z","steps":["trace[1798261194] 'process raft request' (duration: 39.318873ms)","trace[1798261194] 'compare' (duration: 221.501077ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:25:37.261251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.174514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:25:37.261418Z","caller":"traceutil/trace.go:171","msg":"trace[1453856461] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:669; }","duration":"566.19567ms","start":"2026-10-17T11:25:36.69518Z","end":"2026-10-17T11:25:37.261376Z","steps":["trace[1453856461] 'read index received' (duration: 24.381626ms)","trace[1453856461] 'applied index is now lower than readState.Index' (duration: 541.812274ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:25:37.261564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.387263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:25:37.261611Z","caller":"traceutil/trace.go:171","msg":"trace[1502839058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"566.569695ms","start":"2026-10-17T11:25:36.695027Z","end":"2026-10-17T11:25:37.261597Z","steps":["trace[1502839058] 'agreement among raft nodes before linearized reading' (duration: 566.448733ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:25:37.261652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:25:36.695001Z","time spent":"566.641357ms","remote":"127.0.0.1:55796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-17T11:25:37.261727Z","caller":"traceutil/trace.go:171","msg":"trace[591332003] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"580.506966ms","start":"2026-10-17T11:25:36.681144Z","end":"2026-10-17T11:25:37.261651Z","steps":["trace[591332003] 'process raft request' (duration: 378.824554ms)","trace[591332003] 'compare' (duration: 201.043342ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:25:37.262001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:25:36.681125Z","time spent":"580.72733ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:25:37.275058Z","caller":"traceutil/trace.go:171","msg":"trace[2036391360] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"520.917543ms","start":"2026-10-17T11:25:36.754115Z","end":"2026-10-17T11:25:37.275033Z","steps":["trace[2036391360] 'process raft request' (duration: 520.73757ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:25:37.275271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:25:36.754093Z","time spent":"521.131666ms","remote":"127.0.0.1:56178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-17T11:25:53.492554Z","caller":"traceutil/trace.go:171","msg":"trace[1834226973] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"131.806631ms","start":"2026-10-17T11:25:53.360723Z","end":"2026-10-17T11:25:53.492529Z","steps":["trace[1834226973] 'read index received' (duration: 131.516896ms)","trace[1834226973] 'applied index is now lower than readState.Index' (duration: 288.565µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:25:53.492654Z","caller":"traceutil/trace.go:171","msg":"trace[88995799] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"238.835138ms","start":"2026-10-17T11:25:53.253785Z","end":"2026-10-17T11:25:53.49262Z","steps":["trace[88995799] 'process raft request' (duration: 238.586834ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:25:53.492827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.079215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-17T11:25:53.492933Z","caller":"traceutil/trace.go:171","msg":"trace[1140465015] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:818; }","duration":"132.255477ms","start":"2026-10-17T11:25:53.360656Z","end":"2026-10-17T11:25:53.492911Z","steps":["trace[1140465015] 'agreement among raft nodes before linearized reading' (duration: 132.000994ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:26:25.475417Z","caller":"traceutil/trace.go:171","msg":"trace[944907108] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"270.303ms","start":"2026-10-17T11:26:25.20509Z","end":"2026-10-17T11:26:25.475393Z","steps":["trace[944907108] 'process raft request' (duration: 270.131277ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:26:50.88184Z","caller":"traceutil/trace.go:171","msg":"trace[1575984013] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"128.704602ms","start":"2026-10-17T11:26:50.753104Z","end":"2026-10-17T11:26:50.881808Z","steps":["trace[1575984013] 'process raft request' (duration: 71.874397ms)","trace[1575984013] 'compare' (duration: 56.693543ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:26:53.154998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.041076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107267"} {"level":"info","ts":"2026-10-17T11:26:53.1553Z","caller":"traceutil/trace.go:171","msg":"trace[754752551] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:1525; }","duration":"104.40974ms","start":"2026-10-17T11:26:53.050856Z","end":"2026-10-17T11:26:53.155266Z","steps":["trace[754752551] 'range keys from in-memory index tree' (duration: 103.782742ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:27:17.23408Z","caller":"traceutil/trace.go:171","msg":"trace[2037634111] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"133.945742ms","start":"2026-10-17T11:27:17.100095Z","end":"2026-10-17T11:27:17.234041Z","steps":["trace[2037634111] 'process raft request' (duration: 133.72311ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:27:17.808825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.387827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-def472d0-1a64-42a0-ac85-1240d15b0eec\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-17T11:27:17.808914Z","caller":"traceutil/trace.go:171","msg":"trace[1286644174] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-def472d0-1a64-42a0-ac85-1240d15b0eec; range_end:; response_count:1; response_revision:1911; }","duration":"117.539289ms","start":"2026-10-17T11:27:17.691357Z","end":"2026-10-17T11:27:17.808896Z","steps":["trace[1286644174] 'range keys from in-memory index tree' (duration: 117.191045ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:27:17.809232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.927292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:27:17.809325Z","caller":"traceutil/trace.go:171","msg":"trace[1632486242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1911; }","duration":"127.130845ms","start":"2026-10-17T11:27:17.682174Z","end":"2026-10-17T11:27:17.809305Z","steps":["trace[1632486242] 'range keys from in-memory index tree' (duration: 126.836821ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:27:31.447324Z","caller":"traceutil/trace.go:171","msg":"trace[1968866397] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"129.494637ms","start":"2026-10-17T11:27:31.317776Z","end":"2026-10-17T11:27:31.44727Z","steps":["trace[1968866397] 'process raft request' (duration: 129.299244ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:27:53.883605Z","caller":"traceutil/trace.go:171","msg":"trace[1409265223] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"311.543423ms","start":"2026-10-17T11:27:53.572033Z","end":"2026-10-17T11:27:53.883576Z","steps":["trace[1409265223] 'process raft request' (duration: 309.781335ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:27:53.883769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.132918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:27:53.883816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:27:53.571982Z","time spent":"311.714679ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:27:53.883835Z","caller":"traceutil/trace.go:171","msg":"trace[1134163177] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2157; }","duration":"253.223581ms","start":"2026-10-17T11:27:53.630592Z","end":"2026-10-17T11:27:53.883816Z","steps":["trace[1134163177] 'agreement among raft nodes before linearized reading' (duration: 253.075476ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:27:53.883577Z","caller":"traceutil/trace.go:171","msg":"trace[1404580216] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2235; }","duration":"252.91491ms","start":"2026-10-17T11:27:53.630615Z","end":"2026-10-17T11:27:53.88353Z","steps":["trace[1404580216] 'read index received' (duration: 251.217005ms)","trace[1404580216] 'applied index is now lower than readState.Index' (duration: 1.696225ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:27:53.8842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.155137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:27:53.884248Z","caller":"traceutil/trace.go:171","msg":"trace[544413505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2157; }","duration":"202.299671ms","start":"2026-10-17T11:27:53.681934Z","end":"2026-10-17T11:27:53.884234Z","steps":["trace[544413505] 'agreement among raft nodes before linearized reading' (duration: 202.233679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:27:53.884651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.221607ms","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-10-17T11:27:53.884692Z","caller":"traceutil/trace.go:171","msg":"trace[1097593179] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2157; }","duration":"151.3197ms","start":"2026-10-17T11:27:53.733362Z","end":"2026-10-17T11:27:53.884681Z","steps":["trace[1097593179] 'agreement among raft nodes before linearized reading' (duration: 151.147095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:27:53.884881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.264921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-17T11:27:53.884919Z","caller":"traceutil/trace.go:171","msg":"trace[399297388] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2157; }","duration":"188.323334ms","start":"2026-10-17T11:27:53.696583Z","end":"2026-10-17T11:27:53.884906Z","steps":["trace[399297388] 'agreement among raft nodes before linearized reading' (duration: 188.2244ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:04.70327Z","caller":"traceutil/trace.go:171","msg":"trace[916333479] linearizableReadLoop","detail":"{readStateIndex:2734; appliedIndex:2733; }","duration":"264.103033ms","start":"2026-10-17T11:29:04.439132Z","end":"2026-10-17T11:29:04.703235Z","steps":["trace[916333479] 'read index received' (duration: 261.18478ms)","trace[916333479] 'applied index is now lower than readState.Index' (duration: 2.915993ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:29:04.703497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.336529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-17T11:29:04.703598Z","caller":"traceutil/trace.go:171","msg":"trace[208393962] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2637; }","duration":"264.491133ms","start":"2026-10-17T11:29:04.439083Z","end":"2026-10-17T11:29:04.703575Z","steps":["trace[208393962] 'agreement among raft nodes before linearized reading' (duration: 264.239767ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:29:04.703587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.649956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:29:04.703688Z","caller":"traceutil/trace.go:171","msg":"trace[154226199] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2637; }","duration":"256.81705ms","start":"2026-10-17T11:29:04.446848Z","end":"2026-10-17T11:29:04.703665Z","steps":["trace[154226199] 'agreement among raft nodes before linearized reading' (duration: 256.628846ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:29:04.703942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.154609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-17T11:29:04.704075Z","caller":"traceutil/trace.go:171","msg":"trace[819775969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2637; }","duration":"132.377354ms","start":"2026-10-17T11:29:04.571674Z","end":"2026-10-17T11:29:04.704051Z","steps":["trace[819775969] 'agreement among raft nodes before linearized reading' (duration: 131.984044ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:35.838133Z","caller":"traceutil/trace.go:171","msg":"trace[2106612240] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"105.625629ms","start":"2026-10-17T11:29:35.732484Z","end":"2026-10-17T11:29:35.838109Z","steps":["trace[2106612240] 'process raft request' (duration: 105.479736ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:41.671229Z","caller":"traceutil/trace.go:171","msg":"trace[1136013670] transaction","detail":"{read_only:false; response_revision:2841; number_of_response:1; }","duration":"110.239874ms","start":"2026-10-17T11:29:41.560962Z","end":"2026-10-17T11:29:41.671202Z","steps":["trace[1136013670] 'process raft request' (duration: 110.06612ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:16.592954Z","caller":"traceutil/trace.go:171","msg":"trace[2027715253] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"100.932028ms","start":"2026-10-17T11:34:16.491989Z","end":"2026-10-17T11:34:16.592921Z","steps":["trace[2027715253] 'process raft request' (duration: 100.636693ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:22.354077Z","caller":"traceutil/trace.go:171","msg":"trace[266005593] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"357.306754ms","start":"2026-10-17T11:34:21.996739Z","end":"2026-10-17T11:34:22.354046Z","steps":["trace[266005593] 'process raft request' (duration: 357.02713ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:22.355111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:21.996703Z","time spent":"358.28915ms","remote":"127.0.0.1:56010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:34:22.355871Z","caller":"traceutil/trace.go:171","msg":"trace[1751471026] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"358.689796ms","start":"2026-10-17T11:34:21.997158Z","end":"2026-10-17T11:34:22.355848Z","steps":["trace[1751471026] 'process raft request' (duration: 356.830697ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:22.355956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:21.997123Z","time spent":"358.798378ms","remote":"127.0.0.1:55880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":878,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-17T11:34:22.386269Z","caller":"traceutil/trace.go:171","msg":"trace[1780770912] linearizableReadLoop","detail":"{readStateIndex:5303; appliedIndex:5300; }","duration":"220.056801ms","start":"2026-10-17T11:34:22.16619Z","end":"2026-10-17T11:34:22.386247Z","steps":["trace[1780770912] 'read index received' (duration: 187.666033ms)","trace[1780770912] 'applied index is now lower than readState.Index' (duration: 32.389578ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:34:22.386371Z","caller":"traceutil/trace.go:171","msg":"trace[1905848922] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"339.972582ms","start":"2026-10-17T11:34:22.046343Z","end":"2026-10-17T11:34:22.386315Z","steps":["trace[1905848922] 'process raft request' (duration: 339.786609ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:22.386634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.529212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-17T11:34:22.386698Z","caller":"traceutil/trace.go:171","msg":"trace[1576272189] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5111; }","duration":"159.653234ms","start":"2026-10-17T11:34:22.227029Z","end":"2026-10-17T11:34:22.386682Z","steps":["trace[1576272189] 'agreement among raft nodes before linearized reading' (duration: 159.479681ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:22.386582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.993281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c9286c98-fc8c-4644-9257-9c8440938fe7\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-10-17T11:34:22.38686Z","caller":"traceutil/trace.go:171","msg":"trace[1344491454] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c9286c98-fc8c-4644-9257-9c8440938fe7; range_end:; response_count:1; response_revision:5111; }","duration":"206.279926ms","start":"2026-10-17T11:34:22.180567Z","end":"2026-10-17T11:34:22.386846Z","steps":["trace[1344491454] 'agreement among raft nodes before linearized reading' (duration: 205.92083ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:22.386923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.108095ms","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-10-17T11:34:22.388324Z","caller":"traceutil/trace.go:171","msg":"trace[54966989] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5111; }","duration":"202.559527ms","start":"2026-10-17T11:34:22.185748Z","end":"2026-10-17T11:34:22.388307Z","steps":["trace[54966989] 'agreement among raft nodes before linearized reading' (duration: 200.925301ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:22.387024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:22.046325Z","time spent":"340.296337ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:34:22.386561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.365497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T11:34:22.389429Z","caller":"traceutil/trace.go:171","msg":"trace[905282487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5111; }","duration":"223.301733ms","start":"2026-10-17T11:34:22.166107Z","end":"2026-10-17T11:34:22.389409Z","steps":["trace[905282487] 'agreement among raft nodes before linearized reading' (duration: 220.277245ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:22.80568Z","caller":"traceutil/trace.go:171","msg":"trace[1133924436] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"151.237042ms","start":"2026-10-17T11:34:22.654411Z","end":"2026-10-17T11:34:22.805649Z","steps":["trace[1133924436] 'process raft request' (duration: 150.969457ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:22.805691Z","caller":"traceutil/trace.go:171","msg":"trace[682782151] linearizableReadLoop","detail":"{readStateIndex:5311; appliedIndex:5310; }","duration":"123.05439ms","start":"2026-10-17T11:34:22.682589Z","end":"2026-10-17T11:34:22.805644Z","steps":["trace[682782151] 'read index received' (duration: 122.782875ms)","trace[682782151] 'applied index is now lower than readState.Index' (duration: 258.114µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:34:22.805947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.312544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:34:22.806118Z","caller":"traceutil/trace.go:171","msg":"trace[1268946926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5119; }","duration":"123.488407ms","start":"2026-10-17T11:34:22.682505Z","end":"2026-10-17T11:34:22.805993Z","steps":["trace[1268946926] 'agreement among raft nodes before linearized reading' (duration: 123.314844ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:36.863721Z","caller":"traceutil/trace.go:171","msg":"trace[707872538] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"324.517811ms","start":"2026-10-17T11:34:36.539176Z","end":"2026-10-17T11:34:36.863694Z","steps":["trace[707872538] 'process raft request' (duration: 324.350409ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:36.8639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:36.539154Z","time spent":"324.642114ms","remote":"127.0.0.1:56010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11647,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:34:37.090944Z","caller":"traceutil/trace.go:171","msg":"trace[1692800374] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"534.283962ms","start":"2026-10-17T11:34:36.556629Z","end":"2026-10-17T11:34:37.090913Z","steps":["trace[1692800374] 'process raft request' (duration: 512.346181ms)","trace[1692800374] 'compare' (duration: 21.028107ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:34:37.09103Z","caller":"traceutil/trace.go:171","msg":"trace[1473795583] linearizableReadLoop","detail":"{readStateIndex:5496; appliedIndex:5494; }","duration":"427.329634ms","start":"2026-10-17T11:34:36.663676Z","end":"2026-10-17T11:34:37.091005Z","steps":["trace[1473795583] 'read index received' (duration: 199.924488ms)","trace[1473795583] 'applied index is now lower than readState.Index' (duration: 227.401846ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:34:37.09112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:36.556615Z","time spent":"534.411484ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:34:37.091266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.564598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-17T11:34:37.091306Z","caller":"traceutil/trace.go:171","msg":"trace[1775566225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5297; }","duration":"427.676249ms","start":"2026-10-17T11:34:36.66362Z","end":"2026-10-17T11:34:37.091296Z","steps":["trace[1775566225] 'agreement among raft nodes before linearized reading' (duration: 427.491047ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:37.091338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:36.663593Z","time spent":"427.735581ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-17T11:34:37.09153Z","caller":"traceutil/trace.go:171","msg":"trace[45303344] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"220.730231ms","start":"2026-10-17T11:34:36.870763Z","end":"2026-10-17T11:34:37.091493Z","steps":["trace[45303344] 'process raft request' (duration: 219.719596ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:37.091755Z","caller":"traceutil/trace.go:171","msg":"trace[1697133289] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"119.721956ms","start":"2026-10-17T11:34:36.97202Z","end":"2026-10-17T11:34:37.091742Z","steps":["trace[1697133289] 'process raft request' (duration: 119.676916ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:37.091864Z","caller":"traceutil/trace.go:171","msg":"trace[773273870] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"218.324564ms","start":"2026-10-17T11:34:36.873527Z","end":"2026-10-17T11:34:37.091851Z","steps":["trace[773273870] 'process raft request' (duration: 217.832106ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:37.09201Z","caller":"traceutil/trace.go:171","msg":"trace[20050528] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"214.407443ms","start":"2026-10-17T11:34:36.877589Z","end":"2026-10-17T11:34:37.091997Z","steps":["trace[20050528] 'process raft request' (duration: 214.015847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:37.095153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.59444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-17T11:34:37.096463Z","caller":"traceutil/trace.go:171","msg":"trace[948197051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5302; }","duration":"430.970701ms","start":"2026-10-17T11:34:36.665476Z","end":"2026-10-17T11:34:37.096447Z","steps":["trace[948197051] 'agreement among raft nodes before linearized reading' (duration: 429.438467ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:37.096515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:36.665466Z","time spent":"431.033543ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-17T11:34:37.095235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.796651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-17T11:34:37.096776Z","caller":"traceutil/trace.go:171","msg":"trace[1078787332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5302; }","duration":"218.381065ms","start":"2026-10-17T11:34:36.878374Z","end":"2026-10-17T11:34:37.096755Z","steps":["trace[1078787332] 'agreement among raft nodes before linearized reading' (duration: 216.7481ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:37.095305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.110282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:34:37.09715Z","caller":"traceutil/trace.go:171","msg":"trace[1252564678] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:5302; }","duration":"412.97132ms","start":"2026-10-17T11:34:36.684152Z","end":"2026-10-17T11:34:37.097123Z","steps":["trace[1252564678] 'agreement among raft nodes before linearized reading' (duration: 411.072941ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:37.097228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:36.684141Z","time spent":"413.060431ms","remote":"127.0.0.1:34764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-17T11:34:37.095369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.386233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:34:37.097349Z","caller":"traceutil/trace.go:171","msg":"trace[715920177] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5302; }","duration":"416.377333ms","start":"2026-10-17T11:34:36.680954Z","end":"2026-10-17T11:34:37.097331Z","steps":["trace[715920177] 'agreement among raft nodes before linearized reading' (duration: 414.383092ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:37.097405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:36.680941Z","time spent":"416.437074ms","remote":"127.0.0.1:55806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T11:34:37.095469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.414331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-17T11:34:37.097564Z","caller":"traceutil/trace.go:171","msg":"trace[656669524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5302; }","duration":"430.570145ms","start":"2026-10-17T11:34:36.666983Z","end":"2026-10-17T11:34:37.097553Z","steps":["trace[656669524] 'agreement among raft nodes before linearized reading' (duration: 428.405761ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:37.09761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:36.666952Z","time spent":"430.648416ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-17T11:34:37.259313Z","caller":"traceutil/trace.go:171","msg":"trace[22124122] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"152.507897ms","start":"2026-10-17T11:34:37.106561Z","end":"2026-10-17T11:34:37.259069Z","steps":["trace[22124122] 'process raft request' (duration: 110.467802ms)","trace[22124122] 'compare' (duration: 41.764541ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:34:37.259467Z","caller":"traceutil/trace.go:171","msg":"trace[1952159163] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"152.69936ms","start":"2026-10-17T11:34:37.106709Z","end":"2026-10-17T11:34:37.259408Z","steps":["trace[1952159163] 'process raft request' (duration: 152.253043ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:37.260597Z","caller":"traceutil/trace.go:171","msg":"trace[785033249] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"149.50936ms","start":"2026-10-17T11:34:37.111066Z","end":"2026-10-17T11:34:37.260575Z","steps":["trace[785033249] 'process raft request' (duration: 148.678438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:37.502504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.009435ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:34:37.502656Z","caller":"traceutil/trace.go:171","msg":"trace[1890374061] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"176.221346ms","start":"2026-10-17T11:34:37.32641Z","end":"2026-10-17T11:34:37.502631Z","steps":["trace[1890374061] 'process raft request' (duration: 47.953878ms)","trace[1890374061] 'compare' (duration: 127.798421ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:34:37.743557Z","caller":"traceutil/trace.go:171","msg":"trace[1117965436] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"229.971445ms","start":"2026-10-17T11:34:37.513539Z","end":"2026-10-17T11:34:37.743511Z","steps":["trace[1117965436] 'process raft request' (duration: 229.556498ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:37.743643Z","caller":"traceutil/trace.go:171","msg":"trace[1352576029] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"230.053396ms","start":"2026-10-17T11:34:37.513551Z","end":"2026-10-17T11:34:37.743605Z","steps":["trace[1352576029] 'process raft request' (duration: 229.66795ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:37.744059Z","caller":"traceutil/trace.go:171","msg":"trace[997445861] transaction","detail":"{read_only:false; response_revision:5312; number_of_response:1; }","duration":"231.800694ms","start":"2026-10-17T11:34:37.512218Z","end":"2026-10-17T11:34:37.744019Z","steps":["trace[997445861] 'process raft request' (duration: 160.631854ms)","trace[997445861] 'compare' (duration: 69.619486ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:34:45.684414Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2861} {"level":"info","ts":"2026-10-17T11:34:45.774297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2861,"took":"87.856356ms","hash":585490565,"current-db-size-bytes":52092928,"current-db-size":"52 MB","current-db-size-in-use-bytes":27602944,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:34:45.774385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":585490565,"revision":2861,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:35:19.490393Z","caller":"traceutil/trace.go:171","msg":"trace[370530399] transaction","detail":"{read_only:false; response_revision:5660; number_of_response:1; }","duration":"113.664988ms","start":"2026-10-17T11:35:19.376689Z","end":"2026-10-17T11:35:19.490354Z","steps":["trace[370530399] 'process raft request' (duration: 100.16028ms)","trace[370530399] 'compare' (duration: 13.01572ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:38:44.730567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.638393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-17T11:38:44.730637Z","caller":"traceutil/trace.go:171","msg":"trace[1857857260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7097; }","duration":"102.121645ms","start":"2026-10-17T11:38:44.6285Z","end":"2026-10-17T11:38:44.730622Z","steps":["trace[1857857260] 'agreement among raft nodes before linearized reading' (duration: 101.93281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:38:44.730881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.470112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-17T11:38:44.73095Z","caller":"traceutil/trace.go:171","msg":"trace[487186010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7097; }","duration":"100.550914ms","start":"2026-10-17T11:38:44.630388Z","end":"2026-10-17T11:38:44.730939Z","steps":["trace[487186010] 'agreement among raft nodes before linearized reading' (duration: 100.439401ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:45.691315Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5370} {"level":"info","ts":"2026-10-17T11:39:45.782993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5370,"took":"89.590309ms","hash":3773215879,"current-db-size-bytes":52092928,"current-db-size":"52 MB","current-db-size-in-use-bytes":18890752,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-17T11:39:45.783114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3773215879,"revision":5370,"compact-revision":2861}