{"level":"warn","ts":"2026-09-01T05:10:26.139561Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T05:10:26.139637Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.129: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.129:2380","--initial-cluster=instance=https://162.253.55.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.129:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-01T05:10:26.139695Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T05:10:26.139705Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.129:2380"]} {"level":"info","ts":"2026-09-01T05:10:26.139723Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T05:10:26.140329Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"]} {"level":"info","ts":"2026-09-01T05:10:26.140401Z","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.129:2380"],"listen-peer-urls":["https://162.253.55.129:2380"],"advertise-client-urls":["https://162.253.55.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.129:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-01T05:10:26.152605Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.017973ms"} {"level":"info","ts":"2026-09-01T05:10:26.182718Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d232699cb6c87299","cluster-id":"f2b9115890c3fc7f"} {"level":"info","ts":"2026-09-01T05:10:26.182956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T05:10:26.183005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became follower at term 0"} {"level":"info","ts":"2026-09-01T05:10:26.183032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d232699cb6c87299 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T05:10:26.183072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became follower at term 1"} {"level":"info","ts":"2026-09-01T05:10:26.183149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=(15146284618602803865)"} {"level":"warn","ts":"2026-09-01T05:10:26.208946Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T05:10:26.211169Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T05:10:26.21424Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-01T05:10:26.217762Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d232699cb6c87299","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T05:10:26.218235Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d232699cb6c87299","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T05:10:26.219089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=(15146284618602803865)"} {"level":"info","ts":"2026-09-01T05:10:26.2193Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f2b9115890c3fc7f","local-member-id":"d232699cb6c87299","added-peer-id":"d232699cb6c87299","added-peer-peer-urls":["https://162.253.55.129:2380"]} {"level":"info","ts":"2026-09-01T05:10:26.21839Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T05:10:26.221445Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T05:10:26.221488Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T05:10:26.223042Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T05:10:26.223098Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.129:2380"} {"level":"info","ts":"2026-09-01T05:10:26.223123Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.129:2380"} {"level":"info","ts":"2026-09-01T05:10:26.223454Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d232699cb6c87299","initial-advertise-peer-urls":["https://162.253.55.129:2380"],"listen-peer-urls":["https://162.253.55.129:2380"],"advertise-client-urls":["https://162.253.55.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T05:10:26.223581Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T05:10:26.684938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T05:10:26.684995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T05:10:26.685036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 received MsgPreVoteResp from d232699cb6c87299 at term 1"} {"level":"info","ts":"2026-09-01T05:10:26.685117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became candidate at term 2"} {"level":"info","ts":"2026-09-01T05:10:26.685136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 received MsgVoteResp from d232699cb6c87299 at term 2"} {"level":"info","ts":"2026-09-01T05:10:26.685153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became leader at term 2"} {"level":"info","ts":"2026-09-01T05:10:26.685171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d232699cb6c87299 elected leader d232699cb6c87299 at term 2"} {"level":"info","ts":"2026-09-01T05:10:26.739644Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d232699cb6c87299","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.129:2379]}","request-path":"/0/members/d232699cb6c87299/attributes","cluster-id":"f2b9115890c3fc7f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T05:10:26.739656Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T05:10:26.739878Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T05:10:26.739912Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T05:10:26.739826Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T05:10:26.739846Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T05:10:26.742527Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T05:10:26.748231Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.129:2379"} {"level":"info","ts":"2026-09-01T05:10:26.76266Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f2b9115890c3fc7f","local-member-id":"d232699cb6c87299","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T05:10:26.767104Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T05:10:26.767172Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-09-01T05:10:32.288572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.57198ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T05:10:32.288836Z","caller":"traceutil/trace.go:171","msg":"trace[1357119102] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"299.583237ms","start":"2026-09-01T05:10:31.989178Z","end":"2026-09-01T05:10:32.288761Z","steps":["trace[1357119102] 'process raft request' (duration: 299.519415ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:32.288809Z","caller":"traceutil/trace.go:171","msg":"trace[990930378] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"330.187187ms","start":"2026-09-01T05:10:31.958571Z","end":"2026-09-01T05:10:32.288758Z","steps":["trace[990930378] 'process raft request' (duration: 136.690871ms)","trace[990930378] 'compare' (duration: 192.395644ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:10:32.289154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:10:31.958557Z","time spent":"330.51268ms","remote":"127.0.0.1:46262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T05:10:32.782514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.293577ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T05:10:32.782635Z","caller":"traceutil/trace.go:171","msg":"trace[1718181928] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:298; }","duration":"486.417223ms","start":"2026-09-01T05:10:32.296197Z","end":"2026-09-01T05:10:32.782614Z","steps":["trace[1718181928] 'read index received' (duration: 348.734551ms)","trace[1718181928] 'applied index is now lower than readState.Index' (duration: 137.680772ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:10:32.782718Z","caller":"traceutil/trace.go:171","msg":"trace[277380312] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"489.397145ms","start":"2026-09-01T05:10:32.293306Z","end":"2026-09-01T05:10:32.782703Z","steps":["trace[277380312] 'process raft request' (duration: 351.593759ms)","trace[277380312] 'compare' (duration: 136.980525ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:10:32.782791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:10:32.293283Z","time spent":"489.472378ms","remote":"127.0.0.1:46410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T05:10:32.783158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.931252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-09-01T05:10:32.783237Z","caller":"traceutil/trace.go:171","msg":"trace[686562136] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:291; }","duration":"487.054847ms","start":"2026-09-01T05:10:32.296157Z","end":"2026-09-01T05:10:32.783212Z","steps":["trace[686562136] 'agreement among raft nodes before linearized reading' (duration: 486.841529ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:10:32.783275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:10:32.296141Z","time spent":"487.125659ms","remote":"127.0.0.1:46262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" "} {"level":"info","ts":"2026-09-01T05:10:32.787789Z","caller":"traceutil/trace.go:171","msg":"trace[1255871209] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"134.780672ms","start":"2026-09-01T05:10:32.652995Z","end":"2026-09-01T05:10:32.787776Z","steps":["trace[1255871209] 'process raft request' (duration: 134.715409ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:32.792962Z","caller":"traceutil/trace.go:171","msg":"trace[345633030] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"139.020483ms","start":"2026-09-01T05:10:32.653922Z","end":"2026-09-01T05:10:32.792942Z","steps":["trace[345633030] 'process raft request' (duration: 138.914648ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:32.792985Z","caller":"traceutil/trace.go:171","msg":"trace[1453926998] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"139.432588ms","start":"2026-09-01T05:10:32.653533Z","end":"2026-09-01T05:10:32.792965Z","steps":["trace[1453926998] 'process raft request' (duration: 139.23668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:10:32.793068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.758056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:10:32.793115Z","caller":"traceutil/trace.go:171","msg":"trace[1746489381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:292; }","duration":"188.824548ms","start":"2026-09-01T05:10:32.604277Z","end":"2026-09-01T05:10:32.793101Z","steps":["trace[1746489381] 'agreement among raft nodes before linearized reading' (duration: 188.719694ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:10:32.7931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.808651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T05:10:32.793141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.041406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:10:32.79322Z","caller":"traceutil/trace.go:171","msg":"trace[358813813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:292; }","duration":"282.172032ms","start":"2026-09-01T05:10:32.511028Z","end":"2026-09-01T05:10:32.7932Z","steps":["trace[358813813] 'agreement among raft nodes before linearized reading' (duration: 282.028577ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:32.793256Z","caller":"traceutil/trace.go:171","msg":"trace[8422635] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"138.171472ms","start":"2026-09-01T05:10:32.655072Z","end":"2026-09-01T05:10:32.793243Z","steps":["trace[8422635] 'process raft request' (duration: 137.817588ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:32.79317Z","caller":"traceutil/trace.go:171","msg":"trace[307386008] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:292; }","duration":"107.919426ms","start":"2026-09-01T05:10:32.685225Z","end":"2026-09-01T05:10:32.793144Z","steps":["trace[307386008] 'agreement among raft nodes before linearized reading' (duration: 107.777551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:10:32.7935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.268616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-09-01T05:10:32.79354Z","caller":"traceutil/trace.go:171","msg":"trace[1015748560] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:292; }","duration":"193.343948ms","start":"2026-09-01T05:10:32.600183Z","end":"2026-09-01T05:10:32.793527Z","steps":["trace[1015748560] 'agreement among raft nodes before linearized reading' (duration: 193.265805ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:32.793616Z","caller":"traceutil/trace.go:171","msg":"trace[708167891] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"138.877638ms","start":"2026-09-01T05:10:32.654698Z","end":"2026-09-01T05:10:32.793575Z","steps":["trace[708167891] 'process raft request' (duration: 138.166461ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:05.541099Z","caller":"traceutil/trace.go:171","msg":"trace[1777887913] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"107.747288ms","start":"2026-09-01T05:11:05.433331Z","end":"2026-09-01T05:11:05.541078Z","steps":["trace[1777887913] 'process raft request' (duration: 105.773553ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:05.547143Z","caller":"traceutil/trace.go:171","msg":"trace[1354944416] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"100.271999ms","start":"2026-09-01T05:11:05.446845Z","end":"2026-09-01T05:11:05.547117Z","steps":["trace[1354944416] 'process raft request' (duration: 100.117224ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:11.263536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.995207ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T05:11:11.263737Z","caller":"traceutil/trace.go:171","msg":"trace[421217321] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"254.220907ms","start":"2026-09-01T05:11:11.009501Z","end":"2026-09-01T05:11:11.263722Z","steps":["trace[421217321] 'process raft request' (duration: 254.144595ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:11.26389Z","caller":"traceutil/trace.go:171","msg":"trace[2003407884] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"254.711391ms","start":"2026-09-01T05:11:11.009147Z","end":"2026-09-01T05:11:11.263858Z","steps":["trace[2003407884] 'process raft request' (duration: 43.20805ms)","trace[2003407884] 'compare' (duration: 210.898875ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:11:11.963451Z","caller":"traceutil/trace.go:171","msg":"trace[344162923] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"358.259767ms","start":"2026-09-01T05:11:11.605171Z","end":"2026-09-01T05:11:11.96343Z","steps":["trace[344162923] 'read index received' (duration: 332.570708ms)","trace[344162923] 'applied index is now lower than readState.Index' (duration: 25.688349ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:11:11.963548Z","caller":"traceutil/trace.go:171","msg":"trace[1310169158] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"561.085686ms","start":"2026-09-01T05:11:11.402437Z","end":"2026-09-01T05:11:11.963523Z","steps":["trace[1310169158] 'process raft request' (duration: 535.461158ms)","trace[1310169158] 'compare' (duration: 24.887358ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:11:11.963699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.517604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-01T05:11:11.96371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:11:11.402409Z","time spent":"561.223878ms","remote":"127.0.0.1:46128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T05:11:11.963739Z","caller":"traceutil/trace.go:171","msg":"trace[1461896105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"358.602926ms","start":"2026-09-01T05:11:11.605125Z","end":"2026-09-01T05:11:11.963728Z","steps":["trace[1461896105] 'agreement among raft nodes before linearized reading' (duration: 358.418681ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:11.963722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.289107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T05:11:11.963767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:11:11.605108Z","time spent":"358.653008ms","remote":"127.0.0.1:46314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-01T05:11:11.963783Z","caller":"traceutil/trace.go:171","msg":"trace[496908424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"358.38618ms","start":"2026-09-01T05:11:11.605378Z","end":"2026-09-01T05:11:11.963764Z","steps":["trace[496908424] 'agreement among raft nodes before linearized reading' (duration: 358.295007ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:11.963806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.115116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xbzhd\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-09-01T05:11:11.963824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:11:11.605356Z","time spent":"358.458132ms","remote":"127.0.0.1:46024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-01T05:11:11.963873Z","caller":"traceutil/trace.go:171","msg":"trace[78803823] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xbzhd; range_end:; response_count:1; response_revision:626; }","duration":"206.24551ms","start":"2026-09-01T05:11:11.757612Z","end":"2026-09-01T05:11:11.963857Z","steps":["trace[78803823] 'agreement among raft nodes before linearized reading' (duration: 206.092886ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:29.63779Z","caller":"traceutil/trace.go:171","msg":"trace[909803852] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"198.327841ms","start":"2026-09-01T05:11:29.439437Z","end":"2026-09-01T05:11:29.637765Z","steps":["trace[909803852] 'process raft request' (duration: 198.191778ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:29.671911Z","caller":"traceutil/trace.go:171","msg":"trace[1576569680] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"107.390574ms","start":"2026-09-01T05:11:29.564499Z","end":"2026-09-01T05:11:29.671889Z","steps":["trace[1576569680] 'process raft request' (duration: 107.22863ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:59.477092Z","caller":"traceutil/trace.go:171","msg":"trace[1574657306] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"272.236801ms","start":"2026-09-01T05:11:59.204831Z","end":"2026-09-01T05:11:59.477068Z","steps":["trace[1574657306] 'process raft request' (duration: 272.061907ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:24.537013Z","caller":"traceutil/trace.go:171","msg":"trace[622135806] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"117.555446ms","start":"2026-09-01T05:12:24.419432Z","end":"2026-09-01T05:12:24.536987Z","steps":["trace[622135806] 'process raft request' (duration: 100.328037ms)","trace[622135806] 'compare' (duration: 17.106157ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:12:32.065634Z","caller":"traceutil/trace.go:171","msg":"trace[837518843] transaction","detail":"{read_only:false; response_revision:1582; number_of_response:1; }","duration":"103.972346ms","start":"2026-09-01T05:12:31.961644Z","end":"2026-09-01T05:12:32.065616Z","steps":["trace[837518843] 'process raft request' (duration: 103.544249ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:12:38.439967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.31842ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:12:38.440099Z","caller":"traceutil/trace.go:171","msg":"trace[1551351495] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1727; }","duration":"123.484463ms","start":"2026-09-01T05:12:38.316587Z","end":"2026-09-01T05:12:38.440072Z","steps":["trace[1551351495] 'range keys from in-memory index tree' (duration: 123.30196ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:38.49579Z","caller":"traceutil/trace.go:171","msg":"trace[1902742739] linearizableReadLoop","detail":"{readStateIndex:1799; appliedIndex:1798; }","duration":"109.079896ms","start":"2026-09-01T05:12:38.386688Z","end":"2026-09-01T05:12:38.495768Z","steps":["trace[1902742739] 'read index received' (duration: 108.934714ms)","trace[1902742739] 'applied index is now lower than readState.Index' (duration: 144.222µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:12:38.495804Z","caller":"traceutil/trace.go:171","msg":"trace[918608031] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1727; }","duration":"233.083657ms","start":"2026-09-01T05:12:38.262701Z","end":"2026-09-01T05:12:38.495785Z","steps":["trace[918608031] 'process raft request' (duration: 232.924714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:12:38.495912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.199778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:12:38.495962Z","caller":"traceutil/trace.go:171","msg":"trace[1237902901] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1727; }","duration":"109.30675ms","start":"2026-09-01T05:12:38.386643Z","end":"2026-09-01T05:12:38.49595Z","steps":["trace[1237902901] 'agreement among raft nodes before linearized reading' (duration: 109.204939ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:38.519532Z","caller":"traceutil/trace.go:171","msg":"trace[820757805] transaction","detail":"{read_only:false; response_revision:1728; number_of_response:1; }","duration":"104.993737ms","start":"2026-09-01T05:12:38.414518Z","end":"2026-09-01T05:12:38.519512Z","steps":["trace[820757805] 'process raft request' (duration: 104.806124ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:12:49.360816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.060452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-74b7e6a7-2f09-4f65-be71-94a091035675\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-01T05:12:49.360918Z","caller":"traceutil/trace.go:171","msg":"trace[386757223] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-74b7e6a7-2f09-4f65-be71-94a091035675; range_end:; response_count:1; response_revision:1885; }","duration":"354.202104ms","start":"2026-09-01T05:12:49.006692Z","end":"2026-09-01T05:12:49.360894Z","steps":["trace[386757223] 'range keys from in-memory index tree' (duration: 353.922229ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:12:49.361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:12:49.006673Z","time spent":"354.305995ms","remote":"127.0.0.1:46246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-74b7e6a7-2f09-4f65-be71-94a091035675\" "} {"level":"warn","ts":"2026-09-01T05:12:49.360818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.089147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-74b7e6a7-2f09-4f65-be71-94a091035675\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-01T05:12:49.361059Z","caller":"traceutil/trace.go:171","msg":"trace[1405399153] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-74b7e6a7-2f09-4f65-be71-94a091035675; range_end:; response_count:1; response_revision:1885; }","duration":"136.381392ms","start":"2026-09-01T05:12:49.224657Z","end":"2026-09-01T05:12:49.361039Z","steps":["trace[1405399153] 'range keys from in-memory index tree' (duration: 135.869104ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:49.663517Z","caller":"traceutil/trace.go:171","msg":"trace[391862169] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1960; }","duration":"253.122647ms","start":"2026-09-01T05:12:49.410371Z","end":"2026-09-01T05:12:49.663493Z","steps":["trace[391862169] 'read index received' (duration: 253.037895ms)","trace[391862169] 'applied index is now lower than readState.Index' (duration: 83.632µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:12:49.66363Z","caller":"traceutil/trace.go:171","msg":"trace[1517973340] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"293.853643ms","start":"2026-09-01T05:12:49.369765Z","end":"2026-09-01T05:12:49.663619Z","steps":["trace[1517973340] 'process raft request' (duration: 293.571688ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:12:49.663916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.529683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-01T05:12:49.664032Z","caller":"traceutil/trace.go:171","msg":"trace[1379363845] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1886; }","duration":"253.648885ms","start":"2026-09-01T05:12:49.410354Z","end":"2026-09-01T05:12:49.664003Z","steps":["trace[1379363845] 'agreement among raft nodes before linearized reading' (duration: 253.34467ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:49.758447Z","caller":"traceutil/trace.go:171","msg":"trace[850161847] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"266.975877ms","start":"2026-09-01T05:12:49.491445Z","end":"2026-09-01T05:12:49.758421Z","steps":["trace[850161847] 'process raft request' (duration: 266.893855ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:49.758459Z","caller":"traceutil/trace.go:171","msg":"trace[1287170798] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"328.331444ms","start":"2026-09-01T05:12:49.430109Z","end":"2026-09-01T05:12:49.758441Z","steps":["trace[1287170798] 'process raft request' (duration: 328.07014ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:12:49.758741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:12:49.430083Z","time spent":"328.543087ms","remote":"127.0.0.1:46314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T05:12:49.759276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.659458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:12:49.759381Z","caller":"traceutil/trace.go:171","msg":"trace[1014531002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1888; }","duration":"153.81281ms","start":"2026-09-01T05:12:49.605541Z","end":"2026-09-01T05:12:49.759354Z","steps":["trace[1014531002] 'agreement among raft nodes before linearized reading' (duration: 152.965826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:12:49.776702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.332906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-09-01T05:12:49.776764Z","caller":"traceutil/trace.go:171","msg":"trace[1250121426] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1889; }","duration":"108.438937ms","start":"2026-09-01T05:12:49.66831Z","end":"2026-09-01T05:12:49.776749Z","steps":["trace[1250121426] 'agreement among raft nodes before linearized reading' (duration: 108.274545ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:13:22.979625Z","caller":"traceutil/trace.go:171","msg":"trace[266589869] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"133.832568ms","start":"2026-09-01T05:13:22.845765Z","end":"2026-09-01T05:13:22.979597Z","steps":["trace[266589869] 'process raft request' (duration: 133.661506ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:13:23.091868Z","caller":"traceutil/trace.go:171","msg":"trace[466799350] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"108.13668ms","start":"2026-09-01T05:13:22.983697Z","end":"2026-09-01T05:13:23.091834Z","steps":["trace[466799350] 'process raft request' (duration: 73.047138ms)","trace[466799350] 'compare' (duration: 34.937179ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:13:24.237064Z","caller":"traceutil/trace.go:171","msg":"trace[1329048664] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"167.836605ms","start":"2026-09-01T05:13:24.06921Z","end":"2026-09-01T05:13:24.237047Z","steps":["trace[1329048664] 'process raft request' (duration: 167.738624ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:13:24.697775Z","caller":"traceutil/trace.go:171","msg":"trace[119444653] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2218; }","duration":"340.712978ms","start":"2026-09-01T05:13:24.357035Z","end":"2026-09-01T05:13:24.697748Z","steps":["trace[119444653] 'read index received' (duration: 340.535086ms)","trace[119444653] 'applied index is now lower than readState.Index' (duration: 176.812µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:13:24.697984Z","caller":"traceutil/trace.go:171","msg":"trace[993056383] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"349.664415ms","start":"2026-09-01T05:13:24.3483Z","end":"2026-09-01T05:13:24.697964Z","steps":["trace[993056383] 'process raft request' (duration: 349.221059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:13:24.698124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:13:24.348273Z","time spent":"349.775048ms","remote":"127.0.0.1:46314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T05:13:24.698369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.325757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-01T05:13:24.699082Z","caller":"traceutil/trace.go:171","msg":"trace[1834842963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2136; }","duration":"342.028679ms","start":"2026-09-01T05:13:24.357025Z","end":"2026-09-01T05:13:24.699053Z","steps":["trace[1834842963] 'agreement among raft nodes before linearized reading' (duration: 340.942352ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:13:24.699166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:13:24.356927Z","time spent":"342.223872ms","remote":"127.0.0.1:46314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-01T05:13:24.698544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.409278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-01T05:13:24.699318Z","caller":"traceutil/trace.go:171","msg":"trace[879792780] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2136; }","duration":"268.254892ms","start":"2026-09-01T05:13:24.431052Z","end":"2026-09-01T05:13:24.699307Z","steps":["trace[879792780] 'agreement among raft nodes before linearized reading' (duration: 267.388478ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:13:24.848819Z","caller":"traceutil/trace.go:171","msg":"trace[1570008596] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"144.941253ms","start":"2026-09-01T05:13:24.703849Z","end":"2026-09-01T05:13:24.84879Z","steps":["trace[1570008596] 'process raft request' (duration: 144.870822ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:13:24.849307Z","caller":"traceutil/trace.go:171","msg":"trace[2112550294] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"145.41894ms","start":"2026-09-01T05:13:24.703854Z","end":"2026-09-01T05:13:24.849273Z","steps":["trace[2112550294] 'process raft request' (duration: 68.912712ms)","trace[2112550294] 'compare' (duration: 75.737606ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:14:26.800955Z","caller":"traceutil/trace.go:171","msg":"trace[1060221450] transaction","detail":"{read_only:false; response_revision:2517; number_of_response:1; }","duration":"100.029624ms","start":"2026-09-01T05:14:26.700895Z","end":"2026-09-01T05:14:26.800924Z","steps":["trace[1060221450] 'process raft request' (duration: 68.538775ms)","trace[1060221450] 'compare' (duration: 31.389595ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:15:13.197324Z","caller":"traceutil/trace.go:171","msg":"trace[170397152] transaction","detail":"{read_only:false; response_revision:2826; number_of_response:1; }","duration":"118.912379ms","start":"2026-09-01T05:15:13.078387Z","end":"2026-09-01T05:15:13.197299Z","steps":["trace[170397152] 'process raft request' (duration: 118.765594ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:15:18.481395Z","caller":"traceutil/trace.go:171","msg":"trace[1570397675] transaction","detail":"{read_only:false; response_revision:2853; number_of_response:1; }","duration":"104.13999ms","start":"2026-09-01T05:15:18.377232Z","end":"2026-09-01T05:15:18.481372Z","steps":["trace[1570397675] 'process raft request' (duration: 103.914241ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:15:18.782031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.736652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:15:18.782149Z","caller":"traceutil/trace.go:171","msg":"trace[111979146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2854; }","duration":"175.928078ms","start":"2026-09-01T05:15:18.606195Z","end":"2026-09-01T05:15:18.782123Z","steps":["trace[111979146] 'range keys from in-memory index tree' (duration: 175.640807ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:19:43.514698Z","caller":"traceutil/trace.go:171","msg":"trace[518613732] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"133.736122ms","start":"2026-09-01T05:19:43.380944Z","end":"2026-09-01T05:19:43.514681Z","steps":["trace[518613732] 'process raft request' (duration: 133.605239ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:19:43.514757Z","caller":"traceutil/trace.go:171","msg":"trace[164049552] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5122; }","duration":"132.347834ms","start":"2026-09-01T05:19:43.382382Z","end":"2026-09-01T05:19:43.51473Z","steps":["trace[164049552] 'read index received' (duration: 132.332724ms)","trace[164049552] 'applied index is now lower than readState.Index' (duration: 12.31µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:19:43.514956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.547288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-01T05:19:43.515013Z","caller":"traceutil/trace.go:171","msg":"trace[1486299014] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4933; }","duration":"132.633249ms","start":"2026-09-01T05:19:43.38237Z","end":"2026-09-01T05:19:43.515003Z","steps":["trace[1486299014] 'agreement among raft nodes before linearized reading' (duration: 132.430785ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:19:43.523287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.589941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-09-01T05:19:43.523342Z","caller":"traceutil/trace.go:171","msg":"trace[355126672] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4935; }","duration":"107.674632ms","start":"2026-09-01T05:19:43.415658Z","end":"2026-09-01T05:19:43.523332Z","steps":["trace[355126672] 'agreement among raft nodes before linearized reading' (duration: 107.525609ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:19:50.10156Z","caller":"traceutil/trace.go:171","msg":"trace[2062591051] transaction","detail":"{read_only:false; response_revision:4987; number_of_response:1; }","duration":"165.564115ms","start":"2026-09-01T05:19:49.935967Z","end":"2026-09-01T05:19:50.101531Z","steps":["trace[2062591051] 'process raft request' (duration: 74.091557ms)","trace[2062591051] 'compare' (duration: 91.365646ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:19:54.046545Z","caller":"traceutil/trace.go:171","msg":"trace[1847915708] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"242.184347ms","start":"2026-09-01T05:19:53.804335Z","end":"2026-09-01T05:19:54.046519Z","steps":["trace[1847915708] 'process raft request' (duration: 187.039889ms)","trace[1847915708] 'compare' (duration: 55.021675ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:19:54.059591Z","caller":"traceutil/trace.go:171","msg":"trace[1378479457] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"238.926012ms","start":"2026-09-01T05:19:53.820628Z","end":"2026-09-01T05:19:54.059554Z","steps":["trace[1378479457] 'process raft request' (duration: 238.652857ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:19:54.059704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.78833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:19:54.059764Z","caller":"traceutil/trace.go:171","msg":"trace[496969669] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5087; }","duration":"197.891492ms","start":"2026-09-01T05:19:53.861856Z","end":"2026-09-01T05:19:54.059748Z","steps":["trace[496969669] 'agreement among raft nodes before linearized reading' (duration: 197.79283ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:19:54.059738Z","caller":"traceutil/trace.go:171","msg":"trace[1974709135] linearizableReadLoop","detail":"{readStateIndex:5279; appliedIndex:5277; }","duration":"197.556986ms","start":"2026-09-01T05:19:53.861899Z","end":"2026-09-01T05:19:54.059456Z","steps":["trace[1974709135] 'read index received' (duration: 129.488204ms)","trace[1974709135] 'applied index is now lower than readState.Index' (duration: 68.067572ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:19:55.42084Z","caller":"traceutil/trace.go:171","msg":"trace[676812411] linearizableReadLoop","detail":"{readStateIndex:5322; appliedIndex:5321; }","duration":"105.005937ms","start":"2026-09-01T05:19:55.315814Z","end":"2026-09-01T05:19:55.42082Z","steps":["trace[676812411] 'read index received' (duration: 81.721499ms)","trace[676812411] 'applied index is now lower than readState.Index' (duration: 23.283698ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:19:55.421133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.297643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-01T05:19:55.421186Z","caller":"traceutil/trace.go:171","msg":"trace[79568492] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5128; }","duration":"105.365884ms","start":"2026-09-01T05:19:55.315797Z","end":"2026-09-01T05:19:55.421163Z","steps":["trace[79568492] 'agreement among raft nodes before linearized reading' (duration: 105.16332ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:19:55.421169Z","caller":"traceutil/trace.go:171","msg":"trace[849177500] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"105.858964ms","start":"2026-09-01T05:19:55.315271Z","end":"2026-09-01T05:19:55.42113Z","steps":["trace[849177500] 'process raft request' (duration: 82.309351ms)","trace[849177500] 'compare' (duration: 23.128345ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:20:26.777042Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2898} {"level":"info","ts":"2026-09-01T05:20:26.853706Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2898,"took":"75.493791ms","hash":3229603276,"current-db-size-bytes":52142080,"current-db-size":"52 MB","current-db-size-in-use-bytes":27758592,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T05:20:26.853784Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3229603276,"revision":2898,"compact-revision":-1} {"level":"warn","ts":"2026-09-01T05:23:42.245706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.287354ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T05:23:42.24592Z","caller":"traceutil/trace.go:171","msg":"trace[1753896084] transaction","detail":"{read_only:false; response_revision:6811; number_of_response:1; }","duration":"169.779903ms","start":"2026-09-01T05:23:42.076111Z","end":"2026-09-01T05:23:42.245891Z","steps":["trace[1753896084] 'process raft request' (duration: 61.196869ms)","trace[1753896084] 'compare' (duration: 107.972363ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:25:26.78268Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5375} {"level":"info","ts":"2026-09-01T05:25:26.896276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5375,"took":"112.251197ms","hash":3692854552,"current-db-size-bytes":52142080,"current-db-size":"52 MB","current-db-size-in-use-bytes":18915328,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T05:25:26.896343Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3692854552,"revision":5375,"compact-revision":2898}