{"level":"warn","ts":"2026-10-19T01:49:10.429059Z","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-19T01:49:10.429187Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.167: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.167:2380","--initial-cluster=instance=https://162.253.55.167:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.167:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.167: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-19T01:49:10.429302Z","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-19T01:49:10.429324Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.167:2380"]} {"level":"info","ts":"2026-10-19T01:49:10.429365Z","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-19T01:49:10.430375Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"]} {"level":"info","ts":"2026-10-19T01:49:10.430528Z","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":16,"max-cpu-available":16,"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.167:2380"],"listen-peer-urls":["https://162.253.55.167:2380"],"advertise-client-urls":["https://162.253.55.167:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.167: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-19T01:49:10.43412Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.10367ms"} {"level":"info","ts":"2026-10-19T01:49:10.442752Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"83287f3a81241ad4","cluster-id":"185ed9b8ed398b9a"} {"level":"info","ts":"2026-10-19T01:49:10.442858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=()"} {"level":"info","ts":"2026-10-19T01:49:10.442884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became follower at term 0"} {"level":"info","ts":"2026-10-19T01:49:10.442897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 83287f3a81241ad4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-19T01:49:10.442913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became follower at term 1"} {"level":"info","ts":"2026-10-19T01:49:10.44296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=(9450943707288443604)"} {"level":"warn","ts":"2026-10-19T01:49:10.449221Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-19T01:49:10.456605Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-19T01:49:10.458504Z","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-19T01:49:10.461664Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"83287f3a81241ad4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-19T01:49:10.461853Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"83287f3a81241ad4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-19T01:49:10.462124Z","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-19T01:49:10.462235Z","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-19T01:49:10.462311Z","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-19T01:49:10.463108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=(9450943707288443604)"} {"level":"info","ts":"2026-10-19T01:49:10.463302Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"185ed9b8ed398b9a","local-member-id":"83287f3a81241ad4","added-peer-id":"83287f3a81241ad4","added-peer-peer-urls":["https://162.253.55.167:2380"]} {"level":"info","ts":"2026-10-19T01:49:10.466315Z","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-19T01:49:10.466477Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.167:2380"} {"level":"info","ts":"2026-10-19T01:49:10.466542Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.167:2380"} {"level":"info","ts":"2026-10-19T01:49:10.466706Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"83287f3a81241ad4","initial-advertise-peer-urls":["https://162.253.55.167:2380"],"listen-peer-urls":["https://162.253.55.167:2380"],"advertise-client-urls":["https://162.253.55.167:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-19T01:49:10.46679Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-19T01:49:10.743744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 is starting a new election at term 1"} {"level":"info","ts":"2026-10-19T01:49:10.743809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-19T01:49:10.743866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 received MsgPreVoteResp from 83287f3a81241ad4 at term 1"} {"level":"info","ts":"2026-10-19T01:49:10.743887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became candidate at term 2"} {"level":"info","ts":"2026-10-19T01:49:10.743901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 received MsgVoteResp from 83287f3a81241ad4 at term 2"} {"level":"info","ts":"2026-10-19T01:49:10.743916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became leader at term 2"} {"level":"info","ts":"2026-10-19T01:49:10.743929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 83287f3a81241ad4 elected leader 83287f3a81241ad4 at term 2"} {"level":"info","ts":"2026-10-19T01:49:10.745893Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"83287f3a81241ad4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.167:2379]}","request-path":"/0/members/83287f3a81241ad4/attributes","cluster-id":"185ed9b8ed398b9a","publish-timeout":"7s"} {"level":"info","ts":"2026-10-19T01:49:10.746135Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:49:10.746168Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:49:10.74631Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-19T01:49:10.746419Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-19T01:49:10.746437Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:10.747882Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"185ed9b8ed398b9a","local-member-id":"83287f3a81241ad4","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:10.748011Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:10.748065Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:10.750366Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-19T01:49:10.752121Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.167:2379"} {"level":"info","ts":"2026-10-19T01:49:58.548366Z","caller":"traceutil/trace.go:171","msg":"trace[1583007882] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"139.378758ms","start":"2026-10-19T01:49:58.408954Z","end":"2026-10-19T01:49:58.548333Z","steps":["trace[1583007882] 'process raft request' (duration: 78.660648ms)","trace[1583007882] 'compare' (duration: 60.515585ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:49:58.549366Z","caller":"traceutil/trace.go:171","msg":"trace[505611791] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"106.747799ms","start":"2026-10-19T01:49:58.442573Z","end":"2026-10-19T01:49:58.54932Z","steps":["trace[505611791] 'process raft request' (duration: 106.451812ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:49:58.722076Z","caller":"traceutil/trace.go:171","msg":"trace[352292662] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"104.930951ms","start":"2026-10-19T01:49:58.617118Z","end":"2026-10-19T01:49:58.722049Z","steps":["trace[352292662] 'process raft request' (duration: 74.91735ms)","trace[352292662] 'compare' (duration: 29.507688ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:50:04.087288Z","caller":"traceutil/trace.go:171","msg":"trace[1400077966] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"144.530573ms","start":"2026-10-19T01:50:03.942724Z","end":"2026-10-19T01:50:04.087255Z","steps":["trace[1400077966] 'process raft request' (duration: 143.967407ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:04.407723Z","caller":"traceutil/trace.go:171","msg":"trace[39031240] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"237.717088ms","start":"2026-10-19T01:50:04.16997Z","end":"2026-10-19T01:50:04.407687Z","steps":["trace[39031240] 'process raft request' (duration: 237.444991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:04.817368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.37584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cwz52\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-19T01:50:04.817543Z","caller":"traceutil/trace.go:171","msg":"trace[1786396525] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cwz52; range_end:; response_count:1; response_revision:656; }","duration":"325.659787ms","start":"2026-10-19T01:50:04.491855Z","end":"2026-10-19T01:50:04.817515Z","steps":["trace[1786396525] 'range keys from in-memory index tree' (duration: 325.096623ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:04.817597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:50:04.491822Z","time spent":"325.76399ms","remote":"127.0.0.1:52410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-cwz52\" "} {"level":"info","ts":"2026-10-19T01:50:06.86292Z","caller":"traceutil/trace.go:171","msg":"trace[1796785155] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"143.180706ms","start":"2026-10-19T01:50:06.719708Z","end":"2026-10-19T01:50:06.862889Z","steps":["trace[1796785155] 'process raft request' (duration: 140.326222ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:21.610723Z","caller":"traceutil/trace.go:171","msg":"trace[1902915886] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:857; }","duration":"122.121119ms","start":"2026-10-19T01:50:21.488561Z","end":"2026-10-19T01:50:21.610683Z","steps":["trace[1902915886] 'read index received' (duration: 121.698418ms)","trace[1902915886] 'applied index is now lower than readState.Index' (duration: 421.211µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:50:21.61082Z","caller":"traceutil/trace.go:171","msg":"trace[546657006] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"248.711725ms","start":"2026-10-19T01:50:21.362072Z","end":"2026-10-19T01:50:21.610784Z","steps":["trace[546657006] 'process raft request' (duration: 248.308394ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:21.61099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.385847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-19T01:50:21.61105Z","caller":"traceutil/trace.go:171","msg":"trace[344913888] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:825; }","duration":"122.52434ms","start":"2026-10-19T01:50:21.488508Z","end":"2026-10-19T01:50:21.611032Z","steps":["trace[344913888] 'agreement among raft nodes before linearized reading' (duration: 122.378446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:45.972721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.488999ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:51:45.972867Z","caller":"traceutil/trace.go:171","msg":"trace[1133753052] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1934; }","duration":"434.634863ms","start":"2026-10-19T01:51:45.538202Z","end":"2026-10-19T01:51:45.972837Z","steps":["trace[1133753052] 'range keys from in-memory index tree' (duration: 434.473759ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:45.974222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.918972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:51:45.974352Z","caller":"traceutil/trace.go:171","msg":"trace[1034859469] linearizableReadLoop","detail":"{readStateIndex:2013; appliedIndex:2012; }","duration":"427.135985ms","start":"2026-10-19T01:51:45.547193Z","end":"2026-10-19T01:51:45.974329Z","steps":["trace[1034859469] 'read index received' (duration: 64.682µs)","trace[1034859469] 'applied index is now lower than readState.Index' (duration: 427.069573ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:51:45.974639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.445183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-19T01:51:45.974703Z","caller":"traceutil/trace.go:171","msg":"trace[1742310243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1935; }","duration":"427.546176ms","start":"2026-10-19T01:51:45.54714Z","end":"2026-10-19T01:51:45.974686Z","steps":["trace[1742310243] 'agreement among raft nodes before linearized reading' (duration: 427.297589ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:45.974791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:45.547116Z","time spent":"427.663138ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-19T01:51:45.974662Z","caller":"traceutil/trace.go:171","msg":"trace[985811625] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"540.196537ms","start":"2026-10-19T01:51:45.43434Z","end":"2026-10-19T01:51:45.974536Z","steps":["trace[985811625] 'process raft request' (duration: 109.858338ms)","trace[985811625] 'compare' (duration: 428.693705ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:51:45.975171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:45.434299Z","time spent":"540.69251ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:51:46.016447Z","caller":"traceutil/trace.go:171","msg":"trace[755356480] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"344.121008ms","start":"2026-10-19T01:51:45.672271Z","end":"2026-10-19T01:51:46.016392Z","steps":["trace[755356480] 'process raft request' (duration: 343.992784ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.016598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:45.672254Z","time spent":"344.261211ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:51:46.147161Z","caller":"traceutil/trace.go:171","msg":"trace[511147765] linearizableReadLoop","detail":"{readStateIndex:2015; appliedIndex:2013; }","duration":"172.741871ms","start":"2026-10-19T01:51:45.974384Z","end":"2026-10-19T01:51:46.147125Z","steps":["trace[511147765] 'read index received' (duration: 41.977541ms)","trace[511147765] 'applied index is now lower than readState.Index' (duration: 130.76307ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:46.147246Z","caller":"traceutil/trace.go:171","msg":"trace[2014152966] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"232.502774ms","start":"2026-10-19T01:51:45.914696Z","end":"2026-10-19T01:51:46.147199Z","steps":["trace[2014152966] 'process raft request' (duration: 232.162514ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.147456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.030852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-19T01:51:46.147523Z","caller":"traceutil/trace.go:171","msg":"trace[1015397468] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1938; }","duration":"212.155205ms","start":"2026-10-19T01:51:45.935345Z","end":"2026-10-19T01:51:46.147501Z","steps":["trace[1015397468] 'agreement among raft nodes before linearized reading' (duration: 211.808755ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:46.147512Z","caller":"traceutil/trace.go:171","msg":"trace[102239257] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"167.466602ms","start":"2026-10-19T01:51:45.98Z","end":"2026-10-19T01:51:46.147466Z","steps":["trace[102239257] 'process raft request' (duration: 167.07312ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.147546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.588498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-19T01:51:46.147639Z","caller":"traceutil/trace.go:171","msg":"trace[732309633] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1938; }","duration":"469.717162ms","start":"2026-10-19T01:51:45.677899Z","end":"2026-10-19T01:51:46.147616Z","steps":["trace[732309633] 'agreement among raft nodes before linearized reading' (duration: 469.452235ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.147684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:45.677888Z","time spent":"469.786033ms","remote":"127.0.0.1:52568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":67,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-10-19T01:51:46.147695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.698799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-19T01:51:46.147738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.56147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-19T01:51:46.147821Z","caller":"traceutil/trace.go:171","msg":"trace[835129613] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1938; }","duration":"526.869403ms","start":"2026-10-19T01:51:45.620919Z","end":"2026-10-19T01:51:46.147789Z","steps":["trace[835129613] 'agreement among raft nodes before linearized reading' (duration: 526.408081ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:46.147859Z","caller":"traceutil/trace.go:171","msg":"trace[2127407503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1938; }","duration":"573.760594ms","start":"2026-10-19T01:51:45.574078Z","end":"2026-10-19T01:51:46.147839Z","steps":["trace[2127407503] 'agreement among raft nodes before linearized reading' (duration: 573.253881ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.147885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:45.620909Z","time spent":"526.960406ms","remote":"127.0.0.1:52732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":247,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-10-19T01:51:46.147954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:45.574063Z","time spent":"573.870188ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-19T01:51:46.148022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.186945ms","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-19T01:51:46.148064Z","caller":"traceutil/trace.go:171","msg":"trace[1440493811] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1938; }","duration":"574.289189ms","start":"2026-10-19T01:51:45.573763Z","end":"2026-10-19T01:51:46.148052Z","steps":["trace[1440493811] 'agreement among raft nodes before linearized reading' (duration: 574.089044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.148101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:45.573745Z","time spent":"574.34778ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-19T01:51:46.539647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.825955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:51:46.539995Z","caller":"traceutil/trace.go:171","msg":"trace[641413824] linearizableReadLoop","detail":"{readStateIndex:2021; appliedIndex:2017; }","duration":"188.425247ms","start":"2026-10-19T01:51:46.351549Z","end":"2026-10-19T01:51:46.539975Z","steps":["trace[641413824] 'read index received' (duration: 167.468282ms)","trace[641413824] 'applied index is now lower than readState.Index' (duration: 20.955755ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:46.540045Z","caller":"traceutil/trace.go:171","msg":"trace[1889961350] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"244.184403ms","start":"2026-10-19T01:51:46.295831Z","end":"2026-10-19T01:51:46.540016Z","steps":["trace[1889961350] 'process raft request' (duration: 244.09727ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.540075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.541041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:51:46.540117Z","caller":"traceutil/trace.go:171","msg":"trace[1143562243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1943; }","duration":"188.639173ms","start":"2026-10-19T01:51:46.351468Z","end":"2026-10-19T01:51:46.540107Z","steps":["trace[1143562243] 'agreement among raft nodes before linearized reading' (duration: 188.569541ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:46.540133Z","caller":"traceutil/trace.go:171","msg":"trace[907161078] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"385.961675ms","start":"2026-10-19T01:51:46.154149Z","end":"2026-10-19T01:51:46.540111Z","steps":["trace[907161078] 'process raft request' (duration: 385.613346ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:46.54002Z","caller":"traceutil/trace.go:171","msg":"trace[605546903] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"386.092618ms","start":"2026-10-19T01:51:46.153798Z","end":"2026-10-19T01:51:46.539891Z","steps":["trace[605546903] 'process raft request' (duration: 136.891523ms)","trace[605546903] 'compare' (duration: 248.549917ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:46.54016Z","caller":"traceutil/trace.go:171","msg":"trace[1807181529] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"383.11141ms","start":"2026-10-19T01:51:46.156984Z","end":"2026-10-19T01:51:46.540095Z","steps":["trace[1807181529] 'process raft request' (duration: 382.879614ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.540254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:46.154139Z","time spent":"386.035147ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:51:46.540313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:46.153769Z","time spent":"386.451088ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:51:46.540351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:51:46.156951Z","time spent":"383.298355ms","remote":"127.0.0.1:52410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:51:46.562304Z","caller":"traceutil/trace.go:171","msg":"trace[1953655523] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"192.177727ms","start":"2026-10-19T01:51:46.370106Z","end":"2026-10-19T01:51:46.562284Z","steps":["trace[1953655523] 'process raft request' (duration: 191.674564ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:30.616572Z","caller":"traceutil/trace.go:171","msg":"trace[609266268] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"127.991404ms","start":"2026-10-19T01:52:30.488552Z","end":"2026-10-19T01:52:30.616543Z","steps":["trace[609266268] 'read index received' (duration: 112.642183ms)","trace[609266268] 'applied index is now lower than readState.Index' (duration: 15.347801ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:52:30.616626Z","caller":"traceutil/trace.go:171","msg":"trace[2139920503] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"169.654193ms","start":"2026-10-19T01:52:30.44694Z","end":"2026-10-19T01:52:30.616594Z","steps":["trace[2139920503] 'process raft request' (duration: 154.304182ms)","trace[2139920503] 'compare' (duration: 15.012472ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:52:30.616862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.286992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-19T01:52:30.616977Z","caller":"traceutil/trace.go:171","msg":"trace[1818634678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2231; }","duration":"128.436026ms","start":"2026-10-19T01:52:30.488518Z","end":"2026-10-19T01:52:30.616954Z","steps":["trace[1818634678] 'agreement among raft nodes before linearized reading' (duration: 128.190919ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:36.447908Z","caller":"traceutil/trace.go:171","msg":"trace[1587073928] transaction","detail":"{read_only:false; response_revision:2259; number_of_response:1; }","duration":"224.996277ms","start":"2026-10-19T01:52:36.222887Z","end":"2026-10-19T01:52:36.447884Z","steps":["trace[1587073928] 'process raft request' (duration: 224.828143ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:36.50706Z","caller":"traceutil/trace.go:171","msg":"trace[76623375] linearizableReadLoop","detail":"{readStateIndex:2350; appliedIndex:2348; }","duration":"212.678997ms","start":"2026-10-19T01:52:36.294351Z","end":"2026-10-19T01:52:36.50703Z","steps":["trace[76623375] 'read index received' (duration: 153.383417ms)","trace[76623375] 'applied index is now lower than readState.Index' (duration: 59.29463ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:52:36.507111Z","caller":"traceutil/trace.go:171","msg":"trace[852242895] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"257.61367ms","start":"2026-10-19T01:52:36.249445Z","end":"2026-10-19T01:52:36.507059Z","steps":["trace[852242895] 'process raft request' (duration: 245.7416ms)","trace[852242895] 'compare' (duration: 11.703526ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:52:36.507264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.883952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:52:36.507301Z","caller":"traceutil/trace.go:171","msg":"trace[899849204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2260; }","duration":"212.993434ms","start":"2026-10-19T01:52:36.294297Z","end":"2026-10-19T01:52:36.50729Z","steps":["trace[899849204] 'agreement among raft nodes before linearized reading' (duration: 212.897112ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:52:36.50732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.761568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:52:36.507367Z","caller":"traceutil/trace.go:171","msg":"trace[861880118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2260; }","duration":"158.85399ms","start":"2026-10-19T01:52:36.348499Z","end":"2026-10-19T01:52:36.507353Z","steps":["trace[861880118] 'agreement among raft nodes before linearized reading' (duration: 158.769848ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:28.745126Z","caller":"traceutil/trace.go:171","msg":"trace[2056516464] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"124.145937ms","start":"2026-10-19T01:53:28.62094Z","end":"2026-10-19T01:53:28.745086Z","steps":["trace[2056516464] 'process raft request' (duration: 123.931711ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:00.680784Z","caller":"traceutil/trace.go:171","msg":"trace[1320885] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"151.950291ms","start":"2026-10-19T01:59:00.5288Z","end":"2026-10-19T01:59:00.68075Z","steps":["trace[1320885] 'process raft request' (duration: 105.097598ms)","trace[1320885] 'compare' (duration: 46.156355ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:59:00.681535Z","caller":"traceutil/trace.go:171","msg":"trace[1006164920] linearizableReadLoop","detail":"{readStateIndex:5428; appliedIndex:5427; }","duration":"107.202152ms","start":"2026-10-19T01:59:00.574318Z","end":"2026-10-19T01:59:00.681521Z","steps":["trace[1006164920] 'read index received' (duration: 59.597419ms)","trace[1006164920] 'applied index is now lower than readState.Index' (duration: 47.603643ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:59:00.681866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.489669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-10-19T01:59:00.68191Z","caller":"traceutil/trace.go:171","msg":"trace[786530810] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5224; }","duration":"107.639733ms","start":"2026-10-19T01:59:00.574258Z","end":"2026-10-19T01:59:00.681898Z","steps":["trace[786530810] 'agreement among raft nodes before linearized reading' (duration: 107.318365ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:05.761528Z","caller":"traceutil/trace.go:171","msg":"trace[1673337832] linearizableReadLoop","detail":"{readStateIndex:5636; appliedIndex:5635; }","duration":"121.348065ms","start":"2026-10-19T01:59:05.640151Z","end":"2026-10-19T01:59:05.761499Z","steps":["trace[1673337832] 'read index received' (duration: 121.258392ms)","trace[1673337832] 'applied index is now lower than readState.Index' (duration: 69.612µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:59:05.761613Z","caller":"traceutil/trace.go:171","msg":"trace[1686915232] transaction","detail":"{read_only:false; response_revision:5423; number_of_response:1; }","duration":"164.168423ms","start":"2026-10-19T01:59:05.597418Z","end":"2026-10-19T01:59:05.761587Z","steps":["trace[1686915232] 'process raft request' (duration: 163.857875ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:59:05.762243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.076984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:729175"} {"level":"info","ts":"2026-10-19T01:59:05.762343Z","caller":"traceutil/trace.go:171","msg":"trace[1440526615] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5423; }","duration":"122.223567ms","start":"2026-10-19T01:59:05.640096Z","end":"2026-10-19T01:59:05.762319Z","steps":["trace[1440526615] 'agreement among raft nodes before linearized reading' (duration: 121.57593ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:07.953026Z","caller":"traceutil/trace.go:171","msg":"trace[1684493750] transaction","detail":"{read_only:false; response_revision:5461; number_of_response:1; }","duration":"106.476722ms","start":"2026-10-19T01:59:07.846514Z","end":"2026-10-19T01:59:07.952991Z","steps":["trace[1684493750] 'process raft request' (duration: 73.234949ms)","trace[1684493750] 'compare' (duration: 32.989826ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:59:11.003727Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2966} {"level":"info","ts":"2026-10-19T01:59:11.091145Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2966,"took":"85.422213ms","hash":830658846,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":30392320,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-19T01:59:11.09122Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":830658846,"revision":2966,"compact-revision":-1} {"level":"warn","ts":"2026-10-19T01:59:21.387942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.977089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:59:21.388313Z","caller":"traceutil/trace.go:171","msg":"trace[2013476111] transaction","detail":"{read_only:false; response_revision:5704; number_of_response:1; }","duration":"154.408593ms","start":"2026-10-19T01:59:21.23387Z","end":"2026-10-19T01:59:21.388278Z","steps":["trace[2013476111] 'process raft request' (duration: 47.983782ms)","trace[2013476111] 'compare' (duration: 105.782274ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:59:33.18136Z","caller":"traceutil/trace.go:171","msg":"trace[2115431407] transaction","detail":"{read_only:false; response_revision:5909; number_of_response:1; }","duration":"140.375962ms","start":"2026-10-19T01:59:33.040953Z","end":"2026-10-19T01:59:33.181329Z","steps":["trace[2115431407] 'process raft request' (duration: 137.53161ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:00:25.449404Z","caller":"traceutil/trace.go:171","msg":"trace[412331567] transaction","detail":"{read_only:false; response_revision:6400; number_of_response:1; }","duration":"122.579017ms","start":"2026-10-19T02:00:25.326794Z","end":"2026-10-19T02:00:25.449373Z","steps":["trace[412331567] 'process raft request' (duration: 122.230678ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:04:11.022168Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5526} {"level":"info","ts":"2026-10-19T02:04:11.104277Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5526,"took":"80.054967ms","hash":3273315750,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":28106752,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-19T02:04:11.104345Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3273315750,"revision":5526,"compact-revision":2966} {"level":"info","ts":"2026-10-19T02:06:00.670216Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023c3.wal"} {"level":"info","ts":"2026-10-19T02:06:01.191856Z","caller":"traceutil/trace.go:171","msg":"trace[1622402437] transaction","detail":"{read_only:false; response_revision:8835; number_of_response:1; }","duration":"248.20889ms","start":"2026-10-19T02:06:00.9436Z","end":"2026-10-19T02:06:01.191809Z","steps":["trace[1622402437] 'process raft request' (duration: 247.987724ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:01.354914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.110956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19709"} {"level":"info","ts":"2026-10-19T02:06:01.355028Z","caller":"traceutil/trace.go:171","msg":"trace[2032894607] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8835; }","duration":"157.278971ms","start":"2026-10-19T02:06:01.197726Z","end":"2026-10-19T02:06:01.355005Z","steps":["trace[2032894607] 'range keys from in-memory index tree' (duration: 156.87133ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:13.042334Z","caller":"traceutil/trace.go:171","msg":"trace[910539212] transaction","detail":"{read_only:false; response_revision:8895; number_of_response:1; }","duration":"119.797447ms","start":"2026-10-19T02:06:12.922502Z","end":"2026-10-19T02:06:13.042299Z","steps":["trace[910539212] 'process raft request' (duration: 119.538571ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:13.86564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.312571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:06:13.865865Z","caller":"traceutil/trace.go:171","msg":"trace[110416690] transaction","detail":"{read_only:false; response_revision:8898; number_of_response:1; }","duration":"140.142816ms","start":"2026-10-19T02:06:13.725702Z","end":"2026-10-19T02:06:13.865845Z","steps":["trace[110416690] 'process raft request' (duration: 140.069334ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:13.865914Z","caller":"traceutil/trace.go:171","msg":"trace[13611860] linearizableReadLoop","detail":"{readStateIndex:9220; appliedIndex:9219; }","duration":"228.357234ms","start":"2026-10-19T02:06:13.637531Z","end":"2026-10-19T02:06:13.865888Z","steps":["trace[13611860] 'read index received' (duration: 18.630813ms)","trace[13611860] 'applied index is now lower than readState.Index' (duration: 209.724041ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:06:13.865998Z","caller":"traceutil/trace.go:171","msg":"trace[1857438686] transaction","detail":"{read_only:false; response_revision:8897; number_of_response:1; }","duration":"259.118552ms","start":"2026-10-19T02:06:13.606812Z","end":"2026-10-19T02:06:13.865931Z","steps":["trace[1857438686] 'process raft request' (duration: 49.416701ms)","trace[1857438686] 'compare' (duration: 209.130217ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:06:13.866095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.56454ms","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-19T02:06:13.866123Z","caller":"traceutil/trace.go:171","msg":"trace[1179118864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8898; }","duration":"228.693443ms","start":"2026-10-19T02:06:13.637424Z","end":"2026-10-19T02:06:13.866117Z","steps":["trace[1179118864] 'agreement among raft nodes before linearized reading' (duration: 228.58471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:13.866295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.753092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:06:13.866405Z","caller":"traceutil/trace.go:171","msg":"trace[11236509] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:8898; }","duration":"194.953598ms","start":"2026-10-19T02:06:13.671427Z","end":"2026-10-19T02:06:13.86638Z","steps":["trace[11236509] 'agreement among raft nodes before linearized reading' (duration: 194.723122ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:13.866431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.626627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-rgtzg\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-19T02:06:13.866525Z","caller":"traceutil/trace.go:171","msg":"trace[49403116] range","detail":"{range_begin:/registry/pods/openstack/keepalived-rgtzg; range_end:; response_count:1; response_revision:8898; }","duration":"165.756642ms","start":"2026-10-19T02:06:13.700748Z","end":"2026-10-19T02:06:13.866505Z","steps":["trace[49403116] 'agreement among raft nodes before linearized reading' (duration: 165.438383ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:14.536163Z","caller":"traceutil/trace.go:171","msg":"trace[2042426068] transaction","detail":"{read_only:false; response_revision:8905; number_of_response:1; }","duration":"116.325019ms","start":"2026-10-19T02:06:14.419806Z","end":"2026-10-19T02:06:14.536131Z","steps":["trace[2042426068] 'process raft request' (duration: 80.982501ms)","trace[2042426068] 'compare' (duration: 34.866774ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:06:43.616857Z","caller":"traceutil/trace.go:171","msg":"trace[787903033] transaction","detail":"{read_only:false; response_revision:9111; number_of_response:1; }","duration":"107.899159ms","start":"2026-10-19T02:06:43.50893Z","end":"2026-10-19T02:06:43.616829Z","steps":["trace[787903033] 'process raft request' (duration: 107.728725ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:56.079051Z","caller":"traceutil/trace.go:171","msg":"trace[1906677361] transaction","detail":"{read_only:false; response_revision:9177; number_of_response:1; }","duration":"173.146352ms","start":"2026-10-19T02:06:55.905864Z","end":"2026-10-19T02:06:56.07901Z","steps":["trace[1906677361] 'process raft request' (duration: 172.892916ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:56.615312Z","caller":"traceutil/trace.go:171","msg":"trace[1516067660] transaction","detail":"{read_only:false; response_revision:9182; number_of_response:1; }","duration":"148.02392ms","start":"2026-10-19T02:06:56.467263Z","end":"2026-10-19T02:06:56.615287Z","steps":["trace[1516067660] 'process raft request' (duration: 147.813205ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:56.615764Z","caller":"traceutil/trace.go:171","msg":"trace[1587039394] transaction","detail":"{read_only:false; response_revision:9184; number_of_response:1; }","duration":"136.801689ms","start":"2026-10-19T02:06:56.478948Z","end":"2026-10-19T02:06:56.61575Z","steps":["trace[1587039394] 'process raft request' (duration: 136.627085ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:56.615717Z","caller":"traceutil/trace.go:171","msg":"trace[1584264256] transaction","detail":"{read_only:false; response_revision:9183; number_of_response:1; }","duration":"147.788134ms","start":"2026-10-19T02:06:56.467859Z","end":"2026-10-19T02:06:56.615647Z","steps":["trace[1584264256] 'process raft request' (duration: 147.392893ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:48.404806Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:07:48.4104Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-19T02:07:48.410506Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-19T02:08:29.146699Z","caller":"traceutil/trace.go:171","msg":"trace[653777953] linearizableReadLoop","detail":"{readStateIndex:10417; appliedIndex:10416; }","duration":"249.852424ms","start":"2026-10-19T02:08:28.896814Z","end":"2026-10-19T02:08:29.146666Z","steps":["trace[653777953] 'read index received' (duration: 210.320195ms)","trace[653777953] 'applied index is now lower than readState.Index' (duration: 39.530919ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:08:29.1471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.265374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-rgtzg\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-19T02:08:29.147147Z","caller":"traceutil/trace.go:171","msg":"trace[974847558] range","detail":"{range_begin:/registry/pods/openstack/keepalived-rgtzg; range_end:; response_count:1; response_revision:10057; }","duration":"250.375317ms","start":"2026-10-19T02:08:28.896757Z","end":"2026-10-19T02:08:29.147133Z","steps":["trace[974847558] 'agreement among raft nodes before linearized reading' (duration: 250.08924ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:08:29.147239Z","caller":"traceutil/trace.go:171","msg":"trace[251255266] transaction","detail":"{read_only:false; response_revision:10057; number_of_response:1; }","duration":"275.332691ms","start":"2026-10-19T02:08:28.871854Z","end":"2026-10-19T02:08:29.147187Z","steps":["trace[251255266] 'process raft request' (duration: 235.261988ms)","trace[251255266] 'compare' (duration: 39.385456ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:08:29.16172Z","caller":"traceutil/trace.go:171","msg":"trace[1976598698] transaction","detail":"{read_only:false; response_revision:10058; number_of_response:1; }","duration":"182.954169ms","start":"2026-10-19T02:08:28.978747Z","end":"2026-10-19T02:08:29.161701Z","steps":["trace[1976598698] 'process raft request' (duration: 182.802385ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:08:29.162093Z","caller":"traceutil/trace.go:171","msg":"trace[1418471892] transaction","detail":"{read_only:false; response_revision:10059; number_of_response:1; }","duration":"170.775265ms","start":"2026-10-19T02:08:28.991292Z","end":"2026-10-19T02:08:29.162067Z","steps":["trace[1418471892] 'process raft request' (duration: 170.365034ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:08:29.162161Z","caller":"traceutil/trace.go:171","msg":"trace[115788220] transaction","detail":"{read_only:false; response_revision:10060; number_of_response:1; }","duration":"164.147104ms","start":"2026-10-19T02:08:28.997982Z","end":"2026-10-19T02:08:29.162129Z","steps":["trace[115788220] 'process raft request' (duration: 163.940397ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:08:29.162219Z","caller":"traceutil/trace.go:171","msg":"trace[1272347914] transaction","detail":"{read_only:false; response_revision:10061; number_of_response:1; }","duration":"148.782388ms","start":"2026-10-19T02:08:29.013413Z","end":"2026-10-19T02:08:29.162195Z","steps":["trace[1272347914] 'process raft request' (duration: 148.651625ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:11.035326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7976} {"level":"info","ts":"2026-10-19T02:09:11.125536Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7976,"took":"88.247066ms","hash":80359731,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":25088000,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-19T02:09:11.125616Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":80359731,"revision":7976,"compact-revision":5526} {"level":"info","ts":"2026-10-19T02:14:10.729785Z","caller":"traceutil/trace.go:171","msg":"trace[734408192] transaction","detail":"{read_only:false; response_revision:12510; number_of_response:1; }","duration":"166.246212ms","start":"2026-10-19T02:14:10.563498Z","end":"2026-10-19T02:14:10.729744Z","steps":["trace[734408192] 'process raft request' (duration: 166.1544ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:14:10.729985Z","caller":"traceutil/trace.go:171","msg":"trace[178565333] linearizableReadLoop","detail":"{readStateIndex:12952; appliedIndex:12948; }","duration":"132.615379ms","start":"2026-10-19T02:14:10.597338Z","end":"2026-10-19T02:14:10.729953Z","steps":["trace[178565333] 'read index received' (duration: 63.166199ms)","trace[178565333] 'applied index is now lower than readState.Index' (duration: 69.44729ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:14:10.730078Z","caller":"traceutil/trace.go:171","msg":"trace[1524283568] transaction","detail":"{read_only:false; response_revision:12509; number_of_response:1; }","duration":"167.643838ms","start":"2026-10-19T02:14:10.562402Z","end":"2026-10-19T02:14:10.730046Z","steps":["trace[1524283568] 'process raft request' (duration: 111.517169ms)","trace[1524283568] 'compare' (duration: 55.469722ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:14:10.730318Z","caller":"traceutil/trace.go:171","msg":"trace[2384334] transaction","detail":"{read_only:false; response_revision:12511; number_of_response:1; }","duration":"144.990177ms","start":"2026-10-19T02:14:10.585306Z","end":"2026-10-19T02:14:10.730296Z","steps":["trace[2384334] 'process raft request' (duration: 144.393312ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:14:10.730362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.01444ms","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-19T02:14:10.730415Z","caller":"traceutil/trace.go:171","msg":"trace[1845474882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12511; }","duration":"133.129083ms","start":"2026-10-19T02:14:10.597276Z","end":"2026-10-19T02:14:10.730405Z","steps":["trace[1845474882] 'agreement among raft nodes before linearized reading' (duration: 132.952888ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:14:11.087037Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10365} {"level":"info","ts":"2026-10-19T02:14:11.380138Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10365,"took":"289.686105ms","hash":857058815,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":25636864,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-19T02:14:11.3804Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":857058815,"revision":10365,"compact-revision":7976} {"level":"info","ts":"2026-10-19T02:14:11.697996Z","caller":"traceutil/trace.go:171","msg":"trace[1167687245] transaction","detail":"{read_only:false; response_revision:12517; number_of_response:1; }","duration":"173.837406ms","start":"2026-10-19T02:14:11.524102Z","end":"2026-10-19T02:14:11.69794Z","steps":["trace[1167687245] 'process raft request' (duration: 173.393415ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:14:11.940355Z","caller":"traceutil/trace.go:171","msg":"trace[1361546459] linearizableReadLoop","detail":"{readStateIndex:12960; appliedIndex:12959; }","duration":"110.205425ms","start":"2026-10-19T02:14:11.830104Z","end":"2026-10-19T02:14:11.940309Z","steps":["trace[1361546459] 'read index received' (duration: 99.012218ms)","trace[1361546459] 'applied index is now lower than readState.Index' (duration: 11.191757ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:14:11.94041Z","caller":"traceutil/trace.go:171","msg":"trace[92991795] transaction","detail":"{read_only:false; response_revision:12518; number_of_response:1; }","duration":"112.657808ms","start":"2026-10-19T02:14:11.827713Z","end":"2026-10-19T02:14:11.940371Z","steps":["trace[92991795] 'process raft request' (duration: 101.39517ms)","trace[92991795] 'compare' (duration: 11.038603ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:14:11.940703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.582495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7839"} {"level":"info","ts":"2026-10-19T02:14:11.940758Z","caller":"traceutil/trace.go:171","msg":"trace[1905805653] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:12518; }","duration":"110.711658ms","start":"2026-10-19T02:14:11.830028Z","end":"2026-10-19T02:14:11.940739Z","steps":["trace[1905805653] 'agreement among raft nodes before linearized reading' (duration: 110.469151ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:19:11.096156Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12516} {"level":"info","ts":"2026-10-19T02:19:11.185268Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12516,"took":"86.041313ms","hash":4101899466,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":28078080,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-19T02:19:11.185366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4101899466,"revision":12516,"compact-revision":10365} {"level":"info","ts":"2026-10-19T02:20:02.180308Z","caller":"traceutil/trace.go:171","msg":"trace[2012654277] transaction","detail":"{read_only:false; response_revision:14863; number_of_response:1; }","duration":"105.209515ms","start":"2026-10-19T02:20:02.075068Z","end":"2026-10-19T02:20:02.180278Z","steps":["trace[2012654277] 'process raft request' (duration: 104.997559ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:21:08.895504Z","caller":"traceutil/trace.go:171","msg":"trace[66312422] transaction","detail":"{read_only:false; response_revision:15385; number_of_response:1; }","duration":"327.217907ms","start":"2026-10-19T02:21:08.56822Z","end":"2026-10-19T02:21:08.895438Z","steps":["trace[66312422] 'process raft request' (duration: 326.954031ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:21:08.895758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:21:08.56819Z","time spent":"327.451973ms","remote":"127.0.0.1:52304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":854,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-19T02:21:09.044687Z","caller":"traceutil/trace.go:171","msg":"trace[1958079305] transaction","detail":"{read_only:false; response_revision:15386; number_of_response:1; }","duration":"432.26887ms","start":"2026-10-19T02:21:08.612389Z","end":"2026-10-19T02:21:09.044658Z","steps":["trace[1958079305] 'process raft request' (duration: 412.578735ms)","trace[1958079305] 'compare' (duration: 19.475539ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:21:09.044869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:21:08.612357Z","time spent":"432.406914ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:21:09.04524Z","caller":"traceutil/trace.go:171","msg":"trace[92646269] transaction","detail":"{read_only:false; response_revision:15388; number_of_response:1; }","duration":"430.387383ms","start":"2026-10-19T02:21:08.614811Z","end":"2026-10-19T02:21:09.045198Z","steps":["trace[92646269] 'process raft request' (duration: 430.079754ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:21:09.045508Z","caller":"traceutil/trace.go:171","msg":"trace[781209782] transaction","detail":"{read_only:false; response_revision:15389; number_of_response:1; }","duration":"428.509034ms","start":"2026-10-19T02:21:08.616988Z","end":"2026-10-19T02:21:09.045497Z","steps":["trace[781209782] 'process raft request' (duration: 428.029612ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:21:09.045552Z","caller":"traceutil/trace.go:171","msg":"trace[409526769] transaction","detail":"{read_only:false; response_revision:15387; number_of_response:1; }","duration":"433.03278ms","start":"2026-10-19T02:21:08.612503Z","end":"2026-10-19T02:21:09.045536Z","steps":["trace[409526769] 'process raft request' (duration: 432.108426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:21:09.045571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:21:08.616972Z","time spent":"428.573365ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:21:09.045617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:21:08.612447Z","time spent":"433.134422ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:21:09.045499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:21:08.614795Z","time spent":"430.549666ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:22:41.770844Z","caller":"traceutil/trace.go:171","msg":"trace[734941203] transaction","detail":"{read_only:false; response_revision:16430; number_of_response:1; }","duration":"344.068749ms","start":"2026-10-19T02:22:41.426752Z","end":"2026-10-19T02:22:41.770821Z","steps":["trace[734941203] 'process raft request' (duration: 343.905284ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:22:41.771001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:22:41.426734Z","time spent":"344.187493ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:22:41.791635Z","caller":"traceutil/trace.go:171","msg":"trace[1384664358] linearizableReadLoop","detail":"{readStateIndex:17011; appliedIndex:17007; }","duration":"168.179311ms","start":"2026-10-19T02:22:41.623427Z","end":"2026-10-19T02:22:41.791607Z","steps":["trace[1384664358] 'read index received' (duration: 147.228693ms)","trace[1384664358] 'applied index is now lower than readState.Index' (duration: 20.949568ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:22:41.792015Z","caller":"traceutil/trace.go:171","msg":"trace[1251635999] transaction","detail":"{read_only:false; response_revision:16431; number_of_response:1; }","duration":"358.885319ms","start":"2026-10-19T02:22:41.433114Z","end":"2026-10-19T02:22:41.792Z","steps":["trace[1251635999] 'process raft request' (duration: 358.226062ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:22:41.792127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:22:41.433102Z","time spent":"358.950531ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:22:41.792308Z","caller":"traceutil/trace.go:171","msg":"trace[249931872] transaction","detail":"{read_only:false; response_revision:16432; number_of_response:1; }","duration":"341.102274ms","start":"2026-10-19T02:22:41.451194Z","end":"2026-10-19T02:22:41.792296Z","steps":["trace[249931872] 'process raft request' (duration: 340.325814ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:22:41.792373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:22:41.451168Z","time spent":"341.172915ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:22:41.792535Z","caller":"traceutil/trace.go:171","msg":"trace[1444580883] transaction","detail":"{read_only:false; response_revision:16433; number_of_response:1; }","duration":"317.667053ms","start":"2026-10-19T02:22:41.474857Z","end":"2026-10-19T02:22:41.792524Z","steps":["trace[1444580883] 'process raft request' (duration: 316.710109ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:22:41.792598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:22:41.474842Z","time spent":"317.726034ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:22:41.792759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.32947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:22:41.792799Z","caller":"traceutil/trace.go:171","msg":"trace[1845327481] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16433; }","duration":"169.403412ms","start":"2026-10-19T02:22:41.623386Z","end":"2026-10-19T02:22:41.79279Z","steps":["trace[1845327481] 'agreement among raft nodes before linearized reading' (duration: 169.281609ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:22:41.792963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.947977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-19T02:22:41.792999Z","caller":"traceutil/trace.go:171","msg":"trace[2093074267] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16433; }","duration":"163.004368ms","start":"2026-10-19T02:22:41.629987Z","end":"2026-10-19T02:22:41.792991Z","steps":["trace[2093074267] 'agreement among raft nodes before linearized reading' (duration: 162.911995ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:24:11.104289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14541} {"level":"info","ts":"2026-10-19T02:24:11.19233Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14541,"took":"84.194118ms","hash":2771219897,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":31178752,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:24:11.192412Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2771219897,"revision":14541,"compact-revision":12516} {"level":"info","ts":"2026-10-19T02:28:29.017588Z","caller":"traceutil/trace.go:171","msg":"trace[1064021371] linearizableReadLoop","detail":"{readStateIndex:19567; appliedIndex:19564; }","duration":"152.363986ms","start":"2026-10-19T02:28:28.865192Z","end":"2026-10-19T02:28:29.017556Z","steps":["trace[1064021371] 'read index received' (duration: 15.461116ms)","trace[1064021371] 'applied index is now lower than readState.Index' (duration: 136.9017ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:28:29.017689Z","caller":"traceutil/trace.go:171","msg":"trace[927003711] transaction","detail":"{read_only:false; response_revision:18908; number_of_response:1; }","duration":"194.347442ms","start":"2026-10-19T02:28:28.823316Z","end":"2026-10-19T02:28:29.017663Z","steps":["trace[927003711] 'process raft request' (duration: 193.962523ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:29.017783Z","caller":"traceutil/trace.go:171","msg":"trace[2095221742] transaction","detail":"{read_only:false; number_of_response:1; response_revision:18908; }","duration":"192.495156ms","start":"2026-10-19T02:28:28.825211Z","end":"2026-10-19T02:28:29.017706Z","steps":["trace[2095221742] 'process raft request' (duration: 192.301911ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:29.018036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.697924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/ingress-nginx/ingress-nginx-controller-bbgjs.18dfcb46740d232b\" ","response":"range_response_count:1 size:767"} {"level":"info","ts":"2026-10-19T02:28:29.018092Z","caller":"traceutil/trace.go:171","msg":"trace[2119262383] range","detail":"{range_begin:/registry/events/ingress-nginx/ingress-nginx-controller-bbgjs.18dfcb46740d232b; range_end:; response_count:1; response_revision:18908; }","duration":"152.942041ms","start":"2026-10-19T02:28:28.865133Z","end":"2026-10-19T02:28:29.018075Z","steps":["trace[2119262383] 'agreement among raft nodes before linearized reading' (duration: 152.551071ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:29.130277Z","caller":"traceutil/trace.go:171","msg":"trace[1128993096] transaction","detail":"{read_only:false; response_revision:18910; number_of_response:1; }","duration":"100.63919ms","start":"2026-10-19T02:28:29.029588Z","end":"2026-10-19T02:28:29.130227Z","steps":["trace[1128993096] 'process raft request' (duration: 100.380553ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:29.243762Z","caller":"traceutil/trace.go:171","msg":"trace[2086817841] transaction","detail":"{read_only:false; response_revision:18911; number_of_response:1; }","duration":"105.254719ms","start":"2026-10-19T02:28:29.138473Z","end":"2026-10-19T02:28:29.243728Z","steps":["trace[2086817841] 'process raft request' (duration: 72.075559ms)","trace[2086817841] 'compare' (duration: 32.988735ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:28:29.973358Z","caller":"traceutil/trace.go:171","msg":"trace[752735229] linearizableReadLoop","detail":"{readStateIndex:19602; appliedIndex:19601; }","duration":"110.276747ms","start":"2026-10-19T02:28:29.863047Z","end":"2026-10-19T02:28:29.973324Z","steps":["trace[752735229] 'read index received' (duration: 20.534136ms)","trace[752735229] 'applied index is now lower than readState.Index' (duration: 89.740531ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:28:29.973454Z","caller":"traceutil/trace.go:171","msg":"trace[1837805173] transaction","detail":"{read_only:false; response_revision:18941; number_of_response:1; }","duration":"115.262685ms","start":"2026-10-19T02:28:29.858145Z","end":"2026-10-19T02:28:29.973408Z","steps":["trace[1837805173] 'process raft request' (duration: 25.497994ms)","trace[1837805173] 'compare' (duration: 89.502104ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:28:29.973672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.590805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-19T02:28:29.973723Z","caller":"traceutil/trace.go:171","msg":"trace[1533951208] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18941; }","duration":"110.708488ms","start":"2026-10-19T02:28:29.863002Z","end":"2026-10-19T02:28:29.97371Z","steps":["trace[1533951208] 'agreement among raft nodes before linearized reading' (duration: 110.493032ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:32.173241Z","caller":"traceutil/trace.go:171","msg":"trace[1349688036] linearizableReadLoop","detail":"{readStateIndex:19627; appliedIndex:19626; }","duration":"151.596628ms","start":"2026-10-19T02:28:32.02161Z","end":"2026-10-19T02:28:32.173207Z","steps":["trace[1349688036] 'read index received' (duration: 151.408652ms)","trace[1349688036] 'applied index is now lower than readState.Index' (duration: 186.565µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:28:32.173296Z","caller":"traceutil/trace.go:171","msg":"trace[1397197023] transaction","detail":"{read_only:false; response_revision:18965; number_of_response:1; }","duration":"185.423345ms","start":"2026-10-19T02:28:31.987833Z","end":"2026-10-19T02:28:32.173257Z","steps":["trace[1397197023] 'process raft request' (duration: 185.174837ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:32.173564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.916315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-19T02:28:32.173659Z","caller":"traceutil/trace.go:171","msg":"trace[1418597021] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18965; }","duration":"152.075879ms","start":"2026-10-19T02:28:32.021563Z","end":"2026-10-19T02:28:32.173639Z","steps":["trace[1418597021] 'agreement among raft nodes before linearized reading' (duration: 151.759261ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:32.333042Z","caller":"traceutil/trace.go:171","msg":"trace[631568538] linearizableReadLoop","detail":"{readStateIndex:19628; appliedIndex:19627; }","duration":"159.692105ms","start":"2026-10-19T02:28:32.173325Z","end":"2026-10-19T02:28:32.333017Z","steps":["trace[631568538] 'read index received' (duration: 127.014376ms)","trace[631568538] 'applied index is now lower than readState.Index' (duration: 32.676699ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:28:32.333158Z","caller":"traceutil/trace.go:171","msg":"trace[1328176991] transaction","detail":"{read_only:false; response_revision:18967; number_of_response:1; }","duration":"152.48997ms","start":"2026-10-19T02:28:32.18065Z","end":"2026-10-19T02:28:32.33314Z","steps":["trace[1328176991] 'process raft request' (duration: 152.311685ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:32.33318Z","caller":"traceutil/trace.go:171","msg":"trace[1475226952] transaction","detail":"{read_only:false; response_revision:18966; number_of_response:1; }","duration":"292.95162ms","start":"2026-10-19T02:28:32.040216Z","end":"2026-10-19T02:28:32.333167Z","steps":["trace[1475226952] 'process raft request' (duration: 260.100068ms)","trace[1475226952] 'compare' (duration: 32.366139ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:28:32.333438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.722696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-kn4zc\" ","response":"range_response_count:1 size:22094"} {"level":"info","ts":"2026-10-19T02:28:32.333479Z","caller":"traceutil/trace.go:171","msg":"trace[671850505] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-kn4zc; range_end:; response_count:1; response_revision:18967; }","duration":"285.808027ms","start":"2026-10-19T02:28:32.047661Z","end":"2026-10-19T02:28:32.333469Z","steps":["trace[671850505] 'agreement among raft nodes before linearized reading' (duration: 285.620712ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:32.333751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.847441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-10-19T02:28:32.333804Z","caller":"traceutil/trace.go:171","msg":"trace[1565843308] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18967; }","duration":"156.953654ms","start":"2026-10-19T02:28:32.176839Z","end":"2026-10-19T02:28:32.333793Z","steps":["trace[1565843308] 'agreement among raft nodes before linearized reading' (duration: 156.807661ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:32.33398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.226057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-19T02:28:32.334019Z","caller":"traceutil/trace.go:171","msg":"trace[1123109967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18967; }","duration":"300.267718ms","start":"2026-10-19T02:28:32.033742Z","end":"2026-10-19T02:28:32.33401Z","steps":["trace[1123109967] 'agreement among raft nodes before linearized reading' (duration: 300.164445ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:32.334045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:28:32.033693Z","time spent":"300.344769ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-19T02:28:32.334237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.446132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-19T02:28:32.334267Z","caller":"traceutil/trace.go:171","msg":"trace[138402855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18967; }","duration":"300.475793ms","start":"2026-10-19T02:28:32.033783Z","end":"2026-10-19T02:28:32.334259Z","steps":["trace[138402855] 'agreement among raft nodes before linearized reading' (duration: 300.377451ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:32.334294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:28:32.033758Z","time spent":"300.526205ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-19T02:29:03.471924Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:29:03.478739Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-19T02:29:03.478889Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-19T02:29:11.115212Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16993} {"level":"info","ts":"2026-10-19T02:29:11.228703Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16993,"took":"108.315557ms","hash":3206090731,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":32710656,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-19T02:29:11.228779Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3206090731,"revision":16993,"compact-revision":14541} {"level":"info","ts":"2026-10-19T02:34:11.12707Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19377} {"level":"info","ts":"2026-10-19T02:34:11.254778Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19377,"took":"120.389088ms","hash":2560931306,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":30507008,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-19T02:34:11.254945Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2560931306,"revision":19377,"compact-revision":16993} {"level":"info","ts":"2026-10-19T02:34:57.270158Z","caller":"traceutil/trace.go:171","msg":"trace[880928] transaction","detail":"{read_only:false; response_revision:21891; number_of_response:1; }","duration":"304.12607ms","start":"2026-10-19T02:34:56.966012Z","end":"2026-10-19T02:34:57.270139Z","steps":["trace[880928] 'process raft request' (duration: 304.005497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:34:57.270284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:34:56.965984Z","time spent":"304.229383ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:34:57.291561Z","caller":"traceutil/trace.go:171","msg":"trace[1551484482] linearizableReadLoop","detail":"{readStateIndex:22652; appliedIndex:22651; }","duration":"300.21812ms","start":"2026-10-19T02:34:56.99128Z","end":"2026-10-19T02:34:57.291498Z","steps":["trace[1551484482] 'read index received' (duration: 279.216031ms)","trace[1551484482] 'applied index is now lower than readState.Index' (duration: 21.000369ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:34:57.292071Z","caller":"traceutil/trace.go:171","msg":"trace[875743480] transaction","detail":"{read_only:false; response_revision:21892; number_of_response:1; }","duration":"321.590999ms","start":"2026-10-19T02:34:56.970463Z","end":"2026-10-19T02:34:57.292054Z","steps":["trace[875743480] 'process raft request' (duration: 320.747518ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:34:57.292275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:34:56.970449Z","time spent":"321.672731ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:34:57.292538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.210776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-19T02:34:57.292649Z","caller":"traceutil/trace.go:171","msg":"trace[1080872597] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21894; }","duration":"301.347729ms","start":"2026-10-19T02:34:56.991261Z","end":"2026-10-19T02:34:57.292609Z","steps":["trace[1080872597] 'agreement among raft nodes before linearized reading' (duration: 301.035241ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:34:57.292699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:34:56.991195Z","time spent":"301.494922ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-19T02:34:57.292892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.940751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:34:57.292946Z","caller":"traceutil/trace.go:171","msg":"trace[457942827] transaction","detail":"{read_only:false; response_revision:21893; number_of_response:1; }","duration":"199.361833ms","start":"2026-10-19T02:34:57.09357Z","end":"2026-10-19T02:34:57.292932Z","steps":["trace[457942827] 'process raft request' (duration: 197.824084ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:34:57.292975Z","caller":"traceutil/trace.go:171","msg":"trace[1343346300] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:21894; }","duration":"268.083746ms","start":"2026-10-19T02:34:57.024868Z","end":"2026-10-19T02:34:57.292952Z","steps":["trace[1343346300] 'agreement among raft nodes before linearized reading' (duration: 267.928721ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:34:57.29311Z","caller":"traceutil/trace.go:171","msg":"trace[416106673] transaction","detail":"{read_only:false; response_revision:21894; number_of_response:1; }","duration":"196.291055ms","start":"2026-10-19T02:34:57.096809Z","end":"2026-10-19T02:34:57.2931Z","steps":["trace[416106673] 'process raft request' (duration: 194.627662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:34:57.293317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.130129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:34:57.293372Z","caller":"traceutil/trace.go:171","msg":"trace[1908944180] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:21894; }","duration":"109.220341ms","start":"2026-10-19T02:34:57.184138Z","end":"2026-10-19T02:34:57.293358Z","steps":["trace[1908944180] 'agreement among raft nodes before linearized reading' (duration: 109.101148ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:35:03.682099Z","caller":"traceutil/trace.go:171","msg":"trace[552708622] transaction","detail":"{read_only:false; response_revision:21938; number_of_response:1; }","duration":"384.03697ms","start":"2026-10-19T02:35:03.298037Z","end":"2026-10-19T02:35:03.682074Z","steps":["trace[552708622] 'process raft request' (duration: 383.886866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:03.682249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:03.298008Z","time spent":"384.161403ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:35:03.93908Z","caller":"traceutil/trace.go:171","msg":"trace[989777697] linearizableReadLoop","detail":"{readStateIndex:22702; appliedIndex:22698; }","duration":"588.988647ms","start":"2026-10-19T02:35:03.350063Z","end":"2026-10-19T02:35:03.939051Z","steps":["trace[989777697] 'read index received' (duration: 331.872942ms)","trace[989777697] 'applied index is now lower than readState.Index' (duration: 257.114515ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:35:03.939439Z","caller":"traceutil/trace.go:171","msg":"trace[1939468367] transaction","detail":"{read_only:false; response_revision:21939; number_of_response:1; }","duration":"621.572103ms","start":"2026-10-19T02:35:03.317855Z","end":"2026-10-19T02:35:03.939427Z","steps":["trace[1939468367] 'process raft request' (duration: 620.923906ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:03.939589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:03.317836Z","time spent":"621.640855ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:35:03.939767Z","caller":"traceutil/trace.go:171","msg":"trace[21779948] transaction","detail":"{read_only:false; response_revision:21940; number_of_response:1; }","duration":"614.821759ms","start":"2026-10-19T02:35:03.324935Z","end":"2026-10-19T02:35:03.939757Z","steps":["trace[21779948] 'process raft request' (duration: 614.021219ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:03.939827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:03.324906Z","time spent":"614.888321ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:35:03.939976Z","caller":"traceutil/trace.go:171","msg":"trace[921385838] transaction","detail":"{read_only:false; response_revision:21941; number_of_response:1; }","duration":"614.818949ms","start":"2026-10-19T02:35:03.325146Z","end":"2026-10-19T02:35:03.939965Z","steps":["trace[921385838] 'process raft request' (duration: 613.851425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:03.940033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:03.325139Z","time spent":"614.86455ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:35:03.940169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.102555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:35:03.940207Z","caller":"traceutil/trace.go:171","msg":"trace[2139798421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21941; }","duration":"590.162896ms","start":"2026-10-19T02:35:03.350034Z","end":"2026-10-19T02:35:03.940197Z","steps":["trace[2139798421] 'agreement among raft nodes before linearized reading' (duration: 590.101725ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:03.940236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:03.349891Z","time spent":"590.339631ms","remote":"127.0.0.1:52216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-19T02:35:03.940463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.895517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-19T02:35:03.9405Z","caller":"traceutil/trace.go:171","msg":"trace[1695053030] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21941; }","duration":"562.98127ms","start":"2026-10-19T02:35:03.377508Z","end":"2026-10-19T02:35:03.94049Z","steps":["trace[1695053030] 'agreement among raft nodes before linearized reading' (duration: 562.865547ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:03.940547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:03.377488Z","time spent":"563.051742ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-19T02:35:03.940853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.457667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:35:03.940892Z","caller":"traceutil/trace.go:171","msg":"trace[149450019] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:21941; }","duration":"178.54303ms","start":"2026-10-19T02:35:03.762337Z","end":"2026-10-19T02:35:03.94088Z","steps":["trace[149450019] 'agreement among raft nodes before linearized reading' (duration: 178.483209ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:35:04.202664Z","caller":"traceutil/trace.go:171","msg":"trace[1558809284] linearizableReadLoop","detail":"{readStateIndex:22703; appliedIndex:22702; }","duration":"230.963503ms","start":"2026-10-19T02:35:03.971659Z","end":"2026-10-19T02:35:04.202623Z","steps":["trace[1558809284] 'read index received' (duration: 207.937673ms)","trace[1558809284] 'applied index is now lower than readState.Index' (duration: 23.02413ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:35:04.202679Z","caller":"traceutil/trace.go:171","msg":"trace[1203393028] transaction","detail":"{read_only:false; response_revision:21942; number_of_response:1; }","duration":"257.665759ms","start":"2026-10-19T02:35:03.944968Z","end":"2026-10-19T02:35:04.202634Z","steps":["trace[1203393028] 'process raft request' (duration: 234.638608ms)","trace[1203393028] 'compare' (duration: 22.740613ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:35:04.203127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.383164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:35:04.203247Z","caller":"traceutil/trace.go:171","msg":"trace[207126153] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:21942; }","duration":"231.61482ms","start":"2026-10-19T02:35:03.971613Z","end":"2026-10-19T02:35:04.203228Z","steps":["trace[207126153] 'agreement among raft nodes before linearized reading' (duration: 231.173148ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:04.724245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.721197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.167\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-19T02:35:04.724326Z","caller":"traceutil/trace.go:171","msg":"trace[730345269] range","detail":"{range_begin:/registry/masterleases/162.253.55.167; range_end:; response_count:1; response_revision:21942; }","duration":"175.852451ms","start":"2026-10-19T02:35:04.548454Z","end":"2026-10-19T02:35:04.724306Z","steps":["trace[730345269] 'range keys from in-memory index tree' (duration: 175.563082ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:04.724625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.909514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:35:04.724675Z","caller":"traceutil/trace.go:171","msg":"trace[325288659] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21942; }","duration":"372.996707ms","start":"2026-10-19T02:35:04.351666Z","end":"2026-10-19T02:35:04.724663Z","steps":["trace[325288659] 'range keys from in-memory index tree' (duration: 372.829252ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:04.724708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:04.351641Z","time spent":"373.056249ms","remote":"127.0.0.1:52216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-19T02:35:04.725022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.825048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-19T02:35:04.725025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.307217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:35:04.725103Z","caller":"traceutil/trace.go:171","msg":"trace[39607323] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:21942; }","duration":"343.927811ms","start":"2026-10-19T02:35:04.381149Z","end":"2026-10-19T02:35:04.725077Z","steps":["trace[39607323] 'count revisions from in-memory index tree' (duration: 343.728205ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:35:04.725115Z","caller":"traceutil/trace.go:171","msg":"trace[1078295390] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:21942; }","duration":"200.429931ms","start":"2026-10-19T02:35:04.524656Z","end":"2026-10-19T02:35:04.725086Z","steps":["trace[1078295390] 'count revisions from in-memory index tree' (duration: 200.152653ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:04.725146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:04.38111Z","time spent":"344.024724ms","remote":"127.0.0.1:52268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":92,"response size":31,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:35:04.725139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.912101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:35:04.725233Z","caller":"traceutil/trace.go:171","msg":"trace[2050780236] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21942; }","duration":"351.015714ms","start":"2026-10-19T02:35:04.37417Z","end":"2026-10-19T02:35:04.725186Z","steps":["trace[2050780236] 'range keys from in-memory index tree' (duration: 350.743286ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:35:04.725272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:35:04.37412Z","time spent":"351.141027ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-19T02:35:04.870468Z","caller":"traceutil/trace.go:171","msg":"trace[426249058] transaction","detail":"{read_only:false; response_revision:21943; number_of_response:1; }","duration":"139.241211ms","start":"2026-10-19T02:35:04.730961Z","end":"2026-10-19T02:35:04.870202Z","steps":["trace[426249058] 'process raft request' (duration: 137.868446ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:35:04.870669Z","caller":"traceutil/trace.go:171","msg":"trace[1611712438] transaction","detail":"{read_only:false; response_revision:21944; number_of_response:1; }","duration":"138.990145ms","start":"2026-10-19T02:35:04.731599Z","end":"2026-10-19T02:35:04.870589Z","steps":["trace[1611712438] 'process raft request' (duration: 138.521023ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:35:04.870725Z","caller":"traceutil/trace.go:171","msg":"trace[1719094833] transaction","detail":"{read_only:false; response_revision:21945; number_of_response:1; }","duration":"138.967964ms","start":"2026-10-19T02:35:04.731728Z","end":"2026-10-19T02:35:04.870696Z","steps":["trace[1719094833] 'process raft request' (duration: 138.722447ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:35:04.870795Z","caller":"traceutil/trace.go:171","msg":"trace[415750004] transaction","detail":"{read_only:false; response_revision:21946; number_of_response:1; }","duration":"138.840612ms","start":"2026-10-19T02:35:04.731941Z","end":"2026-10-19T02:35:04.870781Z","steps":["trace[415750004] 'process raft request' (duration: 138.700537ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:35:04.874217Z","caller":"traceutil/trace.go:171","msg":"trace[1516490111] transaction","detail":"{read_only:false; response_revision:21947; number_of_response:1; }","duration":"121.054295ms","start":"2026-10-19T02:35:04.753139Z","end":"2026-10-19T02:35:04.874194Z","steps":["trace[1516490111] 'process raft request' (duration: 120.920542ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:39:11.155528Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21649} {"level":"info","ts":"2026-10-19T02:39:11.28509Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21649,"took":"124.615984ms","hash":3903213157,"current-db-size-bytes":55373824,"current-db-size":"55 MB","current-db-size-in-use-bytes":31469568,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T02:39:11.28515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3903213157,"revision":21649,"compact-revision":19377} {"level":"info","ts":"2026-10-19T02:39:27.98538Z","caller":"traceutil/trace.go:171","msg":"trace[33141761] linearizableReadLoop","detail":"{readStateIndex:25379; appliedIndex:25378; }","duration":"233.367264ms","start":"2026-10-19T02:39:27.751986Z","end":"2026-10-19T02:39:27.985353Z","steps":["trace[33141761] 'read index received' (duration: 233.105097ms)","trace[33141761] 'applied index is now lower than readState.Index' (duration: 261.407µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:39:27.985506Z","caller":"traceutil/trace.go:171","msg":"trace[693725086] transaction","detail":"{read_only:false; response_revision:24537; number_of_response:1; }","duration":"247.128806ms","start":"2026-10-19T02:39:27.73834Z","end":"2026-10-19T02:39:27.985469Z","steps":["trace[693725086] 'process raft request' (duration: 246.825708ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:39:27.985618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.61004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-19T02:39:27.985684Z","caller":"traceutil/trace.go:171","msg":"trace[376944044] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24537; }","duration":"233.695812ms","start":"2026-10-19T02:39:27.751963Z","end":"2026-10-19T02:39:27.985659Z","steps":["trace[376944044] 'agreement among raft nodes before linearized reading' (duration: 233.491387ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:41:47.299206Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068bd.wal"} {"level":"info","ts":"2026-10-19T02:43:21.447182Z","caller":"traceutil/trace.go:171","msg":"trace[787293533] transaction","detail":"{read_only:false; response_revision:26771; number_of_response:1; }","duration":"163.40451ms","start":"2026-10-19T02:43:21.283752Z","end":"2026-10-19T02:43:21.447157Z","steps":["trace[787293533] 'process raft request' (duration: 163.182044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:21.710058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.859025ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:43:21.710238Z","caller":"traceutil/trace.go:171","msg":"trace[1478643744] transaction","detail":"{read_only:false; response_revision:26772; number_of_response:1; }","duration":"256.21955ms","start":"2026-10-19T02:43:21.453987Z","end":"2026-10-19T02:43:21.710207Z","steps":["trace[1478643744] 'process raft request' (duration: 102.073777ms)","trace[1478643744] 'compare' (duration: 153.682381ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:43:22.135006Z","caller":"traceutil/trace.go:171","msg":"trace[604710349] linearizableReadLoop","detail":"{readStateIndex:27675; appliedIndex:27674; }","duration":"160.103135ms","start":"2026-10-19T02:43:21.974874Z","end":"2026-10-19T02:43:22.134977Z","steps":["trace[604710349] 'read index received' (duration: 159.872899ms)","trace[604710349] 'applied index is now lower than readState.Index' (duration: 229.276µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:43:22.135132Z","caller":"traceutil/trace.go:171","msg":"trace[374807637] transaction","detail":"{read_only:false; response_revision:26775; number_of_response:1; }","duration":"169.198548ms","start":"2026-10-19T02:43:21.965908Z","end":"2026-10-19T02:43:22.135107Z","steps":["trace[374807637] 'process raft request' (duration: 168.8715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:22.135276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.379731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:43:22.135314Z","caller":"traceutil/trace.go:171","msg":"trace[1610748642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26775; }","duration":"160.492915ms","start":"2026-10-19T02:43:21.974807Z","end":"2026-10-19T02:43:22.1353Z","steps":["trace[1610748642] 'agreement among raft nodes before linearized reading' (duration: 160.31722ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:43:22.185017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.416481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11786"} {"level":"warn","ts":"2026-10-19T02:43:22.185077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.284777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-10-19T02:43:22.185073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.798097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-19T02:43:22.185127Z","caller":"traceutil/trace.go:171","msg":"trace[1976898776] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26777; }","duration":"197.562645ms","start":"2026-10-19T02:43:21.987538Z","end":"2026-10-19T02:43:22.185101Z","steps":["trace[1976898776] 'agreement among raft nodes before linearized reading' (duration: 197.208416ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:22.185167Z","caller":"traceutil/trace.go:171","msg":"trace[1649080091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26777; }","duration":"204.441942ms","start":"2026-10-19T02:43:21.980704Z","end":"2026-10-19T02:43:22.185146Z","steps":["trace[1649080091] 'agreement among raft nodes before linearized reading' (duration: 204.018551ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:22.185192Z","caller":"traceutil/trace.go:171","msg":"trace[1023356291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26777; }","duration":"198.95211ms","start":"2026-10-19T02:43:21.986214Z","end":"2026-10-19T02:43:22.185166Z","steps":["trace[1023356291] 'agreement among raft nodes before linearized reading' (duration: 198.55343ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:44:11.165143Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23901} {"level":"info","ts":"2026-10-19T02:44:11.303783Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23901,"took":"131.975484ms","hash":2884860346,"current-db-size-bytes":56643584,"current-db-size":"57 MB","current-db-size-in-use-bytes":45563904,"current-db-size-in-use":"46 MB"} {"level":"info","ts":"2026-10-19T02:44:11.303858Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2884860346,"revision":23901,"compact-revision":21649} {"level":"info","ts":"2026-10-19T02:44:26.149279Z","caller":"traceutil/trace.go:171","msg":"trace[641161969] transaction","detail":"{read_only:false; response_revision:27344; number_of_response:1; }","duration":"150.039376ms","start":"2026-10-19T02:44:25.99917Z","end":"2026-10-19T02:44:26.14921Z","steps":["trace[641161969] 'process raft request' (duration: 149.819221ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:44:26.436752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.925311ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:44:26.437116Z","caller":"traceutil/trace.go:171","msg":"trace[620852584] transaction","detail":"{read_only:false; response_revision:27345; number_of_response:1; }","duration":"325.965467ms","start":"2026-10-19T02:44:26.111108Z","end":"2026-10-19T02:44:26.437074Z","steps":["trace[620852584] 'process raft request' (duration: 163.591834ms)","trace[620852584] 'compare' (duration: 161.47395ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:44:26.437268Z","caller":"traceutil/trace.go:171","msg":"trace[503501860] transaction","detail":"{read_only:false; response_revision:27346; number_of_response:1; }","duration":"283.262402ms","start":"2026-10-19T02:44:26.153981Z","end":"2026-10-19T02:44:26.437244Z","steps":["trace[503501860] 'process raft request' (duration: 283.090028ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:44:26.437302Z","caller":"traceutil/trace.go:171","msg":"trace[765778524] linearizableReadLoop","detail":"{readStateIndex:28260; appliedIndex:28259; }","duration":"288.087927ms","start":"2026-10-19T02:44:26.149171Z","end":"2026-10-19T02:44:26.437259Z","steps":["trace[765778524] 'read index received' (duration: 125.549559ms)","trace[765778524] 'applied index is now lower than readState.Index' (duration: 162.520867ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:44:26.437281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:44:26.111076Z","time spent":"326.10081ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:44:26.437508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.789767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:44:26.437631Z","caller":"traceutil/trace.go:171","msg":"trace[1304025116] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:27346; }","duration":"315.971661ms","start":"2026-10-19T02:44:26.12163Z","end":"2026-10-19T02:44:26.437601Z","steps":["trace[1304025116] 'agreement among raft nodes before linearized reading' (duration: 315.751506ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:44:26.437669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.566671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"warn","ts":"2026-10-19T02:44:26.437684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:44:26.121604Z","time spent":"316.069884ms","remote":"127.0.0.1:60174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"info","ts":"2026-10-19T02:44:26.437716Z","caller":"traceutil/trace.go:171","msg":"trace[1381986154] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:27346; }","duration":"246.662714ms","start":"2026-10-19T02:44:26.191039Z","end":"2026-10-19T02:44:26.437702Z","steps":["trace[1381986154] 'agreement among raft nodes before linearized reading' (duration: 246.418338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:44:26.438814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.594519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-19T02:44:26.438852Z","caller":"traceutil/trace.go:171","msg":"trace[1693223700] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:27346; }","duration":"256.679942ms","start":"2026-10-19T02:44:26.182165Z","end":"2026-10-19T02:44:26.438845Z","steps":["trace[1693223700] 'agreement among raft nodes before linearized reading' (duration: 255.275225ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:44:26.717408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.959569ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:44:26.717508Z","caller":"traceutil/trace.go:171","msg":"trace[1003374807] linearizableReadLoop","detail":"{readStateIndex:28262; appliedIndex:28261; }","duration":"212.123019ms","start":"2026-10-19T02:44:26.505368Z","end":"2026-10-19T02:44:26.717491Z","steps":["trace[1003374807] 'read index received' (duration: 56.013396ms)","trace[1003374807] 'applied index is now lower than readState.Index' (duration: 156.108323ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:44:26.71772Z","caller":"traceutil/trace.go:171","msg":"trace[1047350038] transaction","detail":"{read_only:false; response_revision:27347; number_of_response:1; }","duration":"262.54422ms","start":"2026-10-19T02:44:26.455129Z","end":"2026-10-19T02:44:26.717674Z","steps":["trace[1047350038] 'process raft request' (duration: 106.230992ms)","trace[1047350038] 'compare' (duration: 155.794135ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:44:26.717847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.452237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-19T02:44:26.717931Z","caller":"traceutil/trace.go:171","msg":"trace[2023267496] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27347; }","duration":"212.58866ms","start":"2026-10-19T02:44:26.505321Z","end":"2026-10-19T02:44:26.717909Z","steps":["trace[2023267496] 'agreement among raft nodes before linearized reading' (duration: 212.328024ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:44:26.757608Z","caller":"traceutil/trace.go:171","msg":"trace[1400128918] transaction","detail":"{read_only:false; response_revision:27348; number_of_response:1; }","duration":"210.928798ms","start":"2026-10-19T02:44:26.546639Z","end":"2026-10-19T02:44:26.757568Z","steps":["trace[1400128918] 'process raft request' (duration: 210.688332ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:44:26.757941Z","caller":"traceutil/trace.go:171","msg":"trace[1199229123] transaction","detail":"{read_only:false; response_revision:27349; number_of_response:1; }","duration":"204.059382ms","start":"2026-10-19T02:44:26.553865Z","end":"2026-10-19T02:44:26.757925Z","steps":["trace[1199229123] 'process raft request' (duration: 203.63759ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:44:26.763207Z","caller":"traceutil/trace.go:171","msg":"trace[544062434] transaction","detail":"{read_only:false; response_revision:27350; number_of_response:1; }","duration":"191.612263ms","start":"2026-10-19T02:44:26.571565Z","end":"2026-10-19T02:44:26.763177Z","steps":["trace[544062434] 'process raft request' (duration: 191.384367ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:44:26.763484Z","caller":"traceutil/trace.go:171","msg":"trace[1391151276] transaction","detail":"{read_only:false; response_revision:27351; number_of_response:1; }","duration":"188.460973ms","start":"2026-10-19T02:44:26.574968Z","end":"2026-10-19T02:44:26.763429Z","steps":["trace[1391151276] 'process raft request' (duration: 188.152824ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:44:26.764114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.916714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-19T02:44:26.764105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.321294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-19T02:44:26.764194Z","caller":"traceutil/trace.go:171","msg":"trace[2006050964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27353; }","duration":"180.479388ms","start":"2026-10-19T02:44:26.583694Z","end":"2026-10-19T02:44:26.764174Z","steps":["trace[2006050964] 'agreement among raft nodes before linearized reading' (duration: 180.206581ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:44:26.764212Z","caller":"traceutil/trace.go:171","msg":"trace[1099303352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27353; }","duration":"173.021757ms","start":"2026-10-19T02:44:26.591139Z","end":"2026-10-19T02:44:26.764161Z","steps":["trace[1099303352] 'agreement among raft nodes before linearized reading' (duration: 172.819272ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:44:26.764304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.496794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-19T02:44:26.76546Z","caller":"traceutil/trace.go:171","msg":"trace[1844696421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27353; }","duration":"175.693684ms","start":"2026-10-19T02:44:26.589739Z","end":"2026-10-19T02:44:26.765433Z","steps":["trace[1844696421] 'agreement among raft nodes before linearized reading' (duration: 174.36157ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:47:24.602761Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:47:24.609874Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-19T02:47:24.609989Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-19T02:49:11.172054Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27239} {"level":"info","ts":"2026-10-19T02:49:11.343408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27239,"took":"165.167053ms","hash":2862284249,"current-db-size-bytes":57913344,"current-db-size":"58 MB","current-db-size-in-use-bytes":36388864,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-19T02:49:11.343579Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2862284249,"revision":27239,"compact-revision":23901} {"level":"info","ts":"2026-10-19T02:54:11.180617Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30096} {"level":"info","ts":"2026-10-19T02:54:11.355267Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30096,"took":"169.662688ms","hash":1320673922,"current-db-size-bytes":57913344,"current-db-size":"58 MB","current-db-size-in-use-bytes":31297536,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:54:11.355332Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1320673922,"revision":30096,"compact-revision":27239} {"level":"info","ts":"2026-10-19T02:59:11.187117Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32361} {"level":"info","ts":"2026-10-19T02:59:11.380828Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32361,"took":"188.205985ms","hash":1596235779,"current-db-size-bytes":58957824,"current-db-size":"59 MB","current-db-size-in-use-bytes":30322688,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-19T02:59:11.380907Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1596235779,"revision":32361,"compact-revision":30096} {"level":"info","ts":"2026-10-19T03:04:11.198363Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34584} {"level":"info","ts":"2026-10-19T03:04:11.351432Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34584,"took":"148.568538ms","hash":3442140145,"current-db-size-bytes":58957824,"current-db-size":"59 MB","current-db-size-in-use-bytes":30769152,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T03:04:11.351509Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3442140145,"revision":34584,"compact-revision":32361} {"level":"info","ts":"2026-10-19T03:08:06.736799Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T03:08:06.744432Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-19T03:08:06.744545Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-19T03:09:11.223775Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36876} {"level":"info","ts":"2026-10-19T03:09:11.372674Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36876,"took":"144.816462ms","hash":1901867112,"current-db-size-bytes":59383808,"current-db-size":"59 MB","current-db-size-in-use-bytes":32882688,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-19T03:09:11.372782Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1901867112,"revision":36876,"compact-revision":34584} {"level":"info","ts":"2026-10-19T03:14:11.230389Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39250} {"level":"info","ts":"2026-10-19T03:14:11.374743Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39250,"took":"139.032054ms","hash":2594932341,"current-db-size-bytes":62349312,"current-db-size":"62 MB","current-db-size-in-use-bytes":32665600,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-19T03:14:11.374836Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2594932341,"revision":39250,"compact-revision":36876} {"level":"info","ts":"2026-10-19T03:19:11.240044Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41481} {"level":"info","ts":"2026-10-19T03:19:11.375861Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41481,"took":"131.196492ms","hash":3976992862,"current-db-size-bytes":62349312,"current-db-size":"62 MB","current-db-size-in-use-bytes":30633984,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T03:19:11.37593Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3976992862,"revision":41481,"compact-revision":39250}