{"level":"warn","ts":"2026-08-31T19:48:11.085837Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-31T19:48:11.085917Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.223: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.223:2380","--initial-cluster=instance=https://162.253.55.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.223: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-08-31T19:48:11.085981Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-31T19:48:11.085993Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-08-31T19:48:11.086012Z","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-08-31T19:48:11.086788Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"]} {"level":"info","ts":"2026-08-31T19:48:11.086868Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.223: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-08-31T19:48:11.091396Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.28551ms"} {"level":"info","ts":"2026-08-31T19:48:11.100036Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0f50f8a6c5f7d06","cluster-id":"62f129f77cf8e487"} {"level":"info","ts":"2026-08-31T19:48:11.100211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=()"} {"level":"info","ts":"2026-08-31T19:48:11.100244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 0"} {"level":"info","ts":"2026-08-31T19:48:11.100273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0f50f8a6c5f7d06 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-31T19:48:11.100291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 1"} {"level":"info","ts":"2026-08-31T19:48:11.100353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"warn","ts":"2026-08-31T19:48:11.1067Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-31T19:48:11.112436Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-31T19:48:11.114263Z","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-08-31T19:48:11.116788Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0f50f8a6c5f7d06","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-31T19:48:11.11708Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0f50f8a6c5f7d06","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-31T19:48:11.117112Z","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-08-31T19:48:11.117275Z","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-08-31T19:48:11.117295Z","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-08-31T19:48:11.118231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"info","ts":"2026-08-31T19:48:11.118553Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","added-peer-id":"a0f50f8a6c5f7d06","added-peer-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-08-31T19:48:11.121778Z","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-08-31T19:48:11.122137Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0f50f8a6c5f7d06","initial-advertise-peer-urls":["https://162.253.55.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-31T19:48:11.122179Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-31T19:48:11.122277Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-08-31T19:48:11.122293Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-08-31T19:48:12.101397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 is starting a new election at term 1"} {"level":"info","ts":"2026-08-31T19:48:12.101457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-31T19:48:12.101478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgPreVoteResp from a0f50f8a6c5f7d06 at term 1"} {"level":"info","ts":"2026-08-31T19:48:12.101545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became candidate at term 2"} {"level":"info","ts":"2026-08-31T19:48:12.101571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgVoteResp from a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-08-31T19:48:12.101592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became leader at term 2"} {"level":"info","ts":"2026-08-31T19:48:12.101616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0f50f8a6c5f7d06 elected leader a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-08-31T19:48:12.10278Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-31T19:48:12.104082Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-31T19:48:12.104066Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0f50f8a6c5f7d06","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.223:2379]}","request-path":"/0/members/a0f50f8a6c5f7d06/attributes","cluster-id":"62f129f77cf8e487","publish-timeout":"7s"} {"level":"info","ts":"2026-08-31T19:48:12.104201Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-31T19:48:12.104557Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-31T19:48:12.104644Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-31T19:48:12.104658Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","cluster-version":"3.5"} {"level":"info","ts":"2026-08-31T19:48:12.104857Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-31T19:48:12.104901Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-31T19:48:12.107246Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-31T19:48:12.107983Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.223:2379"} {"level":"info","ts":"2026-08-31T19:48:57.548295Z","caller":"traceutil/trace.go:171","msg":"trace[97167060] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"172.223397ms","start":"2026-08-31T19:48:57.376024Z","end":"2026-08-31T19:48:57.548248Z","steps":["trace[97167060] 'process raft request' (duration: 171.695913ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:48:57.743487Z","caller":"traceutil/trace.go:171","msg":"trace[1568301825] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"106.034366ms","start":"2026-08-31T19:48:57.637425Z","end":"2026-08-31T19:48:57.743459Z","steps":["trace[1568301825] 'process raft request' (duration: 105.882762ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:48:57.99935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.180553ms","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-08-31T19:48:57.999542Z","caller":"traceutil/trace.go:171","msg":"trace[1677812746] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:609; }","duration":"101.407898ms","start":"2026-08-31T19:48:57.898113Z","end":"2026-08-31T19:48:57.999521Z","steps":["trace[1677812746] 'range keys from in-memory index tree' (duration: 101.156942ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:48:58.601851Z","caller":"traceutil/trace.go:171","msg":"trace[1296641594] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"443.224143ms","start":"2026-08-31T19:48:58.158587Z","end":"2026-08-31T19:48:58.601811Z","steps":["trace[1296641594] 'process raft request' (duration: 440.874914ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:48:58.601966Z","caller":"traceutil/trace.go:171","msg":"trace[861268394] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"426.792153ms","start":"2026-08-31T19:48:58.175145Z","end":"2026-08-31T19:48:58.601937Z","steps":["trace[861268394] 'process raft request' (duration: 426.579778ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:48:58.602087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.897239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:476"} {"level":"info","ts":"2026-08-31T19:48:58.602135Z","caller":"traceutil/trace.go:171","msg":"trace[1664293690] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"383.982871ms","start":"2026-08-31T19:48:58.218141Z","end":"2026-08-31T19:48:58.602124Z","steps":["trace[1664293690] 'agreement among raft nodes before linearized reading' (duration: 383.777796ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:48:58.601883Z","caller":"traceutil/trace.go:171","msg":"trace[293687812] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:632; }","duration":"383.697684ms","start":"2026-08-31T19:48:58.218167Z","end":"2026-08-31T19:48:58.601864Z","steps":["trace[293687812] 'read index received' (duration: 373.990176ms)","trace[293687812] 'applied index is now lower than readState.Index' (duration: 9.706388ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:48:58.602632Z","caller":"traceutil/trace.go:171","msg":"trace[1249398159] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"423.774037ms","start":"2026-08-31T19:48:58.178798Z","end":"2026-08-31T19:48:58.602572Z","steps":["trace[1249398159] 'process raft request' (duration: 422.987127ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:48:58.602166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T19:48:58.218114Z","time spent":"384.044062ms","remote":"127.0.0.1:36328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-31T19:48:58.60278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T19:48:58.178789Z","time spent":"423.91212ms","remote":"127.0.0.1:36252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T19:48:58.602782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T19:48:58.158546Z","time spent":"443.427768ms","remote":"127.0.0.1:36162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T19:48:58.602942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T19:48:58.175112Z","time spent":"426.908596ms","remote":"127.0.0.1:36328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T19:49:44.980382Z","caller":"traceutil/trace.go:171","msg":"trace[1592466946] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"125.814812ms","start":"2026-08-31T19:49:44.85454Z","end":"2026-08-31T19:49:44.980355Z","steps":["trace[1592466946] 'process raft request' (duration: 125.646067ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:49:45.050144Z","caller":"traceutil/trace.go:171","msg":"trace[1490639696] linearizableReadLoop","detail":"{readStateIndex:1216; appliedIndex:1214; }","duration":"193.102777ms","start":"2026-08-31T19:49:44.857019Z","end":"2026-08-31T19:49:45.050121Z","steps":["trace[1490639696] 'read index received' (duration: 123.167174ms)","trace[1490639696] 'applied index is now lower than readState.Index' (duration: 69.933633ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:49:45.050144Z","caller":"traceutil/trace.go:171","msg":"trace[748360824] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"194.514123ms","start":"2026-08-31T19:49:44.85561Z","end":"2026-08-31T19:49:45.050125Z","steps":["trace[748360824] 'process raft request' (duration: 193.726334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:49:45.050352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.310813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-31T19:49:45.050399Z","caller":"traceutil/trace.go:171","msg":"trace[1606258274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1181; }","duration":"193.390055ms","start":"2026-08-31T19:49:44.856999Z","end":"2026-08-31T19:49:45.050389Z","steps":["trace[1606258274] 'agreement among raft nodes before linearized reading' (duration: 193.227131ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:50:31.968294Z","caller":"traceutil/trace.go:171","msg":"trace[957081113] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"303.439659ms","start":"2026-08-31T19:50:31.664825Z","end":"2026-08-31T19:50:31.968264Z","steps":["trace[957081113] 'process raft request' (duration: 303.217693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:50:31.968517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T19:50:31.664807Z","time spent":"303.601393ms","remote":"127.0.0.1:36252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T19:50:32.112233Z","caller":"traceutil/trace.go:171","msg":"trace[1578848078] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"134.831039ms","start":"2026-08-31T19:50:31.977367Z","end":"2026-08-31T19:50:32.112198Z","steps":["trace[1578848078] 'process raft request' (duration: 98.108074ms)","trace[1578848078] 'compare' (duration: 36.52651ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:50:32.11244Z","caller":"traceutil/trace.go:171","msg":"trace[1785182810] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"134.89891ms","start":"2026-08-31T19:50:31.977517Z","end":"2026-08-31T19:50:32.112416Z","steps":["trace[1785182810] 'process raft request' (duration: 134.602783ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:50:32.11268Z","caller":"traceutil/trace.go:171","msg":"trace[387607181] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"135.985358ms","start":"2026-08-31T19:50:31.97667Z","end":"2026-08-31T19:50:32.112655Z","steps":["trace[387607181] 'process raft request' (duration: 135.650979ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:50:32.112724Z","caller":"traceutil/trace.go:171","msg":"trace[953927516] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"129.427173ms","start":"2026-08-31T19:50:31.983278Z","end":"2026-08-31T19:50:32.112706Z","steps":["trace[953927516] 'process raft request' (duration: 129.178466ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:51:17.046642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.373349ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T19:51:17.046716Z","caller":"traceutil/trace.go:171","msg":"trace[570356105] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"140.891168ms","start":"2026-08-31T19:51:16.905813Z","end":"2026-08-31T19:51:17.046704Z","steps":["trace[570356105] 'process raft request' (duration: 21.274313ms)","trace[570356105] 'compare' (duration: 119.264527ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:51:22.954132Z","caller":"traceutil/trace.go:171","msg":"trace[1825193878] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"107.186168ms","start":"2026-08-31T19:51:22.84682Z","end":"2026-08-31T19:51:22.954006Z","steps":["trace[1825193878] 'process raft request' (duration: 106.91657ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:52:19.359037Z","caller":"traceutil/trace.go:171","msg":"trace[1214143317] transaction","detail":"{read_only:false; response_revision:2666; number_of_response:1; }","duration":"113.887582ms","start":"2026-08-31T19:52:19.245127Z","end":"2026-08-31T19:52:19.359014Z","steps":["trace[1214143317] 'process raft request' (duration: 113.762759ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:52:19.424254Z","caller":"traceutil/trace.go:171","msg":"trace[1896069600] transaction","detail":"{read_only:false; response_revision:2667; number_of_response:1; }","duration":"160.037187ms","start":"2026-08-31T19:52:19.264192Z","end":"2026-08-31T19:52:19.424229Z","steps":["trace[1896069600] 'process raft request' (duration: 159.859762ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:52:19.424473Z","caller":"traceutil/trace.go:171","msg":"trace[1992348804] linearizableReadLoop","detail":"{readStateIndex:2769; appliedIndex:2767; }","duration":"136.860707ms","start":"2026-08-31T19:52:19.287596Z","end":"2026-08-31T19:52:19.424456Z","steps":["trace[1992348804] 'read index received' (duration: 71.247496ms)","trace[1992348804] 'applied index is now lower than readState.Index' (duration: 65.612251ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T19:52:19.424603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.99743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T19:52:19.424655Z","caller":"traceutil/trace.go:171","msg":"trace[767633039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2669; }","duration":"137.093412ms","start":"2026-08-31T19:52:19.287553Z","end":"2026-08-31T19:52:19.424646Z","steps":["trace[767633039] 'agreement among raft nodes before linearized reading' (duration: 137.00775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:52:19.424726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.570267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-31T19:52:19.424809Z","caller":"traceutil/trace.go:171","msg":"trace[60302172] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2669; }","duration":"121.72689ms","start":"2026-08-31T19:52:19.303066Z","end":"2026-08-31T19:52:19.424793Z","steps":["trace[60302172] 'agreement among raft nodes before linearized reading' (duration: 121.591617ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:52:53.264808Z","caller":"traceutil/trace.go:171","msg":"trace[44590594] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"116.399801ms","start":"2026-08-31T19:52:53.148375Z","end":"2026-08-31T19:52:53.264775Z","steps":["trace[44590594] 'process raft request' (duration: 116.219596ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:52:53.605626Z","caller":"traceutil/trace.go:171","msg":"trace[1627790478] transaction","detail":"{read_only:false; response_revision:2873; number_of_response:1; }","duration":"148.801915ms","start":"2026-08-31T19:52:53.456798Z","end":"2026-08-31T19:52:53.6056Z","steps":["trace[1627790478] 'process raft request' (duration: 136.882822ms)","trace[1627790478] 'compare' (duration: 11.351249ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:55:45.362582Z","caller":"traceutil/trace.go:171","msg":"trace[429275741] transaction","detail":"{read_only:false; response_revision:3922; number_of_response:1; }","duration":"104.634096ms","start":"2026-08-31T19:55:45.257912Z","end":"2026-08-31T19:55:45.362546Z","steps":["trace[429275741] 'process raft request' (duration: 104.485493ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:55:45.363067Z","caller":"traceutil/trace.go:171","msg":"trace[1164734866] transaction","detail":"{read_only:false; response_revision:3921; number_of_response:1; }","duration":"106.588296ms","start":"2026-08-31T19:55:45.256462Z","end":"2026-08-31T19:55:45.36305Z","steps":["trace[1164734866] 'process raft request' (duration: 81.381659ms)","trace[1164734866] 'compare' (duration: 24.377606ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:56:21.208712Z","caller":"traceutil/trace.go:171","msg":"trace[1402841302] transaction","detail":"{read_only:false; response_revision:4166; number_of_response:1; }","duration":"128.297578ms","start":"2026-08-31T19:56:21.080391Z","end":"2026-08-31T19:56:21.208688Z","steps":["trace[1402841302] 'process raft request' (duration: 128.124284ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:56:21.209135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.330196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-08-31T19:56:21.209221Z","caller":"traceutil/trace.go:171","msg":"trace[1306052467] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4166; }","duration":"100.450249ms","start":"2026-08-31T19:56:21.108753Z","end":"2026-08-31T19:56:21.209203Z","steps":["trace[1306052467] 'agreement among raft nodes before linearized reading' (duration: 100.283044ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:56:21.317433Z","caller":"traceutil/trace.go:171","msg":"trace[1060961101] linearizableReadLoop","detail":"{readStateIndex:4325; appliedIndex:4324; }","duration":"104.329098ms","start":"2026-08-31T19:56:21.213078Z","end":"2026-08-31T19:56:21.317407Z","steps":["trace[1060961101] 'read index received' (duration: 103.445035ms)","trace[1060961101] 'applied index is now lower than readState.Index' (duration: 883.133µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:56:21.317597Z","caller":"traceutil/trace.go:171","msg":"trace[32202595] transaction","detail":"{read_only:false; response_revision:4167; number_of_response:1; }","duration":"107.537429ms","start":"2026-08-31T19:56:21.210045Z","end":"2026-08-31T19:56:21.317582Z","steps":["trace[32202595] 'process raft request' (duration: 106.359438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:56:21.317923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.82164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-08-31T19:56:21.318022Z","caller":"traceutil/trace.go:171","msg":"trace[729622045] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4167; }","duration":"104.940893ms","start":"2026-08-31T19:56:21.213044Z","end":"2026-08-31T19:56:21.317985Z","steps":["trace[729622045] 'agreement among raft nodes before linearized reading' (duration: 104.735558ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:56:21.318514Z","caller":"traceutil/trace.go:171","msg":"trace[1113984676] transaction","detail":"{read_only:false; response_revision:4168; number_of_response:1; }","duration":"103.949018ms","start":"2026-08-31T19:56:21.214549Z","end":"2026-08-31T19:56:21.318498Z","steps":["trace[1113984676] 'process raft request' (duration: 103.62513ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:56:21.318642Z","caller":"traceutil/trace.go:171","msg":"trace[736218870] transaction","detail":"{read_only:false; response_revision:4169; number_of_response:1; }","duration":"103.587549ms","start":"2026-08-31T19:56:21.215035Z","end":"2026-08-31T19:56:21.318623Z","steps":["trace[736218870] 'process raft request' (duration: 103.213758ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:56:21.318662Z","caller":"traceutil/trace.go:171","msg":"trace[1792109529] transaction","detail":"{read_only:false; response_revision:4170; number_of_response:1; }","duration":"102.725567ms","start":"2026-08-31T19:56:21.215915Z","end":"2026-08-31T19:56:21.318641Z","steps":["trace[1792109529] 'process raft request' (duration: 102.378478ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:57:58.971584Z","caller":"traceutil/trace.go:171","msg":"trace[1181245207] transaction","detail":"{read_only:false; response_revision:5393; number_of_response:1; }","duration":"201.554914ms","start":"2026-08-31T19:57:58.770006Z","end":"2026-08-31T19:57:58.971561Z","steps":["trace[1181245207] 'process raft request' (duration: 201.40096ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:57:59.034695Z","caller":"traceutil/trace.go:171","msg":"trace[473603187] transaction","detail":"{read_only:false; response_revision:5394; number_of_response:1; }","duration":"199.861441ms","start":"2026-08-31T19:57:58.834804Z","end":"2026-08-31T19:57:59.034666Z","steps":["trace[473603187] 'process raft request' (duration: 184.411707ms)","trace[473603187] 'compare' (duration: 15.193788ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:57:59.349916Z","caller":"traceutil/trace.go:171","msg":"trace[1069032583] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5399; }","duration":"105.654751ms","start":"2026-08-31T19:57:59.244239Z","end":"2026-08-31T19:57:59.349893Z","steps":["trace[1069032583] 'process raft request' (duration: 105.61867ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:57:59.34999Z","caller":"traceutil/trace.go:171","msg":"trace[552036227] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"107.944009ms","start":"2026-08-31T19:57:59.242Z","end":"2026-08-31T19:57:59.349944Z","steps":["trace[552036227] 'process raft request' (duration: 107.676623ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:57:59.350021Z","caller":"traceutil/trace.go:171","msg":"trace[717682225] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"106.447602ms","start":"2026-08-31T19:57:59.243554Z","end":"2026-08-31T19:57:59.350001Z","steps":["trace[717682225] 'process raft request' (duration: 106.260316ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:58:12.134248Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2975} {"level":"info","ts":"2026-08-31T19:58:12.233747Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2975,"took":"97.280848ms","hash":2473800907,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":31186944,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-31T19:58:12.233829Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2473800907,"revision":2975,"compact-revision":-1} {"level":"info","ts":"2026-08-31T19:58:16.00569Z","caller":"traceutil/trace.go:171","msg":"trace[64358766] linearizableReadLoop","detail":"{readStateIndex:5901; appliedIndex:5899; }","duration":"100.516871ms","start":"2026-08-31T19:58:15.905146Z","end":"2026-08-31T19:58:16.005663Z","steps":["trace[64358766] 'read index received' (duration: 100.223403ms)","trace[64358766] 'applied index is now lower than readState.Index' (duration: 292.508µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T19:58:16.005898Z","caller":"traceutil/trace.go:171","msg":"trace[1811216172] transaction","detail":"{read_only:false; response_revision:5684; number_of_response:1; }","duration":"119.028942ms","start":"2026-08-31T19:58:15.886842Z","end":"2026-08-31T19:58:16.005871Z","steps":["trace[1811216172] 'process raft request' (duration: 118.763535ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:58:16.005929Z","caller":"traceutil/trace.go:171","msg":"trace[2032732922] transaction","detail":"{read_only:false; response_revision:5683; number_of_response:1; }","duration":"119.301009ms","start":"2026-08-31T19:58:15.886598Z","end":"2026-08-31T19:58:16.005899Z","steps":["trace[2032732922] 'process raft request' (duration: 118.851968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:58:16.006198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.044044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-31T19:58:16.006243Z","caller":"traceutil/trace.go:171","msg":"trace[779025566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5684; }","duration":"101.138666ms","start":"2026-08-31T19:58:15.905091Z","end":"2026-08-31T19:58:16.00623Z","steps":["trace[779025566] 'agreement among raft nodes before linearized reading' (duration: 100.896359ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:58:16.881601Z","caller":"traceutil/trace.go:171","msg":"trace[1846571756] transaction","detail":"{read_only:false; response_revision:5689; number_of_response:1; }","duration":"639.09153ms","start":"2026-08-31T19:58:16.242484Z","end":"2026-08-31T19:58:16.881576Z","steps":["trace[1846571756] 'process raft request' (duration: 638.923056ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T19:58:16.881749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T19:58:16.242456Z","time spent":"639.216113ms","remote":"127.0.0.1:36252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T19:58:16.881911Z","caller":"traceutil/trace.go:171","msg":"trace[194799134] linearizableReadLoop","detail":"{readStateIndex:5906; appliedIndex:5906; }","duration":"263.303737ms","start":"2026-08-31T19:58:16.618592Z","end":"2026-08-31T19:58:16.881896Z","steps":["trace[194799134] 'read index received' (duration: 263.295897ms)","trace[194799134] 'applied index is now lower than readState.Index' (duration: 6.27µs)"],"step_count":2} {"level":"warn","ts":"2026-08-31T19:58:16.882197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.578535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T19:58:16.88229Z","caller":"traceutil/trace.go:171","msg":"trace[1137721323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5689; }","duration":"263.739929ms","start":"2026-08-31T19:58:16.618531Z","end":"2026-08-31T19:58:16.882271Z","steps":["trace[1137721323] 'agreement among raft nodes before linearized reading' (duration: 263.555585ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T19:59:22.251162Z","caller":"traceutil/trace.go:171","msg":"trace[712591358] transaction","detail":"{read_only:false; response_revision:6385; number_of_response:1; }","duration":"130.002688ms","start":"2026-08-31T19:59:22.121126Z","end":"2026-08-31T19:59:22.251129Z","steps":["trace[712591358] 'process raft request' (duration: 129.71849ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:03:12.149186Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5628} {"level":"info","ts":"2026-08-31T20:03:12.238549Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5628,"took":"87.460935ms","hash":2762531802,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":28917760,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-31T20:03:12.23862Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2762531802,"revision":5628,"compact-revision":2975} {"level":"info","ts":"2026-08-31T20:05:03.080537Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023c5.wal"} {"level":"info","ts":"2026-08-31T20:05:18.913636Z","caller":"traceutil/trace.go:171","msg":"trace[2056977354] transaction","detail":"{read_only:false; response_revision:8925; number_of_response:1; }","duration":"109.82393ms","start":"2026-08-31T20:05:18.803783Z","end":"2026-08-31T20:05:18.913607Z","steps":["trace[2056977354] 'process raft request' (duration: 63.956991ms)","trace[2056977354] 'compare' (duration: 45.519989ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:05:18.913687Z","caller":"traceutil/trace.go:171","msg":"trace[1675185744] transaction","detail":"{read_only:false; response_revision:8926; number_of_response:1; }","duration":"109.344697ms","start":"2026-08-31T20:05:18.804314Z","end":"2026-08-31T20:05:18.913658Z","steps":["trace[1675185744] 'process raft request' (duration: 109.216774ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:05:19.380423Z","caller":"traceutil/trace.go:171","msg":"trace[161687123] transaction","detail":"{read_only:false; response_revision:8930; number_of_response:1; }","duration":"146.429323ms","start":"2026-08-31T20:05:19.233963Z","end":"2026-08-31T20:05:19.380392Z","steps":["trace[161687123] 'process raft request' (duration: 146.171595ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:05:35.571848Z","caller":"traceutil/trace.go:171","msg":"trace[28447845] transaction","detail":"{read_only:false; response_revision:9018; number_of_response:1; }","duration":"129.08883ms","start":"2026-08-31T20:05:35.442731Z","end":"2026-08-31T20:05:35.57182Z","steps":["trace[28447845] 'process raft request' (duration: 128.884925ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:05:35.654809Z","caller":"traceutil/trace.go:171","msg":"trace[1130788136] transaction","detail":"{read_only:false; response_revision:9019; number_of_response:1; }","duration":"106.71277ms","start":"2026-08-31T20:05:35.548077Z","end":"2026-08-31T20:05:35.65479Z","steps":["trace[1130788136] 'process raft request' (duration: 45.074709ms)","trace[1130788136] 'compare' (duration: 61.303361ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:05:35.897378Z","caller":"traceutil/trace.go:171","msg":"trace[2075428864] transaction","detail":"{read_only:false; response_revision:9020; number_of_response:1; }","duration":"178.037568ms","start":"2026-08-31T20:05:35.71931Z","end":"2026-08-31T20:05:35.897347Z","steps":["trace[2075428864] 'process raft request' (duration: 163.423675ms)","trace[2075428864] 'compare' (duration: 14.422767ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:05:47.158544Z","caller":"traceutil/trace.go:171","msg":"trace[419705312] transaction","detail":"{read_only:false; response_revision:9129; number_of_response:1; }","duration":"135.862874ms","start":"2026-08-31T20:05:47.022644Z","end":"2026-08-31T20:05:47.158507Z","steps":["trace[419705312] 'process raft request' (duration: 135.626618ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:05:51.367245Z","caller":"traceutil/trace.go:171","msg":"trace[1798629657] transaction","detail":"{read_only:false; response_revision:9153; number_of_response:1; }","duration":"194.223ms","start":"2026-08-31T20:05:51.172972Z","end":"2026-08-31T20:05:51.367195Z","steps":["trace[1798629657] 'process raft request' (duration: 193.287326ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:05:51.374956Z","caller":"traceutil/trace.go:171","msg":"trace[402205127] transaction","detail":"{read_only:false; response_revision:9154; number_of_response:1; }","duration":"154.482467ms","start":"2026-08-31T20:05:51.220445Z","end":"2026-08-31T20:05:51.374928Z","steps":["trace[402205127] 'process raft request' (duration: 154.318653ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:05:53.512569Z","caller":"traceutil/trace.go:171","msg":"trace[1512050791] transaction","detail":"{read_only:false; response_revision:9166; number_of_response:1; }","duration":"131.718697ms","start":"2026-08-31T20:05:53.380814Z","end":"2026-08-31T20:05:53.512533Z","steps":["trace[1512050791] 'process raft request' (duration: 131.523233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:06:03.734056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.823564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T20:06:03.734416Z","caller":"traceutil/trace.go:171","msg":"trace[84748294] transaction","detail":"{read_only:false; response_revision:9218; number_of_response:1; }","duration":"171.207444ms","start":"2026-08-31T20:06:03.56317Z","end":"2026-08-31T20:06:03.734378Z","steps":["trace[84748294] 'process raft request' (duration: 28.976349ms)","trace[84748294] 'compare' (duration: 141.568858ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:06:04.439527Z","caller":"traceutil/trace.go:171","msg":"trace[1728315344] transaction","detail":"{read_only:false; response_revision:9222; number_of_response:1; }","duration":"100.934443ms","start":"2026-08-31T20:06:04.338572Z","end":"2026-08-31T20:06:04.439506Z","steps":["trace[1728315344] 'process raft request' (duration: 100.760639ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:06:06.553381Z","caller":"traceutil/trace.go:171","msg":"trace[1915763857] linearizableReadLoop","detail":"{readStateIndex:9574; appliedIndex:9573; }","duration":"138.817647ms","start":"2026-08-31T20:06:06.414525Z","end":"2026-08-31T20:06:06.553342Z","steps":["trace[1915763857] 'read index received' (duration: 103.687082ms)","trace[1915763857] 'applied index is now lower than readState.Index' (duration: 35.129265ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:06:06.553446Z","caller":"traceutil/trace.go:171","msg":"trace[1430550406] transaction","detail":"{read_only:false; response_revision:9240; number_of_response:1; }","duration":"138.946151ms","start":"2026-08-31T20:06:06.414466Z","end":"2026-08-31T20:06:06.553412Z","steps":["trace[1430550406] 'process raft request' (duration: 103.554228ms)","trace[1430550406] 'compare' (duration: 35.167007ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T20:06:06.553628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.083865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-08-31T20:06:06.553714Z","caller":"traceutil/trace.go:171","msg":"trace[261466300] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:9240; }","duration":"139.185998ms","start":"2026-08-31T20:06:06.414509Z","end":"2026-08-31T20:06:06.553695Z","steps":["trace[261466300] 'agreement among raft nodes before linearized reading' (duration: 138.986982ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:06:06.569953Z","caller":"traceutil/trace.go:171","msg":"trace[108215389] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9241; }","duration":"152.199819ms","start":"2026-08-31T20:06:06.417719Z","end":"2026-08-31T20:06:06.569919Z","steps":["trace[108215389] 'process raft request' (duration: 152.075646ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:06:06.570036Z","caller":"traceutil/trace.go:171","msg":"trace[426091385] transaction","detail":"{read_only:false; response_revision:9241; number_of_response:1; }","duration":"155.338339ms","start":"2026-08-31T20:06:06.414663Z","end":"2026-08-31T20:06:06.570002Z","steps":["trace[426091385] 'process raft request' (duration: 155.010741ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:06:06.570154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.334149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-31T20:06:06.570206Z","caller":"traceutil/trace.go:171","msg":"trace[1967439707] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9241; }","duration":"126.410601ms","start":"2026-08-31T20:06:06.443783Z","end":"2026-08-31T20:06:06.570194Z","steps":["trace[1967439707] 'agreement among raft nodes before linearized reading' (duration: 126.265548ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:06:06.570293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.607556ms","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-08-31T20:06:06.570403Z","caller":"traceutil/trace.go:171","msg":"trace[50595088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9241; }","duration":"104.859673ms","start":"2026-08-31T20:06:06.465524Z","end":"2026-08-31T20:06:06.570384Z","steps":["trace[50595088] 'agreement among raft nodes before linearized reading' (duration: 104.485233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:06:06.57069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.307239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-08-31T20:06:06.570818Z","caller":"traceutil/trace.go:171","msg":"trace[1805653746] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:9241; }","duration":"155.423572ms","start":"2026-08-31T20:06:06.415347Z","end":"2026-08-31T20:06:06.570771Z","steps":["trace[1805653746] 'agreement among raft nodes before linearized reading' (duration: 154.492808ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:06:06.694938Z","caller":"traceutil/trace.go:171","msg":"trace[16065764] transaction","detail":"{read_only:false; response_revision:9243; number_of_response:1; }","duration":"119.079165ms","start":"2026-08-31T20:06:06.575834Z","end":"2026-08-31T20:06:06.694913Z","steps":["trace[16065764] 'process raft request' (duration: 79.851686ms)","trace[16065764] 'compare' (duration: 38.521461ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:06:06.695262Z","caller":"traceutil/trace.go:171","msg":"trace[1272889574] transaction","detail":"{read_only:false; response_revision:9245; number_of_response:1; }","duration":"118.384297ms","start":"2026-08-31T20:06:06.576855Z","end":"2026-08-31T20:06:06.695239Z","steps":["trace[1272889574] 'process raft request' (duration: 117.619658ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:06:06.695222Z","caller":"traceutil/trace.go:171","msg":"trace[789707265] transaction","detail":"{read_only:false; response_revision:9244; number_of_response:1; }","duration":"118.561921ms","start":"2026-08-31T20:06:06.576634Z","end":"2026-08-31T20:06:06.695196Z","steps":["trace[789707265] 'process raft request' (duration: 117.754851ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:06:06.696136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.74429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-31T20:06:06.696187Z","caller":"traceutil/trace.go:171","msg":"trace[511332487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9246; }","duration":"113.826271ms","start":"2026-08-31T20:06:06.582345Z","end":"2026-08-31T20:06:06.696171Z","steps":["trace[511332487] 'agreement among raft nodes before linearized reading' (duration: 113.695688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:06:06.696301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.47885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-44cxj\" ","response":"range_response_count:1 size:4673"} {"level":"info","ts":"2026-08-31T20:06:06.696332Z","caller":"traceutil/trace.go:171","msg":"trace[454293667] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-44cxj; range_end:; response_count:1; response_revision:9246; }","duration":"120.510411ms","start":"2026-08-31T20:06:06.575811Z","end":"2026-08-31T20:06:06.696322Z","steps":["trace[454293667] 'agreement among raft nodes before linearized reading' (duration: 120.452469ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:06:48.960708Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a0f50f8a6c5f7d06","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-31T20:06:48.969104Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-31T20:06:48.969247Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-31T20:08:12.156688Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7981} {"level":"info","ts":"2026-08-31T20:08:12.229141Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7981,"took":"69.95131ms","hash":574087405,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":28008448,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-31T20:08:12.229201Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":574087405,"revision":7981,"compact-revision":5628} {"level":"info","ts":"2026-08-31T20:13:12.171024Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10336} {"level":"info","ts":"2026-08-31T20:13:12.259483Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10336,"took":"86.232803ms","hash":1763198876,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":25579520,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-31T20:13:12.259547Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1763198876,"revision":10336,"compact-revision":7981} {"level":"warn","ts":"2026-08-31T20:13:25.228787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.543393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T20:13:25.228906Z","caller":"traceutil/trace.go:171","msg":"trace[1071735960] transaction","detail":"{read_only:false; response_revision:12580; number_of_response:1; }","duration":"151.484042ms","start":"2026-08-31T20:13:25.077402Z","end":"2026-08-31T20:13:25.228886Z","steps":["trace[1071735960] 'process raft request' (duration: 45.737273ms)","trace[1071735960] 'compare' (duration: 105.38875ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:13:25.710795Z","caller":"traceutil/trace.go:171","msg":"trace[1763792838] transaction","detail":"{read_only:false; response_revision:12582; number_of_response:1; }","duration":"240.334741ms","start":"2026-08-31T20:13:25.470432Z","end":"2026-08-31T20:13:25.710766Z","steps":["trace[1763792838] 'process raft request' (duration: 227.576897ms)","trace[1763792838] 'compare' (duration: 12.638501ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:13:25.729037Z","caller":"traceutil/trace.go:171","msg":"trace[277261031] transaction","detail":"{read_only:false; response_revision:12583; number_of_response:1; }","duration":"237.023448ms","start":"2026-08-31T20:13:25.49199Z","end":"2026-08-31T20:13:25.729014Z","steps":["trace[277261031] 'process raft request' (duration: 236.518064ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:13:25.72909Z","caller":"traceutil/trace.go:171","msg":"trace[875931618] transaction","detail":"{read_only:false; response_revision:12584; number_of_response:1; }","duration":"236.217337ms","start":"2026-08-31T20:13:25.492847Z","end":"2026-08-31T20:13:25.729065Z","steps":["trace[875931618] 'process raft request' (duration: 235.822137ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:18:12.177988Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12504} {"level":"info","ts":"2026-08-31T20:18:12.263134Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12504,"took":"82.635359ms","hash":711583070,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":27693056,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-31T20:18:12.263195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":711583070,"revision":12504,"compact-revision":10336} {"level":"info","ts":"2026-08-31T20:19:41.083557Z","caller":"traceutil/trace.go:171","msg":"trace[968457799] transaction","detail":"{read_only:false; response_revision:15104; number_of_response:1; }","duration":"189.937522ms","start":"2026-08-31T20:19:40.893556Z","end":"2026-08-31T20:19:41.083493Z","steps":["trace[968457799] 'process raft request' (duration: 186.609608ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:20:02.874302Z","caller":"traceutil/trace.go:171","msg":"trace[1583631653] transaction","detail":"{read_only:false; response_revision:15213; number_of_response:1; }","duration":"168.013494ms","start":"2026-08-31T20:20:02.706257Z","end":"2026-08-31T20:20:02.87427Z","steps":["trace[1583631653] 'process raft request' (duration: 167.758817ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:20:21.076092Z","caller":"traceutil/trace.go:171","msg":"trace[1074017343] transaction","detail":"{read_only:false; response_revision:15322; number_of_response:1; }","duration":"104.094298ms","start":"2026-08-31T20:20:20.971956Z","end":"2026-08-31T20:20:21.076051Z","steps":["trace[1074017343] 'process raft request' (duration: 103.869593ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:20:22.035602Z","caller":"traceutil/trace.go:171","msg":"trace[1379435789] linearizableReadLoop","detail":"{readStateIndex:15871; appliedIndex:15870; }","duration":"295.703983ms","start":"2026-08-31T20:20:21.73986Z","end":"2026-08-31T20:20:22.035564Z","steps":["trace[1379435789] 'read index received' (duration: 295.349124ms)","trace[1379435789] 'applied index is now lower than readState.Index' (duration: 353.749µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:20:22.035795Z","caller":"traceutil/trace.go:171","msg":"trace[667308539] transaction","detail":"{read_only:false; response_revision:15329; number_of_response:1; }","duration":"353.892543ms","start":"2026-08-31T20:20:21.681829Z","end":"2026-08-31T20:20:22.035721Z","steps":["trace[667308539] 'process raft request' (duration: 353.497763ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:20:22.036004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.115152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-62948\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-08-31T20:20:22.036086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:20:21.681762Z","time spent":"354.17192ms","remote":"127.0.0.1:36252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T20:20:22.036112Z","caller":"traceutil/trace.go:171","msg":"trace[1842169109] range","detail":"{range_begin:/registry/pods/openstack/keepalived-62948; range_end:; response_count:1; response_revision:15329; }","duration":"191.253785ms","start":"2026-08-31T20:20:21.844834Z","end":"2026-08-31T20:20:22.036088Z","steps":["trace[1842169109] 'agreement among raft nodes before linearized reading' (duration: 190.960868ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:20:22.035863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.96317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-31T20:20:22.036261Z","caller":"traceutil/trace.go:171","msg":"trace[394125752] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:15329; }","duration":"296.35526ms","start":"2026-08-31T20:20:21.739843Z","end":"2026-08-31T20:20:22.036199Z","steps":["trace[394125752] 'agreement among raft nodes before linearized reading' (duration: 295.922309ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:20:47.704048Z","caller":"traceutil/trace.go:171","msg":"trace[1758708122] linearizableReadLoop","detail":"{readStateIndex:16211; appliedIndex:16210; }","duration":"131.711431ms","start":"2026-08-31T20:20:47.572277Z","end":"2026-08-31T20:20:47.703988Z","steps":["trace[1758708122] 'read index received' (duration: 131.314501ms)","trace[1758708122] 'applied index is now lower than readState.Index' (duration: 395.51µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:20:47.704245Z","caller":"traceutil/trace.go:171","msg":"trace[1353579806] transaction","detail":"{read_only:false; response_revision:15656; number_of_response:1; }","duration":"133.67264ms","start":"2026-08-31T20:20:47.570531Z","end":"2026-08-31T20:20:47.704203Z","steps":["trace[1353579806] 'process raft request' (duration: 133.166928ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:20:47.704554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.215224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-31T20:20:47.704645Z","caller":"traceutil/trace.go:171","msg":"trace[434452602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15656; }","duration":"132.404189ms","start":"2026-08-31T20:20:47.572226Z","end":"2026-08-31T20:20:47.70463Z","steps":["trace[434452602] 'agreement among raft nodes before linearized reading' (duration: 132.083201ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:20:48.063088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.364562ms","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-08-31T20:20:48.063254Z","caller":"traceutil/trace.go:171","msg":"trace[920040350] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:15656; }","duration":"164.552496ms","start":"2026-08-31T20:20:47.898676Z","end":"2026-08-31T20:20:48.063228Z","steps":["trace[920040350] 'range keys from in-memory index tree' (duration: 164.31514ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:20:48.06426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.309614ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T20:20:48.064754Z","caller":"traceutil/trace.go:171","msg":"trace[1717217892] linearizableReadLoop","detail":"{readStateIndex:16212; appliedIndex:16211; }","duration":"352.357385ms","start":"2026-08-31T20:20:47.712367Z","end":"2026-08-31T20:20:48.064725Z","steps":["trace[1717217892] 'read index received' (duration: 53.84874ms)","trace[1717217892] 'applied index is now lower than readState.Index' (duration: 298.506345ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:20:48.064832Z","caller":"traceutil/trace.go:171","msg":"trace[659888454] transaction","detail":"{read_only:false; response_revision:15657; number_of_response:1; }","duration":"354.081099ms","start":"2026-08-31T20:20:47.710689Z","end":"2026-08-31T20:20:48.06477Z","steps":["trace[659888454] 'process raft request' (duration: 55.491583ms)","trace[659888454] 'compare' (duration: 296.876182ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T20:20:48.065083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:20:47.710659Z","time spent":"354.289383ms","remote":"127.0.0.1:36328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T20:20:48.065982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.717991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:17 size:156837"} {"level":"info","ts":"2026-08-31T20:20:48.066099Z","caller":"traceutil/trace.go:171","msg":"trace[927932674] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:17; response_revision:15657; }","duration":"247.867165ms","start":"2026-08-31T20:20:47.818187Z","end":"2026-08-31T20:20:48.066054Z","steps":["trace[927932674] 'agreement among raft nodes before linearized reading' (duration: 246.8593ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:20:48.066444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.016296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:66 size:630551"} {"level":"info","ts":"2026-08-31T20:20:48.066532Z","caller":"traceutil/trace.go:171","msg":"trace[1837652966] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:66; response_revision:15657; }","duration":"354.12481ms","start":"2026-08-31T20:20:47.712362Z","end":"2026-08-31T20:20:48.066487Z","steps":["trace[1837652966] 'agreement among raft nodes before linearized reading' (duration: 352.55884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:20:48.066617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:20:47.712327Z","time spent":"354.246053ms","remote":"127.0.0.1:36252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":66,"response size":630574,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-08-31T20:21:43.801045Z","caller":"traceutil/trace.go:171","msg":"trace[751472591] transaction","detail":"{read_only:false; response_revision:16307; number_of_response:1; }","duration":"138.977036ms","start":"2026-08-31T20:21:43.662036Z","end":"2026-08-31T20:21:43.801013Z","steps":["trace[751472591] 'process raft request' (duration: 105.433052ms)","trace[751472591] 'compare' (duration: 33.344268ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:21:43.801251Z","caller":"traceutil/trace.go:171","msg":"trace[1414183582] transaction","detail":"{read_only:false; response_revision:16308; number_of_response:1; }","duration":"132.46547ms","start":"2026-08-31T20:21:43.668749Z","end":"2026-08-31T20:21:43.801215Z","steps":["trace[1414183582] 'process raft request' (duration: 132.216834ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:22:05.055066Z","caller":"traceutil/trace.go:171","msg":"trace[780340296] transaction","detail":"{read_only:false; response_revision:16419; number_of_response:1; }","duration":"152.773267ms","start":"2026-08-31T20:22:04.90225Z","end":"2026-08-31T20:22:05.055023Z","steps":["trace[780340296] 'process raft request' (duration: 106.744415ms)","trace[780340296] 'compare' (duration: 45.859177ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:22:05.950688Z","caller":"traceutil/trace.go:171","msg":"trace[1203116337] transaction","detail":"{read_only:false; response_revision:16423; number_of_response:1; }","duration":"192.143118ms","start":"2026-08-31T20:22:05.758523Z","end":"2026-08-31T20:22:05.950667Z","steps":["trace[1203116337] 'process raft request' (duration: 191.983384ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:22:06.011176Z","caller":"traceutil/trace.go:171","msg":"trace[23137667] linearizableReadLoop","detail":"{readStateIndex:17001; appliedIndex:16998; }","duration":"114.042082ms","start":"2026-08-31T20:22:05.897109Z","end":"2026-08-31T20:22:06.011151Z","steps":["trace[23137667] 'read index received' (duration: 53.503032ms)","trace[23137667] 'applied index is now lower than readState.Index' (duration: 60.538ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:22:06.011503Z","caller":"traceutil/trace.go:171","msg":"trace[1265016285] transaction","detail":"{read_only:false; response_revision:16424; number_of_response:1; }","duration":"120.106266ms","start":"2026-08-31T20:22:05.891384Z","end":"2026-08-31T20:22:06.011491Z","steps":["trace[1265016285] 'process raft request' (duration: 119.153512ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:22:06.011682Z","caller":"traceutil/trace.go:171","msg":"trace[1630761937] transaction","detail":"{read_only:false; response_revision:16425; number_of_response:1; }","duration":"115.445276ms","start":"2026-08-31T20:22:05.896227Z","end":"2026-08-31T20:22:06.011672Z","steps":["trace[1630761937] 'process raft request' (duration: 114.874812ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:22:06.011935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.80179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:669"} {"level":"info","ts":"2026-08-31T20:22:06.012034Z","caller":"traceutil/trace.go:171","msg":"trace[1928057328] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16425; }","duration":"114.941685ms","start":"2026-08-31T20:22:05.897069Z","end":"2026-08-31T20:22:06.01201Z","steps":["trace[1928057328] 'agreement among raft nodes before linearized reading' (duration: 114.685728ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:23:12.184927Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14539} {"level":"info","ts":"2026-08-31T20:23:12.270992Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14539,"took":"83.127405ms","hash":2470871738,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":30089216,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-31T20:23:12.271219Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2470871738,"revision":14539,"compact-revision":12504} {"level":"info","ts":"2026-08-31T20:28:12.199511Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16829} {"level":"info","ts":"2026-08-31T20:28:12.308568Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16829,"took":"106.18003ms","hash":208597387,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":30961664,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-31T20:28:12.30866Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":208597387,"revision":16829,"compact-revision":14539} {"level":"info","ts":"2026-08-31T20:28:55.525314Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a0f50f8a6c5f7d06","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-31T20:28:55.532922Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-31T20:28:55.533038Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-31T20:28:56.285977Z","caller":"traceutil/trace.go:171","msg":"trace[945680397] transaction","detail":"{read_only:false; response_revision:19332; number_of_response:1; }","duration":"109.476684ms","start":"2026-08-31T20:28:56.17647Z","end":"2026-08-31T20:28:56.285947Z","steps":["trace[945680397] 'process raft request' (duration: 109.177666ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:29:04.863335Z","caller":"traceutil/trace.go:171","msg":"trace[1488418953] linearizableReadLoop","detail":"{readStateIndex:20052; appliedIndex:20051; }","duration":"132.890858ms","start":"2026-08-31T20:29:04.73042Z","end":"2026-08-31T20:29:04.863311Z","steps":["trace[1488418953] 'read index received' (duration: 132.660023ms)","trace[1488418953] 'applied index is now lower than readState.Index' (duration: 229.475µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:29:04.863407Z","caller":"traceutil/trace.go:171","msg":"trace[2049957854] transaction","detail":"{read_only:false; response_revision:19376; number_of_response:1; }","duration":"148.273971ms","start":"2026-08-31T20:29:04.715084Z","end":"2026-08-31T20:29:04.863358Z","steps":["trace[2049957854] 'process raft request' (duration: 148.007824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:29:04.863501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.046162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-31T20:29:04.863651Z","caller":"traceutil/trace.go:171","msg":"trace[2065150586] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:19376; }","duration":"133.136695ms","start":"2026-08-31T20:29:04.730395Z","end":"2026-08-31T20:29:04.863532Z","steps":["trace[2065150586] 'agreement among raft nodes before linearized reading' (duration: 133.002192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:29:05.361603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.571519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-31T20:29:05.361677Z","caller":"traceutil/trace.go:171","msg":"trace[249769479] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:0; response_revision:19378; }","duration":"266.681442ms","start":"2026-08-31T20:29:05.094966Z","end":"2026-08-31T20:29:05.361648Z","steps":["trace[249769479] 'range keys from in-memory index tree' (duration: 266.486937ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:29:05.36245Z","caller":"traceutil/trace.go:171","msg":"trace[1982180878] transaction","detail":"{read_only:false; response_revision:19379; number_of_response:1; }","duration":"194.101205ms","start":"2026-08-31T20:29:05.168319Z","end":"2026-08-31T20:29:05.36242Z","steps":["trace[1982180878] 'process raft request' (duration: 188.582365ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:29:05.432839Z","caller":"traceutil/trace.go:171","msg":"trace[1731303079] transaction","detail":"{read_only:false; response_revision:19380; number_of_response:1; }","duration":"154.363605ms","start":"2026-08-31T20:29:05.278437Z","end":"2026-08-31T20:29:05.432801Z","steps":["trace[1731303079] 'process raft request' (duration: 154.088218ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:29:05.433099Z","caller":"traceutil/trace.go:171","msg":"trace[938876427] transaction","detail":"{read_only:false; response_revision:19381; number_of_response:1; }","duration":"145.959651ms","start":"2026-08-31T20:29:05.287068Z","end":"2026-08-31T20:29:05.433028Z","steps":["trace[938876427] 'process raft request' (duration: 145.637063ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:29:05.866526Z","caller":"traceutil/trace.go:171","msg":"trace[687311902] linearizableReadLoop","detail":"{readStateIndex:20059; appliedIndex:20058; }","duration":"392.639855ms","start":"2026-08-31T20:29:05.473851Z","end":"2026-08-31T20:29:05.866491Z","steps":["trace[687311902] 'read index received' (duration: 369.798713ms)","trace[687311902] 'applied index is now lower than readState.Index' (duration: 22.824001ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:29:05.866706Z","caller":"traceutil/trace.go:171","msg":"trace[95998127] transaction","detail":"{read_only:false; response_revision:19383; number_of_response:1; }","duration":"408.497108ms","start":"2026-08-31T20:29:05.458121Z","end":"2026-08-31T20:29:05.866618Z","steps":["trace[95998127] 'process raft request' (duration: 385.463392ms)","trace[95998127] 'compare' (duration: 22.647586ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T20:29:05.866859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.990833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-6rdsc\" ","response":"range_response_count:1 size:22101"} {"level":"info","ts":"2026-08-31T20:29:05.866922Z","caller":"traceutil/trace.go:171","msg":"trace[867655952] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-6rdsc; range_end:; response_count:1; response_revision:19383; }","duration":"393.110636ms","start":"2026-08-31T20:29:05.473797Z","end":"2026-08-31T20:29:05.866908Z","steps":["trace[867655952] 'agreement among raft nodes before linearized reading' (duration: 392.85468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:29:05.866966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:29:05.473774Z","time spent":"393.181228ms","remote":"127.0.0.1:36252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22124,"request content":"key:\"/registry/pods/openstack/nova-compute-default-6rdsc\" "} {"level":"warn","ts":"2026-08-31T20:29:05.866967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:29:05.4581Z","time spent":"408.722334ms","remote":"127.0.0.1:60040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1942,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T20:29:05.9074Z","caller":"traceutil/trace.go:171","msg":"trace[318775077] transaction","detail":"{read_only:false; response_revision:19385; number_of_response:1; }","duration":"204.797999ms","start":"2026-08-31T20:29:05.702575Z","end":"2026-08-31T20:29:05.907373Z","steps":["trace[318775077] 'process raft request' (duration: 204.706686ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:29:05.90772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.410641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.223\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-08-31T20:29:05.907404Z","caller":"traceutil/trace.go:171","msg":"trace[641859218] transaction","detail":"{read_only:false; response_revision:19384; number_of_response:1; }","duration":"239.376528ms","start":"2026-08-31T20:29:05.667996Z","end":"2026-08-31T20:29:05.907372Z","steps":["trace[641859218] 'process raft request' (duration: 239.155182ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:29:05.907481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.692614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-08-31T20:29:05.908124Z","caller":"traceutil/trace.go:171","msg":"trace[353153213] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19385; }","duration":"144.356311ms","start":"2026-08-31T20:29:05.763747Z","end":"2026-08-31T20:29:05.908104Z","steps":["trace[353153213] 'agreement among raft nodes before linearized reading' (duration: 143.627083ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:29:05.90902Z","caller":"traceutil/trace.go:171","msg":"trace[2033505931] range","detail":"{range_begin:/registry/masterleases/162.253.55.223; range_end:; response_count:1; response_revision:19385; }","duration":"387.560234ms","start":"2026-08-31T20:29:05.520246Z","end":"2026-08-31T20:29:05.907806Z","steps":["trace[2033505931] 'agreement among raft nodes before linearized reading' (duration: 387.186785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:29:05.909097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:29:05.520234Z","time spent":"388.846017ms","remote":"127.0.0.1:36100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/162.253.55.223\" "} {"level":"info","ts":"2026-08-31T20:29:06.1021Z","caller":"traceutil/trace.go:171","msg":"trace[885150122] linearizableReadLoop","detail":"{readStateIndex:20062; appliedIndex:20061; }","duration":"194.706381ms","start":"2026-08-31T20:29:05.907342Z","end":"2026-08-31T20:29:06.102048Z","steps":["trace[885150122] 'read index received' (duration: 194.544897ms)","trace[885150122] 'applied index is now lower than readState.Index' (duration: 160.114µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:29:06.102184Z","caller":"traceutil/trace.go:171","msg":"trace[744740379] transaction","detail":"{read_only:false; response_revision:19386; number_of_response:1; }","duration":"226.871299ms","start":"2026-08-31T20:29:05.875276Z","end":"2026-08-31T20:29:06.102148Z","steps":["trace[744740379] 'process raft request' (duration: 226.609802ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:29:06.103185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.308699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946783"} {"level":"info","ts":"2026-08-31T20:29:06.103238Z","caller":"traceutil/trace.go:171","msg":"trace[819655098] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:19386; }","duration":"227.399112ms","start":"2026-08-31T20:29:05.875826Z","end":"2026-08-31T20:29:06.103225Z","steps":["trace[819655098] 'agreement among raft nodes before linearized reading' (duration: 226.372106ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:29:06.111737Z","caller":"traceutil/trace.go:171","msg":"trace[571353649] transaction","detail":"{read_only:false; response_revision:19387; number_of_response:1; }","duration":"199.484082ms","start":"2026-08-31T20:29:05.912235Z","end":"2026-08-31T20:29:06.111719Z","steps":["trace[571353649] 'process raft request' (duration: 199.00853ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:33:12.207138Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19046} {"level":"info","ts":"2026-08-31T20:33:12.308466Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19046,"took":"97.950214ms","hash":4102711960,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":34050048,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-31T20:33:12.308541Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4102711960,"revision":19046,"compact-revision":16829} {"level":"info","ts":"2026-08-31T20:35:08.534654Z","caller":"traceutil/trace.go:171","msg":"trace[2032970778] linearizableReadLoop","detail":"{readStateIndex:22957; appliedIndex:22956; }","duration":"191.286131ms","start":"2026-08-31T20:35:08.343317Z","end":"2026-08-31T20:35:08.534604Z","steps":["trace[2032970778] 'read index received' (duration: 191.2519ms)","trace[2032970778] 'applied index is now lower than readState.Index' (duration: 32.951µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:35:08.534689Z","caller":"traceutil/trace.go:171","msg":"trace[1025304627] transaction","detail":"{read_only:false; response_revision:22190; number_of_response:1; }","duration":"191.979859ms","start":"2026-08-31T20:35:08.342659Z","end":"2026-08-31T20:35:08.534639Z","steps":["trace[1025304627] 'process raft request' (duration: 191.735702ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:35:08.534929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.579628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-31T20:35:08.534969Z","caller":"traceutil/trace.go:171","msg":"trace[591940721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22190; }","duration":"191.665709ms","start":"2026-08-31T20:35:08.343296Z","end":"2026-08-31T20:35:08.534962Z","steps":["trace[591940721] 'agreement among raft nodes before linearized reading' (duration: 191.454214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:35:08.580746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.070973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-31T20:35:08.580758Z","caller":"traceutil/trace.go:171","msg":"trace[976071482] transaction","detail":"{read_only:false; response_revision:22191; number_of_response:1; }","duration":"198.943025ms","start":"2026-08-31T20:35:08.38177Z","end":"2026-08-31T20:35:08.580713Z","steps":["trace[976071482] 'process raft request' (duration: 197.299693ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:35:08.580866Z","caller":"traceutil/trace.go:171","msg":"trace[1813210108] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:22191; }","duration":"189.252758ms","start":"2026-08-31T20:35:08.391588Z","end":"2026-08-31T20:35:08.58084Z","steps":["trace[1813210108] 'agreement among raft nodes before linearized reading' (duration: 189.034343ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:35:08.581189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.470774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-31T20:35:08.581257Z","caller":"traceutil/trace.go:171","msg":"trace[23224324] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:22191; }","duration":"187.591556ms","start":"2026-08-31T20:35:08.39365Z","end":"2026-08-31T20:35:08.581242Z","steps":["trace[23224324] 'agreement among raft nodes before linearized reading' (duration: 187.502774ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:35:31.334518Z","caller":"traceutil/trace.go:171","msg":"trace[1384820761] transaction","detail":"{read_only:false; response_revision:22319; number_of_response:1; }","duration":"236.180963ms","start":"2026-08-31T20:35:31.098272Z","end":"2026-08-31T20:35:31.334453Z","steps":["trace[1384820761] 'process raft request' (duration: 143.234387ms)","trace[1384820761] 'compare' (duration: 90.871613ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:35:31.334662Z","caller":"traceutil/trace.go:171","msg":"trace[1023272480] linearizableReadLoop","detail":"{readStateIndex:23093; appliedIndex:23091; }","duration":"209.126584ms","start":"2026-08-31T20:35:31.125431Z","end":"2026-08-31T20:35:31.334558Z","steps":["trace[1023272480] 'read index received' (duration: 116.087076ms)","trace[1023272480] 'applied index is now lower than readState.Index' (duration: 93.037587ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T20:35:31.335059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.596547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-08-31T20:35:31.335128Z","caller":"traceutil/trace.go:171","msg":"trace[1421695543] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22320; }","duration":"209.690779ms","start":"2026-08-31T20:35:31.125403Z","end":"2026-08-31T20:35:31.335094Z","steps":["trace[1421695543] 'agreement among raft nodes before linearized reading' (duration: 209.363751ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:35:31.335206Z","caller":"traceutil/trace.go:171","msg":"trace[1511187749] transaction","detail":"{read_only:false; response_revision:22320; number_of_response:1; }","duration":"235.68341ms","start":"2026-08-31T20:35:31.099492Z","end":"2026-08-31T20:35:31.335176Z","steps":["trace[1511187749] 'process raft request' (duration: 234.857808ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:35:31.557966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.053444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-08-31T20:35:31.558093Z","caller":"traceutil/trace.go:171","msg":"trace[957786172] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:22320; }","duration":"114.205067ms","start":"2026-08-31T20:35:31.44384Z","end":"2026-08-31T20:35:31.558045Z","steps":["trace[957786172] 'range keys from in-memory index tree' (duration: 113.756706ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:35:31.747075Z","caller":"traceutil/trace.go:171","msg":"trace[892592580] transaction","detail":"{read_only:false; response_revision:22321; number_of_response:1; }","duration":"151.261731ms","start":"2026-08-31T20:35:31.595781Z","end":"2026-08-31T20:35:31.747043Z","steps":["trace[892592580] 'process raft request' (duration: 151.062457ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:35:32.08831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.480336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-31T20:35:32.088421Z","caller":"traceutil/trace.go:171","msg":"trace[247361084] linearizableReadLoop","detail":"{readStateIndex:23095; appliedIndex:23093; }","duration":"469.922783ms","start":"2026-08-31T20:35:31.618478Z","end":"2026-08-31T20:35:32.088401Z","steps":["trace[247361084] 'read index received' (duration: 128.414619ms)","trace[247361084] 'applied index is now lower than readState.Index' (duration: 341.506774ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:35:32.088507Z","caller":"traceutil/trace.go:171","msg":"trace[1618896092] transaction","detail":"{read_only:false; response_revision:22322; number_of_response:1; }","duration":"483.790226ms","start":"2026-08-31T20:35:31.604701Z","end":"2026-08-31T20:35:32.088491Z","steps":["trace[1618896092] 'process raft request' (duration: 162.005144ms)","trace[1618896092] 'compare' (duration: 321.339392ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T20:35:32.088569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:35:31.604675Z","time spent":"483.863739ms","remote":"127.0.0.1:36328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T20:35:32.088606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.563823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-31T20:35:32.08869Z","caller":"traceutil/trace.go:171","msg":"trace[787495886] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:22322; }","duration":"216.711547ms","start":"2026-08-31T20:35:31.871958Z","end":"2026-08-31T20:35:32.08867Z","steps":["trace[787495886] 'agreement among raft nodes before linearized reading' (duration: 216.559873ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:35:32.088867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.381644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-31T20:35:32.088927Z","caller":"traceutil/trace.go:171","msg":"trace[1440092200] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22322; }","duration":"470.487547ms","start":"2026-08-31T20:35:31.618423Z","end":"2026-08-31T20:35:32.08891Z","steps":["trace[1440092200] 'agreement among raft nodes before linearized reading' (duration: 470.396104ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:35:32.088979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:35:31.618401Z","time spent":"470.568001ms","remote":"127.0.0.1:36064","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-08-31T20:35:32.707968Z","caller":"traceutil/trace.go:171","msg":"trace[1138566948] transaction","detail":"{read_only:false; response_revision:22323; number_of_response:1; }","duration":"156.181027ms","start":"2026-08-31T20:35:32.551745Z","end":"2026-08-31T20:35:32.707926Z","steps":["trace[1138566948] 'process raft request' (duration: 155.876589ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:35:32.906102Z","caller":"traceutil/trace.go:171","msg":"trace[1121111366] linearizableReadLoop","detail":"{readStateIndex:23097; appliedIndex:23096; }","duration":"198.168696ms","start":"2026-08-31T20:35:32.707872Z","end":"2026-08-31T20:35:32.906041Z","steps":["trace[1121111366] 'read index received' (duration: 197.818496ms)","trace[1121111366] 'applied index is now lower than readState.Index' (duration: 348.66µs)"],"step_count":2} {"level":"warn","ts":"2026-08-31T20:35:32.906376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.619242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-31T20:35:32.906454Z","caller":"traceutil/trace.go:171","msg":"trace[470456226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22324; }","duration":"223.754336ms","start":"2026-08-31T20:35:32.682684Z","end":"2026-08-31T20:35:32.906438Z","steps":["trace[470456226] 'agreement among raft nodes before linearized reading' (duration: 223.49897ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:35:32.906513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.857113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-31T20:35:32.906391Z","caller":"traceutil/trace.go:171","msg":"trace[1411880140] transaction","detail":"{read_only:false; response_revision:22324; number_of_response:1; }","duration":"227.377718ms","start":"2026-08-31T20:35:32.678982Z","end":"2026-08-31T20:35:32.90636Z","steps":["trace[1411880140] 'process raft request' (duration: 226.849335ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:35:32.906594Z","caller":"traceutil/trace.go:171","msg":"trace[1710001173] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22324; }","duration":"198.972436ms","start":"2026-08-31T20:35:32.707601Z","end":"2026-08-31T20:35:32.906574Z","steps":["trace[1710001173] 'agreement among raft nodes before linearized reading' (duration: 198.792911ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:38:12.215069Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21351} {"level":"info","ts":"2026-08-31T20:38:12.338462Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21351,"took":"119.289047ms","hash":3891111774,"current-db-size-bytes":54878208,"current-db-size":"55 MB","current-db-size-in-use-bytes":29704192,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-31T20:38:12.338556Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3891111774,"revision":21351,"compact-revision":19046} {"level":"info","ts":"2026-08-31T20:40:03.203207Z","caller":"traceutil/trace.go:171","msg":"trace[1134598510] transaction","detail":"{read_only:false; response_revision:24955; number_of_response:1; }","duration":"314.815155ms","start":"2026-08-31T20:40:02.888362Z","end":"2026-08-31T20:40:03.203177Z","steps":["trace[1134598510] 'process raft request' (duration: 314.592579ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:40:03.203491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:40:02.88833Z","time spent":"314.994229ms","remote":"127.0.0.1:36328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T20:40:03.25483Z","caller":"traceutil/trace.go:171","msg":"trace[1647137139] linearizableReadLoop","detail":"{readStateIndex:25809; appliedIndex:25807; }","duration":"282.41428ms","start":"2026-08-31T20:40:02.972373Z","end":"2026-08-31T20:40:03.254788Z","steps":["trace[1647137139] 'read index received' (duration: 230.5658ms)","trace[1647137139] 'applied index is now lower than readState.Index' (duration: 51.84677ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T20:40:03.254932Z","caller":"traceutil/trace.go:171","msg":"trace[1486192564] transaction","detail":"{read_only:false; response_revision:24956; number_of_response:1; }","duration":"337.621265ms","start":"2026-08-31T20:40:02.917269Z","end":"2026-08-31T20:40:03.25489Z","steps":["trace[1486192564] 'process raft request' (duration: 337.330478ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:40:03.25517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.769119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-08-31T20:40:03.25518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T20:40:02.917244Z","time spent":"337.78918ms","remote":"127.0.0.1:36328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T20:40:03.255233Z","caller":"traceutil/trace.go:171","msg":"trace[725086773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24956; }","duration":"282.896062ms","start":"2026-08-31T20:40:02.972324Z","end":"2026-08-31T20:40:03.25522Z","steps":["trace[725086773] 'agreement among raft nodes before linearized reading' (duration: 282.672337ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T20:40:03.255865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.407229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-31T20:40:03.255959Z","caller":"traceutil/trace.go:171","msg":"trace[461538446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24957; }","duration":"282.531723ms","start":"2026-08-31T20:40:02.973411Z","end":"2026-08-31T20:40:03.255943Z","steps":["trace[461538446] 'agreement among raft nodes before linearized reading' (duration: 282.300676ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T20:41:35.662979Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068c1.wal"} {"level":"info","ts":"2026-08-31T20:43:12.224265Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23538} {"level":"info","ts":"2026-08-31T20:43:12.352277Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23538,"took":"124.435637ms","hash":2434964800,"current-db-size-bytes":56459264,"current-db-size":"56 MB","current-db-size-in-use-bytes":43159552,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-08-31T20:43:12.352366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2434964800,"revision":23538,"compact-revision":21351} {"level":"info","ts":"2026-08-31T20:48:12.237865Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26669} {"level":"info","ts":"2026-08-31T20:48:12.388283Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26669,"took":"144.489087ms","hash":3551012856,"current-db-size-bytes":56459264,"current-db-size":"56 MB","current-db-size-in-use-bytes":30158848,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-31T20:48:12.38836Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3551012856,"revision":26669,"compact-revision":23538} {"level":"info","ts":"2026-08-31T20:48:30.475354Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a0f50f8a6c5f7d06","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-31T20:48:30.484187Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-31T20:48:30.48437Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}