{"level":"warn","ts":"2026-09-01T04:16:14.623349Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T04:16:14.623502Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.92: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.92:2380","--initial-cluster=instance=https://162.253.55.92:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.92:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.92:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-01T04:16:14.623598Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T04:16:14.623611Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.92:2380"]} {"level":"info","ts":"2026-09-01T04:16:14.623634Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T04:16:14.625067Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"]} {"level":"info","ts":"2026-09-01T04:16:14.625228Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.92:2380"],"listen-peer-urls":["https://162.253.55.92:2380"],"advertise-client-urls":["https://162.253.55.92:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.92:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-01T04:16:14.633569Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.023997ms"} {"level":"info","ts":"2026-09-01T04:16:14.640931Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39a4f14f6507253d","cluster-id":"22d06cab78b8ace5"} {"level":"info","ts":"2026-09-01T04:16:14.641021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T04:16:14.641161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became follower at term 0"} {"level":"info","ts":"2026-09-01T04:16:14.641184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39a4f14f6507253d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T04:16:14.641194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became follower at term 1"} {"level":"info","ts":"2026-09-01T04:16:14.641283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=(4153710079642117437)"} {"level":"warn","ts":"2026-09-01T04:16:14.65341Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T04:16:14.655231Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T04:16:14.656689Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-01T04:16:14.658973Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39a4f14f6507253d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T04:16:14.659177Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39a4f14f6507253d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T04:16:14.659274Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T04:16:14.659361Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T04:16:14.659389Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T04:16:14.665008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=(4153710079642117437)"} {"level":"info","ts":"2026-09-01T04:16:14.665577Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"22d06cab78b8ace5","local-member-id":"39a4f14f6507253d","added-peer-id":"39a4f14f6507253d","added-peer-peer-urls":["https://162.253.55.92:2380"]} {"level":"info","ts":"2026-09-01T04:16:14.669264Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T04:16:14.673453Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39a4f14f6507253d","initial-advertise-peer-urls":["https://162.253.55.92:2380"],"listen-peer-urls":["https://162.253.55.92:2380"],"advertise-client-urls":["https://162.253.55.92:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T04:16:14.669835Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.92:2380"} {"level":"info","ts":"2026-09-01T04:16:14.675Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.92:2380"} {"level":"info","ts":"2026-09-01T04:16:14.675031Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T04:16:14.841868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T04:16:14.84194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T04:16:14.841981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d received MsgPreVoteResp from 39a4f14f6507253d at term 1"} {"level":"info","ts":"2026-09-01T04:16:14.841997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became candidate at term 2"} {"level":"info","ts":"2026-09-01T04:16:14.842005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d received MsgVoteResp from 39a4f14f6507253d at term 2"} {"level":"info","ts":"2026-09-01T04:16:14.842016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became leader at term 2"} {"level":"info","ts":"2026-09-01T04:16:14.842025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39a4f14f6507253d elected leader 39a4f14f6507253d at term 2"} {"level":"info","ts":"2026-09-01T04:16:14.842992Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:16:14.843901Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39a4f14f6507253d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.92:2379]}","request-path":"/0/members/39a4f14f6507253d/attributes","cluster-id":"22d06cab78b8ace5","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T04:16:14.843922Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:16:14.844098Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"22d06cab78b8ace5","local-member-id":"39a4f14f6507253d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:16:14.844174Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:16:14.844198Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:16:14.844229Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T04:16:14.844245Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T04:16:14.844303Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:16:14.847175Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T04:16:14.847772Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.92:2379"} {"level":"info","ts":"2026-09-01T04:16:24.80905Z","caller":"traceutil/trace.go:171","msg":"trace[420033163] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"131.626536ms","start":"2026-09-01T04:16:24.677372Z","end":"2026-09-01T04:16:24.808999Z","steps":["trace[420033163] 'process raft request' (duration: 131.279628ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:16:29.475574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.16942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:16:29.476141Z","caller":"traceutil/trace.go:171","msg":"trace[1041971560] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:374; }","duration":"262.133459ms","start":"2026-09-01T04:16:29.213982Z","end":"2026-09-01T04:16:29.476116Z","steps":["trace[1041971560] 'read index received' (duration: 55.842µs)","trace[1041971560] 'applied index is now lower than readState.Index' (duration: 262.075777ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:16:29.476223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.244931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:16:29.476259Z","caller":"traceutil/trace.go:171","msg":"trace[37896441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:363; }","duration":"262.330033ms","start":"2026-09-01T04:16:29.213917Z","end":"2026-09-01T04:16:29.476247Z","steps":["trace[37896441] 'agreement among raft nodes before linearized reading' (duration: 262.260532ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:29.476503Z","caller":"traceutil/trace.go:171","msg":"trace[564442920] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"490.191629ms","start":"2026-09-01T04:16:28.986261Z","end":"2026-09-01T04:16:29.476452Z","steps":["trace[564442920] 'process raft request' (duration: 173.079493ms)","trace[564442920] 'compare' (duration: 314.862213ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:16:29.476938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:16:28.986234Z","time spent":"490.573709ms","remote":"127.0.0.1:35404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:16:29.828618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.166477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:16:29.82874Z","caller":"traceutil/trace.go:171","msg":"trace[1612824327] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"345.259596ms","start":"2026-09-01T04:16:29.483465Z","end":"2026-09-01T04:16:29.828724Z","steps":["trace[1612824327] 'process raft request' (duration: 141.913004ms)","trace[1612824327] 'compare' (duration: 203.049214ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:16:29.82881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:16:29.483444Z","time spent":"345.323147ms","remote":"127.0.0.1:35404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:16:29.887231Z","caller":"traceutil/trace.go:171","msg":"trace[1905082487] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"397.199082ms","start":"2026-09-01T04:16:29.49Z","end":"2026-09-01T04:16:29.887199Z","steps":["trace[1905082487] 'process raft request' (duration: 397.059089ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:16:29.887442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:16:29.489967Z","time spent":"397.380475ms","remote":"127.0.0.1:35334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:17:04.439599Z","caller":"traceutil/trace.go:171","msg":"trace[1402571244] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"118.908193ms","start":"2026-09-01T04:17:04.320661Z","end":"2026-09-01T04:17:04.439569Z","steps":["trace[1402571244] 'process raft request' (duration: 118.709358ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:17:04.501523Z","caller":"traceutil/trace.go:171","msg":"trace[1456271096] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"171.855555ms","start":"2026-09-01T04:17:04.329638Z","end":"2026-09-01T04:17:04.501494Z","steps":["trace[1456271096] 'process raft request' (duration: 170.509552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:04.994488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.854245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:17:04.994602Z","caller":"traceutil/trace.go:171","msg":"trace[1918918209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:606; }","duration":"453.992008ms","start":"2026-09-01T04:17:04.540557Z","end":"2026-09-01T04:17:04.994549Z","steps":["trace[1918918209] 'range keys from in-memory index tree' (duration: 453.725162ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:04.994702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:04.540531Z","time spent":"454.110351ms","remote":"127.0.0.1:35144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-01T04:17:05.051165Z","caller":"traceutil/trace.go:171","msg":"trace[534147945] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"475.124458ms","start":"2026-09-01T04:17:04.576011Z","end":"2026-09-01T04:17:05.051136Z","steps":["trace[534147945] 'process raft request' (duration: 474.891032ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:05.051317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:04.57599Z","time spent":"475.250961ms","remote":"127.0.0.1:35620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T04:17:05.391503Z","caller":"traceutil/trace.go:171","msg":"trace[1029293369] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"325.997392ms","start":"2026-09-01T04:17:05.065474Z","end":"2026-09-01T04:17:05.391472Z","steps":["trace[1029293369] 'read index received' (duration: 308.953639ms)","trace[1029293369] 'applied index is now lower than readState.Index' (duration: 17.042383ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:17:05.391575Z","caller":"traceutil/trace.go:171","msg":"trace[555643808] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"327.866586ms","start":"2026-09-01T04:17:05.063683Z","end":"2026-09-01T04:17:05.39155Z","steps":["trace[555643808] 'process raft request' (duration: 310.66877ms)","trace[555643808] 'compare' (duration: 17.003192ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:17:05.391743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.242988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:17:05.391844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.965536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-01T04:17:05.391871Z","caller":"traceutil/trace.go:171","msg":"trace[228586748] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:608; }","duration":"326.386382ms","start":"2026-09-01T04:17:05.065443Z","end":"2026-09-01T04:17:05.391829Z","steps":["trace[228586748] 'agreement among raft nodes before linearized reading' (duration: 326.188377ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:17:05.391919Z","caller":"traceutil/trace.go:171","msg":"trace[1297080740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:608; }","duration":"316.056868ms","start":"2026-09-01T04:17:05.07584Z","end":"2026-09-01T04:17:05.391897Z","steps":["trace[1297080740] 'agreement among raft nodes before linearized reading' (duration: 315.829892ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:05.392078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:05.075804Z","time spent":"316.265923ms","remote":"127.0.0.1:35404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-01T04:17:05.391926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:05.065428Z","time spent":"326.484904ms","remote":"127.0.0.1:35394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-09-01T04:17:05.392094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:05.063646Z","time spent":"327.987929ms","remote":"127.0.0.1:35404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:17:22.347575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.077076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-01T04:17:22.347669Z","caller":"traceutil/trace.go:171","msg":"trace[1770355887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"119.23323ms","start":"2026-09-01T04:17:22.228419Z","end":"2026-09-01T04:17:22.347652Z","steps":["trace[1770355887] 'range keys from in-memory index tree' (duration: 118.820989ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:17:22.589873Z","caller":"traceutil/trace.go:171","msg":"trace[2071421894] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"170.969247ms","start":"2026-09-01T04:17:22.418877Z","end":"2026-09-01T04:17:22.589847Z","steps":["trace[2071421894] 'read index received' (duration: 170.696711ms)","trace[2071421894] 'applied index is now lower than readState.Index' (duration: 271.326µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:17:22.589951Z","caller":"traceutil/trace.go:171","msg":"trace[495872622] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"235.976281ms","start":"2026-09-01T04:17:22.353947Z","end":"2026-09-01T04:17:22.589923Z","steps":["trace[495872622] 'process raft request' (duration: 235.697024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:22.590103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.206153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qhwrj\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-01T04:17:22.590146Z","caller":"traceutil/trace.go:171","msg":"trace[1367411870] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qhwrj; range_end:; response_count:1; response_revision:776; }","duration":"171.304774ms","start":"2026-09-01T04:17:22.418827Z","end":"2026-09-01T04:17:22.590132Z","steps":["trace[1367411870] 'agreement among raft nodes before linearized reading' (duration: 171.149351ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:17:55.562516Z","caller":"traceutil/trace.go:171","msg":"trace[2098769687] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"361.696159ms","start":"2026-09-01T04:17:55.200784Z","end":"2026-09-01T04:17:55.56248Z","steps":["trace[2098769687] 'process raft request' (duration: 361.422512ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:55.562917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:55.200715Z","time spent":"361.950924ms","remote":"127.0.0.1:35404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:17:55.828758Z","caller":"traceutil/trace.go:171","msg":"trace[1167808858] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"156.500648ms","start":"2026-09-01T04:17:55.672195Z","end":"2026-09-01T04:17:55.828696Z","steps":["trace[1167808858] 'read index received' (duration: 131.033282ms)","trace[1167808858] 'applied index is now lower than readState.Index' (duration: 25.465976ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:17:55.82918Z","caller":"traceutil/trace.go:171","msg":"trace[825149713] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"161.312273ms","start":"2026-09-01T04:17:55.667843Z","end":"2026-09-01T04:17:55.829156Z","steps":["trace[825149713] 'process raft request' (duration: 135.470648ms)","trace[825149713] 'compare' (duration: 25.21686ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:17:55.829449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.744681ms","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-09-01T04:17:55.829552Z","caller":"traceutil/trace.go:171","msg":"trace[1652870122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1185; }","duration":"150.903896ms","start":"2026-09-01T04:17:55.678622Z","end":"2026-09-01T04:17:55.829525Z","steps":["trace[1652870122] 'agreement among raft nodes before linearized reading' (duration: 150.617919ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:55.829879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.685517ms","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-09-01T04:17:55.829916Z","caller":"traceutil/trace.go:171","msg":"trace[1223728907] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1185; }","duration":"157.759749ms","start":"2026-09-01T04:17:55.672146Z","end":"2026-09-01T04:17:55.829906Z","steps":["trace[1223728907] 'agreement among raft nodes before linearized reading' (duration: 157.661565ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:59.181247Z","caller":"traceutil/trace.go:171","msg":"trace[95921429] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"239.869887ms","start":"2026-09-01T04:18:58.941344Z","end":"2026-09-01T04:18:59.181214Z","steps":["trace[95921429] 'process raft request' (duration: 227.237836ms)","trace[95921429] 'compare' (duration: 11.931155ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:18:59.25423Z","caller":"traceutil/trace.go:171","msg":"trace[1409943421] linearizableReadLoop","detail":"{readStateIndex:1997; appliedIndex:1993; }","duration":"305.12896ms","start":"2026-09-01T04:18:58.949078Z","end":"2026-09-01T04:18:59.254207Z","steps":["trace[1409943421] 'read index received' (duration: 219.536422ms)","trace[1409943421] 'applied index is now lower than readState.Index' (duration: 85.591378ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:18:59.254874Z","caller":"traceutil/trace.go:171","msg":"trace[889505581] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"313.472548ms","start":"2026-09-01T04:18:58.941379Z","end":"2026-09-01T04:18:59.254851Z","steps":["trace[889505581] 'process raft request' (duration: 312.558516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:59.25497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.871006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-09-01T04:18:59.254979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.021483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ed084c39-1fb0-49f8-89f5-6db09eff7699\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-09-01T04:18:59.255015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:58.941358Z","time spent":"313.576191ms","remote":"127.0.0.1:35318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:18:59.255065Z","caller":"traceutil/trace.go:171","msg":"trace[1425174149] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ed084c39-1fb0-49f8-89f5-6db09eff7699; range_end:; response_count:1; response_revision:1920; }","duration":"197.166977ms","start":"2026-09-01T04:18:59.057878Z","end":"2026-09-01T04:18:59.255045Z","steps":["trace[1425174149] 'agreement among raft nodes before linearized reading' (duration: 196.87852ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:59.255072Z","caller":"traceutil/trace.go:171","msg":"trace[1935402761] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"251.453305ms","start":"2026-09-01T04:18:59.003608Z","end":"2026-09-01T04:18:59.255061Z","steps":["trace[1935402761] 'process raft request' (duration: 250.551493ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:59.25503Z","caller":"traceutil/trace.go:171","msg":"trace[1073204548] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1920; }","duration":"305.959588ms","start":"2026-09-01T04:18:58.949049Z","end":"2026-09-01T04:18:59.255008Z","steps":["trace[1073204548] 'agreement among raft nodes before linearized reading' (duration: 305.764453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:59.255415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.617334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-01T04:18:59.255429Z","caller":"traceutil/trace.go:171","msg":"trace[1539297803] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"313.879638ms","start":"2026-09-01T04:18:58.941531Z","end":"2026-09-01T04:18:59.25541Z","steps":["trace[1539297803] 'process raft request' (duration: 312.538805ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:59.255448Z","caller":"traceutil/trace.go:171","msg":"trace[2073239721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1920; }","duration":"117.683855ms","start":"2026-09-01T04:18:59.137755Z","end":"2026-09-01T04:18:59.255439Z","steps":["trace[2073239721] 'agreement among raft nodes before linearized reading' (duration: 117.590002ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:59.25547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:58.949039Z","time spent":"306.39737ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-01T04:18:59.255522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:58.94152Z","time spent":"313.948749ms","remote":"127.0.0.1:35412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:18:59.255587Z","caller":"traceutil/trace.go:171","msg":"trace[1919090632] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"314.039122ms","start":"2026-09-01T04:18:58.941531Z","end":"2026-09-01T04:18:59.25557Z","steps":["trace[1919090632] 'process raft request' (duration: 312.586886ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:59.255677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:58.941522Z","time spent":"314.103623ms","remote":"127.0.0.1:35318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:18:59.697976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.226521ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:18:59.698117Z","caller":"traceutil/trace.go:171","msg":"trace[1932203896] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1998; }","duration":"158.906831ms","start":"2026-09-01T04:18:59.539185Z","end":"2026-09-01T04:18:59.698092Z","steps":["trace[1932203896] 'read index received' (duration: 50.051µs)","trace[1932203896] 'applied index is now lower than readState.Index' (duration: 158.85507ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:18:59.698197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.020503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:18:59.698224Z","caller":"traceutil/trace.go:171","msg":"trace[685679419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1921; }","duration":"159.082525ms","start":"2026-09-01T04:18:59.53913Z","end":"2026-09-01T04:18:59.698213Z","steps":["trace[685679419] 'agreement among raft nodes before linearized reading' (duration: 159.018253ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:59.698273Z","caller":"traceutil/trace.go:171","msg":"trace[2078194376] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"436.936422ms","start":"2026-09-01T04:18:59.261279Z","end":"2026-09-01T04:18:59.698216Z","steps":["trace[2078194376] 'process raft request' (duration: 57.345202ms)","trace[2078194376] 'compare' (duration: 378.939564ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:18:59.698647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:59.261252Z","time spent":"437.120636ms","remote":"127.0.0.1:35404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:19:00.142345Z","caller":"traceutil/trace.go:171","msg":"trace[193268447] linearizableReadLoop","detail":"{readStateIndex:2000; appliedIndex:1999; }","duration":"211.200382ms","start":"2026-09-01T04:18:59.931128Z","end":"2026-09-01T04:19:00.142328Z","steps":["trace[193268447] 'read index received' (duration: 211.11603ms)","trace[193268447] 'applied index is now lower than readState.Index' (duration: 83.422µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:19:00.142453Z","caller":"traceutil/trace.go:171","msg":"trace[1368975104] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"220.952645ms","start":"2026-09-01T04:18:59.921463Z","end":"2026-09-01T04:19:00.142416Z","steps":["trace[1368975104] 'process raft request' (duration: 220.73058ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:19:00.142619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.422517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-01T04:19:00.14276Z","caller":"traceutil/trace.go:171","msg":"trace[1102662664] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1922; }","duration":"211.57065ms","start":"2026-09-01T04:18:59.931113Z","end":"2026-09-01T04:19:00.142684Z","steps":["trace[1102662664] 'agreement among raft nodes before linearized reading' (duration: 211.291994ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:19:00.158971Z","caller":"traceutil/trace.go:171","msg":"trace[1580873345] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"124.215832ms","start":"2026-09-01T04:19:00.034713Z","end":"2026-09-01T04:19:00.158929Z","steps":["trace[1580873345] 'process raft request' (duration: 123.890753ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:19:15.648533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.426863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:19:15.648711Z","caller":"traceutil/trace.go:171","msg":"trace[1594706493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2054; }","duration":"110.655238ms","start":"2026-09-01T04:19:15.538001Z","end":"2026-09-01T04:19:15.648656Z","steps":["trace[1594706493] 'range keys from in-memory index tree' (duration: 110.274249ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:19:38.537319Z","caller":"traceutil/trace.go:171","msg":"trace[1035145848] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"176.138538ms","start":"2026-09-01T04:19:38.361152Z","end":"2026-09-01T04:19:38.53729Z","steps":["trace[1035145848] 'process raft request' (duration: 125.718361ms)","trace[1035145848] 'compare' (duration: 50.083999ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:19:38.744589Z","caller":"traceutil/trace.go:171","msg":"trace[1941849091] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"139.202373ms","start":"2026-09-01T04:19:38.605345Z","end":"2026-09-01T04:19:38.744547Z","steps":["trace[1941849091] 'process raft request' (duration: 59.907454ms)","trace[1941849091] 'compare' (duration: 79.121585ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:19:39.256175Z","caller":"traceutil/trace.go:171","msg":"trace[938725025] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"152.942453ms","start":"2026-09-01T04:19:39.103198Z","end":"2026-09-01T04:19:39.256141Z","steps":["trace[938725025] 'process raft request' (duration: 152.689547ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:19:39.63369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.848311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:19:39.633928Z","caller":"traceutil/trace.go:171","msg":"trace[1522119698] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2188; }","duration":"171.173ms","start":"2026-09-01T04:19:39.462727Z","end":"2026-09-01T04:19:39.6339Z","steps":["trace[1522119698] 'count revisions from in-memory index tree' (duration: 170.705808ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:19:39.719846Z","caller":"traceutil/trace.go:171","msg":"trace[2139170968] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2276; }","duration":"112.283699ms","start":"2026-09-01T04:19:39.607534Z","end":"2026-09-01T04:19:39.719818Z","steps":["trace[2139170968] 'read index received' (duration: 111.910619ms)","trace[2139170968] 'applied index is now lower than readState.Index' (duration: 366.74µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:19:39.720046Z","caller":"traceutil/trace.go:171","msg":"trace[386008667] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"200.06737ms","start":"2026-09-01T04:19:39.519934Z","end":"2026-09-01T04:19:39.720001Z","steps":["trace[386008667] 'process raft request' (duration: 199.650289ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:19:39.72018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.559885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-01T04:19:39.720258Z","caller":"traceutil/trace.go:171","msg":"trace[1514985254] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2189; }","duration":"112.717248ms","start":"2026-09-01T04:19:39.607528Z","end":"2026-09-01T04:19:39.720245Z","steps":["trace[1514985254] 'agreement among raft nodes before linearized reading' (duration: 112.410821ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:19:40.034597Z","caller":"traceutil/trace.go:171","msg":"trace[239499201] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"219.134098ms","start":"2026-09-01T04:19:39.815405Z","end":"2026-09-01T04:19:40.034539Z","steps":["trace[239499201] 'process raft request' (duration: 218.940343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:19:40.034883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.344406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-01T04:19:40.034966Z","caller":"traceutil/trace.go:171","msg":"trace[960640115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2190; }","duration":"121.485589ms","start":"2026-09-01T04:19:39.913459Z","end":"2026-09-01T04:19:40.034945Z","steps":["trace[960640115] 'agreement among raft nodes before linearized reading' (duration: 121.246643ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:19:40.034912Z","caller":"traceutil/trace.go:171","msg":"trace[1645809469] linearizableReadLoop","detail":"{readStateIndex:2278; appliedIndex:2277; }","duration":"121.007148ms","start":"2026-09-01T04:19:39.913502Z","end":"2026-09-01T04:19:40.034509Z","steps":["trace[1645809469] 'read index received' (duration: 120.71751ms)","trace[1645809469] 'applied index is now lower than readState.Index' (duration: 287.988µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:21:33.645526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.095192ms","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-09-01T04:21:33.645625Z","caller":"traceutil/trace.go:171","msg":"trace[337507331] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2906; }","duration":"294.267196ms","start":"2026-09-01T04:21:33.351338Z","end":"2026-09-01T04:21:33.645606Z","steps":["trace[337507331] 'range keys from in-memory index tree' (duration: 293.849355ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:33.664897Z","caller":"traceutil/trace.go:171","msg":"trace[2093630993] linearizableReadLoop","detail":"{readStateIndex:3019; appliedIndex:3018; }","duration":"123.468901ms","start":"2026-09-01T04:21:33.541387Z","end":"2026-09-01T04:21:33.664856Z","steps":["trace[2093630993] 'read index received' (duration: 120.879253ms)","trace[2093630993] 'applied index is now lower than readState.Index' (duration: 2.586448ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:21:33.665196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.781969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-01T04:21:33.665259Z","caller":"traceutil/trace.go:171","msg":"trace[122465224] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2907; }","duration":"123.912972ms","start":"2026-09-01T04:21:33.541326Z","end":"2026-09-01T04:21:33.665239Z","steps":["trace[122465224] 'agreement among raft nodes before linearized reading' (duration: 123.681017ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:39.029988Z","caller":"traceutil/trace.go:171","msg":"trace[1081450154] transaction","detail":"{read_only:false; response_revision:2933; number_of_response:1; }","duration":"173.753179ms","start":"2026-09-01T04:21:38.856202Z","end":"2026-09-01T04:21:39.029955Z","steps":["trace[1081450154] 'process raft request' (duration: 173.551214ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:15.105782Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2807} {"level":"info","ts":"2026-09-01T04:26:15.189032Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2807,"took":"81.864761ms","hash":1731909683,"current-db-size-bytes":52604928,"current-db-size":"53 MB","current-db-size-in-use-bytes":26877952,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-01T04:26:15.189113Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1731909683,"revision":2807,"compact-revision":-1} {"level":"info","ts":"2026-09-01T04:26:23.390167Z","caller":"traceutil/trace.go:171","msg":"trace[1156184222] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"154.515665ms","start":"2026-09-01T04:26:23.23563Z","end":"2026-09-01T04:26:23.390146Z","steps":["trace[1156184222] 'process raft request' (duration: 154.372412ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:23.587263Z","caller":"traceutil/trace.go:171","msg":"trace[1351974501] linearizableReadLoop","detail":"{readStateIndex:5400; appliedIndex:5398; }","duration":"271.987497ms","start":"2026-09-01T04:26:23.315253Z","end":"2026-09-01T04:26:23.58724Z","steps":["trace[1351974501] 'read index received' (duration: 74.842766ms)","trace[1351974501] 'applied index is now lower than readState.Index' (duration: 197.14338ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:26:23.587247Z","caller":"traceutil/trace.go:171","msg":"trace[1903513122] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"342.404856ms","start":"2026-09-01T04:26:23.244789Z","end":"2026-09-01T04:26:23.587194Z","steps":["trace[1903513122] 'process raft request' (duration: 341.168977ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:23.587351Z","caller":"traceutil/trace.go:171","msg":"trace[1903412422] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"269.488406ms","start":"2026-09-01T04:26:23.317835Z","end":"2026-09-01T04:26:23.587324Z","steps":["trace[1903412422] 'process raft request' (duration: 269.210709ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:23.587373Z","caller":"traceutil/trace.go:171","msg":"trace[1002853943] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"256.49308ms","start":"2026-09-01T04:26:23.330854Z","end":"2026-09-01T04:26:23.587347Z","steps":["trace[1002853943] 'process raft request' (duration: 256.311546ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:26:23.587453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:26:23.24477Z","time spent":"342.581921ms","remote":"127.0.0.1:35334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11829,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:26:23.587511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.251032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-01T04:26:23.587567Z","caller":"traceutil/trace.go:171","msg":"trace[777485228] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5201; }","duration":"272.309373ms","start":"2026-09-01T04:26:23.315239Z","end":"2026-09-01T04:26:23.587549Z","steps":["trace[777485228] 'agreement among raft nodes before linearized reading' (duration: 272.118959ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:23.614504Z","caller":"traceutil/trace.go:171","msg":"trace[1000676432] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"135.134978ms","start":"2026-09-01T04:26:23.479346Z","end":"2026-09-01T04:26:23.614481Z","steps":["trace[1000676432] 'process raft request' (duration: 134.989285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:26:23.614846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.470453ms","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-09-01T04:26:23.614962Z","caller":"traceutil/trace.go:171","msg":"trace[906319840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5202; }","duration":"229.630387ms","start":"2026-09-01T04:26:23.385308Z","end":"2026-09-01T04:26:23.614939Z","steps":["trace[906319840] 'agreement among raft nodes before linearized reading' (duration: 229.399381ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:23.979075Z","caller":"traceutil/trace.go:171","msg":"trace[1602580561] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"244.047376ms","start":"2026-09-01T04:26:23.735003Z","end":"2026-09-01T04:26:23.979051Z","steps":["trace[1602580561] 'process raft request' (duration: 243.837291ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:23.979376Z","caller":"traceutil/trace.go:171","msg":"trace[523523091] transaction","detail":"{read_only:false; response_revision:5211; number_of_response:1; }","duration":"243.896914ms","start":"2026-09-01T04:26:23.735453Z","end":"2026-09-01T04:26:23.97935Z","steps":["trace[523523091] 'process raft request' (duration: 243.536694ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:23.979559Z","caller":"traceutil/trace.go:171","msg":"trace[303514929] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"243.833141ms","start":"2026-09-01T04:26:23.73571Z","end":"2026-09-01T04:26:23.979544Z","steps":["trace[303514929] 'process raft request' (duration: 243.750619ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:23.979619Z","caller":"traceutil/trace.go:171","msg":"trace[1667913672] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"243.952534ms","start":"2026-09-01T04:26:23.735656Z","end":"2026-09-01T04:26:23.979608Z","steps":["trace[1667913672] 'process raft request' (duration: 243.595766ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:02.302471Z","caller":"traceutil/trace.go:171","msg":"trace[361195930] linearizableReadLoop","detail":"{readStateIndex:5828; appliedIndex:5827; }","duration":"184.824354ms","start":"2026-09-01T04:27:02.117627Z","end":"2026-09-01T04:27:02.302451Z","steps":["trace[361195930] 'read index received' (duration: 184.722512ms)","trace[361195930] 'applied index is now lower than readState.Index' (duration: 101.082µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:27:02.302532Z","caller":"traceutil/trace.go:171","msg":"trace[1670872715] transaction","detail":"{read_only:false; response_revision:5616; number_of_response:1; }","duration":"185.307257ms","start":"2026-09-01T04:27:02.117209Z","end":"2026-09-01T04:27:02.302516Z","steps":["trace[1670872715] 'process raft request' (duration: 185.120112ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:02.302678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.03255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-09-01T04:27:02.302712Z","caller":"traceutil/trace.go:171","msg":"trace[420353363] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5616; }","duration":"185.102811ms","start":"2026-09-01T04:27:02.117599Z","end":"2026-09-01T04:27:02.302702Z","steps":["trace[420353363] 'agreement among raft nodes before linearized reading' (duration: 184.928477ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:02.511122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.461022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:27:02.511347Z","caller":"traceutil/trace.go:171","msg":"trace[1123429315] transaction","detail":"{read_only:false; response_revision:5617; number_of_response:1; }","duration":"202.510152ms","start":"2026-09-01T04:27:02.308798Z","end":"2026-09-01T04:27:02.511308Z","steps":["trace[1123429315] 'process raft request' (duration: 87.769143ms)","trace[1123429315] 'compare' (duration: 114.155445ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:27:02.511441Z","caller":"traceutil/trace.go:171","msg":"trace[1400363709] linearizableReadLoop","detail":"{readStateIndex:5831; appliedIndex:5828; }","duration":"180.384261ms","start":"2026-09-01T04:27:02.331036Z","end":"2026-09-01T04:27:02.51142Z","steps":["trace[1400363709] 'read index received' (duration: 65.543069ms)","trace[1400363709] 'applied index is now lower than readState.Index' (duration: 114.840162ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:27:02.511491Z","caller":"traceutil/trace.go:171","msg":"trace[1500424223] transaction","detail":"{read_only:false; response_revision:5618; number_of_response:1; }","duration":"194.235847ms","start":"2026-09-01T04:27:02.317229Z","end":"2026-09-01T04:27:02.511465Z","steps":["trace[1500424223] 'process raft request' (duration: 194.004281ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:02.511571Z","caller":"traceutil/trace.go:171","msg":"trace[1069000536] transaction","detail":"{read_only:false; response_revision:5619; number_of_response:1; }","duration":"184.919387ms","start":"2026-09-01T04:27:02.326631Z","end":"2026-09-01T04:27:02.51155Z","steps":["trace[1069000536] 'process raft request' (duration: 184.671721ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:02.511628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.578655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-01T04:27:02.511673Z","caller":"traceutil/trace.go:171","msg":"trace[1065882123] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5620; }","duration":"180.657876ms","start":"2026-09-01T04:27:02.330999Z","end":"2026-09-01T04:27:02.511656Z","steps":["trace[1065882123] 'agreement among raft nodes before linearized reading' (duration: 180.480502ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:02.511809Z","caller":"traceutil/trace.go:171","msg":"trace[139127161] transaction","detail":"{read_only:false; response_revision:5620; number_of_response:1; }","duration":"122.384419ms","start":"2026-09-01T04:27:02.389368Z","end":"2026-09-01T04:27:02.511752Z","steps":["trace[139127161] 'process raft request' (duration: 122.002701ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:16.002582Z","caller":"traceutil/trace.go:171","msg":"trace[287829276] transaction","detail":"{read_only:false; response_revision:5708; number_of_response:1; }","duration":"112.430765ms","start":"2026-09-01T04:27:15.890091Z","end":"2026-09-01T04:27:16.002522Z","steps":["trace[287829276] 'process raft request' (duration: 112.244211ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:31:15.114729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5111} {"level":"info","ts":"2026-09-01T04:31:15.206306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5111,"took":"89.915889ms","hash":970150370,"current-db-size-bytes":52604928,"current-db-size":"53 MB","current-db-size-in-use-bytes":19349504,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T04:31:15.207082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":970150370,"revision":5111,"compact-revision":2807}