{"level":"warn","ts":"2026-09-02T07:53:29.396731Z","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-02T07:53:29.396824Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.85: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.85:2380","--initial-cluster=instance=https://162.253.55.85:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.85:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.85: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-02T07:53:29.396984Z","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-02T07:53:29.397004Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.85:2380"]} {"level":"info","ts":"2026-09-02T07:53:29.397045Z","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-02T07:53:29.397817Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.85:2379"]} {"level":"info","ts":"2026-09-02T07:53:29.397974Z","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.85:2380"],"listen-peer-urls":["https://162.253.55.85:2380"],"advertise-client-urls":["https://162.253.55.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.85: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-02T07:53:29.403446Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.153651ms"} {"level":"info","ts":"2026-09-02T07:53:29.411882Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"427150911cb3975a","cluster-id":"f76f6804bd8187de"} {"level":"info","ts":"2026-09-02T07:53:29.412046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a switched to configuration voters=()"} {"level":"info","ts":"2026-09-02T07:53:29.41211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became follower at term 0"} {"level":"info","ts":"2026-09-02T07:53:29.412144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 427150911cb3975a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-02T07:53:29.41221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became follower at term 1"} {"level":"info","ts":"2026-09-02T07:53:29.412325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a switched to configuration voters=(4787696463053559642)"} {"level":"warn","ts":"2026-09-02T07:53:29.420632Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-02T07:53:29.422548Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-02T07:53:29.424015Z","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-02T07:53:29.426818Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"427150911cb3975a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-02T07:53:29.427589Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"427150911cb3975a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-02T07:53:29.42887Z","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-02T07:53:29.428951Z","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-02T07:53:29.42896Z","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-02T07:53:29.429171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a switched to configuration voters=(4787696463053559642)"} {"level":"info","ts":"2026-09-02T07:53:29.429276Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f76f6804bd8187de","local-member-id":"427150911cb3975a","added-peer-id":"427150911cb3975a","added-peer-peer-urls":["https://162.253.55.85:2380"]} {"level":"info","ts":"2026-09-02T07:53:29.430581Z","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-02T07:53:29.430712Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"427150911cb3975a","initial-advertise-peer-urls":["https://162.253.55.85:2380"],"listen-peer-urls":["https://162.253.55.85:2380"],"advertise-client-urls":["https://162.253.55.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-02T07:53:29.430735Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-02T07:53:29.430794Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.85:2380"} {"level":"info","ts":"2026-09-02T07:53:29.430807Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.85:2380"} {"level":"info","ts":"2026-09-02T07:53:30.213105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a is starting a new election at term 1"} {"level":"info","ts":"2026-09-02T07:53:30.213197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became pre-candidate at term 1"} {"level":"info","ts":"2026-09-02T07:53:30.213223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a received MsgPreVoteResp from 427150911cb3975a at term 1"} {"level":"info","ts":"2026-09-02T07:53:30.213242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became candidate at term 2"} {"level":"info","ts":"2026-09-02T07:53:30.213252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a received MsgVoteResp from 427150911cb3975a at term 2"} {"level":"info","ts":"2026-09-02T07:53:30.213267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"427150911cb3975a became leader at term 2"} {"level":"info","ts":"2026-09-02T07:53:30.213285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 427150911cb3975a elected leader 427150911cb3975a at term 2"} {"level":"info","ts":"2026-09-02T07:53:30.21445Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T07:53:30.215667Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T07:53:30.215669Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"427150911cb3975a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.85:2379]}","request-path":"/0/members/427150911cb3975a/attributes","cluster-id":"f76f6804bd8187de","publish-timeout":"7s"} {"level":"info","ts":"2026-09-02T07:53:30.216096Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-02T07:53:30.21617Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-02T07:53:30.215815Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T07:53:30.216548Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f76f6804bd8187de","local-member-id":"427150911cb3975a","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T07:53:30.216664Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T07:53:30.216723Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T07:53:30.21817Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.85:2379"} {"level":"info","ts":"2026-09-02T07:53:30.220453Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-02T07:53:38.088383Z","caller":"traceutil/trace.go:171","msg":"trace[260605527] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"161.26531ms","start":"2026-09-02T07:53:37.927095Z","end":"2026-09-02T07:53:38.08836Z","steps":["trace[260605527] 'process raft request' (duration: 161.136006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:53:38.277638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.339594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-02T07:53:38.277753Z","caller":"traceutil/trace.go:171","msg":"trace[101948934] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:293; }","duration":"101.503449ms","start":"2026-09-02T07:53:38.17623Z","end":"2026-09-02T07:53:38.277733Z","steps":["trace[101948934] 'range keys from in-memory index tree' (duration: 101.203ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:53:38.391652Z","caller":"traceutil/trace.go:171","msg":"trace[1879755631] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"110.131454ms","start":"2026-09-02T07:53:38.281496Z","end":"2026-09-02T07:53:38.391628Z","steps":["trace[1879755631] 'process raft request' (duration: 109.959649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:53:38.729206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.11485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T07:53:38.729328Z","caller":"traceutil/trace.go:171","msg":"trace[2026944450] linearizableReadLoop","detail":"{readStateIndex:304; appliedIndex:302; }","duration":"432.478769ms","start":"2026-09-02T07:53:38.296808Z","end":"2026-09-02T07:53:38.729287Z","steps":["trace[2026944450] 'read index received' (duration: 94.581718ms)","trace[2026944450] 'applied index is now lower than readState.Index' (duration: 337.895941ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T07:53:38.729325Z","caller":"traceutil/trace.go:171","msg":"trace[1215752627] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"447.5215ms","start":"2026-09-02T07:53:38.281772Z","end":"2026-09-02T07:53:38.729294Z","steps":["trace[1215752627] 'process raft request' (duration: 303.741761ms)","trace[1215752627] 'compare' (duration: 143.000347ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T07:53:38.729443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.213176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-02T07:53:38.729436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T07:53:38.281752Z","time spent":"447.625352ms","remote":"127.0.0.1:33258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T07:53:38.729492Z","caller":"traceutil/trace.go:171","msg":"trace[1124051664] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:0; response_revision:295; }","duration":"333.292588ms","start":"2026-09-02T07:53:38.396185Z","end":"2026-09-02T07:53:38.729477Z","steps":["trace[1124051664] 'agreement among raft nodes before linearized reading' (duration: 333.226936ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:53:38.729557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T07:53:38.396166Z","time spent":"333.38145ms","remote":"127.0.0.1:33196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" "} {"level":"warn","ts":"2026-09-02T07:53:38.729542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.704905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-02T07:53:38.729534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.706976ms","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-09-02T07:53:38.729622Z","caller":"traceutil/trace.go:171","msg":"trace[391995725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:295; }","duration":"122.822089ms","start":"2026-09-02T07:53:38.606779Z","end":"2026-09-02T07:53:38.729601Z","steps":["trace[391995725] 'agreement among raft nodes before linearized reading' (duration: 122.668634ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:53:38.729649Z","caller":"traceutil/trace.go:171","msg":"trace[1001693823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:295; }","duration":"432.831649ms","start":"2026-09-02T07:53:38.296789Z","end":"2026-09-02T07:53:38.729621Z","steps":["trace[1001693823] 'agreement among raft nodes before linearized reading' (duration: 432.607433ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:53:38.729714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T07:53:38.296711Z","time spent":"432.988604ms","remote":"127.0.0.1:33258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-02T07:53:38.729729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.05554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-02T07:53:38.729752Z","caller":"traceutil/trace.go:171","msg":"trace[2019590929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:295; }","duration":"275.078421ms","start":"2026-09-02T07:53:38.454667Z","end":"2026-09-02T07:53:38.729745Z","steps":["trace[2019590929] 'agreement among raft nodes before linearized reading' (duration: 275.023489ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.186639Z","caller":"traceutil/trace.go:171","msg":"trace[429428948] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"105.557477ms","start":"2026-09-02T07:54:09.081044Z","end":"2026-09-02T07:54:09.186602Z","steps":["trace[429428948] 'process raft request' (duration: 74.252145ms)","trace[429428948] 'compare' (duration: 31.20926ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T07:54:09.19451Z","caller":"traceutil/trace.go:171","msg":"trace[230174498] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"109.436603ms","start":"2026-09-02T07:54:09.085049Z","end":"2026-09-02T07:54:09.194486Z","steps":["trace[230174498] 'process raft request' (duration: 108.37607ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.194507Z","caller":"traceutil/trace.go:171","msg":"trace[733695145] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"109.377122ms","start":"2026-09-02T07:54:09.085093Z","end":"2026-09-02T07:54:09.19447Z","steps":["trace[733695145] 'process raft request' (duration: 108.463012ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.194756Z","caller":"traceutil/trace.go:171","msg":"trace[1097615879] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"109.704859ms","start":"2026-09-02T07:54:09.08504Z","end":"2026-09-02T07:54:09.194745Z","steps":["trace[1097615879] 'process raft request' (duration: 108.281997ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.195013Z","caller":"traceutil/trace.go:171","msg":"trace[174494271] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"105.72833ms","start":"2026-09-02T07:54:09.089274Z","end":"2026-09-02T07:54:09.195002Z","steps":["trace[174494271] 'process raft request' (duration: 104.420451ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.195162Z","caller":"traceutil/trace.go:171","msg":"trace[1856936551] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"105.920545ms","start":"2026-09-02T07:54:09.089209Z","end":"2026-09-02T07:54:09.19513Z","steps":["trace[1856936551] 'process raft request' (duration: 104.437282ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.195355Z","caller":"traceutil/trace.go:171","msg":"trace[1794944012] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"105.377843ms","start":"2026-09-02T07:54:09.089966Z","end":"2026-09-02T07:54:09.195344Z","steps":["trace[1794944012] 'process raft request' (duration: 103.959201ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.195437Z","caller":"traceutil/trace.go:171","msg":"trace[181382368] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"105.73666ms","start":"2026-09-02T07:54:09.089688Z","end":"2026-09-02T07:54:09.195425Z","steps":["trace[181382368] 'process raft request' (duration: 104.167795ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.195317Z","caller":"traceutil/trace.go:171","msg":"trace[1122241092] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"110.125149ms","start":"2026-09-02T07:54:09.085085Z","end":"2026-09-02T07:54:09.19521Z","steps":["trace[1122241092] 'process raft request' (duration: 108.440821ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.195071Z","caller":"traceutil/trace.go:171","msg":"trace[1626104392] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"105.901394ms","start":"2026-09-02T07:54:09.089164Z","end":"2026-09-02T07:54:09.195066Z","steps":["trace[1626104392] 'process raft request' (duration: 104.424001ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:09.194761Z","caller":"traceutil/trace.go:171","msg":"trace[1045201904] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"109.675269ms","start":"2026-09-02T07:54:09.085072Z","end":"2026-09-02T07:54:09.194747Z","steps":["trace[1045201904] 'process raft request' (duration: 108.420761ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:10.695328Z","caller":"traceutil/trace.go:171","msg":"trace[1117396672] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:584; }","duration":"238.892259ms","start":"2026-09-02T07:54:10.456406Z","end":"2026-09-02T07:54:10.695298Z","steps":["trace[1117396672] 'read index received' (duration: 238.207283ms)","trace[1117396672] 'applied index is now lower than readState.Index' (duration: 683.976µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T07:54:10.695385Z","caller":"traceutil/trace.go:171","msg":"trace[1367288782] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"252.038981ms","start":"2026-09-02T07:54:10.443314Z","end":"2026-09-02T07:54:10.695353Z","steps":["trace[1367288782] 'process raft request' (duration: 251.511339ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:54:10.695536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.115713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:20866"} {"level":"info","ts":"2026-09-02T07:54:10.695576Z","caller":"traceutil/trace.go:171","msg":"trace[832218747] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:566; }","duration":"239.197154ms","start":"2026-09-02T07:54:10.456366Z","end":"2026-09-02T07:54:10.695563Z","steps":["trace[832218747] 'agreement among raft nodes before linearized reading' (duration: 239.035641ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:15.449398Z","caller":"traceutil/trace.go:171","msg":"trace[1473545981] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"191.919132ms","start":"2026-09-02T07:54:15.25743Z","end":"2026-09-02T07:54:15.449349Z","steps":["trace[1473545981] 'process raft request' (duration: 191.188086ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:54:16.038577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.310272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T07:54:16.038823Z","caller":"traceutil/trace.go:171","msg":"trace[1142675363] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"155.888362ms","start":"2026-09-02T07:54:15.882898Z","end":"2026-09-02T07:54:16.038786Z","steps":["trace[1142675363] 'process raft request' (duration: 155.80255ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:54:16.038878Z","caller":"traceutil/trace.go:171","msg":"trace[1970897641] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"574.497653ms","start":"2026-09-02T07:54:15.46434Z","end":"2026-09-02T07:54:16.038838Z","steps":["trace[1970897641] 'read index received' (duration: 76.732922ms)","trace[1970897641] 'applied index is now lower than readState.Index' (duration: 497.744701ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T07:54:16.039001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.652257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T07:54:16.038991Z","caller":"traceutil/trace.go:171","msg":"trace[1395152016] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"574.744879ms","start":"2026-09-02T07:54:15.46422Z","end":"2026-09-02T07:54:16.038965Z","steps":["trace[1395152016] 'process raft request' (duration: 76.928256ms)","trace[1395152016] 'compare' (duration: 497.164599ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T07:54:16.039056Z","caller":"traceutil/trace.go:171","msg":"trace[1027910396] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:601; }","duration":"574.75974ms","start":"2026-09-02T07:54:15.464282Z","end":"2026-09-02T07:54:16.039042Z","steps":["trace[1027910396] 'agreement among raft nodes before linearized reading' (duration: 574.675888ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:54:16.039095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T07:54:15.464258Z","time spent":"574.82883ms","remote":"127.0.0.1:33506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-09-02T07:54:16.039115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T07:54:15.464183Z","time spent":"574.877742ms","remote":"127.0.0.1:33168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T07:55:33.882221Z","caller":"traceutil/trace.go:171","msg":"trace[248612090] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"133.929701ms","start":"2026-09-02T07:55:33.74826Z","end":"2026-09-02T07:55:33.88219Z","steps":["trace[248612090] 'process raft request' (duration: 133.744438ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:55:36.039255Z","caller":"traceutil/trace.go:171","msg":"trace[1058426763] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"152.046093ms","start":"2026-09-02T07:55:35.887177Z","end":"2026-09-02T07:55:36.039223Z","steps":["trace[1058426763] 'process raft request' (duration: 151.747789ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:55:36.24748Z","caller":"traceutil/trace.go:171","msg":"trace[2121767927] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"202.718558ms","start":"2026-09-02T07:55:36.044483Z","end":"2026-09-02T07:55:36.247201Z","steps":["trace[2121767927] 'process raft request' (duration: 152.479413ms)","trace[2121767927] 'compare' (duration: 49.939661ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T07:55:54.227262Z","caller":"traceutil/trace.go:171","msg":"trace[1551181689] transaction","detail":"{read_only:false; response_revision:1765; number_of_response:1; }","duration":"101.764917ms","start":"2026-09-02T07:55:54.12545Z","end":"2026-09-02T07:55:54.227215Z","steps":["trace[1551181689] 'process raft request' (duration: 101.526804ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:55:54.514786Z","caller":"traceutil/trace.go:171","msg":"trace[1034281455] linearizableReadLoop","detail":"{readStateIndex:1836; appliedIndex:1835; }","duration":"133.890871ms","start":"2026-09-02T07:55:54.380869Z","end":"2026-09-02T07:55:54.51476Z","steps":["trace[1034281455] 'read index received' (duration: 52.213103ms)","trace[1034281455] 'applied index is now lower than readState.Index' (duration: 81.676668ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T07:55:54.514807Z","caller":"traceutil/trace.go:171","msg":"trace[1986581331] transaction","detail":"{read_only:false; response_revision:1766; number_of_response:1; }","duration":"260.543176ms","start":"2026-09-02T07:55:54.254225Z","end":"2026-09-02T07:55:54.514769Z","steps":["trace[1986581331] 'process raft request' (duration: 178.97319ms)","trace[1986581331] 'compare' (duration: 81.273311ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T07:55:54.515043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.159324ms","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-02T07:55:54.515077Z","caller":"traceutil/trace.go:171","msg":"trace[47143578] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1766; }","duration":"134.279316ms","start":"2026-09-02T07:55:54.380787Z","end":"2026-09-02T07:55:54.515066Z","steps":["trace[47143578] 'agreement among raft nodes before linearized reading' (duration: 134.117794ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:55:54.515299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.064884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T07:55:54.515409Z","caller":"traceutil/trace.go:171","msg":"trace[2060541355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1766; }","duration":"116.239206ms","start":"2026-09-02T07:55:54.399144Z","end":"2026-09-02T07:55:54.515384Z","steps":["trace[2060541355] 'agreement among raft nodes before linearized reading' (duration: 115.82342ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:56:01.594806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.841784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-09-02T07:56:01.594842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.825675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-02T07:56:01.594655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.688226ms","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-09-02T07:56:01.594887Z","caller":"traceutil/trace.go:171","msg":"trace[1112839435] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1871; }","duration":"124.955486ms","start":"2026-09-02T07:56:01.469913Z","end":"2026-09-02T07:56:01.594868Z","steps":["trace[1112839435] 'range keys from in-memory index tree' (duration: 124.693992ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:01.594921Z","caller":"traceutil/trace.go:171","msg":"trace[337529030] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1871; }","duration":"162.963307ms","start":"2026-09-02T07:56:01.431936Z","end":"2026-09-02T07:56:01.594899Z","steps":["trace[337529030] 'count revisions from in-memory index tree' (duration: 162.743473ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:56:01.594807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.802504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T07:56:01.594973Z","caller":"traceutil/trace.go:171","msg":"trace[167166176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1871; }","duration":"196.018277ms","start":"2026-09-02T07:56:01.398937Z","end":"2026-09-02T07:56:01.594955Z","steps":["trace[167166176] 'range keys from in-memory index tree' (duration: 195.692402ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:01.595286Z","caller":"traceutil/trace.go:171","msg":"trace[431500883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1871; }","duration":"159.01613ms","start":"2026-09-02T07:56:01.435893Z","end":"2026-09-02T07:56:01.594909Z","steps":["trace[431500883] 'range keys from in-memory index tree' (duration: 158.522764ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:01.811315Z","caller":"traceutil/trace.go:171","msg":"trace[1787189484] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"212.35829ms","start":"2026-09-02T07:56:01.598927Z","end":"2026-09-02T07:56:01.811285Z","steps":["trace[1787189484] 'process raft request' (duration: 212.208188ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:01.823442Z","caller":"traceutil/trace.go:171","msg":"trace[1913729898] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"223.460617ms","start":"2026-09-02T07:56:01.599947Z","end":"2026-09-02T07:56:01.823407Z","steps":["trace[1913729898] 'process raft request' (duration: 223.378436ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:01.823708Z","caller":"traceutil/trace.go:171","msg":"trace[367009161] linearizableReadLoop","detail":"{readStateIndex:1946; appliedIndex:1942; }","duration":"122.334309ms","start":"2026-09-02T07:56:01.701343Z","end":"2026-09-02T07:56:01.823678Z","steps":["trace[367009161] 'read index received' (duration: 109.848882ms)","trace[367009161] 'applied index is now lower than readState.Index' (duration: 12.482817ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T07:56:01.823732Z","caller":"traceutil/trace.go:171","msg":"trace[440892902] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"224.575074ms","start":"2026-09-02T07:56:01.59913Z","end":"2026-09-02T07:56:01.823705Z","steps":["trace[440892902] 'process raft request' (duration: 224.111187ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:01.823852Z","caller":"traceutil/trace.go:171","msg":"trace[1558502325] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"223.682561ms","start":"2026-09-02T07:56:01.600126Z","end":"2026-09-02T07:56:01.823808Z","steps":["trace[1558502325] 'process raft request' (duration: 223.250505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:56:01.823967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.605103ms","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-09-02T07:56:01.824003Z","caller":"traceutil/trace.go:171","msg":"trace[394256082] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1875; }","duration":"122.685295ms","start":"2026-09-02T07:56:01.701306Z","end":"2026-09-02T07:56:01.823992Z","steps":["trace[394256082] 'agreement among raft nodes before linearized reading' (duration: 122.512122ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:02.205543Z","caller":"traceutil/trace.go:171","msg":"trace[1448545122] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"236.576489ms","start":"2026-09-02T07:56:01.968943Z","end":"2026-09-02T07:56:02.205519Z","steps":["trace[1448545122] 'process raft request' (duration: 236.408477ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:37.423745Z","caller":"traceutil/trace.go:171","msg":"trace[35973306] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2200; }","duration":"114.20091ms","start":"2026-09-02T07:56:37.30952Z","end":"2026-09-02T07:56:37.423721Z","steps":["trace[35973306] 'read index received' (duration: 114.019487ms)","trace[35973306] 'applied index is now lower than readState.Index' (duration: 180.493µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T07:56:37.423908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.338203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T07:56:37.423963Z","caller":"traceutil/trace.go:171","msg":"trace[2068819733] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2123; }","duration":"114.481174ms","start":"2026-09-02T07:56:37.309462Z","end":"2026-09-02T07:56:37.423944Z","steps":["trace[2068819733] 'agreement among raft nodes before linearized reading' (duration: 114.355042ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:37.42404Z","caller":"traceutil/trace.go:171","msg":"trace[1488093181] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"157.354142ms","start":"2026-09-02T07:56:37.266663Z","end":"2026-09-02T07:56:37.424017Z","steps":["trace[1488093181] 'process raft request' (duration: 156.893616ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T07:56:37.720072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.230719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-02T07:56:37.720188Z","caller":"traceutil/trace.go:171","msg":"trace[844951136] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2123; }","duration":"194.391102ms","start":"2026-09-02T07:56:37.525776Z","end":"2026-09-02T07:56:37.720167Z","steps":["trace[844951136] 'range keys from in-memory index tree' (duration: 193.942506ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T07:56:38.023695Z","caller":"traceutil/trace.go:171","msg":"trace[179970644] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"298.429514ms","start":"2026-09-02T07:56:37.725231Z","end":"2026-09-02T07:56:38.02366Z","steps":["trace[179970644] 'process raft request' (duration: 298.185011ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:02:45.032987Z","caller":"traceutil/trace.go:171","msg":"trace[1781248585] transaction","detail":"{read_only:false; response_revision:4353; number_of_response:1; }","duration":"176.071391ms","start":"2026-09-02T08:02:44.856891Z","end":"2026-09-02T08:02:45.032963Z","steps":["trace[1781248585] 'process raft request' (duration: 175.902728ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:03:01.262511Z","caller":"traceutil/trace.go:171","msg":"trace[259780174] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"130.95025ms","start":"2026-09-02T08:03:01.131544Z","end":"2026-09-02T08:03:01.262495Z","steps":["trace[259780174] 'process raft request' (duration: 130.607583ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:03:19.2766Z","caller":"traceutil/trace.go:171","msg":"trace[255554252] linearizableReadLoop","detail":"{readStateIndex:5369; appliedIndex:5368; }","duration":"135.020724ms","start":"2026-09-02T08:03:19.141528Z","end":"2026-09-02T08:03:19.276548Z","steps":["trace[255554252] 'read index received' (duration: 112.010422ms)","trace[255554252] 'applied index is now lower than readState.Index' (duration: 23.008922ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T08:03:19.276933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.381211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-09-02T08:03:19.27704Z","caller":"traceutil/trace.go:171","msg":"trace[1422576104] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5178; }","duration":"135.523963ms","start":"2026-09-02T08:03:19.141485Z","end":"2026-09-02T08:03:19.277009Z","steps":["trace[1422576104] 'agreement among raft nodes before linearized reading' (duration: 135.177757ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:03:19.424361Z","caller":"traceutil/trace.go:171","msg":"trace[1682591057] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"108.006739ms","start":"2026-09-02T08:03:19.316329Z","end":"2026-09-02T08:03:19.424336Z","steps":["trace[1682591057] 'process raft request' (duration: 81.109616ms)","trace[1682591057] 'compare' (duration: 26.676189ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T08:03:19.42462Z","caller":"traceutil/trace.go:171","msg":"trace[1843493527] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"108.127662ms","start":"2026-09-02T08:03:19.31647Z","end":"2026-09-02T08:03:19.424598Z","steps":["trace[1843493527] 'process raft request' (duration: 107.958429ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:03:19.424884Z","caller":"traceutil/trace.go:171","msg":"trace[125877076] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"108.482018ms","start":"2026-09-02T08:03:19.316339Z","end":"2026-09-02T08:03:19.424821Z","steps":["trace[125877076] 'process raft request' (duration: 107.926548ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:03:19.699129Z","caller":"traceutil/trace.go:171","msg":"trace[985210165] transaction","detail":"{read_only:false; response_revision:5184; number_of_response:1; }","duration":"169.441775ms","start":"2026-09-02T08:03:19.529652Z","end":"2026-09-02T08:03:19.699093Z","steps":["trace[985210165] 'process raft request' (duration: 70.124215ms)","trace[985210165] 'compare' (duration: 98.736359ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T08:03:30.24432Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2831} {"level":"info","ts":"2026-09-02T08:03:30.30528Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2831,"took":"59.928811ms","hash":687320296,"current-db-size-bytes":51150848,"current-db-size":"51 MB","current-db-size-in-use-bytes":27766784,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-02T08:03:30.305337Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":687320296,"revision":2831,"compact-revision":-1} {"level":"info","ts":"2026-09-02T08:03:53.502844Z","caller":"traceutil/trace.go:171","msg":"trace[924698462] linearizableReadLoop","detail":"{readStateIndex:5752; appliedIndex:5751; }","duration":"120.84386ms","start":"2026-09-02T08:03:53.381977Z","end":"2026-09-02T08:03:53.502821Z","steps":["trace[924698462] 'read index received' (duration: 120.629766ms)","trace[924698462] 'applied index is now lower than readState.Index' (duration: 212.914µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T08:03:53.503084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.085314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-api-846876bf8-zsnzk\" ","response":"range_response_count:1 size:11889"} {"level":"warn","ts":"2026-09-02T08:03:53.503091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.61783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T08:03:53.503121Z","caller":"traceutil/trace.go:171","msg":"trace[546189687] range","detail":"{range_begin:/registry/pods/openstack/keystone-api-846876bf8-zsnzk; range_end:; response_count:1; response_revision:5550; }","duration":"121.172946ms","start":"2026-09-02T08:03:53.381936Z","end":"2026-09-02T08:03:53.503109Z","steps":["trace[546189687] 'agreement among raft nodes before linearized reading' (duration: 121.016174ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:03:53.503167Z","caller":"traceutil/trace.go:171","msg":"trace[931015062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5550; }","duration":"104.725741ms","start":"2026-09-02T08:03:53.398424Z","end":"2026-09-02T08:03:53.50315Z","steps":["trace[931015062] 'agreement among raft nodes before linearized reading' (duration: 104.586399ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:03:53.502962Z","caller":"traceutil/trace.go:171","msg":"trace[105281317] transaction","detail":"{read_only:false; response_revision:5550; number_of_response:1; }","duration":"344.523629ms","start":"2026-09-02T08:03:53.158379Z","end":"2026-09-02T08:03:53.502902Z","steps":["trace[105281317] 'process raft request' (duration: 344.284074ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T08:03:53.503692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T08:03:53.158333Z","time spent":"345.292683ms","remote":"127.0.0.1:33258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T08:04:04.370652Z","caller":"traceutil/trace.go:171","msg":"trace[474179037] transaction","detail":"{read_only:false; response_revision:5617; number_of_response:1; }","duration":"123.362114ms","start":"2026-09-02T08:04:04.247202Z","end":"2026-09-02T08:04:04.370564Z","steps":["trace[474179037] 'process raft request' (duration: 123.032218ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T08:08:30.250539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5293} {"level":"info","ts":"2026-09-02T08:08:30.337027Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5293,"took":"84.948509ms","hash":14451762,"current-db-size-bytes":51150848,"current-db-size":"51 MB","current-db-size-in-use-bytes":19017728,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-02T08:08:30.337117Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":14451762,"revision":5293,"compact-revision":2831}