{"level":"warn","ts":"2026-10-13T11:04:42.600444Z","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-13T11:04:42.600521Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.6: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://199.204.45.6:2380","--initial-cluster=instance=https://199.204.45.6:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.6:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.6: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-13T11:04:42.600577Z","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-13T11:04:42.600589Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.6:2380"]} {"level":"info","ts":"2026-10-13T11:04:42.600624Z","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-13T11:04:42.601328Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.6:2379"]} {"level":"info","ts":"2026-10-13T11:04:42.601421Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.6:2380"],"listen-peer-urls":["https://199.204.45.6:2380"],"advertise-client-urls":["https://199.204.45.6:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.6:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.6: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-13T11:04:42.608061Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.319617ms"} {"level":"info","ts":"2026-10-13T11:04:42.621255Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4ec288cbdba84d36","cluster-id":"9b45faacd38a820f"} {"level":"info","ts":"2026-10-13T11:04:42.621354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T11:04:42.621372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became follower at term 0"} {"level":"info","ts":"2026-10-13T11:04:42.621379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4ec288cbdba84d36 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T11:04:42.621385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became follower at term 1"} {"level":"info","ts":"2026-10-13T11:04:42.621418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 switched to configuration voters=(5675248889585225014)"} {"level":"warn","ts":"2026-10-13T11:04:42.633664Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T11:04:42.636971Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T11:04:42.64017Z","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-13T11:04:42.64287Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4ec288cbdba84d36","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T11:04:42.643363Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4ec288cbdba84d36","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T11:04:42.643427Z","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-13T11:04:42.643466Z","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-13T11:04:42.643475Z","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-13T11:04:42.645131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 switched to configuration voters=(5675248889585225014)"} {"level":"info","ts":"2026-10-13T11:04:42.645293Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9b45faacd38a820f","local-member-id":"4ec288cbdba84d36","added-peer-id":"4ec288cbdba84d36","added-peer-peer-urls":["https://199.204.45.6:2380"]} {"level":"info","ts":"2026-10-13T11:04:42.647364Z","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-13T11:04:42.647447Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.6:2380"} {"level":"info","ts":"2026-10-13T11:04:42.64748Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.6:2380"} {"level":"info","ts":"2026-10-13T11:04:42.64822Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4ec288cbdba84d36","initial-advertise-peer-urls":["https://199.204.45.6:2380"],"listen-peer-urls":["https://199.204.45.6:2380"],"advertise-client-urls":["https://199.204.45.6:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.6:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T11:04:42.648262Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T11:04:42.822483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T11:04:42.822529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T11:04:42.822561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 received MsgPreVoteResp from 4ec288cbdba84d36 at term 1"} {"level":"info","ts":"2026-10-13T11:04:42.822575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became candidate at term 2"} {"level":"info","ts":"2026-10-13T11:04:42.822584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 received MsgVoteResp from 4ec288cbdba84d36 at term 2"} {"level":"info","ts":"2026-10-13T11:04:42.822595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became leader at term 2"} {"level":"info","ts":"2026-10-13T11:04:42.822643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4ec288cbdba84d36 elected leader 4ec288cbdba84d36 at term 2"} {"level":"info","ts":"2026-10-13T11:04:42.823693Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4ec288cbdba84d36","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.6:2379]}","request-path":"/0/members/4ec288cbdba84d36/attributes","cluster-id":"9b45faacd38a820f","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T11:04:42.823721Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T11:04:42.823715Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:04:42.82374Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T11:04:42.824022Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T11:04:42.824097Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T11:04:42.824962Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9b45faacd38a820f","local-member-id":"4ec288cbdba84d36","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:04:42.825086Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:04:42.825132Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:04:42.82675Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T11:04:42.829309Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.6:2379"} {"level":"warn","ts":"2026-10-13T11:04:45.989217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.394125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:04:45.989354Z","caller":"traceutil/trace.go:171","msg":"trace[1701081781] linearizableReadLoop","detail":"{readStateIndex:170; appliedIndex:169; }","duration":"141.487039ms","start":"2026-10-13T11:04:45.847849Z","end":"2026-10-13T11:04:45.989336Z","steps":["trace[1701081781] 'read index received' (duration: 39.87µs)","trace[1701081781] 'applied index is now lower than readState.Index' (duration: 141.445609ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:04:45.989372Z","caller":"traceutil/trace.go:171","msg":"trace[1724139215] transaction","detail":"{read_only:false; response_revision:166; number_of_response:1; }","duration":"298.934122ms","start":"2026-10-13T11:04:45.690416Z","end":"2026-10-13T11:04:45.98935Z","steps":["trace[1724139215] 'process raft request' (duration: 128.842086ms)","trace[1724139215] 'compare' (duration: 169.201582ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:04:45.989475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.61997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:04:45.989514Z","caller":"traceutil/trace.go:171","msg":"trace[1535495436] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:166; }","duration":"141.700232ms","start":"2026-10-13T11:04:45.8478Z","end":"2026-10-13T11:04:45.9895Z","steps":["trace[1535495436] 'agreement among raft nodes before linearized reading' (duration: 141.601321ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:46.442382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.625008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:04:46.442605Z","caller":"traceutil/trace.go:171","msg":"trace[1775175063] linearizableReadLoop","detail":"{readStateIndex:171; appliedIndex:170; }","duration":"450.126346ms","start":"2026-10-13T11:04:45.992419Z","end":"2026-10-13T11:04:46.442546Z","steps":["trace[1775175063] 'read index received' (duration: 264.119273ms)","trace[1775175063] 'applied index is now lower than readState.Index' (duration: 186.004923ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:04:46.442625Z","caller":"traceutil/trace.go:171","msg":"trace[11817291] transaction","detail":"{read_only:false; response_revision:167; number_of_response:1; }","duration":"450.537303ms","start":"2026-10-13T11:04:45.99205Z","end":"2026-10-13T11:04:46.442587Z","steps":["trace[11817291] 'process raft request' (duration: 264.642551ms)","trace[11817291] 'compare' (duration: 185.492486ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:04:46.442778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.337439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:04:46.442827Z","caller":"traceutil/trace.go:171","msg":"trace[156487553] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-controller; range_end:; response_count:0; response_revision:167; }","duration":"450.437931ms","start":"2026-10-13T11:04:45.99238Z","end":"2026-10-13T11:04:46.442818Z","steps":["trace[156487553] 'agreement among raft nodes before linearized reading' (duration: 450.309839ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:46.442877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:04:45.992359Z","time spent":"450.499712ms","remote":"127.0.0.1:57266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:controller:service-controller\" "} {"level":"warn","ts":"2026-10-13T11:04:46.442838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:04:45.992026Z","time spent":"450.764136ms","remote":"127.0.0.1:57132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:04:46.443075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.457177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:04:46.443129Z","caller":"traceutil/trace.go:171","msg":"trace[30823136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:167; }","duration":"170.569979ms","start":"2026-10-13T11:04:46.272543Z","end":"2026-10-13T11:04:46.443113Z","steps":["trace[30823136] 'agreement among raft nodes before linearized reading' (duration: 170.481357ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:46.443075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.224793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:04:46.44322Z","caller":"traceutil/trace.go:171","msg":"trace[2045734714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:167; }","duration":"105.411236ms","start":"2026-10-13T11:04:46.33779Z","end":"2026-10-13T11:04:46.443201Z","steps":["trace[2045734714] 'agreement among raft nodes before linearized reading' (duration: 105.239953ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:52.943977Z","caller":"traceutil/trace.go:171","msg":"trace[1531291540] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:356; }","duration":"170.853837ms","start":"2026-10-13T11:04:52.773063Z","end":"2026-10-13T11:04:52.943917Z","steps":["trace[1531291540] 'read index received' (duration: 41.169121ms)","trace[1531291540] 'applied index is now lower than readState.Index' (duration: 129.683566ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:04:52.944043Z","caller":"traceutil/trace.go:171","msg":"trace[2012070454] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"212.296102ms","start":"2026-10-13T11:04:52.731703Z","end":"2026-10-13T11:04:52.944Z","steps":["trace[2012070454] 'process raft request' (duration: 129.144528ms)","trace[2012070454] 'compare' (duration: 82.92662ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:04:52.94427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.362341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"warn","ts":"2026-10-13T11:04:52.944426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.051001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-10-13T11:04:52.944412Z","caller":"traceutil/trace.go:171","msg":"trace[926963305] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:349; }","duration":"123.510643ms","start":"2026-10-13T11:04:52.820882Z","end":"2026-10-13T11:04:52.944392Z","steps":["trace[926963305] 'agreement among raft nodes before linearized reading' (duration: 123.32153ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:52.944488Z","caller":"traceutil/trace.go:171","msg":"trace[257907112] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:349; }","duration":"122.140342ms","start":"2026-10-13T11:04:52.822333Z","end":"2026-10-13T11:04:52.944473Z","steps":["trace[257907112] 'agreement among raft nodes before linearized reading' (duration: 122.01082ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:52.944788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.751405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-13T11:04:52.945077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.003364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-10-13T11:04:52.945142Z","caller":"traceutil/trace.go:171","msg":"trace[117870048] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:349; }","duration":"106.289593ms","start":"2026-10-13T11:04:52.838805Z","end":"2026-10-13T11:04:52.945095Z","steps":["trace[117870048] 'agreement among raft nodes before linearized reading' (duration: 105.508342ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:52.945206Z","caller":"traceutil/trace.go:171","msg":"trace[985178333] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:349; }","duration":"172.269438ms","start":"2026-10-13T11:04:52.772851Z","end":"2026-10-13T11:04:52.945121Z","steps":["trace[985178333] 'agreement among raft nodes before linearized reading' (duration: 171.284243ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.136025Z","caller":"traceutil/trace.go:171","msg":"trace[49775486] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"184.251586ms","start":"2026-10-13T11:04:52.951735Z","end":"2026-10-13T11:04:53.135986Z","steps":["trace[49775486] 'process raft request' (duration: 158.098572ms)","trace[49775486] 'compare' (duration: 25.773858ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:04:53.13617Z","caller":"traceutil/trace.go:171","msg":"trace[1831329944] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"182.55662ms","start":"2026-10-13T11:04:52.953568Z","end":"2026-10-13T11:04:53.136125Z","steps":["trace[1831329944] 'process raft request' (duration: 182.390578ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.136289Z","caller":"traceutil/trace.go:171","msg":"trace[766227500] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"182.468309ms","start":"2026-10-13T11:04:52.953782Z","end":"2026-10-13T11:04:53.136251Z","steps":["trace[766227500] 'process raft request' (duration: 182.272826ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.137228Z","caller":"traceutil/trace.go:171","msg":"trace[1014326654] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"181.666277ms","start":"2026-10-13T11:04:52.954818Z","end":"2026-10-13T11:04:53.136484Z","steps":["trace[1014326654] 'process raft request' (duration: 181.273731ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.138343Z","caller":"traceutil/trace.go:171","msg":"trace[1145974302] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"179.990581ms","start":"2026-10-13T11:04:52.956811Z","end":"2026-10-13T11:04:53.136801Z","steps":["trace[1145974302] 'process raft request' (duration: 179.526174ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.140503Z","caller":"traceutil/trace.go:171","msg":"trace[1583012207] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"183.155379ms","start":"2026-10-13T11:04:52.957306Z","end":"2026-10-13T11:04:53.140462Z","steps":["trace[1583012207] 'process raft request' (duration: 179.173539ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.1408Z","caller":"traceutil/trace.go:171","msg":"trace[405179822] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:359; }","duration":"168.63278ms","start":"2026-10-13T11:04:52.972072Z","end":"2026-10-13T11:04:53.140705Z","steps":["trace[405179822] 'read index received' (duration: 15.555575ms)","trace[405179822] 'applied index is now lower than readState.Index' (duration: 153.074555ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:04:53.141066Z","caller":"traceutil/trace.go:171","msg":"trace[81161196] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"183.042377ms","start":"2026-10-13T11:04:52.957987Z","end":"2026-10-13T11:04:53.141029Z","steps":["trace[81161196] 'process raft request' (duration: 182.387677ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:53.141189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.122917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-10-13T11:04:53.141263Z","caller":"traceutil/trace.go:171","msg":"trace[1383110562] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:357; }","duration":"169.227089ms","start":"2026-10-13T11:04:52.972002Z","end":"2026-10-13T11:04:53.141229Z","steps":["trace[1383110562] 'agreement among raft nodes before linearized reading' (duration: 169.136168ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:53.141107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.056003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-10-13T11:04:53.141668Z","caller":"traceutil/trace.go:171","msg":"trace[143335277] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:357; }","duration":"119.638991ms","start":"2026-10-13T11:04:53.021991Z","end":"2026-10-13T11:04:53.14163Z","steps":["trace[143335277] 'agreement among raft nodes before linearized reading' (duration: 119.050632ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.291173Z","caller":"traceutil/trace.go:171","msg":"trace[2127464186] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"102.27187ms","start":"2026-10-13T11:04:53.188876Z","end":"2026-10-13T11:04:53.291148Z","steps":["trace[2127464186] 'process raft request' (duration: 77.775551ms)","trace[2127464186] 'compare' (duration: 24.039822ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:04:53.291501Z","caller":"traceutil/trace.go:171","msg":"trace[1759827466] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"101.994806ms","start":"2026-10-13T11:04:53.189468Z","end":"2026-10-13T11:04:53.291462Z","steps":["trace[1759827466] 'process raft request' (duration: 101.354206ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.472956Z","caller":"traceutil/trace.go:171","msg":"trace[1058127802] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:387; }","duration":"130.023378ms","start":"2026-10-13T11:04:53.342891Z","end":"2026-10-13T11:04:53.472915Z","steps":["trace[1058127802] 'read index received' (duration: 68.221298ms)","trace[1058127802] 'applied index is now lower than readState.Index' (duration: 61.80024ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:04:53.473076Z","caller":"traceutil/trace.go:171","msg":"trace[918451581] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"166.065939ms","start":"2026-10-13T11:04:53.306976Z","end":"2026-10-13T11:04:53.473042Z","steps":["trace[918451581] 'process raft request' (duration: 104.086116ms)","trace[918451581] 'compare' (duration: 61.502866ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:04:53.473144Z","caller":"traceutil/trace.go:171","msg":"trace[278853161] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"157.369418ms","start":"2026-10-13T11:04:53.315756Z","end":"2026-10-13T11:04:53.473126Z","steps":["trace[278853161] 'process raft request' (duration: 157.054794ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:53.473406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.494155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-59pg4\" ","response":"range_response_count:1 size:3439"} {"level":"info","ts":"2026-10-13T11:04:53.47354Z","caller":"traceutil/trace.go:171","msg":"trace[337969983] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-59pg4; range_end:; response_count:1; response_revision:379; }","duration":"130.636517ms","start":"2026-10-13T11:04:53.342854Z","end":"2026-10-13T11:04:53.47349Z","steps":["trace[337969983] 'agreement among raft nodes before linearized reading' (duration: 130.485675ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.477442Z","caller":"traceutil/trace.go:171","msg":"trace[79081425] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"132.428404ms","start":"2026-10-13T11:04:53.344988Z","end":"2026-10-13T11:04:53.477416Z","steps":["trace[79081425] 'process raft request' (duration: 132.240861ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:53.477654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.265411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-10-13T11:04:53.477752Z","caller":"traceutil/trace.go:171","msg":"trace[121200828] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"130.404724ms","start":"2026-10-13T11:04:53.34733Z","end":"2026-10-13T11:04:53.477735Z","steps":["trace[121200828] 'process raft request' (duration: 130.069249ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.477819Z","caller":"traceutil/trace.go:171","msg":"trace[1744592295] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"132.575996ms","start":"2026-10-13T11:04:53.345056Z","end":"2026-10-13T11:04:53.477631Z","steps":["trace[1744592295] 'process raft request' (duration: 132.295722ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:53.477865Z","caller":"traceutil/trace.go:171","msg":"trace[1026289135] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:382; }","duration":"130.502836ms","start":"2026-10-13T11:04:53.347289Z","end":"2026-10-13T11:04:53.477791Z","steps":["trace[1026289135] 'agreement among raft nodes before linearized reading' (duration: 130.185811ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:54.089205Z","caller":"traceutil/trace.go:171","msg":"trace[1062908211] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"133.998756ms","start":"2026-10-13T11:04:53.955183Z","end":"2026-10-13T11:04:54.089182Z","steps":["trace[1062908211] 'process raft request' (duration: 58.110105ms)","trace[1062908211] 'compare' (duration: 75.759999ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:23.621323Z","caller":"traceutil/trace.go:171","msg":"trace[1171660160] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"126.222229ms","start":"2026-10-13T11:05:23.495076Z","end":"2026-10-13T11:05:23.621298Z","steps":["trace[1171660160] 'process raft request' (duration: 126.098607ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:29.013307Z","caller":"traceutil/trace.go:171","msg":"trace[1011406308] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"247.600579ms","start":"2026-10-13T11:05:28.765671Z","end":"2026-10-13T11:05:29.013272Z","steps":["trace[1011406308] 'process raft request' (duration: 247.234973ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:29.024022Z","caller":"traceutil/trace.go:171","msg":"trace[1900523343] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"229.072052ms","start":"2026-10-13T11:05:28.794931Z","end":"2026-10-13T11:05:29.024003Z","steps":["trace[1900523343] 'process raft request' (duration: 228.918849ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:29.024141Z","caller":"traceutil/trace.go:171","msg":"trace[339488699] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"257.155866ms","start":"2026-10-13T11:05:28.76696Z","end":"2026-10-13T11:05:29.024115Z","steps":["trace[339488699] 'process raft request' (duration: 252.381947ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:35.236301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.975891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-13T11:05:35.236414Z","caller":"traceutil/trace.go:171","msg":"trace[489057000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"130.188304ms","start":"2026-10-13T11:05:35.106208Z","end":"2026-10-13T11:05:35.236396Z","steps":["trace[489057000] 'range keys from in-memory index tree' (duration: 129.8712ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:35.475058Z","caller":"traceutil/trace.go:171","msg":"trace[1815144321] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:671; }","duration":"219.839108ms","start":"2026-10-13T11:05:35.255202Z","end":"2026-10-13T11:05:35.475041Z","steps":["trace[1815144321] 'read index received' (duration: 7.863283ms)","trace[1815144321] 'applied index is now lower than readState.Index' (duration: 211.975285ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:35.475136Z","caller":"traceutil/trace.go:171","msg":"trace[456778341] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"230.909787ms","start":"2026-10-13T11:05:35.244178Z","end":"2026-10-13T11:05:35.475088Z","steps":["trace[456778341] 'process raft request' (duration: 230.290288ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:35.475215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.006271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-13T11:05:35.475254Z","caller":"traceutil/trace.go:171","msg":"trace[5992819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:652; }","duration":"220.083861ms","start":"2026-10-13T11:05:35.255164Z","end":"2026-10-13T11:05:35.475248Z","steps":["trace[5992819] 'agreement among raft nodes before linearized reading' (duration: 219.97893ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:35.942154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.680794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:05:35.942302Z","caller":"traceutil/trace.go:171","msg":"trace[51028510] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"462.891719ms","start":"2026-10-13T11:05:35.47937Z","end":"2026-10-13T11:05:35.942262Z","steps":["trace[51028510] 'process raft request' (duration: 238.869571ms)","trace[51028510] 'compare' (duration: 223.507681ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:05:35.942389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:35.479348Z","time spent":"463.000551ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:05:35.979253Z","caller":"traceutil/trace.go:171","msg":"trace[1571365367] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:673; }","duration":"310.185292ms","start":"2026-10-13T11:05:35.66905Z","end":"2026-10-13T11:05:35.979235Z","steps":["trace[1571365367] 'read index received' (duration: 49.133444ms)","trace[1571365367] 'applied index is now lower than readState.Index' (duration: 261.051118ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:35.979411Z","caller":"traceutil/trace.go:171","msg":"trace[591180101] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"453.747129ms","start":"2026-10-13T11:05:35.525653Z","end":"2026-10-13T11:05:35.9794Z","steps":["trace[591180101] 'process raft request' (duration: 453.397104ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:35.979517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.454556ms","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-13T11:05:35.979554Z","caller":"traceutil/trace.go:171","msg":"trace[1830065541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:655; }","duration":"310.561408ms","start":"2026-10-13T11:05:35.668984Z","end":"2026-10-13T11:05:35.979545Z","steps":["trace[1830065541] 'agreement among raft nodes before linearized reading' (duration: 310.458926ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:35.979576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:35.668964Z","time spent":"310.606548ms","remote":"127.0.0.1:57208","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":"warn","ts":"2026-10-13T11:05:35.979579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:35.52563Z","time spent":"453.86076ms","remote":"127.0.0.1:57182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:05:35.979698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.70161ms","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-13T11:05:35.979757Z","caller":"traceutil/trace.go:171","msg":"trace[160193921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:655; }","duration":"199.855493ms","start":"2026-10-13T11:05:35.779886Z","end":"2026-10-13T11:05:35.979742Z","steps":["trace[160193921] 'agreement among raft nodes before linearized reading' (duration: 199.66577ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:35.97972Z","caller":"traceutil/trace.go:171","msg":"trace[501997370] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"440.906824ms","start":"2026-10-13T11:05:35.538748Z","end":"2026-10-13T11:05:35.979654Z","steps":["trace[501997370] 'process raft request' (duration: 440.425458ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:35.979895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:35.538734Z","time spent":"441.095547ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:05:36.731203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.348967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:05:36.731315Z","caller":"traceutil/trace.go:171","msg":"trace[1149770984] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"717.871391ms","start":"2026-10-13T11:05:36.013424Z","end":"2026-10-13T11:05:36.731295Z","steps":["trace[1149770984] 'read index received' (duration: 387.28163ms)","trace[1149770984] 'applied index is now lower than readState.Index' (duration: 330.588391ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:36.731422Z","caller":"traceutil/trace.go:171","msg":"trace[304509153] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"733.83825ms","start":"2026-10-13T11:05:35.997565Z","end":"2026-10-13T11:05:36.731404Z","steps":["trace[304509153] 'process raft request' (duration: 403.164498ms)","trace[304509153] 'compare' (duration: 330.109203ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:05:36.731497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:35.997549Z","time spent":"733.90541ms","remote":"127.0.0.1:57132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:05:36.731662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.223376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-10-13T11:05:36.731663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.891232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:05:36.731735Z","caller":"traceutil/trace.go:171","msg":"trace[1560337926] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:658; }","duration":"718.346808ms","start":"2026-10-13T11:05:36.013373Z","end":"2026-10-13T11:05:36.731719Z","steps":["trace[1560337926] 'agreement among raft nodes before linearized reading' (duration: 718.199416ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:36.731743Z","caller":"traceutil/trace.go:171","msg":"trace[1333202219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"393.017403ms","start":"2026-10-13T11:05:36.338709Z","end":"2026-10-13T11:05:36.731726Z","steps":["trace[1333202219] 'agreement among raft nodes before linearized reading' (duration: 392.876001ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:36.731776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:36.013356Z","time spent":"718.407219ms","remote":"127.0.0.1:57148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-10-13T11:05:36.731785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:36.338686Z","time spent":"393.089395ms","remote":"127.0.0.1:56966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T11:05:51.477561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.358224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:05:51.477663Z","caller":"traceutil/trace.go:171","msg":"trace[497977496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:818; }","duration":"137.511015ms","start":"2026-10-13T11:05:51.340131Z","end":"2026-10-13T11:05:51.477642Z","steps":["trace[497977496] 'range keys from in-memory index tree' (duration: 137.291752ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:51.477682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.454333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-13T11:05:51.47781Z","caller":"traceutil/trace.go:171","msg":"trace[34439049] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:818; }","duration":"115.647035ms","start":"2026-10-13T11:05:51.362138Z","end":"2026-10-13T11:05:51.477785Z","steps":["trace[34439049] 'range keys from in-memory index tree' (duration: 115.142328ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:06:21.831518Z","caller":"traceutil/trace.go:171","msg":"trace[656228341] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"107.171861ms","start":"2026-10-13T11:06:21.724321Z","end":"2026-10-13T11:06:21.831493Z","steps":["trace[656228341] 'process raft request' (duration: 106.982918ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:06:39.60344Z","caller":"traceutil/trace.go:171","msg":"trace[1584635493] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"101.552894ms","start":"2026-10-13T11:06:39.501826Z","end":"2026-10-13T11:06:39.603379Z","steps":["trace[1584635493] 'process raft request' (duration: 88.479204ms)","trace[1584635493] 'compare' (duration: 12.792048ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:06:39.753496Z","caller":"traceutil/trace.go:171","msg":"trace[684987034] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"124.063172ms","start":"2026-10-13T11:06:39.629397Z","end":"2026-10-13T11:06:39.75346Z","steps":["trace[684987034] 'process raft request' (duration: 93.583139ms)","trace[684987034] 'compare' (duration: 30.303795ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:06:39.754515Z","caller":"traceutil/trace.go:171","msg":"trace[953436563] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"124.445978ms","start":"2026-10-13T11:06:39.630036Z","end":"2026-10-13T11:06:39.754482Z","steps":["trace[953436563] 'process raft request' (duration: 123.400974ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:09.499345Z","caller":"traceutil/trace.go:171","msg":"trace[267942246] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"161.992881ms","start":"2026-10-13T11:07:09.337328Z","end":"2026-10-13T11:07:09.499321Z","steps":["trace[267942246] 'read index received' (duration: 161.922258ms)","trace[267942246] 'applied index is now lower than readState.Index' (duration: 69.523µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:07:09.499434Z","caller":"traceutil/trace.go:171","msg":"trace[1099209499] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"182.337179ms","start":"2026-10-13T11:07:09.317063Z","end":"2026-10-13T11:07:09.4994Z","steps":["trace[1099209499] 'process raft request' (duration: 182.113811ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:09.499562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.201598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:07:09.499619Z","caller":"traceutil/trace.go:171","msg":"trace[2013845840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1888; }","duration":"162.281011ms","start":"2026-10-13T11:07:09.337318Z","end":"2026-10-13T11:07:09.499599Z","steps":["trace[2013845840] 'agreement among raft nodes before linearized reading' (duration: 162.135526ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:09.522331Z","caller":"traceutil/trace.go:171","msg":"trace[81136014] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"116.114093ms","start":"2026-10-13T11:07:09.40619Z","end":"2026-10-13T11:07:09.522304Z","steps":["trace[81136014] 'process raft request' (duration: 115.926326ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:09.522491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.930394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-820d3c0c-2e1e-4a7b-917d-4fae78cd4251\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-10-13T11:07:09.522755Z","caller":"traceutil/trace.go:171","msg":"trace[652065259] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-820d3c0c-2e1e-4a7b-917d-4fae78cd4251; range_end:; response_count:1; response_revision:1889; }","duration":"123.208765ms","start":"2026-10-13T11:07:09.399446Z","end":"2026-10-13T11:07:09.522655Z","steps":["trace[652065259] 'agreement among raft nodes before linearized reading' (duration: 122.794199ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:09.69114Z","caller":"traceutil/trace.go:171","msg":"trace[42309293] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"160.733885ms","start":"2026-10-13T11:07:09.530355Z","end":"2026-10-13T11:07:09.691089Z","steps":["trace[42309293] 'process raft request' (duration: 143.495401ms)","trace[42309293] 'compare' (duration: 16.905042ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:07:22.945099Z","caller":"traceutil/trace.go:171","msg":"trace[1780577351] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"113.213637ms","start":"2026-10-13T11:07:22.831856Z","end":"2026-10-13T11:07:22.94507Z","steps":["trace[1780577351] 'process raft request' (duration: 113.054142ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:32.87196Z","caller":"traceutil/trace.go:171","msg":"trace[42205270] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"117.917972ms","start":"2026-10-13T11:07:32.75396Z","end":"2026-10-13T11:07:32.871878Z","steps":["trace[42205270] 'process raft request' (duration: 117.781477ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:38.07915Z","caller":"traceutil/trace.go:171","msg":"trace[172893568] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"153.897868ms","start":"2026-10-13T11:07:37.925227Z","end":"2026-10-13T11:07:38.079125Z","steps":["trace[172893568] 'process raft request' (duration: 153.765684ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:38.406903Z","caller":"traceutil/trace.go:171","msg":"trace[1344425734] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"133.348676ms","start":"2026-10-13T11:07:38.273532Z","end":"2026-10-13T11:07:38.406881Z","steps":["trace[1344425734] 'process raft request' (duration: 133.121459ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:38.843112Z","caller":"traceutil/trace.go:171","msg":"trace[1038239655] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2180; }","duration":"230.481287ms","start":"2026-10-13T11:07:38.61261Z","end":"2026-10-13T11:07:38.843091Z","steps":["trace[1038239655] 'read index received' (duration: 230.320252ms)","trace[1038239655] 'applied index is now lower than readState.Index' (duration: 160.315µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:07:38.843341Z","caller":"traceutil/trace.go:171","msg":"trace[1469243518] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"238.653756ms","start":"2026-10-13T11:07:38.604654Z","end":"2026-10-13T11:07:38.843308Z","steps":["trace[1469243518] 'process raft request' (duration: 238.320295ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:38.84345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.747836ms","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-13T11:07:38.843561Z","caller":"traceutil/trace.go:171","msg":"trace[2046315138] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2103; }","duration":"230.937282ms","start":"2026-10-13T11:07:38.612575Z","end":"2026-10-13T11:07:38.843512Z","steps":["trace[2046315138] 'agreement among raft nodes before linearized reading' (duration: 230.640243ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:39.329795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.954721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:07:39.32999Z","caller":"traceutil/trace.go:171","msg":"trace[1288327362] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"482.912193ms","start":"2026-10-13T11:07:38.847021Z","end":"2026-10-13T11:07:39.329933Z","steps":["trace[1288327362] 'process raft request' (duration: 195.567719ms)","trace[1288327362] 'compare' (duration: 286.366812ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:07:39.330097Z","caller":"traceutil/trace.go:171","msg":"trace[175561488] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"317.25958ms","start":"2026-10-13T11:07:39.012818Z","end":"2026-10-13T11:07:39.330078Z","steps":["trace[175561488] 'process raft request' (duration: 317.171707ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:39.330119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:38.847001Z","time spent":"483.052608ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:07:39.33018Z","caller":"traceutil/trace.go:171","msg":"trace[1528931758] linearizableReadLoop","detail":"{readStateIndex:2182; appliedIndex:2181; }","duration":"470.92067ms","start":"2026-10-13T11:07:38.859231Z","end":"2026-10-13T11:07:39.330152Z","steps":["trace[1528931758] 'read index received' (duration: 183.365549ms)","trace[1528931758] 'applied index is now lower than readState.Index' (duration: 287.551381ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:07:39.330227Z","caller":"traceutil/trace.go:171","msg":"trace[110564337] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"411.563427ms","start":"2026-10-13T11:07:38.918634Z","end":"2026-10-13T11:07:39.330198Z","steps":["trace[110564337] 'process raft request' (duration: 411.268937ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:39.330432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.163308ms","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-13T11:07:39.330466Z","caller":"traceutil/trace.go:171","msg":"trace[960013013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2106; }","duration":"471.267102ms","start":"2026-10-13T11:07:38.859189Z","end":"2026-10-13T11:07:39.330456Z","steps":["trace[960013013] 'agreement among raft nodes before linearized reading' (duration: 471.101827ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:39.330492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:38.85917Z","time spent":"471.316713ms","remote":"127.0.0.1:57208","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":"warn","ts":"2026-10-13T11:07:39.33054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.007676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-13T11:07:39.330577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.926222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-13T11:07:39.330618Z","caller":"traceutil/trace.go:171","msg":"trace[1297315343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2106; }","duration":"432.12917ms","start":"2026-10-13T11:07:38.898472Z","end":"2026-10-13T11:07:39.330601Z","steps":["trace[1297315343] 'agreement among raft nodes before linearized reading' (duration: 431.886082ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:39.330632Z","caller":"traceutil/trace.go:171","msg":"trace[778116202] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2106; }","duration":"115.996024ms","start":"2026-10-13T11:07:39.214613Z","end":"2026-10-13T11:07:39.330609Z","steps":["trace[778116202] 'agreement among raft nodes before linearized reading' (duration: 115.839199ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:39.330657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:38.898456Z","time spent":"432.194862ms","remote":"127.0.0.1:57208","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-13T11:07:39.33114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:38.918614Z","time spent":"411.66384ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:07:39.33161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:39.012794Z","time spent":"318.762459ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:07:39.666988Z","caller":"traceutil/trace.go:171","msg":"trace[1076759092] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"331.97438ms","start":"2026-10-13T11:07:39.334987Z","end":"2026-10-13T11:07:39.666962Z","steps":["trace[1076759092] 'process raft request' (duration: 331.36475ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:39.667175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:39.33496Z","time spent":"332.127955ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:07:39.669256Z","caller":"traceutil/trace.go:171","msg":"trace[1729507061] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"333.877942ms","start":"2026-10-13T11:07:39.335363Z","end":"2026-10-13T11:07:39.669241Z","steps":["trace[1729507061] 'process raft request' (duration: 333.710427ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:07:39.669467Z","caller":"traceutil/trace.go:171","msg":"trace[1724775152] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2184; }","duration":"329.311253ms","start":"2026-10-13T11:07:39.340133Z","end":"2026-10-13T11:07:39.669444Z","steps":["trace[1724775152] 'read index received' (duration: 326.253323ms)","trace[1724775152] 'applied index is now lower than readState.Index' (duration: 3.0561ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:07:39.66949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:39.33534Z","time spent":"334.020196ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:07:39.669623Z","caller":"traceutil/trace.go:171","msg":"trace[1180319761] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"334.1562ms","start":"2026-10-13T11:07:39.335433Z","end":"2026-10-13T11:07:39.669589Z","steps":["trace[1180319761] 'process raft request' (duration: 333.756127ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:39.669556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.412447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:07:39.669761Z","caller":"traceutil/trace.go:171","msg":"trace[1331957404] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2109; }","duration":"329.656614ms","start":"2026-10-13T11:07:39.340084Z","end":"2026-10-13T11:07:39.66974Z","steps":["trace[1331957404] 'agreement among raft nodes before linearized reading' (duration: 329.434147ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:07:39.669811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:39.340076Z","time spent":"329.722996ms","remote":"127.0.0.1:56960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T11:07:39.669879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:07:39.335418Z","time spent":"334.315946ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:08:50.240263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.988242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-10-13T11:08:50.240303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.727295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-13T11:08:50.240321Z","caller":"traceutil/trace.go:171","msg":"trace[818038614] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2590; }","duration":"192.089684ms","start":"2026-10-13T11:08:50.04822Z","end":"2026-10-13T11:08:50.240309Z","steps":["trace[818038614] 'range keys from in-memory index tree' (duration: 191.881569ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:08:50.240349Z","caller":"traceutil/trace.go:171","msg":"trace[1339634387] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2590; }","duration":"191.777736ms","start":"2026-10-13T11:08:50.048555Z","end":"2026-10-13T11:08:50.240333Z","steps":["trace[1339634387] 'range keys from in-memory index tree' (duration: 191.666094ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:08:50.240253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.955916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-13T11:08:50.240387Z","caller":"traceutil/trace.go:171","msg":"trace[1452129611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2590; }","duration":"215.155341ms","start":"2026-10-13T11:08:50.025223Z","end":"2026-10-13T11:08:50.240379Z","steps":["trace[1452129611] 'range keys from in-memory index tree' (duration: 214.800612ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:08:50.240378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.607118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-13T11:08:50.240455Z","caller":"traceutil/trace.go:171","msg":"trace[1127151738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2590; }","duration":"221.733922ms","start":"2026-10-13T11:08:50.018704Z","end":"2026-10-13T11:08:50.240438Z","steps":["trace[1127151738] 'range keys from in-memory index tree' (duration: 221.399363ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:09:21.954392Z","caller":"traceutil/trace.go:171","msg":"trace[1703749110] transaction","detail":"{read_only:false; response_revision:2765; number_of_response:1; }","duration":"117.567675ms","start":"2026-10-13T11:09:21.836804Z","end":"2026-10-13T11:09:21.954371Z","steps":["trace[1703749110] 'process raft request' (duration: 117.440332ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:09:27.426699Z","caller":"traceutil/trace.go:171","msg":"trace[993066816] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"148.036946ms","start":"2026-10-13T11:09:27.278629Z","end":"2026-10-13T11:09:27.426666Z","steps":["trace[993066816] 'process raft request' (duration: 147.843772ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:12:40.240316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.429279ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:12:40.240504Z","caller":"traceutil/trace.go:171","msg":"trace[29513340] transaction","detail":"{read_only:false; response_revision:3951; number_of_response:1; }","duration":"109.583831ms","start":"2026-10-13T11:12:40.130902Z","end":"2026-10-13T11:12:40.240485Z","steps":["trace[29513340] 'process raft request' (duration: 109.51849ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:40.240561Z","caller":"traceutil/trace.go:171","msg":"trace[1924396541] transaction","detail":"{read_only:false; response_revision:3950; number_of_response:1; }","duration":"133.698334ms","start":"2026-10-13T11:12:40.106824Z","end":"2026-10-13T11:12:40.240522Z","steps":["trace[1924396541] 'process raft request' (duration: 29.984391ms)","trace[1924396541] 'compare' (duration: 103.244764ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:13:21.60758Z","caller":"traceutil/trace.go:171","msg":"trace[777044712] transaction","detail":"{read_only:false; response_revision:4236; number_of_response:1; }","duration":"143.011105ms","start":"2026-10-13T11:13:21.464526Z","end":"2026-10-13T11:13:21.607537Z","steps":["trace[777044712] 'process raft request' (duration: 71.753588ms)","trace[777044712] 'compare' (duration: 71.017483ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:13:21.607702Z","caller":"traceutil/trace.go:171","msg":"trace[1398039454] transaction","detail":"{read_only:false; response_revision:4238; number_of_response:1; }","duration":"141.803513ms","start":"2026-10-13T11:13:21.465836Z","end":"2026-10-13T11:13:21.60764Z","steps":["trace[1398039454] 'process raft request' (duration: 141.663061ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.607824Z","caller":"traceutil/trace.go:171","msg":"trace[1580795868] transaction","detail":"{read_only:false; response_revision:4239; number_of_response:1; }","duration":"141.851194ms","start":"2026-10-13T11:13:21.465962Z","end":"2026-10-13T11:13:21.607813Z","steps":["trace[1580795868] 'process raft request' (duration: 141.572699ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.607757Z","caller":"traceutil/trace.go:171","msg":"trace[2015460456] transaction","detail":"{read_only:false; response_revision:4243; number_of_response:1; }","duration":"139.93366ms","start":"2026-10-13T11:13:21.467794Z","end":"2026-10-13T11:13:21.607728Z","steps":["trace[2015460456] 'process raft request' (duration: 139.870279ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.608056Z","caller":"traceutil/trace.go:171","msg":"trace[302861049] transaction","detail":"{read_only:false; response_revision:4237; number_of_response:1; }","duration":"143.179648ms","start":"2026-10-13T11:13:21.464855Z","end":"2026-10-13T11:13:21.608035Z","steps":["trace[302861049] 'process raft request' (duration: 142.609458ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.608099Z","caller":"traceutil/trace.go:171","msg":"trace[171432755] transaction","detail":"{read_only:false; response_revision:4240; number_of_response:1; }","duration":"141.514388ms","start":"2026-10-13T11:13:21.466554Z","end":"2026-10-13T11:13:21.608069Z","steps":["trace[171432755] 'process raft request' (duration: 141.022619ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.608062Z","caller":"traceutil/trace.go:171","msg":"trace[919483117] transaction","detail":"{read_only:false; response_revision:4241; number_of_response:1; }","duration":"141.127112ms","start":"2026-10-13T11:13:21.466879Z","end":"2026-10-13T11:13:21.608006Z","steps":["trace[919483117] 'process raft request' (duration: 140.729245ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.60818Z","caller":"traceutil/trace.go:171","msg":"trace[949900503] transaction","detail":"{read_only:false; response_revision:4242; number_of_response:1; }","duration":"140.426169ms","start":"2026-10-13T11:13:21.467743Z","end":"2026-10-13T11:13:21.60817Z","steps":["trace[949900503] 'process raft request' (duration: 139.892569ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.620784Z","caller":"traceutil/trace.go:171","msg":"trace[728199361] transaction","detail":"{read_only:false; response_revision:4244; number_of_response:1; }","duration":"150.325927ms","start":"2026-10-13T11:13:21.470432Z","end":"2026-10-13T11:13:21.620757Z","steps":["trace[728199361] 'process raft request' (duration: 150.102913ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.62082Z","caller":"traceutil/trace.go:171","msg":"trace[1649721149] transaction","detail":"{read_only:false; response_revision:4245; number_of_response:1; }","duration":"150.211245ms","start":"2026-10-13T11:13:21.470586Z","end":"2026-10-13T11:13:21.620797Z","steps":["trace[1649721149] 'process raft request' (duration: 150.074002ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.620962Z","caller":"traceutil/trace.go:171","msg":"trace[1297324278] transaction","detail":"{read_only:false; response_revision:4246; number_of_response:1; }","duration":"150.088452ms","start":"2026-10-13T11:13:21.47085Z","end":"2026-10-13T11:13:21.620939Z","steps":["trace[1297324278] 'process raft request' (duration: 149.890479ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621054Z","caller":"traceutil/trace.go:171","msg":"trace[2046326316] transaction","detail":"{read_only:false; response_revision:4249; number_of_response:1; }","duration":"149.521712ms","start":"2026-10-13T11:13:21.471514Z","end":"2026-10-13T11:13:21.621036Z","steps":["trace[2046326316] 'process raft request' (duration: 149.370049ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621111Z","caller":"traceutil/trace.go:171","msg":"trace[7924084] transaction","detail":"{read_only:false; response_revision:4250; number_of_response:1; }","duration":"149.473501ms","start":"2026-10-13T11:13:21.471625Z","end":"2026-10-13T11:13:21.621099Z","steps":["trace[7924084] 'process raft request' (duration: 149.286638ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621188Z","caller":"traceutil/trace.go:171","msg":"trace[35660561] transaction","detail":"{read_only:false; response_revision:4252; number_of_response:1; }","duration":"149.380819ms","start":"2026-10-13T11:13:21.471798Z","end":"2026-10-13T11:13:21.621179Z","steps":["trace[35660561] 'process raft request' (duration: 149.170686ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621149Z","caller":"traceutil/trace.go:171","msg":"trace[418607100] transaction","detail":"{read_only:false; response_revision:4251; number_of_response:1; }","duration":"149.41198ms","start":"2026-10-13T11:13:21.471696Z","end":"2026-10-13T11:13:21.621108Z","steps":["trace[418607100] 'process raft request' (duration: 149.242117ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621222Z","caller":"traceutil/trace.go:171","msg":"trace[94823694] transaction","detail":"{read_only:false; response_revision:4247; number_of_response:1; }","duration":"150.304356ms","start":"2026-10-13T11:13:21.470903Z","end":"2026-10-13T11:13:21.621208Z","steps":["trace[94823694] 'process raft request' (duration: 149.870108ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621218Z","caller":"traceutil/trace.go:171","msg":"trace[306886695] transaction","detail":"{read_only:false; response_revision:4255; number_of_response:1; }","duration":"147.187101ms","start":"2026-10-13T11:13:21.474002Z","end":"2026-10-13T11:13:21.621189Z","steps":["trace[306886695] 'process raft request' (duration: 147.062548ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621261Z","caller":"traceutil/trace.go:171","msg":"trace[1039693563] transaction","detail":"{read_only:false; response_revision:4253; number_of_response:1; }","duration":"147.70537ms","start":"2026-10-13T11:13:21.473545Z","end":"2026-10-13T11:13:21.62125Z","steps":["trace[1039693563] 'process raft request' (duration: 147.456165ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621236Z","caller":"traceutil/trace.go:171","msg":"trace[93705391] transaction","detail":"{read_only:false; response_revision:4254; number_of_response:1; }","duration":"147.408075ms","start":"2026-10-13T11:13:21.473777Z","end":"2026-10-13T11:13:21.621185Z","steps":["trace[93705391] 'process raft request' (duration: 147.258462ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621316Z","caller":"traceutil/trace.go:171","msg":"trace[550991993] transaction","detail":"{read_only:false; response_revision:4248; number_of_response:1; }","duration":"150.346957ms","start":"2026-10-13T11:13:21.470956Z","end":"2026-10-13T11:13:21.621303Z","steps":["trace[550991993] 'process raft request' (duration: 149.892218ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621427Z","caller":"traceutil/trace.go:171","msg":"trace[167651118] transaction","detail":"{read_only:false; response_revision:4257; number_of_response:1; }","duration":"147.091749ms","start":"2026-10-13T11:13:21.474324Z","end":"2026-10-13T11:13:21.621416Z","steps":["trace[167651118] 'process raft request' (duration: 146.799663ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.62156Z","caller":"traceutil/trace.go:171","msg":"trace[234747315] transaction","detail":"{read_only:false; response_revision:4258; number_of_response:1; }","duration":"147.16127ms","start":"2026-10-13T11:13:21.474382Z","end":"2026-10-13T11:13:21.621543Z","steps":["trace[234747315] 'process raft request' (duration: 146.772633ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.621346Z","caller":"traceutil/trace.go:171","msg":"trace[1415478341] transaction","detail":"{read_only:false; response_revision:4256; number_of_response:1; }","duration":"146.980057ms","start":"2026-10-13T11:13:21.474266Z","end":"2026-10-13T11:13:21.621246Z","steps":["trace[1415478341] 'process raft request' (duration: 146.826504ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.622143Z","caller":"traceutil/trace.go:171","msg":"trace[1402311655] transaction","detail":"{read_only:false; response_revision:4260; number_of_response:1; }","duration":"147.072788ms","start":"2026-10-13T11:13:21.47504Z","end":"2026-10-13T11:13:21.622113Z","steps":["trace[1402311655] 'process raft request' (duration: 146.942186ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.622205Z","caller":"traceutil/trace.go:171","msg":"trace[1687121430] transaction","detail":"{read_only:false; response_revision:4261; number_of_response:1; }","duration":"147.100488ms","start":"2026-10-13T11:13:21.47509Z","end":"2026-10-13T11:13:21.622191Z","steps":["trace[1687121430] 'process raft request' (duration: 146.919185ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.62231Z","caller":"traceutil/trace.go:171","msg":"trace[863475980] transaction","detail":"{read_only:false; response_revision:4259; number_of_response:1; }","duration":"147.308053ms","start":"2026-10-13T11:13:21.474895Z","end":"2026-10-13T11:13:21.622203Z","steps":["trace[863475980] 'process raft request' (duration: 147.035728ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.622377Z","caller":"traceutil/trace.go:171","msg":"trace[756141338] transaction","detail":"{read_only:false; response_revision:4262; number_of_response:1; }","duration":"147.15412ms","start":"2026-10-13T11:13:21.475209Z","end":"2026-10-13T11:13:21.622363Z","steps":["trace[756141338] 'process raft request' (duration: 146.830804ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.622593Z","caller":"traceutil/trace.go:171","msg":"trace[1855061733] transaction","detail":"{read_only:false; response_revision:4263; number_of_response:1; }","duration":"146.706462ms","start":"2026-10-13T11:13:21.475877Z","end":"2026-10-13T11:13:21.622584Z","steps":["trace[1855061733] 'process raft request' (duration: 146.207813ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.622784Z","caller":"traceutil/trace.go:171","msg":"trace[1334838454] transaction","detail":"{read_only:false; response_revision:4264; number_of_response:1; }","duration":"147.616798ms","start":"2026-10-13T11:13:21.47515Z","end":"2026-10-13T11:13:21.622767Z","steps":["trace[1334838454] 'process raft request' (duration: 147.17146ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.623068Z","caller":"traceutil/trace.go:171","msg":"trace[729905104] transaction","detail":"{read_only:false; response_revision:4267; number_of_response:1; }","duration":"145.000751ms","start":"2026-10-13T11:13:21.478056Z","end":"2026-10-13T11:13:21.623056Z","steps":["trace[729905104] 'process raft request' (duration: 144.96193ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.623076Z","caller":"traceutil/trace.go:171","msg":"trace[1553541947] transaction","detail":"{read_only:false; response_revision:4265; number_of_response:1; }","duration":"147.037248ms","start":"2026-10-13T11:13:21.476025Z","end":"2026-10-13T11:13:21.623062Z","steps":["trace[1553541947] 'process raft request' (duration: 146.529219ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:21.623177Z","caller":"traceutil/trace.go:171","msg":"trace[1220360841] transaction","detail":"{read_only:false; response_revision:4266; number_of_response:1; }","duration":"145.618742ms","start":"2026-10-13T11:13:21.477548Z","end":"2026-10-13T11:13:21.623167Z","steps":["trace[1220360841] 'process raft request' (duration: 145.427979ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:13:30.60894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.758973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-10-13T11:13:30.609028Z","caller":"traceutil/trace.go:171","msg":"trace[283998590] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4722; }","duration":"104.887024ms","start":"2026-10-13T11:13:30.504123Z","end":"2026-10-13T11:13:30.60901Z","steps":["trace[283998590] 'range keys from in-memory index tree' (duration: 104.570919ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:40.30103Z","caller":"traceutil/trace.go:171","msg":"trace[867568843] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"139.193557ms","start":"2026-10-13T11:13:40.161818Z","end":"2026-10-13T11:13:40.301011Z","steps":["trace[867568843] 'process raft request' (duration: 139.127636ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:40.301063Z","caller":"traceutil/trace.go:171","msg":"trace[613344052] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"139.315159ms","start":"2026-10-13T11:13:40.161726Z","end":"2026-10-13T11:13:40.301041Z","steps":["trace[613344052] 'process raft request' (duration: 139.121276ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:40.301187Z","caller":"traceutil/trace.go:171","msg":"trace[665198642] transaction","detail":"{read_only:false; response_revision:4828; number_of_response:1; }","duration":"138.682118ms","start":"2026-10-13T11:13:40.162496Z","end":"2026-10-13T11:13:40.301178Z","steps":["trace[665198642] 'process raft request' (duration: 138.475454ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:40.946278Z","caller":"traceutil/trace.go:171","msg":"trace[569944878] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"253.947589ms","start":"2026-10-13T11:13:40.692306Z","end":"2026-10-13T11:13:40.946253Z","steps":["trace[569944878] 'process raft request' (duration: 253.819937ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:13:45.814173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.564319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-571462ed-15e0-4a26-9edb-e67abc1e4fe4\" ","response":"range_response_count:1 size:3644"} {"level":"warn","ts":"2026-10-13T11:13:45.814237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.264772ms","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":"info","ts":"2026-10-13T11:13:45.814296Z","caller":"traceutil/trace.go:171","msg":"trace[1124190734] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4944; }","duration":"309.373395ms","start":"2026-10-13T11:13:45.504908Z","end":"2026-10-13T11:13:45.814282Z","steps":["trace[1124190734] 'count revisions from in-memory index tree' (duration: 309.191541ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:13:45.814325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:13:45.504891Z","time spent":"309.426765ms","remote":"127.0.0.1:57036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":495,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-10-13T11:13:45.814335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.524369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-10-13T11:13:45.814253Z","caller":"traceutil/trace.go:171","msg":"trace[673110077] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-571462ed-15e0-4a26-9edb-e67abc1e4fe4; range_end:; response_count:1; response_revision:4944; }","duration":"161.713402ms","start":"2026-10-13T11:13:45.652522Z","end":"2026-10-13T11:13:45.814235Z","steps":["trace[673110077] 'range keys from in-memory index tree' (duration: 161.316875ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:45.814384Z","caller":"traceutil/trace.go:171","msg":"trace[148199563] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4944; }","duration":"161.58312ms","start":"2026-10-13T11:13:45.652784Z","end":"2026-10-13T11:13:45.814367Z","steps":["trace[148199563] 'range keys from in-memory index tree' (duration: 161.415727ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:45.995189Z","caller":"traceutil/trace.go:171","msg":"trace[1088298905] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"176.865431ms","start":"2026-10-13T11:13:45.818283Z","end":"2026-10-13T11:13:45.995148Z","steps":["trace[1088298905] 'process raft request' (duration: 176.718438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:13:56.648327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.673721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:13:56.648894Z","caller":"traceutil/trace.go:171","msg":"trace[1097625836] transaction","detail":"{read_only:false; response_revision:5082; number_of_response:1; }","duration":"230.558888ms","start":"2026-10-13T11:13:56.41825Z","end":"2026-10-13T11:13:56.648809Z","steps":["trace[1097625836] 'process raft request' (duration: 60.261896ms)","trace[1097625836] 'compare' (duration: 169.289104ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:13:56.648973Z","caller":"traceutil/trace.go:171","msg":"trace[1255439958] transaction","detail":"{read_only:false; response_revision:5083; number_of_response:1; }","duration":"227.349741ms","start":"2026-10-13T11:13:56.4216Z","end":"2026-10-13T11:13:56.64895Z","steps":["trace[1255439958] 'process raft request' (duration: 226.849363ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:56.649318Z","caller":"traceutil/trace.go:171","msg":"trace[2030831608] transaction","detail":"{read_only:false; response_revision:5084; number_of_response:1; }","duration":"227.659187ms","start":"2026-10-13T11:13:56.421643Z","end":"2026-10-13T11:13:56.649302Z","steps":["trace[2030831608] 'process raft request' (duration: 227.239179ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:56.649372Z","caller":"traceutil/trace.go:171","msg":"trace[438641353] transaction","detail":"{read_only:false; response_revision:5085; number_of_response:1; }","duration":"227.657346ms","start":"2026-10-13T11:13:56.421691Z","end":"2026-10-13T11:13:56.649348Z","steps":["trace[438641353] 'process raft request' (duration: 227.496184ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:56.649923Z","caller":"traceutil/trace.go:171","msg":"trace[1992606900] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"228.052014ms","start":"2026-10-13T11:13:56.421837Z","end":"2026-10-13T11:13:56.649889Z","steps":["trace[1992606900] 'process raft request' (duration: 227.468154ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:56.650228Z","caller":"traceutil/trace.go:171","msg":"trace[1188569650] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"227.503804ms","start":"2026-10-13T11:13:56.422703Z","end":"2026-10-13T11:13:56.650207Z","steps":["trace[1188569650] 'process raft request' (duration: 227.140447ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:56.650797Z","caller":"traceutil/trace.go:171","msg":"trace[165121345] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"226.007448ms","start":"2026-10-13T11:13:56.424772Z","end":"2026-10-13T11:13:56.65078Z","steps":["trace[165121345] 'process raft request' (duration: 225.388457ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:56.651Z","caller":"traceutil/trace.go:171","msg":"trace[1840744504] linearizableReadLoop","detail":"{readStateIndex:5274; appliedIndex:5267; }","duration":"213.70722ms","start":"2026-10-13T11:13:56.437275Z","end":"2026-10-13T11:13:56.650982Z","steps":["trace[1840744504] 'read index received' (duration: 41.153948ms)","trace[1840744504] 'applied index is now lower than readState.Index' (duration: 172.552162ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:13:56.651263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.204861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-13T11:13:56.651329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.038306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-13T11:13:56.65138Z","caller":"traceutil/trace.go:171","msg":"trace[1771045519] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5089; }","duration":"214.137697ms","start":"2026-10-13T11:13:56.437229Z","end":"2026-10-13T11:13:56.651366Z","steps":["trace[1771045519] 'agreement among raft nodes before linearized reading' (duration: 213.878182ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:56.65144Z","caller":"traceutil/trace.go:171","msg":"trace[1975153778] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5089; }","duration":"165.325574ms","start":"2026-10-13T11:13:56.485979Z","end":"2026-10-13T11:13:56.651304Z","steps":["trace[1975153778] 'agreement among raft nodes before linearized reading' (duration: 165.197002ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:13:56.881245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.587312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:13:56.881581Z","caller":"traceutil/trace.go:171","msg":"trace[2010686673] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"145.475353ms","start":"2026-10-13T11:13:56.73608Z","end":"2026-10-13T11:13:56.881555Z","steps":["trace[2010686673] 'process raft request' (duration: 28.451623ms)","trace[2010686673] 'compare' (duration: 116.405269ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:14:34.970418Z","caller":"traceutil/trace.go:171","msg":"trace[1840258259] transaction","detail":"{read_only:false; response_revision:5423; number_of_response:1; }","duration":"128.347863ms","start":"2026-10-13T11:14:34.842055Z","end":"2026-10-13T11:14:34.970403Z","steps":["trace[1840258259] 'process raft request' (duration: 128.088188ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:14:35.113103Z","caller":"traceutil/trace.go:171","msg":"trace[2112937193] transaction","detail":"{read_only:false; response_revision:5424; number_of_response:1; }","duration":"138.068872ms","start":"2026-10-13T11:14:34.974991Z","end":"2026-10-13T11:14:35.11306Z","steps":["trace[2112937193] 'process raft request' (duration: 68.537378ms)","trace[2112937193] 'compare' (duration: 69.188068ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:14:35.331039Z","caller":"traceutil/trace.go:171","msg":"trace[2023145660] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"355.814576ms","start":"2026-10-13T11:14:34.975201Z","end":"2026-10-13T11:14:35.331015Z","steps":["trace[2023145660] 'process raft request' (duration: 280.146824ms)","trace[2023145660] 'compare' (duration: 74.95247ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:14:35.331437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:14:34.975192Z","time spent":"356.158692ms","remote":"127.0.0.1:57208","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-13T11:14:35.332332Z","caller":"traceutil/trace.go:171","msg":"trace[2010456806] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"356.978157ms","start":"2026-10-13T11:14:34.975337Z","end":"2026-10-13T11:14:35.332315Z","steps":["trace[2010456806] 'process raft request' (duration: 355.389449ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:14:35.332768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:14:34.97533Z","time spent":"357.386974ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:14:35.333436Z","caller":"traceutil/trace.go:171","msg":"trace[926841436] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"321.208382ms","start":"2026-10-13T11:14:35.012212Z","end":"2026-10-13T11:14:35.333421Z","steps":["trace[926841436] 'process raft request' (duration: 319.859179ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:14:35.333714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:14:35.01219Z","time spent":"321.470876ms","remote":"127.0.0.1:57208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:14:43.039904Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2877} {"level":"info","ts":"2026-10-13T11:14:43.134081Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2877,"took":"92.848279ms","hash":3722851801,"current-db-size-bytes":53141504,"current-db-size":"53 MB","current-db-size-in-use-bytes":28594176,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-13T11:14:43.134143Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3722851801,"revision":2877,"compact-revision":-1} {"level":"info","ts":"2026-10-13T11:17:19.25313Z","caller":"traceutil/trace.go:171","msg":"trace[1574273579] transaction","detail":"{read_only:false; response_revision:6570; number_of_response:1; }","duration":"173.559604ms","start":"2026-10-13T11:17:19.079536Z","end":"2026-10-13T11:17:19.253096Z","steps":["trace[1574273579] 'process raft request' (duration: 173.374439ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:17:53.897356Z","caller":"traceutil/trace.go:171","msg":"trace[740296069] transaction","detail":"{read_only:false; response_revision:6829; number_of_response:1; }","duration":"203.225149ms","start":"2026-10-13T11:17:53.69411Z","end":"2026-10-13T11:17:53.897335Z","steps":["trace[740296069] 'process raft request' (duration: 203.107996ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:17:53.906892Z","caller":"traceutil/trace.go:171","msg":"trace[2071721020] linearizableReadLoop","detail":"{readStateIndex:7076; appliedIndex:7074; }","duration":"123.322187ms","start":"2026-10-13T11:17:53.783551Z","end":"2026-10-13T11:17:53.906873Z","steps":["trace[2071721020] 'read index received' (duration: 113.731182ms)","trace[2071721020] 'applied index is now lower than readState.Index' (duration: 9.587424ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:17:53.90707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.497351ms","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-13T11:17:53.907172Z","caller":"traceutil/trace.go:171","msg":"trace[1077978520] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6830; }","duration":"123.642885ms","start":"2026-10-13T11:17:53.783518Z","end":"2026-10-13T11:17:53.907161Z","steps":["trace[1077978520] 'agreement among raft nodes before linearized reading' (duration: 123.419129ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:17:53.907447Z","caller":"traceutil/trace.go:171","msg":"trace[367390052] transaction","detail":"{read_only:false; response_revision:6830; number_of_response:1; }","duration":"163.593176ms","start":"2026-10-13T11:17:53.743711Z","end":"2026-10-13T11:17:53.907304Z","steps":["trace[367390052] 'process raft request' (duration: 163.066342ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:43.049711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5488} {"level":"info","ts":"2026-10-13T11:19:43.129574Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5488,"took":"78.779068ms","hash":236748652,"current-db-size-bytes":53141504,"current-db-size":"53 MB","current-db-size-in-use-bytes":18644992,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-13T11:19:43.129625Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":236748652,"revision":5488,"compact-revision":2877}