{"level":"warn","ts":"2026-09-18T15:15:34.818331Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T15:15:34.818423Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.44: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.44:2380","--initial-cluster=instance=https://162.253.55.44:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.44:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.44: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-09-18T15:15:34.818497Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T15:15:34.81851Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.44:2380"]} {"level":"info","ts":"2026-09-18T15:15:34.818531Z","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-09-18T15:15:34.819155Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.44:2379"]} {"level":"info","ts":"2026-09-18T15:15:34.819262Z","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.44:2380"],"listen-peer-urls":["https://162.253.55.44:2380"],"advertise-client-urls":["https://162.253.55.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.44: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-09-18T15:15:34.826699Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.235398ms"} {"level":"info","ts":"2026-09-18T15:15:34.843089Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b4cb6cb294c6743","cluster-id":"77f9414eebec887e"} {"level":"info","ts":"2026-09-18T15:15:34.843167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T15:15:34.843198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 became follower at term 0"} {"level":"info","ts":"2026-09-18T15:15:34.84321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b4cb6cb294c6743 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T15:15:34.843215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 became follower at term 1"} {"level":"info","ts":"2026-09-18T15:15:34.843244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 switched to configuration voters=(814226616334706499)"} {"level":"warn","ts":"2026-09-18T15:15:34.856617Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T15:15:34.860728Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T15:15:34.864029Z","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-09-18T15:15:34.867782Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b4cb6cb294c6743","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T15:15:34.868247Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b4cb6cb294c6743","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T15:15:34.873166Z","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-09-18T15:15:34.873998Z","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-09-18T15:15:34.874039Z","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-09-18T15:15:34.87403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 switched to configuration voters=(814226616334706499)"} {"level":"info","ts":"2026-09-18T15:15:34.874216Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"77f9414eebec887e","local-member-id":"b4cb6cb294c6743","added-peer-id":"b4cb6cb294c6743","added-peer-peer-urls":["https://162.253.55.44:2380"]} {"level":"info","ts":"2026-09-18T15:15:34.876163Z","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-09-18T15:15:34.876265Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.44:2380"} {"level":"info","ts":"2026-09-18T15:15:34.876321Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.44:2380"} {"level":"info","ts":"2026-09-18T15:15:34.876358Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b4cb6cb294c6743","initial-advertise-peer-urls":["https://162.253.55.44:2380"],"listen-peer-urls":["https://162.253.55.44:2380"],"advertise-client-urls":["https://162.253.55.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T15:15:34.876391Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T15:15:35.84422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T15:15:35.844301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T15:15:35.844323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 received MsgPreVoteResp from b4cb6cb294c6743 at term 1"} {"level":"info","ts":"2026-09-18T15:15:35.844337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 became candidate at term 2"} {"level":"info","ts":"2026-09-18T15:15:35.844344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 received MsgVoteResp from b4cb6cb294c6743 at term 2"} {"level":"info","ts":"2026-09-18T15:15:35.844354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4cb6cb294c6743 became leader at term 2"} {"level":"info","ts":"2026-09-18T15:15:35.844363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b4cb6cb294c6743 elected leader b4cb6cb294c6743 at term 2"} {"level":"info","ts":"2026-09-18T15:15:35.846843Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:15:35.850215Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:15:35.850212Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b4cb6cb294c6743","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.44:2379]}","request-path":"/0/members/b4cb6cb294c6743/attributes","cluster-id":"77f9414eebec887e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T15:15:35.850717Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:15:35.85091Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T15:15:35.851008Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T15:15:35.853018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T15:15:35.853678Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.44:2379"} {"level":"info","ts":"2026-09-18T15:15:35.854742Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"77f9414eebec887e","local-member-id":"b4cb6cb294c6743","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:15:35.854862Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:15:35.85489Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:15:40.050577Z","caller":"traceutil/trace.go:171","msg":"trace[1075663352] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"236.787776ms","start":"2026-09-18T15:15:39.813764Z","end":"2026-09-18T15:15:40.050551Z","steps":["trace[1075663352] 'process raft request' (duration: 236.648723ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:15:40.337792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.647649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:15:40.33805Z","caller":"traceutil/trace.go:171","msg":"trace[1284614077] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"277.693714ms","start":"2026-09-18T15:15:40.060296Z","end":"2026-09-18T15:15:40.337989Z","steps":["trace[1284614077] 'process raft request' (duration: 92.094015ms)","trace[1284614077] 'compare' (duration: 184.405014ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:22.762451Z","caller":"traceutil/trace.go:171","msg":"trace[2036646967] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"276.51085ms","start":"2026-09-18T15:16:22.485914Z","end":"2026-09-18T15:16:22.762424Z","steps":["trace[2036646967] 'read index received' (duration: 275.714547ms)","trace[2036646967] 'applied index is now lower than readState.Index' (duration: 795.363µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:22.762678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.518796ms","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-09-18T15:16:22.762713Z","caller":"traceutil/trace.go:171","msg":"trace[1938059204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:640; }","duration":"175.612088ms","start":"2026-09-18T15:16:22.587091Z","end":"2026-09-18T15:16:22.762703Z","steps":["trace[1938059204] 'agreement among raft nodes before linearized reading' (duration: 175.460675ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:22.76278Z","caller":"traceutil/trace.go:171","msg":"trace[492615609] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"370.006164ms","start":"2026-09-18T15:16:22.392706Z","end":"2026-09-18T15:16:22.762712Z","steps":["trace[492615609] 'process raft request' (duration: 369.174611ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:22.763019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.981379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t9mf6\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-09-18T15:16:22.763178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:22.392675Z","time spent":"370.192237ms","remote":"127.0.0.1:47948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:16:22.763281Z","caller":"traceutil/trace.go:171","msg":"trace[1905137346] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t9mf6; range_end:; response_count:1; response_revision:640; }","duration":"277.407336ms","start":"2026-09-18T15:16:22.485818Z","end":"2026-09-18T15:16:22.763226Z","steps":["trace[1905137346] 'agreement among raft nodes before linearized reading' (duration: 276.743594ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:23.33665Z","caller":"traceutil/trace.go:171","msg":"trace[1097159116] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"539.291393ms","start":"2026-09-18T15:16:22.79734Z","end":"2026-09-18T15:16:23.336632Z","steps":["trace[1097159116] 'process raft request' (duration: 539.159081ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:23.336775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:22.797316Z","time spent":"539.395654ms","remote":"127.0.0.1:48050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:16:23.358252Z","caller":"traceutil/trace.go:171","msg":"trace[1955762975] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"443.088934ms","start":"2026-09-18T15:16:22.915137Z","end":"2026-09-18T15:16:23.358226Z","steps":["trace[1955762975] 'read index received' (duration: 421.39668ms)","trace[1955762975] 'applied index is now lower than readState.Index' (duration: 21.691264ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:23.358379Z","caller":"traceutil/trace.go:171","msg":"trace[1056160315] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"510.618971ms","start":"2026-09-18T15:16:22.847722Z","end":"2026-09-18T15:16:23.358341Z","steps":["trace[1056160315] 'process raft request' (duration: 500.080969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:23.358542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:22.847698Z","time spent":"510.778764ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:16:23.358407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.246328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:16:23.358617Z","caller":"traceutil/trace.go:171","msg":"trace[1911736127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"443.498761ms","start":"2026-09-18T15:16:22.9151Z","end":"2026-09-18T15:16:23.358599Z","steps":["trace[1911736127] 'agreement among raft nodes before linearized reading' (duration: 443.224167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:23.358673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:22.915084Z","time spent":"443.574542ms","remote":"127.0.0.1:47864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-18T15:16:24.935599Z","caller":"traceutil/trace.go:171","msg":"trace[1121795662] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:689; }","duration":"140.351929ms","start":"2026-09-18T15:16:24.795228Z","end":"2026-09-18T15:16:24.93558Z","steps":["trace[1121795662] 'read index received' (duration: 81.853569ms)","trace[1121795662] 'applied index is now lower than readState.Index' (duration: 58.49748ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:24.935652Z","caller":"traceutil/trace.go:171","msg":"trace[643500448] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"153.139757ms","start":"2026-09-18T15:16:24.782485Z","end":"2026-09-18T15:16:24.935625Z","steps":["trace[643500448] 'process raft request' (duration: 138.660002ms)","trace[643500448] 'compare' (duration: 14.324552ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:24.935789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.541052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:16:24.936404Z","caller":"traceutil/trace.go:171","msg":"trace[450081835] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:665; }","duration":"141.190962ms","start":"2026-09-18T15:16:24.795205Z","end":"2026-09-18T15:16:24.936396Z","steps":["trace[450081835] 'agreement among raft nodes before linearized reading' (duration: 140.508751ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:39.758653Z","caller":"traceutil/trace.go:171","msg":"trace[2020172943] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"154.595109ms","start":"2026-09-18T15:16:39.604025Z","end":"2026-09-18T15:16:39.75862Z","steps":["trace[2020172943] 'process raft request' (duration: 154.205323ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:05.953459Z","caller":"traceutil/trace.go:171","msg":"trace[1020610612] linearizableReadLoop","detail":"{readStateIndex:1997; appliedIndex:1996; }","duration":"174.389424ms","start":"2026-09-18T15:18:05.779039Z","end":"2026-09-18T15:18:05.953428Z","steps":["trace[1020610612] 'read index received' (duration: 127.162794ms)","trace[1020610612] 'applied index is now lower than readState.Index' (duration: 47.22516ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:05.953499Z","caller":"traceutil/trace.go:171","msg":"trace[1795522654] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"403.147409ms","start":"2026-09-18T15:18:05.5503Z","end":"2026-09-18T15:18:05.953447Z","steps":["trace[1795522654] 'process raft request' (duration: 355.877278ms)","trace[1795522654] 'compare' (duration: 46.875667ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:18:05.953629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.575956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-18T15:18:05.953691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:05.550285Z","time spent":"403.303221ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:18:05.953734Z","caller":"traceutil/trace.go:171","msg":"trace[928158385] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:1920; }","duration":"174.72192ms","start":"2026-09-18T15:18:05.778978Z","end":"2026-09-18T15:18:05.953699Z","steps":["trace[928158385] 'agreement among raft nodes before linearized reading' (duration: 174.581757ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:05.97894Z","caller":"traceutil/trace.go:171","msg":"trace[713578076] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"189.284282ms","start":"2026-09-18T15:18:05.789627Z","end":"2026-09-18T15:18:05.978911Z","steps":["trace[713578076] 'process raft request' (duration: 189.030757ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:05.978964Z","caller":"traceutil/trace.go:171","msg":"trace[1762466614] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"167.122704ms","start":"2026-09-18T15:18:05.811817Z","end":"2026-09-18T15:18:05.97894Z","steps":["trace[1762466614] 'process raft request' (duration: 166.961201ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:06.199276Z","caller":"traceutil/trace.go:171","msg":"trace[98027508] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"168.392777ms","start":"2026-09-18T15:18:06.030809Z","end":"2026-09-18T15:18:06.199202Z","steps":["trace[98027508] 'process raft request' (duration: 143.91073ms)","trace[98027508] 'compare' (duration: 24.288265ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:06.466573Z","caller":"traceutil/trace.go:171","msg":"trace[1612688113] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"171.284984ms","start":"2026-09-18T15:18:06.295256Z","end":"2026-09-18T15:18:06.466541Z","steps":["trace[1612688113] 'process raft request' (duration: 93.286308ms)","trace[1612688113] 'compare' (duration: 77.518329ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:18.517324Z","caller":"traceutil/trace.go:171","msg":"trace[1753626529] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"217.930381ms","start":"2026-09-18T15:18:18.299374Z","end":"2026-09-18T15:18:18.517305Z","steps":["trace[1753626529] 'process raft request' (duration: 217.82918ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:40.782117Z","caller":"traceutil/trace.go:171","msg":"trace[337019672] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"104.980239ms","start":"2026-09-18T15:18:40.677094Z","end":"2026-09-18T15:18:40.782074Z","steps":["trace[337019672] 'process raft request' (duration: 100.508191ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:41.022581Z","caller":"traceutil/trace.go:171","msg":"trace[2101120524] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"169.6897ms","start":"2026-09-18T15:18:40.852872Z","end":"2026-09-18T15:18:41.022561Z","steps":["trace[2101120524] 'process raft request' (duration: 169.660399ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:41.022636Z","caller":"traceutil/trace.go:171","msg":"trace[388555439] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"326.033787ms","start":"2026-09-18T15:18:40.696562Z","end":"2026-09-18T15:18:41.022596Z","steps":["trace[388555439] 'process raft request' (duration: 325.920373ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:41.022814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:40.696539Z","time spent":"326.17901ms","remote":"127.0.0.1:48136","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-09-18T15:18:41.022813Z","caller":"traceutil/trace.go:171","msg":"trace[1665486578] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2243; }","duration":"345.029294ms","start":"2026-09-18T15:18:40.677744Z","end":"2026-09-18T15:18:41.022773Z","steps":["trace[1665486578] 'read index received' (duration: 99.871874ms)","trace[1665486578] 'applied index is now lower than readState.Index' (duration: 245.144939ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:41.022943Z","caller":"traceutil/trace.go:171","msg":"trace[1149353746] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"345.341062ms","start":"2026-09-18T15:18:40.67754Z","end":"2026-09-18T15:18:41.022881Z","steps":["trace[1149353746] 'process raft request' (duration: 250.342201ms)","trace[1149353746] 'compare' (duration: 94.309731ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:18:41.023192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:40.677511Z","time spent":"345.533317ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:18:41.023265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.480876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-18T15:18:41.023321Z","caller":"traceutil/trace.go:171","msg":"trace[2112453712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2163; }","duration":"345.60717ms","start":"2026-09-18T15:18:40.6777Z","end":"2026-09-18T15:18:41.023307Z","steps":["trace[2112453712] 'agreement among raft nodes before linearized reading' (duration: 345.303191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:41.023373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:40.677681Z","time spent":"345.681211ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T15:18:41.023395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.257558ms","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-09-18T15:18:41.023443Z","caller":"traceutil/trace.go:171","msg":"trace[1073358039] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2163; }","duration":"322.33584ms","start":"2026-09-18T15:18:40.701094Z","end":"2026-09-18T15:18:41.02343Z","steps":["trace[1073358039] 'agreement among raft nodes before linearized reading' (duration: 322.162875ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:41.023474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:40.701072Z","time spent":"322.395862ms","remote":"127.0.0.1:50208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-18T15:18:41.02351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.939409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:41.023493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.693453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:41.023572Z","caller":"traceutil/trace.go:171","msg":"trace[1107065727] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2163; }","duration":"257.045302ms","start":"2026-09-18T15:18:40.766516Z","end":"2026-09-18T15:18:41.023561Z","steps":["trace[1107065727] 'agreement among raft nodes before linearized reading' (duration: 256.898988ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:41.023588Z","caller":"traceutil/trace.go:171","msg":"trace[2091179302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2163; }","duration":"108.825218ms","start":"2026-09-18T15:18:40.914745Z","end":"2026-09-18T15:18:41.02357Z","steps":["trace[2091179302] 'agreement among raft nodes before linearized reading' (duration: 108.633833ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:41.496375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.534576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-09-18T15:18:41.496483Z","caller":"traceutil/trace.go:171","msg":"trace[1307356332] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2164; }","duration":"236.717411ms","start":"2026-09-18T15:18:41.259736Z","end":"2026-09-18T15:18:41.496453Z","steps":["trace[1307356332] 'range keys from in-memory index tree' (duration: 236.260908ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:41.49643Z","caller":"traceutil/trace.go:171","msg":"trace[2034825017] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"157.614195ms","start":"2026-09-18T15:18:41.338788Z","end":"2026-09-18T15:18:41.496402Z","steps":["trace[2034825017] 'process raft request' (duration: 116.992271ms)","trace[2034825017] 'compare' (duration: 40.435608ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:18:41.90994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.194156ms","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-09-18T15:18:41.910008Z","caller":"traceutil/trace.go:171","msg":"trace[1292992725] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2165; }","duration":"266.315239ms","start":"2026-09-18T15:18:41.643677Z","end":"2026-09-18T15:18:41.909992Z","steps":["trace[1292992725] 'range keys from in-memory index tree' (duration: 265.97075ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:50.480025Z","caller":"traceutil/trace.go:171","msg":"trace[667720975] transaction","detail":"{read_only:false; response_revision:2638; number_of_response:1; }","duration":"111.248319ms","start":"2026-09-18T15:19:50.368745Z","end":"2026-09-18T15:19:50.479993Z","steps":["trace[667720975] 'process raft request' (duration: 111.054944ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:51.0488Z","caller":"traceutil/trace.go:171","msg":"trace[724119559] linearizableReadLoop","detail":"{readStateIndex:2742; appliedIndex:2741; }","duration":"132.334367ms","start":"2026-09-18T15:19:50.916446Z","end":"2026-09-18T15:19:51.04878Z","steps":["trace[724119559] 'read index received' (duration: 132.170883ms)","trace[724119559] 'applied index is now lower than readState.Index' (duration: 162.654µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:19:51.048856Z","caller":"traceutil/trace.go:171","msg":"trace[1773982143] transaction","detail":"{read_only:false; response_revision:2641; number_of_response:1; }","duration":"143.061847ms","start":"2026-09-18T15:19:50.905771Z","end":"2026-09-18T15:19:51.048833Z","steps":["trace[1773982143] 'process raft request' (duration: 142.885593ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:51.048914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.451899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:19:51.048942Z","caller":"traceutil/trace.go:171","msg":"trace[637069572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2641; }","duration":"132.526311ms","start":"2026-09-18T15:19:50.916407Z","end":"2026-09-18T15:19:51.048934Z","steps":["trace[637069572] 'agreement among raft nodes before linearized reading' (duration: 132.46642ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:31.579312Z","caller":"traceutil/trace.go:171","msg":"trace[1197687302] transaction","detail":"{read_only:false; response_revision:4294; number_of_response:1; }","duration":"112.204086ms","start":"2026-09-18T15:24:31.467076Z","end":"2026-09-18T15:24:31.57928Z","steps":["trace[1197687302] 'process raft request' (duration: 70.838833ms)","trace[1197687302] 'compare' (duration: 41.258681ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:24:42.007667Z","caller":"traceutil/trace.go:171","msg":"trace[1440567734] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"100.588589ms","start":"2026-09-18T15:24:41.907051Z","end":"2026-09-18T15:24:42.00764Z","steps":["trace[1440567734] 'process raft request' (duration: 100.416096ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:42.195Z","caller":"traceutil/trace.go:171","msg":"trace[947086800] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"206.339932ms","start":"2026-09-18T15:24:41.988642Z","end":"2026-09-18T15:24:42.194981Z","steps":["trace[947086800] 'process raft request' (duration: 150.067045ms)","trace[947086800] 'compare' (duration: 56.112174ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:24:42.195294Z","caller":"traceutil/trace.go:171","msg":"trace[1104099807] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"183.479631ms","start":"2026-09-18T15:24:42.011757Z","end":"2026-09-18T15:24:42.195236Z","steps":["trace[1104099807] 'process raft request' (duration: 183.186436ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:42.340914Z","caller":"traceutil/trace.go:171","msg":"trace[1248757498] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"133.753179ms","start":"2026-09-18T15:24:42.207137Z","end":"2026-09-18T15:24:42.34089Z","steps":["trace[1248757498] 'process raft request' (duration: 116.693782ms)","trace[1248757498] 'compare' (duration: 16.61171ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:24:46.465759Z","caller":"traceutil/trace.go:171","msg":"trace[2130134591] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"111.98688ms","start":"2026-09-18T15:24:46.353752Z","end":"2026-09-18T15:24:46.465739Z","steps":["trace[2130134591] 'process raft request' (duration: 111.677756ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:46.46589Z","caller":"traceutil/trace.go:171","msg":"trace[213100196] linearizableReadLoop","detail":"{readStateIndex:5012; appliedIndex:5011; }","duration":"109.625996ms","start":"2026-09-18T15:24:46.356246Z","end":"2026-09-18T15:24:46.465872Z","steps":["trace[213100196] 'read index received' (duration: 62.168069ms)","trace[213100196] 'applied index is now lower than readState.Index' (duration: 47.457227ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:24:46.466126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.86846ms","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-09-18T15:24:46.466162Z","caller":"traceutil/trace.go:171","msg":"trace[1510858173] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4828; }","duration":"109.941381ms","start":"2026-09-18T15:24:46.356211Z","end":"2026-09-18T15:24:46.466152Z","steps":["trace[1510858173] 'agreement among raft nodes before linearized reading' (duration: 109.812759ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:48.255167Z","caller":"traceutil/trace.go:171","msg":"trace[1715777649] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"141.011849ms","start":"2026-09-18T15:24:48.114125Z","end":"2026-09-18T15:24:48.255137Z","steps":["trace[1715777649] 'process raft request' (duration: 79.863195ms)","trace[1715777649] 'compare' (duration: 61.051393ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:24:56.632942Z","caller":"traceutil/trace.go:171","msg":"trace[1863683354] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"122.872659ms","start":"2026-09-18T15:24:56.510034Z","end":"2026-09-18T15:24:56.632907Z","steps":["trace[1863683354] 'process raft request' (duration: 122.603026ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:24:56.839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.619442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:24:56.839102Z","caller":"traceutil/trace.go:171","msg":"trace[657054406] linearizableReadLoop","detail":"{readStateIndex:5158; appliedIndex:5156; }","duration":"292.032036ms","start":"2026-09-18T15:24:56.547055Z","end":"2026-09-18T15:24:56.839087Z","steps":["trace[657054406] 'read index received' (duration: 85.550802ms)","trace[657054406] 'applied index is now lower than readState.Index' (duration: 206.480224ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:24:56.839333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.154242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:24:56.839435Z","caller":"traceutil/trace.go:171","msg":"trace[1481804799] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4968; }","duration":"175.300595ms","start":"2026-09-18T15:24:56.664097Z","end":"2026-09-18T15:24:56.839398Z","steps":["trace[1481804799] 'agreement among raft nodes before linearized reading' (duration: 175.159963ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:24:56.839447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.34583ms","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-09-18T15:24:56.839615Z","caller":"traceutil/trace.go:171","msg":"trace[1792389337] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4968; }","duration":"292.601354ms","start":"2026-09-18T15:24:56.546981Z","end":"2026-09-18T15:24:56.839583Z","steps":["trace[1792389337] 'agreement among raft nodes before linearized reading' (duration: 292.211239ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:56.839675Z","caller":"traceutil/trace.go:171","msg":"trace[1128707878] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"327.569888ms","start":"2026-09-18T15:24:56.512088Z","end":"2026-09-18T15:24:56.839658Z","steps":["trace[1128707878] 'process raft request' (duration: 155.219796ms)","trace[1128707878] 'compare' (duration: 171.516891ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:24:56.83987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:24:56.512063Z","time spent":"327.701661ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:24:57.190695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.563304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"info","ts":"2026-09-18T15:24:57.190801Z","caller":"traceutil/trace.go:171","msg":"trace[1463764427] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4971; }","duration":"106.717858ms","start":"2026-09-18T15:24:57.084064Z","end":"2026-09-18T15:24:57.190782Z","steps":["trace[1463764427] 'range keys from in-memory index tree' (duration: 106.391092ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:24:57.191045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.761527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7958bb6c56-d5twq.18d673aeb200a81c\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-09-18T15:24:57.191132Z","caller":"traceutil/trace.go:171","msg":"trace[626318834] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7958bb6c56-d5twq.18d673aeb200a81c; range_end:; response_count:1; response_revision:4971; }","duration":"106.884849ms","start":"2026-09-18T15:24:57.084236Z","end":"2026-09-18T15:24:57.19112Z","steps":["trace[626318834] 'range keys from in-memory index tree' (duration: 106.629176ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:57.371074Z","caller":"traceutil/trace.go:171","msg":"trace[1215728453] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"160.401149ms","start":"2026-09-18T15:24:57.210652Z","end":"2026-09-18T15:24:57.371054Z","steps":["trace[1215728453] 'process raft request' (duration: 141.467736ms)","trace[1215728453] 'compare' (duration: 18.832721ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:24:57.396211Z","caller":"traceutil/trace.go:171","msg":"trace[620128527] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"171.132364ms","start":"2026-09-18T15:24:57.225064Z","end":"2026-09-18T15:24:57.396197Z","steps":["trace[620128527] 'process raft request' (duration: 170.938631ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:57.396155Z","caller":"traceutil/trace.go:171","msg":"trace[842497758] linearizableReadLoop","detail":"{readStateIndex:5164; appliedIndex:5162; }","duration":"162.441899ms","start":"2026-09-18T15:24:57.233693Z","end":"2026-09-18T15:24:57.396135Z","steps":["trace[842497758] 'read index received' (duration: 118.379134ms)","trace[842497758] 'applied index is now lower than readState.Index' (duration: 44.061595ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:24:57.396775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.032927ms","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-09-18T15:24:57.396819Z","caller":"traceutil/trace.go:171","msg":"trace[527760768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4974; }","duration":"163.153099ms","start":"2026-09-18T15:24:57.233654Z","end":"2026-09-18T15:24:57.396807Z","steps":["trace[527760768] 'agreement among raft nodes before linearized reading' (duration: 162.936006ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:57.536982Z","caller":"traceutil/trace.go:171","msg":"trace[1852639405] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"158.227548ms","start":"2026-09-18T15:24:57.378734Z","end":"2026-09-18T15:24:57.536961Z","steps":["trace[1852639405] 'process raft request' (duration: 158.147977ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:57.537018Z","caller":"traceutil/trace.go:171","msg":"trace[653474995] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"158.702765ms","start":"2026-09-18T15:24:57.378283Z","end":"2026-09-18T15:24:57.536986Z","steps":["trace[653474995] 'process raft request' (duration: 158.558083ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:57.537043Z","caller":"traceutil/trace.go:171","msg":"trace[1067183371] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"158.758865ms","start":"2026-09-18T15:24:57.378256Z","end":"2026-09-18T15:24:57.537015Z","steps":["trace[1067183371] 'process raft request' (duration: 158.441941ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:57.537908Z","caller":"traceutil/trace.go:171","msg":"trace[1177498098] linearizableReadLoop","detail":"{readStateIndex:5168; appliedIndex:5164; }","duration":"141.330395ms","start":"2026-09-18T15:24:57.396556Z","end":"2026-09-18T15:24:57.537886Z","steps":["trace[1177498098] 'read index received' (duration: 140.091337ms)","trace[1177498098] 'applied index is now lower than readState.Index' (duration: 1.237678ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:24:57.537946Z","caller":"traceutil/trace.go:171","msg":"trace[1616682163] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"138.063188ms","start":"2026-09-18T15:24:57.399867Z","end":"2026-09-18T15:24:57.53793Z","steps":["trace[1616682163] 'process raft request' (duration: 137.869025ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:57.538438Z","caller":"traceutil/trace.go:171","msg":"trace[1384436308] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"159.651909ms","start":"2026-09-18T15:24:57.378774Z","end":"2026-09-18T15:24:57.538425Z","steps":["trace[1384436308] 'process raft request' (duration: 158.153687ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:24:57.538722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.087326ms","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-09-18T15:24:57.538801Z","caller":"traceutil/trace.go:171","msg":"trace[1357284963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4979; }","duration":"217.211078ms","start":"2026-09-18T15:24:57.321576Z","end":"2026-09-18T15:24:57.538787Z","steps":["trace[1357284963] 'agreement among raft nodes before linearized reading' (duration: 216.386627ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:24:59.185448Z","caller":"traceutil/trace.go:171","msg":"trace[1508897724] linearizableReadLoop","detail":"{readStateIndex:5247; appliedIndex:5246; }","duration":"114.513228ms","start":"2026-09-18T15:24:59.070919Z","end":"2026-09-18T15:24:59.185432Z","steps":["trace[1508897724] 'read index received' (duration: 114.441327ms)","trace[1508897724] 'applied index is now lower than readState.Index' (duration: 71.061µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:24:59.185635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.69026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-09-18T15:24:59.185701Z","caller":"traceutil/trace.go:171","msg":"trace[1358000705] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:5056; }","duration":"114.789471ms","start":"2026-09-18T15:24:59.0709Z","end":"2026-09-18T15:24:59.18569Z","steps":["trace[1358000705] 'agreement among raft nodes before linearized reading' (duration: 114.621079ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:25:13.794976Z","caller":"traceutil/trace.go:171","msg":"trace[1961850363] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"120.546245ms","start":"2026-09-18T15:25:13.674401Z","end":"2026-09-18T15:25:13.794948Z","steps":["trace[1961850363] 'process raft request' (duration: 105.56327ms)","trace[1961850363] 'compare' (duration: 14.864353ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:25:14.40845Z","caller":"traceutil/trace.go:171","msg":"trace[96771346] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"107.68231ms","start":"2026-09-18T15:25:14.300744Z","end":"2026-09-18T15:25:14.408427Z","steps":["trace[96771346] 'process raft request' (duration: 107.526508ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:25:35.886518Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2887} {"level":"info","ts":"2026-09-18T15:25:35.99966Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2887,"took":"111.821677ms","hash":3928641818,"current-db-size-bytes":53088256,"current-db-size":"53 MB","current-db-size-in-use-bytes":27807744,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-18T15:25:35.999746Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3928641818,"revision":2887,"compact-revision":-1} {"level":"info","ts":"2026-09-18T15:26:13.12557Z","caller":"traceutil/trace.go:171","msg":"trace[1963670089] transaction","detail":"{read_only:false; response_revision:5688; number_of_response:1; }","duration":"147.39216ms","start":"2026-09-18T15:26:12.978152Z","end":"2026-09-18T15:26:13.125544Z","steps":["trace[1963670089] 'process raft request' (duration: 147.202478ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:13.305666Z","caller":"traceutil/trace.go:171","msg":"trace[1091610282] transaction","detail":"{read_only:false; response_revision:5689; number_of_response:1; }","duration":"121.942332ms","start":"2026-09-18T15:26:13.183684Z","end":"2026-09-18T15:26:13.305626Z","steps":["trace[1091610282] 'process raft request' (duration: 101.935702ms)","trace[1091610282] 'compare' (duration: 19.848538ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:30:35.893196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5372} {"level":"info","ts":"2026-09-18T15:30:36.013774Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5372,"took":"119.259917ms","hash":2070723318,"current-db-size-bytes":53088256,"current-db-size":"53 MB","current-db-size-in-use-bytes":18792448,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T15:30:36.013843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2070723318,"revision":5372,"compact-revision":2887}