{"level":"warn","ts":"2026-10-13T11:02:42.079581Z","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:02:42.079678Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.215:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.215:2380","--initial-cluster=instance=https://162.253.55.215:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.215:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.215: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:02:42.079759Z","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:02:42.079778Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.215:2380"]} {"level":"info","ts":"2026-10-13T11:02:42.0798Z","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:02:42.080662Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"]} {"level":"info","ts":"2026-10-13T11:02:42.080763Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.215:2380"],"listen-peer-urls":["https://162.253.55.215:2380"],"advertise-client-urls":["https://162.253.55.215:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.215: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:02:42.084762Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.69051ms"} {"level":"info","ts":"2026-10-13T11:02:42.094207Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4b019b7871d5da9a","cluster-id":"608f860684155cc8"} {"level":"info","ts":"2026-10-13T11:02:42.094294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T11:02:42.094319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became follower at term 0"} {"level":"info","ts":"2026-10-13T11:02:42.094332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4b019b7871d5da9a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T11:02:42.094343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became follower at term 1"} {"level":"info","ts":"2026-10-13T11:02:42.094378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=(5404771969429527194)"} {"level":"warn","ts":"2026-10-13T11:02:42.103854Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T11:02:42.105365Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T11:02:42.107006Z","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:02:42.110786Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4b019b7871d5da9a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T11:02:42.110927Z","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:02:42.111005Z","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:02:42.111023Z","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:02:42.11101Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4b019b7871d5da9a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T11:02:42.111698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=(5404771969429527194)"} {"level":"info","ts":"2026-10-13T11:02:42.117408Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"608f860684155cc8","local-member-id":"4b019b7871d5da9a","added-peer-id":"4b019b7871d5da9a","added-peer-peer-urls":["https://162.253.55.215:2380"]} {"level":"info","ts":"2026-10-13T11:02:42.118518Z","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:02:42.118706Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4b019b7871d5da9a","initial-advertise-peer-urls":["https://162.253.55.215:2380"],"listen-peer-urls":["https://162.253.55.215:2380"],"advertise-client-urls":["https://162.253.55.215:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T11:02:42.118749Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T11:02:42.118847Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.215:2380"} {"level":"info","ts":"2026-10-13T11:02:42.118864Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.215:2380"} {"level":"info","ts":"2026-10-13T11:02:42.394694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T11:02:42.394868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T11:02:42.394942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a received MsgPreVoteResp from 4b019b7871d5da9a at term 1"} {"level":"info","ts":"2026-10-13T11:02:42.394994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became candidate at term 2"} {"level":"info","ts":"2026-10-13T11:02:42.395023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a received MsgVoteResp from 4b019b7871d5da9a at term 2"} {"level":"info","ts":"2026-10-13T11:02:42.395104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became leader at term 2"} {"level":"info","ts":"2026-10-13T11:02:42.395136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4b019b7871d5da9a elected leader 4b019b7871d5da9a at term 2"} {"level":"info","ts":"2026-10-13T11:02:42.397057Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4b019b7871d5da9a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.215:2379]}","request-path":"/0/members/4b019b7871d5da9a/attributes","cluster-id":"608f860684155cc8","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T11:02:42.397468Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:02:42.398468Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T11:02:42.398842Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T11:02:42.399038Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T11:02:42.399058Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T11:02:42.399099Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"608f860684155cc8","local-member-id":"4b019b7871d5da9a","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:02:42.399365Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:02:42.399394Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:02:42.401357Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.215:2379"} {"level":"info","ts":"2026-10-13T11:02:42.402959Z","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:03:29.100266Z","caller":"traceutil/trace.go:171","msg":"trace[640501222] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"226.284605ms","start":"2026-10-13T11:03:28.873962Z","end":"2026-10-13T11:03:29.100246Z","steps":["trace[640501222] 'read index received' (duration: 170.836344ms)","trace[640501222] 'applied index is now lower than readState.Index' (duration: 55.447751ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:03:29.100361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.385867ms","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:03:29.100381Z","caller":"traceutil/trace.go:171","msg":"trace[1622123983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"226.442349ms","start":"2026-10-13T11:03:28.873934Z","end":"2026-10-13T11:03:29.100377Z","steps":["trace[1622123983] 'agreement among raft nodes before linearized reading' (duration: 226.387098ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:03:29.100573Z","caller":"traceutil/trace.go:171","msg":"trace[431810762] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"227.074382ms","start":"2026-10-13T11:03:28.873441Z","end":"2026-10-13T11:03:29.100515Z","steps":["trace[431810762] 'process raft request' (duration: 171.62605ms)","trace[431810762] 'compare' (duration: 55.063254ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:03:29.104916Z","caller":"traceutil/trace.go:171","msg":"trace[26001070] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"146.021815ms","start":"2026-10-13T11:03:28.958706Z","end":"2026-10-13T11:03:29.104728Z","steps":["trace[26001070] 'process raft request' (duration: 144.687239ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:03:34.792087Z","caller":"traceutil/trace.go:171","msg":"trace[121523569] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"103.802992ms","start":"2026-10-13T11:03:34.688249Z","end":"2026-10-13T11:03:34.792052Z","steps":["trace[121523569] 'process raft request' (duration: 43.557932ms)","trace[121523569] 'compare' (duration: 60.074187ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:03:35.428105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.99166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-13T11:03:35.428157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.598682ms","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:03:35.428256Z","caller":"traceutil/trace.go:171","msg":"trace[267669275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"313.207384ms","start":"2026-10-13T11:03:35.115005Z","end":"2026-10-13T11:03:35.428212Z","steps":["trace[267669275] 'range keys from in-memory index tree' (duration: 312.658693ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:03:35.428301Z","caller":"traceutil/trace.go:171","msg":"trace[2014425869] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:652; }","duration":"268.836467ms","start":"2026-10-13T11:03:35.159433Z","end":"2026-10-13T11:03:35.428269Z","steps":["trace[2014425869] 'range keys from in-memory index tree' (duration: 268.224856ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:03:35.428341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.851713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nmdx9\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-10-13T11:03:35.428322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:03:35.114979Z","time spent":"313.331246ms","remote":"127.0.0.1:38288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-13T11:03:35.428469Z","caller":"traceutil/trace.go:171","msg":"trace[734423973] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nmdx9; range_end:; response_count:1; response_revision:652; }","duration":"425.079736ms","start":"2026-10-13T11:03:35.003351Z","end":"2026-10-13T11:03:35.428431Z","steps":["trace[734423973] 'range keys from in-memory index tree' (duration: 424.626888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:03:35.428527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:03:35.003334Z","time spent":"425.177988ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-nmdx9\" "} {"level":"warn","ts":"2026-10-13T11:03:35.429508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.136218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:03:35.429715Z","caller":"traceutil/trace.go:171","msg":"trace[1603556270] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"234.16995ms","start":"2026-10-13T11:03:35.195521Z","end":"2026-10-13T11:03:35.429691Z","steps":["trace[1603556270] 'process raft request' (duration: 79.877569ms)","trace[1603556270] 'compare' (duration: 152.928444ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:03:35.43Z","caller":"traceutil/trace.go:171","msg":"trace[1726288573] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:681; }","duration":"213.039478ms","start":"2026-10-13T11:03:35.216942Z","end":"2026-10-13T11:03:35.429981Z","steps":["trace[1726288573] 'read index received' (duration: 58.542132ms)","trace[1726288573] 'applied index is now lower than readState.Index' (duration: 154.494746ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:03:35.430176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.221182ms","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:03:35.430248Z","caller":"traceutil/trace.go:171","msg":"trace[1965631843] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:653; }","duration":"213.321624ms","start":"2026-10-13T11:03:35.216907Z","end":"2026-10-13T11:03:35.430229Z","steps":["trace[1965631843] 'agreement among raft nodes before linearized reading' (duration: 213.188371ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:03:35.432139Z","caller":"traceutil/trace.go:171","msg":"trace[678253410] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"181.028843ms","start":"2026-10-13T11:03:35.251063Z","end":"2026-10-13T11:03:35.432091Z","steps":["trace[678253410] 'process raft request' (duration: 179.008384ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:21.397728Z","caller":"traceutil/trace.go:171","msg":"trace[940513048] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"250.014682ms","start":"2026-10-13T11:04:21.147695Z","end":"2026-10-13T11:04:21.39771Z","steps":["trace[940513048] 'process raft request' (duration: 249.91892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:04:21.39791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.119066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:04:21.397945Z","caller":"traceutil/trace.go:171","msg":"trace[1650596703] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1221; }","duration":"168.193248ms","start":"2026-10-13T11:04:21.229743Z","end":"2026-10-13T11:04:21.397936Z","steps":["trace[1650596703] 'agreement among raft nodes before linearized reading' (duration: 168.120617ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:04:21.398037Z","caller":"traceutil/trace.go:171","msg":"trace[1105791107] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1264; }","duration":"167.964564ms","start":"2026-10-13T11:04:21.229769Z","end":"2026-10-13T11:04:21.397734Z","steps":["trace[1105791107] 'read index received' (duration: 167.946383ms)","trace[1105791107] 'applied index is now lower than readState.Index' (duration: 15.301µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:04:36.221853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.666533ms","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:36.221953Z","caller":"traceutil/trace.go:171","msg":"trace[1765910311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1356; }","duration":"113.835046ms","start":"2026-10-13T11:04:36.108094Z","end":"2026-10-13T11:04:36.221929Z","steps":["trace[1765910311] 'range keys from in-memory index tree' (duration: 113.568353ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:09.107479Z","caller":"traceutil/trace.go:171","msg":"trace[1038671023] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"473.715922ms","start":"2026-10-13T11:05:08.633744Z","end":"2026-10-13T11:05:09.10746Z","steps":["trace[1038671023] 'process raft request' (duration: 473.542789ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:09.107617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:08.633732Z","time spent":"473.812324ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:05:09.107827Z","caller":"traceutil/trace.go:171","msg":"trace[132736837] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"473.833694ms","start":"2026-10-13T11:05:08.633972Z","end":"2026-10-13T11:05:09.107805Z","steps":["trace[132736837] 'process raft request' (duration: 473.436397ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:09.108001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:08.63396Z","time spent":"473.968676ms","remote":"127.0.0.1:38428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:05:09.108194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.033921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-13T11:05:09.108244Z","caller":"traceutil/trace.go:171","msg":"trace[2045994513] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"473.555219ms","start":"2026-10-13T11:05:08.634655Z","end":"2026-10-13T11:05:09.10821Z","steps":["trace[2045994513] 'process raft request' (duration: 472.991709ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:09.108261Z","caller":"traceutil/trace.go:171","msg":"trace[96540542] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1896; }","duration":"430.140704ms","start":"2026-10-13T11:05:08.678101Z","end":"2026-10-13T11:05:09.108242Z","steps":["trace[96540542] 'agreement among raft nodes before linearized reading' (duration: 429.92485ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:09.107986Z","caller":"traceutil/trace.go:171","msg":"trace[932300208] linearizableReadLoop","detail":"{readStateIndex:1975; appliedIndex:1971; }","duration":"429.803418ms","start":"2026-10-13T11:05:08.67816Z","end":"2026-10-13T11:05:09.107964Z","steps":["trace[932300208] 'read index received' (duration: 429.168117ms)","trace[932300208] 'applied index is now lower than readState.Index' (duration: 633.471µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:05:09.108316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:08.678058Z","time spent":"430.243796ms","remote":"127.0.0.1:50304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-13T11:05:09.108268Z","caller":"traceutil/trace.go:171","msg":"trace[1487157714] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"469.730355ms","start":"2026-10-13T11:05:08.638487Z","end":"2026-10-13T11:05:09.108218Z","steps":["trace[1487157714] 'process raft request' (duration: 469.366289ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:09.108362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:08.634642Z","time spent":"473.658702ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:05:09.108558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:08.63844Z","time spent":"469.952699ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:05:58.595199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.037349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-13T11:05:58.595273Z","caller":"traceutil/trace.go:171","msg":"trace[601857217] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2210; }","duration":"160.137683ms","start":"2026-10-13T11:05:58.435116Z","end":"2026-10-13T11:05:58.595254Z","steps":["trace[601857217] 'range keys from in-memory index tree' (duration: 159.931154ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:58.595462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.127079ms","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:58.595492Z","caller":"traceutil/trace.go:171","msg":"trace[1896546363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2210; }","duration":"169.180981ms","start":"2026-10-13T11:05:58.426303Z","end":"2026-10-13T11:05:58.595484Z","steps":["trace[1896546363] 'range keys from in-memory index tree' (duration: 168.90673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:58.596055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.040838ms","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:58.596237Z","caller":"traceutil/trace.go:171","msg":"trace[445405489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2210; }","duration":"180.274987ms","start":"2026-10-13T11:05:58.415901Z","end":"2026-10-13T11:05:58.596176Z","steps":["trace[445405489] 'range keys from in-memory index tree' (duration: 179.753977ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:58.683834Z","caller":"traceutil/trace.go:171","msg":"trace[1190445504] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"128.696573ms","start":"2026-10-13T11:05:58.555084Z","end":"2026-10-13T11:05:58.683781Z","steps":["trace[1190445504] 'process raft request' (duration: 128.419484ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:58.904558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.808283ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:05:58.904776Z","caller":"traceutil/trace.go:171","msg":"trace[70604725] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"305.158467ms","start":"2026-10-13T11:05:58.599594Z","end":"2026-10-13T11:05:58.904753Z","steps":["trace[70604725] 'process raft request' (duration: 198.066844ms)","trace[70604725] 'compare' (duration: 106.694889ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:05:58.904901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:58.599574Z","time spent":"305.285442ms","remote":"127.0.0.1:38524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:05:58.905086Z","caller":"traceutil/trace.go:171","msg":"trace[414836286] linearizableReadLoop","detail":"{readStateIndex:2305; appliedIndex:2302; }","duration":"221.365757ms","start":"2026-10-13T11:05:58.683697Z","end":"2026-10-13T11:05:58.905063Z","steps":["trace[414836286] 'read index received' (duration: 113.91214ms)","trace[414836286] 'applied index is now lower than readState.Index' (duration: 107.452777ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:05:58.905256Z","caller":"traceutil/trace.go:171","msg":"trace[1770372791] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"304.354967ms","start":"2026-10-13T11:05:58.600884Z","end":"2026-10-13T11:05:58.905239Z","steps":["trace[1770372791] 'process raft request' (duration: 304.108557ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:58.905345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:58.600878Z","time spent":"304.424519ms","remote":"127.0.0.1:38524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:05:58.905454Z","caller":"traceutil/trace.go:171","msg":"trace[1152468187] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"305.77063ms","start":"2026-10-13T11:05:58.59967Z","end":"2026-10-13T11:05:58.905441Z","steps":["trace[1152468187] 'process raft request' (duration: 304.997102ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:58.905591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:05:58.599663Z","time spent":"305.846674ms","remote":"127.0.0.1:38524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:05:58.905343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.737722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:05:58.906051Z","caller":"traceutil/trace.go:171","msg":"trace[2082355203] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2214; }","duration":"249.442679ms","start":"2026-10-13T11:05:58.656521Z","end":"2026-10-13T11:05:58.905964Z","steps":["trace[2082355203] 'agreement among raft nodes before linearized reading' (duration: 248.769713ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:05:58.915292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.428971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-13T11:05:58.915387Z","caller":"traceutil/trace.go:171","msg":"trace[568508791] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2215; }","duration":"109.576237ms","start":"2026-10-13T11:05:58.805774Z","end":"2026-10-13T11:05:58.915351Z","steps":["trace[568508791] 'agreement among raft nodes before linearized reading' (duration: 109.334618ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:05:58.91531Z","caller":"traceutil/trace.go:171","msg":"trace[1548906078] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"224.874739ms","start":"2026-10-13T11:05:58.690414Z","end":"2026-10-13T11:05:58.915288Z","steps":["trace[1548906078] 'process raft request' (duration: 224.548357ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:32.765801Z","caller":"traceutil/trace.go:171","msg":"trace[1621513343] linearizableReadLoop","detail":"{readStateIndex:4832; appliedIndex:4831; }","duration":"103.015926ms","start":"2026-10-13T11:11:32.662757Z","end":"2026-10-13T11:11:32.765773Z","steps":["trace[1621513343] 'read index received' (duration: 26.339676ms)","trace[1621513343] 'applied index is now lower than readState.Index' (duration: 76.6751ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:11:32.766043Z","caller":"traceutil/trace.go:171","msg":"trace[1520798237] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"103.934125ms","start":"2026-10-13T11:11:32.662093Z","end":"2026-10-13T11:11:32.766027Z","steps":["trace[1520798237] 'process raft request' (duration: 68.60642ms)","trace[1520798237] 'compare' (duration: 34.326406ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:11:32.7663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.526806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-10-13T11:11:32.766328Z","caller":"traceutil/trace.go:171","msg":"trace[328905348] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4648; }","duration":"103.566187ms","start":"2026-10-13T11:11:32.662753Z","end":"2026-10-13T11:11:32.766319Z","steps":["trace[328905348] 'agreement among raft nodes before linearized reading' (duration: 103.418144ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:32.892981Z","caller":"traceutil/trace.go:171","msg":"trace[1544543784] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"120.137098ms","start":"2026-10-13T11:11:32.772805Z","end":"2026-10-13T11:11:32.892942Z","steps":["trace[1544543784] 'process raft request' (duration: 101.335493ms)","trace[1544543784] 'compare' (duration: 18.339285ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:11:32.892995Z","caller":"traceutil/trace.go:171","msg":"trace[1541226598] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"120.175298ms","start":"2026-10-13T11:11:32.772795Z","end":"2026-10-13T11:11:32.89297Z","steps":["trace[1541226598] 'process raft request' (duration: 119.969004ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:32.893355Z","caller":"traceutil/trace.go:171","msg":"trace[1456171667] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"118.574247ms","start":"2026-10-13T11:11:32.774762Z","end":"2026-10-13T11:11:32.893336Z","steps":["trace[1456171667] 'process raft request' (duration: 118.376563ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:32.893366Z","caller":"traceutil/trace.go:171","msg":"trace[1698812880] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"118.386823ms","start":"2026-10-13T11:11:32.774963Z","end":"2026-10-13T11:11:32.893349Z","steps":["trace[1698812880] 'process raft request' (duration: 118.318212ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:32.893443Z","caller":"traceutil/trace.go:171","msg":"trace[650691945] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"119.029756ms","start":"2026-10-13T11:11:32.774365Z","end":"2026-10-13T11:11:32.893395Z","steps":["trace[650691945] 'process raft request' (duration: 118.552256ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:32.893697Z","caller":"traceutil/trace.go:171","msg":"trace[1769885543] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"111.520786ms","start":"2026-10-13T11:11:32.782163Z","end":"2026-10-13T11:11:32.893683Z","steps":["trace[1769885543] 'process raft request' (duration: 111.161599ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:32.894009Z","caller":"traceutil/trace.go:171","msg":"trace[1377734975] linearizableReadLoop","detail":"{readStateIndex:4836; appliedIndex:4832; }","duration":"119.416774ms","start":"2026-10-13T11:11:32.774577Z","end":"2026-10-13T11:11:32.893994Z","steps":["trace[1377734975] 'read index received' (duration: 61.180211ms)","trace[1377734975] 'applied index is now lower than readState.Index' (duration: 58.235733ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:11:32.894133Z","caller":"traceutil/trace.go:171","msg":"trace[1110212786] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"109.592898ms","start":"2026-10-13T11:11:32.78453Z","end":"2026-10-13T11:11:32.894122Z","steps":["trace[1110212786] 'process raft request' (duration: 109.087168ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:11:32.894339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.74637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:11:32.894382Z","caller":"traceutil/trace.go:171","msg":"trace[152881678] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4656; }","duration":"119.799711ms","start":"2026-10-13T11:11:32.774573Z","end":"2026-10-13T11:11:32.894372Z","steps":["trace[152881678] 'agreement among raft nodes before linearized reading' (duration: 119.72416ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:11:32.894407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.738199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-10-13T11:11:32.894455Z","caller":"traceutil/trace.go:171","msg":"trace[461063862] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4656; }","duration":"119.798111ms","start":"2026-10-13T11:11:32.774644Z","end":"2026-10-13T11:11:32.894442Z","steps":["trace[461063862] 'agreement among raft nodes before linearized reading' (duration: 119.645669ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:11:32.894643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.812331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-10-13T11:11:32.894688Z","caller":"traceutil/trace.go:171","msg":"trace[1310245464] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4656; }","duration":"119.889963ms","start":"2026-10-13T11:11:32.774787Z","end":"2026-10-13T11:11:32.894677Z","steps":["trace[1310245464] 'agreement among raft nodes before linearized reading' (duration: 119.73848ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:37.604749Z","caller":"traceutil/trace.go:171","msg":"trace[513805260] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"119.099601ms","start":"2026-10-13T11:11:37.485628Z","end":"2026-10-13T11:11:37.604728Z","steps":["trace[513805260] 'process raft request' (duration: 118.960418ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:37.604848Z","caller":"traceutil/trace.go:171","msg":"trace[1892213614] linearizableReadLoop","detail":"{readStateIndex:4962; appliedIndex:4962; }","duration":"117.300585ms","start":"2026-10-13T11:11:37.487487Z","end":"2026-10-13T11:11:37.604788Z","steps":["trace[1892213614] 'read index received' (duration: 117.289115ms)","trace[1892213614] 'applied index is now lower than readState.Index' (duration: 9.36µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:11:37.605151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.641022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:7 size:61722"} {"level":"info","ts":"2026-10-13T11:11:37.605221Z","caller":"traceutil/trace.go:171","msg":"trace[72785016] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:7; response_revision:4773; }","duration":"117.724204ms","start":"2026-10-13T11:11:37.487476Z","end":"2026-10-13T11:11:37.6052Z","steps":["trace[72785016] 'agreement among raft nodes before linearized reading' (duration: 117.463438ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:37.782285Z","caller":"traceutil/trace.go:171","msg":"trace[1109513423] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"199.298157ms","start":"2026-10-13T11:11:37.582939Z","end":"2026-10-13T11:11:37.782238Z","steps":["trace[1109513423] 'process raft request' (duration: 105.54289ms)","trace[1109513423] 'compare' (duration: 93.217636ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:11:37.782405Z","caller":"traceutil/trace.go:171","msg":"trace[1492546582] linearizableReadLoop","detail":"{readStateIndex:4963; appliedIndex:4962; }","duration":"177.463722ms","start":"2026-10-13T11:11:37.604913Z","end":"2026-10-13T11:11:37.782377Z","steps":["trace[1492546582] 'read index received' (duration: 83.472081ms)","trace[1492546582] 'applied index is now lower than readState.Index' (duration: 93.989141ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:11:37.783657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.912184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2362739"} {"level":"info","ts":"2026-10-13T11:11:37.783709Z","caller":"traceutil/trace.go:171","msg":"trace[1060028924] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4774; }","duration":"269.047746ms","start":"2026-10-13T11:11:37.514644Z","end":"2026-10-13T11:11:37.783692Z","steps":["trace[1060028924] 'agreement among raft nodes before linearized reading' (duration: 267.904343ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:37.784008Z","caller":"traceutil/trace.go:171","msg":"trace[93133493] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4775; }","duration":"177.28969ms","start":"2026-10-13T11:11:37.606697Z","end":"2026-10-13T11:11:37.783986Z","steps":["trace[93133493] 'process raft request' (duration: 177.089076ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:11:37.78429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.361091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4737"} {"level":"info","ts":"2026-10-13T11:11:37.784378Z","caller":"traceutil/trace.go:171","msg":"trace[1666489012] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4775; }","duration":"167.734189ms","start":"2026-10-13T11:11:37.616625Z","end":"2026-10-13T11:11:37.784359Z","steps":["trace[1666489012] 'agreement among raft nodes before linearized reading' (duration: 167.2633ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:11:46.878912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.234765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9425"} {"level":"info","ts":"2026-10-13T11:11:46.879198Z","caller":"traceutil/trace.go:171","msg":"trace[667931960] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4937; }","duration":"163.549732ms","start":"2026-10-13T11:11:46.715631Z","end":"2026-10-13T11:11:46.879181Z","steps":["trace[667931960] 'range keys from in-memory index tree' (duration: 163.085013ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:47.058163Z","caller":"traceutil/trace.go:171","msg":"trace[2037658121] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"115.649862ms","start":"2026-10-13T11:11:46.942491Z","end":"2026-10-13T11:11:47.058141Z","steps":["trace[2037658121] 'process raft request' (duration: 115.496609ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:47.320017Z","caller":"traceutil/trace.go:171","msg":"trace[883998777] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"117.648491ms","start":"2026-10-13T11:11:47.202344Z","end":"2026-10-13T11:11:47.319992Z","steps":["trace[883998777] 'process raft request' (duration: 102.841768ms)","trace[883998777] 'compare' (duration: 14.414585ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:11:47.589639Z","caller":"traceutil/trace.go:171","msg":"trace[717264298] linearizableReadLoop","detail":"{readStateIndex:5140; appliedIndex:5139; }","duration":"109.997708ms","start":"2026-10-13T11:11:47.479615Z","end":"2026-10-13T11:11:47.589612Z","steps":["trace[717264298] 'read index received' (duration: 81.862191ms)","trace[717264298] 'applied index is now lower than readState.Index' (duration: 28.134227ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:11:47.589817Z","caller":"traceutil/trace.go:171","msg":"trace[1304931403] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"121.346093ms","start":"2026-10-13T11:11:47.46845Z","end":"2026-10-13T11:11:47.589796Z","steps":["trace[1304931403] 'process raft request' (duration: 93.089353ms)","trace[1304931403] 'compare' (duration: 27.955504ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:11:47.589982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.299904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f771d94d-478f-4dd1-aded-f2e6e6af986a\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-13T11:11:47.590045Z","caller":"traceutil/trace.go:171","msg":"trace[1886687648] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f771d94d-478f-4dd1-aded-f2e6e6af986a; range_end:; response_count:1; response_revision:4948; }","duration":"110.449057ms","start":"2026-10-13T11:11:47.479575Z","end":"2026-10-13T11:11:47.590024Z","steps":["trace[1886687648] 'agreement among raft nodes before linearized reading' (duration: 110.150581ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:59.520271Z","caller":"traceutil/trace.go:171","msg":"trace[311714137] transaction","detail":"{read_only:false; response_revision:5085; number_of_response:1; }","duration":"198.671274ms","start":"2026-10-13T11:11:59.321566Z","end":"2026-10-13T11:11:59.520238Z","steps":["trace[311714137] 'process raft request' (duration: 153.657317ms)","trace[311714137] 'compare' (duration: 44.714601ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:11:59.520315Z","caller":"traceutil/trace.go:171","msg":"trace[2092596377] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"152.817451ms","start":"2026-10-13T11:11:59.367477Z","end":"2026-10-13T11:11:59.520294Z","steps":["trace[2092596377] 'process raft request' (duration: 152.75876ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:59.520469Z","caller":"traceutil/trace.go:171","msg":"trace[1373202869] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"198.900818ms","start":"2026-10-13T11:11:59.321555Z","end":"2026-10-13T11:11:59.520456Z","steps":["trace[1373202869] 'process raft request' (duration: 198.556351ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:59.520551Z","caller":"traceutil/trace.go:171","msg":"trace[1833766580] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"198.129273ms","start":"2026-10-13T11:11:59.322388Z","end":"2026-10-13T11:11:59.520517Z","steps":["trace[1833766580] 'process raft request' (duration: 197.785087ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:59.806403Z","caller":"traceutil/trace.go:171","msg":"trace[821245602] linearizableReadLoop","detail":"{readStateIndex:5286; appliedIndex:5285; }","duration":"192.295747ms","start":"2026-10-13T11:11:59.61408Z","end":"2026-10-13T11:11:59.806376Z","steps":["trace[821245602] 'read index received' (duration: 192.068714ms)","trace[821245602] 'applied index is now lower than readState.Index' (duration: 225.953µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:11:59.806544Z","caller":"traceutil/trace.go:171","msg":"trace[1409915282] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"231.214455ms","start":"2026-10-13T11:11:59.575316Z","end":"2026-10-13T11:11:59.80653Z","steps":["trace[1409915282] 'process raft request' (duration: 230.864299ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:11:59.806746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.647565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:11:59.806788Z","caller":"traceutil/trace.go:171","msg":"trace[1917630300] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5090; }","duration":"192.765667ms","start":"2026-10-13T11:11:59.614012Z","end":"2026-10-13T11:11:59.806778Z","steps":["trace[1917630300] 'agreement among raft nodes before linearized reading' (duration: 192.674816ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:11:59.806969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.731521ms","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:11:59.807092Z","caller":"traceutil/trace.go:171","msg":"trace[2016847632] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5090; }","duration":"144.898054ms","start":"2026-10-13T11:11:59.66217Z","end":"2026-10-13T11:11:59.807068Z","steps":["trace[2016847632] 'agreement among raft nodes before linearized reading' (duration: 144.578648ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:59.934505Z","caller":"traceutil/trace.go:171","msg":"trace[1679130508] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"120.834321ms","start":"2026-10-13T11:11:59.813612Z","end":"2026-10-13T11:11:59.934447Z","steps":["trace[1679130508] 'process raft request' (duration: 120.560455ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:59.934845Z","caller":"traceutil/trace.go:171","msg":"trace[1571189474] transaction","detail":"{read_only:false; response_revision:5093; number_of_response:1; }","duration":"119.604517ms","start":"2026-10-13T11:11:59.815204Z","end":"2026-10-13T11:11:59.934809Z","steps":["trace[1571189474] 'process raft request' (duration: 119.145408ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:59.935471Z","caller":"traceutil/trace.go:171","msg":"trace[421981679] transaction","detail":"{read_only:false; response_revision:5094; number_of_response:1; }","duration":"120.105956ms","start":"2026-10-13T11:11:59.815345Z","end":"2026-10-13T11:11:59.93545Z","steps":["trace[421981679] 'process raft request' (duration: 119.24829ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:36.490416Z","caller":"traceutil/trace.go:171","msg":"trace[1714148118] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"108.835903ms","start":"2026-10-13T11:12:36.381552Z","end":"2026-10-13T11:12:36.490388Z","steps":["trace[1714148118] 'process raft request' (duration: 25.237939ms)","trace[1714148118] 'compare' (duration: 83.367359ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:12:42.657807Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874} {"level":"info","ts":"2026-10-13T11:12:42.732316Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"73.041225ms","hash":4241260192,"current-db-size-bytes":53161984,"current-db-size":"53 MB","current-db-size-in-use-bytes":29102080,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-13T11:12:42.732383Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4241260192,"revision":2874,"compact-revision":-1} {"level":"info","ts":"2026-10-13T11:17:42.66651Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5483} {"level":"info","ts":"2026-10-13T11:17:42.747999Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5483,"took":"79.565705ms","hash":1309130932,"current-db-size-bytes":53161984,"current-db-size":"53 MB","current-db-size-in-use-bytes":18632704,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-13T11:17:42.748086Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1309130932,"revision":5483,"compact-revision":2874}