{"level":"warn","ts":"2026-09-19T01:50:27.464785Z","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-19T01:50:27.464888Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.84: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.84:2380","--initial-cluster=instance=https://162.253.55.84:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.84:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.84: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-19T01:50:27.46496Z","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-19T01:50:27.464968Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.84:2380"]} {"level":"info","ts":"2026-09-19T01:50:27.464998Z","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-19T01:50:27.46578Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"]} {"level":"info","ts":"2026-09-19T01:50:27.465851Z","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.84:2380"],"listen-peer-urls":["https://162.253.55.84:2380"],"advertise-client-urls":["https://162.253.55.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.84: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-19T01:50:27.471531Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.473048ms"} {"level":"info","ts":"2026-09-19T01:50:27.478081Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ca4c710a8d5349d7","cluster-id":"8e28a51debf1c8ab"} {"level":"info","ts":"2026-09-19T01:50:27.479193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T01:50:27.47926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became follower at term 0"} {"level":"info","ts":"2026-09-19T01:50:27.479277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ca4c710a8d5349d7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T01:50:27.479287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became follower at term 1"} {"level":"info","ts":"2026-09-19T01:50:27.479338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=(14577150384026110423)"} {"level":"warn","ts":"2026-09-19T01:50:27.491564Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T01:50:27.493251Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T01:50:27.494802Z","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-19T01:50:27.497534Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ca4c710a8d5349d7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T01:50:27.497702Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ca4c710a8d5349d7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T01:50:27.497831Z","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-19T01:50:27.497902Z","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-19T01:50:27.497912Z","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-19T01:50:27.503508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=(14577150384026110423)"} {"level":"info","ts":"2026-09-19T01:50:27.503738Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e28a51debf1c8ab","local-member-id":"ca4c710a8d5349d7","added-peer-id":"ca4c710a8d5349d7","added-peer-peer-urls":["https://162.253.55.84:2380"]} {"level":"info","ts":"2026-09-19T01:50:27.504658Z","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-19T01:50:27.504929Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ca4c710a8d5349d7","initial-advertise-peer-urls":["https://162.253.55.84:2380"],"listen-peer-urls":["https://162.253.55.84:2380"],"advertise-client-urls":["https://162.253.55.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T01:50:27.504965Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T01:50:27.505011Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.84:2380"} {"level":"info","ts":"2026-09-19T01:50:27.505031Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.84:2380"} {"level":"info","ts":"2026-09-19T01:50:28.283175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T01:50:28.283238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T01:50:28.283261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 received MsgPreVoteResp from ca4c710a8d5349d7 at term 1"} {"level":"info","ts":"2026-09-19T01:50:28.283275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became candidate at term 2"} {"level":"info","ts":"2026-09-19T01:50:28.28328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 received MsgVoteResp from ca4c710a8d5349d7 at term 2"} {"level":"info","ts":"2026-09-19T01:50:28.28329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became leader at term 2"} {"level":"info","ts":"2026-09-19T01:50:28.283299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ca4c710a8d5349d7 elected leader ca4c710a8d5349d7 at term 2"} {"level":"info","ts":"2026-09-19T01:50:28.289279Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ca4c710a8d5349d7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.84:2379]}","request-path":"/0/members/ca4c710a8d5349d7/attributes","cluster-id":"8e28a51debf1c8ab","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T01:50:28.289308Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:50:28.289481Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:50:28.289705Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:50:28.291397Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T01:50:28.291571Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T01:50:28.291761Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T01:50:28.291906Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e28a51debf1c8ab","local-member-id":"ca4c710a8d5349d7","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:50:28.292135Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:50:28.292183Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:50:28.292743Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.84:2379"} {"level":"info","ts":"2026-09-19T01:50:29.96257Z","caller":"traceutil/trace.go:171","msg":"trace[184597936] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"217.276029ms","start":"2026-09-19T01:50:29.745259Z","end":"2026-09-19T01:50:29.962535Z","steps":["trace[184597936] 'process raft request' (duration: 217.031747ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.349681Z","caller":"traceutil/trace.go:171","msg":"trace[123611040] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"601.443937ms","start":"2026-09-19T01:50:29.748181Z","end":"2026-09-19T01:50:30.349625Z","steps":["trace[123611040] 'process raft request' (duration: 601.037096ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.349771Z","caller":"traceutil/trace.go:171","msg":"trace[1416457814] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"530.815299ms","start":"2026-09-19T01:50:29.81891Z","end":"2026-09-19T01:50:30.349726Z","steps":["trace[1416457814] 'process raft request' (duration: 530.672512ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.349923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.593314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-09-19T01:50:30.34999Z","caller":"traceutil/trace.go:171","msg":"trace[1261498051] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"601.69793ms","start":"2026-09-19T01:50:29.748281Z","end":"2026-09-19T01:50:30.349979Z","steps":["trace[1261498051] 'agreement among raft nodes before linearized reading' (duration: 601.49696ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.350025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.748277Z","time spent":"601.737162ms","remote":"127.0.0.1:55338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-09-19T01:50:30.35008Z","caller":"traceutil/trace.go:171","msg":"trace[674200862] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"532.103316ms","start":"2026-09-19T01:50:29.817962Z","end":"2026-09-19T01:50:30.350065Z","steps":["trace[674200862] 'process raft request' (duration: 531.532086ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.350136Z","caller":"traceutil/trace.go:171","msg":"trace[1425084619] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"531.728097ms","start":"2026-09-19T01:50:29.818398Z","end":"2026-09-19T01:50:30.350126Z","steps":["trace[1425084619] 'process raft request' (duration: 531.124956ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.350205Z","caller":"traceutil/trace.go:171","msg":"trace[1135260707] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"529.570085ms","start":"2026-09-19T01:50:29.820609Z","end":"2026-09-19T01:50:30.350179Z","steps":["trace[1135260707] 'process raft request' (duration: 529.038458ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.350297Z","caller":"traceutil/trace.go:171","msg":"trace[391985349] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"530.950346ms","start":"2026-09-19T01:50:29.819339Z","end":"2026-09-19T01:50:30.350289Z","steps":["trace[391985349] 'process raft request' (duration: 530.268771ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.349687Z","caller":"traceutil/trace.go:171","msg":"trace[912386889] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"532.102026ms","start":"2026-09-19T01:50:29.817525Z","end":"2026-09-19T01:50:30.349627Z","steps":["trace[912386889] 'process raft request' (duration: 531.938628ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.34974Z","caller":"traceutil/trace.go:171","msg":"trace[1848574909] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"601.428776ms","start":"2026-09-19T01:50:29.74829Z","end":"2026-09-19T01:50:30.349719Z","steps":["trace[1848574909] 'read index received' (duration: 214.007391ms)","trace[1848574909] 'applied index is now lower than readState.Index' (duration: 387.420135ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:30.350399Z","caller":"traceutil/trace.go:171","msg":"trace[5178143] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"520.073716ms","start":"2026-09-19T01:50:29.83031Z","end":"2026-09-19T01:50:30.350384Z","steps":["trace[5178143] 'process raft request' (duration: 519.3673ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.35053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.818881Z","time spent":"531.02041ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:30.350564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.819299Z","time spent":"531.016259ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:30.350589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.817505Z","time spent":"532.888426ms","remote":"127.0.0.1:55632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:30.350634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.148111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:50:30.350664Z","caller":"traceutil/trace.go:171","msg":"trace[389371210] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"481.175943ms","start":"2026-09-19T01:50:29.869477Z","end":"2026-09-19T01:50:30.350653Z","steps":["trace[389371210] 'agreement among raft nodes before linearized reading' (duration: 481.139531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.350698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.869449Z","time spent":"481.242076ms","remote":"127.0.0.1:55282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T01:50:30.350712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.81795Z","time spent":"532.165049ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:30.350541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.748169Z","time spent":"601.637977ms","remote":"127.0.0.1:55428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:30.350598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.98944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:50:30.350835Z","caller":"traceutil/trace.go:171","msg":"trace[1216353331] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"353.233133ms","start":"2026-09-19T01:50:29.997573Z","end":"2026-09-19T01:50:30.350807Z","steps":["trace[1216353331] 'agreement among raft nodes before linearized reading' (duration: 353.004832ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.35089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.830301Z","time spent":"520.133629ms","remote":"127.0.0.1:55338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:30.350906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.997553Z","time spent":"353.340059ms","remote":"127.0.0.1:55282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-09-19T01:50:30.350907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.717289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.84\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-19T01:50:30.350949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.008184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-19T01:50:30.350953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.81839Z","time spent":"531.767908ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:50:30.350948Z","caller":"traceutil/trace.go:171","msg":"trace[883771739] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"600.893448ms","start":"2026-09-19T01:50:29.748641Z","end":"2026-09-19T01:50:30.349534Z","steps":["trace[883771739] 'process raft request' (duration: 600.778473ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.350991Z","caller":"traceutil/trace.go:171","msg":"trace[1056273828] range","detail":"{range_begin:/registry/masterleases/162.253.55.84; range_end:; response_count:0; response_revision:11; }","duration":"534.831255ms","start":"2026-09-19T01:50:29.816132Z","end":"2026-09-19T01:50:30.350964Z","steps":["trace[1056273828] 'agreement among raft nodes before linearized reading' (duration: 534.621225ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.35102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.12868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-19T01:50:30.350553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.510188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:50:30.351081Z","caller":"traceutil/trace.go:171","msg":"trace[800534758] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"554.062276ms","start":"2026-09-19T01:50:29.797008Z","end":"2026-09-19T01:50:30.35107Z","steps":["trace[800534758] 'agreement among raft nodes before linearized reading' (duration: 553.483606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.351148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.927924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-19T01:50:30.351168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.796999Z","time spent":"554.15895ms","remote":"127.0.0.1:55282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-19T01:50:30.351208Z","caller":"traceutil/trace.go:171","msg":"trace[880967272] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"531.003708ms","start":"2026-09-19T01:50:29.820173Z","end":"2026-09-19T01:50:30.351177Z","steps":["trace[880967272] 'agreement among raft nodes before linearized reading' (duration: 530.894613ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.351277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.82016Z","time spent":"531.105494ms","remote":"127.0.0.1:55246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-09-19T01:50:30.351048Z","caller":"traceutil/trace.go:171","msg":"trace[1027389993] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"548.163632ms","start":"2026-09-19T01:50:29.802875Z","end":"2026-09-19T01:50:30.351038Z","steps":["trace[1027389993] 'agreement among raft nodes before linearized reading' (duration: 548.12696ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.351333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.116729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-19T01:50:30.351369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.802868Z","time spent":"548.491679ms","remote":"127.0.0.1:55282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-19T01:50:30.351376Z","caller":"traceutil/trace.go:171","msg":"trace[1805273078] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"534.168552ms","start":"2026-09-19T01:50:29.817194Z","end":"2026-09-19T01:50:30.351363Z","steps":["trace[1805273078] 'agreement among raft nodes before linearized reading' (duration: 534.102138ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.35141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.817187Z","time spent":"534.214654ms","remote":"127.0.0.1:55282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T01:50:30.35104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.816122Z","time spent":"534.90661ms","remote":"127.0.0.1:55180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/162.253.55.84\" "} {"level":"info","ts":"2026-09-19T01:50:30.350982Z","caller":"traceutil/trace.go:171","msg":"trace[1685015671] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"548.094499ms","start":"2026-09-19T01:50:29.802877Z","end":"2026-09-19T01:50:30.350971Z","steps":["trace[1685015671] 'agreement among raft nodes before linearized reading' (duration: 548.046196ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.35198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.802795Z","time spent":"549.144632ms","remote":"127.0.0.1:55282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T01:50:30.35198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.820564Z","time spent":"529.702232ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:30.352532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:29.748603Z","time spent":"602.413566ms","remote":"127.0.0.1:55216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:50:30.5118Z","caller":"traceutil/trace.go:171","msg":"trace[258192501] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"153.747759ms","start":"2026-09-19T01:50:30.358007Z","end":"2026-09-19T01:50:30.511755Z","steps":["trace[258192501] 'process raft request' (duration: 123.996304ms)","trace[258192501] 'compare' (duration: 29.364775ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:30.512177Z","caller":"traceutil/trace.go:171","msg":"trace[1989722404] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"150.697133ms","start":"2026-09-19T01:50:30.361456Z","end":"2026-09-19T01:50:30.512153Z","steps":["trace[1989722404] 'process raft request' (duration: 150.168566ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.512549Z","caller":"traceutil/trace.go:171","msg":"trace[1151649757] linearizableReadLoop","detail":"{readStateIndex:21; appliedIndex:14; }","duration":"150.475963ms","start":"2026-09-19T01:50:30.36206Z","end":"2026-09-19T01:50:30.512536Z","steps":["trace[1151649757] 'read index received' (duration: 119.962039ms)","trace[1151649757] 'applied index is now lower than readState.Index' (duration: 30.512924ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:30.512638Z","caller":"traceutil/trace.go:171","msg":"trace[965757069] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"150.60218ms","start":"2026-09-19T01:50:30.362025Z","end":"2026-09-19T01:50:30.512627Z","steps":["trace[965757069] 'process raft request' (duration: 150.351297ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.512601Z","caller":"traceutil/trace.go:171","msg":"trace[1992495524] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"150.520195ms","start":"2026-09-19T01:50:30.362023Z","end":"2026-09-19T01:50:30.512543Z","steps":["trace[1992495524] 'process raft request' (duration: 150.328556ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.512758Z","caller":"traceutil/trace.go:171","msg":"trace[45030168] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"150.964598ms","start":"2026-09-19T01:50:30.361759Z","end":"2026-09-19T01:50:30.512724Z","steps":["trace[45030168] 'process raft request' (duration: 149.929405ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.512813Z","caller":"traceutil/trace.go:171","msg":"trace[275910841] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"150.61129ms","start":"2026-09-19T01:50:30.362195Z","end":"2026-09-19T01:50:30.512807Z","steps":["trace[275910841] 'process raft request' (duration: 150.252831ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.513057Z","caller":"traceutil/trace.go:171","msg":"trace[181056563] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"147.462089ms","start":"2026-09-19T01:50:30.365585Z","end":"2026-09-19T01:50:30.513047Z","steps":["trace[181056563] 'process raft request' (duration: 146.90232ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.513135Z","caller":"traceutil/trace.go:171","msg":"trace[1345941513] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"151.239182ms","start":"2026-09-19T01:50:30.36188Z","end":"2026-09-19T01:50:30.513119Z","steps":["trace[1345941513] 'process raft request' (duration: 150.385938ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.513369Z","caller":"traceutil/trace.go:171","msg":"trace[1463535620] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"151.457142ms","start":"2026-09-19T01:50:30.361891Z","end":"2026-09-19T01:50:30.513348Z","steps":["trace[1463535620] 'process raft request' (duration: 150.42783ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.513362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.259533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-pkxr4\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-09-19T01:50:30.514237Z","caller":"traceutil/trace.go:171","msg":"trace[362425981] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-pkxr4; range_end:; response_count:1; response_revision:20; }","duration":"152.19235ms","start":"2026-09-19T01:50:30.362018Z","end":"2026-09-19T01:50:30.51421Z","steps":["trace[362425981] 'agreement among raft nodes before linearized reading' (duration: 151.19654ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:30.513507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.522569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:50:30.514352Z","caller":"traceutil/trace.go:171","msg":"trace[996445595] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"101.421655ms","start":"2026-09-19T01:50:30.412914Z","end":"2026-09-19T01:50:30.514336Z","steps":["trace[996445595] 'agreement among raft nodes before linearized reading' (duration: 100.517969ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:30.512788Z","caller":"traceutil/trace.go:171","msg":"trace[984545532] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"150.712524ms","start":"2026-09-19T01:50:30.362067Z","end":"2026-09-19T01:50:30.512779Z","steps":["trace[984545532] 'process raft request' (duration: 150.334565ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:10.00893Z","caller":"traceutil/trace.go:171","msg":"trace[1890071675] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"309.253448ms","start":"2026-09-19T01:51:09.69958Z","end":"2026-09-19T01:51:10.008833Z","steps":["trace[1890071675] 'read index received' (duration: 307.688925ms)","trace[1890071675] 'applied index is now lower than readState.Index' (duration: 1.562763ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:51:10.012809Z","caller":"traceutil/trace.go:171","msg":"trace[2105054454] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"317.713056ms","start":"2026-09-19T01:51:09.695078Z","end":"2026-09-19T01:51:10.012791Z","steps":["trace[2105054454] 'process raft request' (duration: 312.504459ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:10.013559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:51:09.695064Z","time spent":"318.074979ms","remote":"127.0.0.1:55204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:51:10.013744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.080951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-09-19T01:51:10.01388Z","caller":"traceutil/trace.go:171","msg":"trace[106129153] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:631; }","duration":"314.296609ms","start":"2026-09-19T01:51:09.699551Z","end":"2026-09-19T01:51:10.013848Z","steps":["trace[106129153] 'agreement among raft nodes before linearized reading' (duration: 313.194541ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:10.014031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:51:09.699539Z","time spent":"314.436893ms","remote":"127.0.0.1:55204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":98737,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-09-19T01:51:10.251964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.674059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:51:10.252172Z","caller":"traceutil/trace.go:171","msg":"trace[1339492994] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"243.136481ms","start":"2026-09-19T01:51:10.00902Z","end":"2026-09-19T01:51:10.252157Z","steps":["trace[1339492994] 'read index received' (duration: 115.899653ms)","trace[1339492994] 'applied index is now lower than readState.Index' (duration: 127.235998ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:51:10.252249Z","caller":"traceutil/trace.go:171","msg":"trace[992571239] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"532.379352ms","start":"2026-09-19T01:51:09.719856Z","end":"2026-09-19T01:51:10.252235Z","steps":["trace[992571239] 'process raft request' (duration: 405.138814ms)","trace[992571239] 'compare' (duration: 123.1589ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:51:10.252311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:51:09.719836Z","time spent":"532.440185ms","remote":"127.0.0.1:55204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:51:10.252429Z","caller":"traceutil/trace.go:171","msg":"trace[470529078] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"493.170151ms","start":"2026-09-19T01:51:09.759251Z","end":"2026-09-19T01:51:10.252421Z","steps":["trace[470529078] 'process raft request' (duration: 492.831539ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:10.252497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:51:09.759228Z","time spent":"493.249253ms","remote":"127.0.0.1:55204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:51:10.252764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.45188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:51:10.252881Z","caller":"traceutil/trace.go:171","msg":"trace[785815456] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:633; }","duration":"295.586184ms","start":"2026-09-19T01:51:09.957242Z","end":"2026-09-19T01:51:10.252828Z","steps":["trace[785815456] 'agreement among raft nodes before linearized reading' (duration: 295.321905ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:10.257718Z","caller":"traceutil/trace.go:171","msg":"trace[551726390] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"160.758115ms","start":"2026-09-19T01:51:10.096936Z","end":"2026-09-19T01:51:10.257694Z","steps":["trace[551726390] 'process raft request' (duration: 160.59059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:10.257794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.207771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-09-19T01:51:10.25784Z","caller":"traceutil/trace.go:171","msg":"trace[173375513] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:634; }","duration":"212.274943ms","start":"2026-09-19T01:51:10.045551Z","end":"2026-09-19T01:51:10.257826Z","steps":["trace[173375513] 'agreement among raft nodes before linearized reading' (duration: 212.107917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:10.257864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.557872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T01:51:10.257952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.602026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-19T01:51:10.257979Z","caller":"traceutil/trace.go:171","msg":"trace[1599035768] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"154.654538ms","start":"2026-09-19T01:51:10.103316Z","end":"2026-09-19T01:51:10.25797Z","steps":["trace[1599035768] 'agreement among raft nodes before linearized reading' (duration: 154.605326ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:10.257985Z","caller":"traceutil/trace.go:171","msg":"trace[2122490260] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:634; }","duration":"100.761239ms","start":"2026-09-19T01:51:10.157206Z","end":"2026-09-19T01:51:10.257967Z","steps":["trace[2122490260] 'agreement among raft nodes before linearized reading' (duration: 100.551572ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:16.686547Z","caller":"traceutil/trace.go:171","msg":"trace[1203041797] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"100.161684ms","start":"2026-09-19T01:51:16.586305Z","end":"2026-09-19T01:51:16.686467Z","steps":["trace[1203041797] 'process raft request' (duration: 99.462061ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:17.130448Z","caller":"traceutil/trace.go:171","msg":"trace[1815082125] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"360.763857ms","start":"2026-09-19T01:51:16.769641Z","end":"2026-09-19T01:51:17.130405Z","steps":["trace[1815082125] 'process raft request' (duration: 360.512119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:17.130789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:51:16.769586Z","time spent":"361.022746ms","remote":"127.0.0.1:55348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:51:34.076362Z","caller":"traceutil/trace.go:171","msg":"trace[1311559168] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"213.987127ms","start":"2026-09-19T01:51:33.862344Z","end":"2026-09-19T01:51:34.076331Z","steps":["trace[1311559168] 'process raft request' (duration: 213.758911ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:05.315289Z","caller":"traceutil/trace.go:171","msg":"trace[2092127901] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"105.560178ms","start":"2026-09-19T01:52:05.209701Z","end":"2026-09-19T01:52:05.315261Z","steps":["trace[2092127901] 'process raft request' (duration: 105.365934ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:56.59555Z","caller":"traceutil/trace.go:171","msg":"trace[382050065] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"327.944675ms","start":"2026-09-19T01:52:56.267586Z","end":"2026-09-19T01:52:56.59553Z","steps":["trace[382050065] 'process raft request' (duration: 327.812392ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:56.595693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:56.26756Z","time spent":"328.056156ms","remote":"127.0.0.1:55348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:52:56.780414Z","caller":"traceutil/trace.go:171","msg":"trace[914144886] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"454.994129ms","start":"2026-09-19T01:52:56.325391Z","end":"2026-09-19T01:52:56.780385Z","steps":["trace[914144886] 'process raft request' (duration: 383.577268ms)","trace[914144886] 'compare' (duration: 71.169316ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:52:56.780588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:56.325362Z","time spent":"455.140222ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:52:56.780587Z","caller":"traceutil/trace.go:171","msg":"trace[962897618] linearizableReadLoop","detail":"{readStateIndex:1960; appliedIndex:1957; }","duration":"193.124328ms","start":"2026-09-19T01:52:56.587442Z","end":"2026-09-19T01:52:56.780566Z","steps":["trace[962897618] 'read index received' (duration: 8.010105ms)","trace[962897618] 'applied index is now lower than readState.Index' (duration: 185.112833ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:52:56.780731Z","caller":"traceutil/trace.go:171","msg":"trace[702624239] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"336.238687ms","start":"2026-09-19T01:52:56.444477Z","end":"2026-09-19T01:52:56.780716Z","steps":["trace[702624239] 'process raft request' (duration: 335.84388ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:56.780861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:56.44445Z","time spent":"336.311928ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:52:56.851531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.977521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:52:56.851602Z","caller":"traceutil/trace.go:171","msg":"trace[812792058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1891; }","duration":"168.182814ms","start":"2026-09-19T01:52:56.683404Z","end":"2026-09-19T01:52:56.851587Z","steps":["trace[812792058] 'agreement among raft nodes before linearized reading' (duration: 168.065042ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:56.851536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.092082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e68ec8cc-749a-4ae8-9e85-5e27a8703484\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-09-19T01:52:56.851727Z","caller":"traceutil/trace.go:171","msg":"trace[1889760014] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e68ec8cc-749a-4ae8-9e85-5e27a8703484; range_end:; response_count:1; response_revision:1891; }","duration":"264.320976ms","start":"2026-09-19T01:52:56.587386Z","end":"2026-09-19T01:52:56.851707Z","steps":["trace[1889760014] 'agreement among raft nodes before linearized reading' (duration: 193.645078ms)","trace[1889760014] 'range keys from in-memory index tree' (duration: 70.346092ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:52:56.995822Z","caller":"traceutil/trace.go:171","msg":"trace[38514386] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"138.728258ms","start":"2026-09-19T01:52:56.857045Z","end":"2026-09-19T01:52:56.995773Z","steps":["trace[38514386] 'process raft request' (duration: 138.218279ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:10.433792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.244472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11985"} {"level":"info","ts":"2026-09-19T01:53:10.433892Z","caller":"traceutil/trace.go:171","msg":"trace[1681458166] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2006; }","duration":"141.419065ms","start":"2026-09-19T01:53:10.292446Z","end":"2026-09-19T01:53:10.433865Z","steps":["trace[1681458166] 'range keys from in-memory index tree' (duration: 141.029308ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:10.435391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.386389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-19T01:53:10.435511Z","caller":"traceutil/trace.go:171","msg":"trace[278810419] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2006; }","duration":"307.605772ms","start":"2026-09-19T01:53:10.127886Z","end":"2026-09-19T01:53:10.435491Z","steps":["trace[278810419] 'range keys from in-memory index tree' (duration: 305.870183ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:10.435612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:10.127868Z","time spent":"307.727265ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-19T01:53:27.334487Z","caller":"traceutil/trace.go:171","msg":"trace[542760369] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"126.593639ms","start":"2026-09-19T01:53:27.207867Z","end":"2026-09-19T01:53:27.33446Z","steps":["trace[542760369] 'process raft request' (duration: 109.192046ms)","trace[542760369] 'compare' (duration: 16.973806ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:53:27.692671Z","caller":"traceutil/trace.go:171","msg":"trace[434405281] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"103.076773ms","start":"2026-09-19T01:53:27.589493Z","end":"2026-09-19T01:53:27.69257Z","steps":["trace[434405281] 'process raft request' (duration: 102.689307ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:53:27.915778Z","caller":"traceutil/trace.go:171","msg":"trace[1261902805] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"121.34428ms","start":"2026-09-19T01:53:27.794403Z","end":"2026-09-19T01:53:27.915747Z","steps":["trace[1261902805] 'process raft request' (duration: 85.715521ms)","trace[1261902805] 'compare' (duration: 35.505177ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:53:29.198881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.511542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:53:29.199069Z","caller":"traceutil/trace.go:171","msg":"trace[1382716615] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"278.1641ms","start":"2026-09-19T01:53:28.920869Z","end":"2026-09-19T01:53:29.199033Z","steps":["trace[1382716615] 'process raft request' (duration: 103.413124ms)","trace[1382716615] 'compare' (duration: 174.302568ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:53:29.581992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.525659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-19T01:53:29.582069Z","caller":"traceutil/trace.go:171","msg":"trace[503288419] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2124; }","duration":"181.671561ms","start":"2026-09-19T01:53:29.40038Z","end":"2026-09-19T01:53:29.582051Z","steps":["trace[503288419] 'range keys from in-memory index tree' (duration: 181.296265ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:29.582653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.411988ms","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-19T01:53:29.582695Z","caller":"traceutil/trace.go:171","msg":"trace[1142964732] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2124; }","duration":"233.484409ms","start":"2026-09-19T01:53:29.3492Z","end":"2026-09-19T01:53:29.582684Z","steps":["trace[1142964732] 'range keys from in-memory index tree' (duration: 233.288766ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:22.444577Z","caller":"traceutil/trace.go:171","msg":"trace[1190077801] linearizableReadLoop","detail":"{readStateIndex:2943; appliedIndex:2942; }","duration":"101.179635ms","start":"2026-09-19T01:55:22.343358Z","end":"2026-09-19T01:55:22.444538Z","steps":["trace[1190077801] 'read index received' (duration: 100.804923ms)","trace[1190077801] 'applied index is now lower than readState.Index' (duration: 369.602µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:55:22.44465Z","caller":"traceutil/trace.go:171","msg":"trace[2085438849] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"104.327848ms","start":"2026-09-19T01:55:22.340273Z","end":"2026-09-19T01:55:22.444601Z","steps":["trace[2085438849] 'process raft request' (duration: 103.996678ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:22.445015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.64555ms","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-09-19T01:55:22.445172Z","caller":"traceutil/trace.go:171","msg":"trace[926734816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2840; }","duration":"101.857888ms","start":"2026-09-19T01:55:22.343292Z","end":"2026-09-19T01:55:22.44515Z","steps":["trace[926734816] 'agreement among raft nodes before linearized reading' (duration: 101.509856ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:22.967592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.120549ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:55:22.96771Z","caller":"traceutil/trace.go:171","msg":"trace[1667794980] linearizableReadLoop","detail":"{readStateIndex:2946; appliedIndex:2945; }","duration":"361.593163ms","start":"2026-09-19T01:55:22.606101Z","end":"2026-09-19T01:55:22.967694Z","steps":["trace[1667794980] 'read index received' (duration: 94.33089ms)","trace[1667794980] 'applied index is now lower than readState.Index' (duration: 267.260833ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:55:22.967849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.760229ms","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-19T01:55:22.967881Z","caller":"traceutil/trace.go:171","msg":"trace[321099740] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2843; }","duration":"361.844962ms","start":"2026-09-19T01:55:22.606026Z","end":"2026-09-19T01:55:22.967871Z","steps":["trace[321099740] 'agreement among raft nodes before linearized reading' (duration: 361.711487ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:22.967917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:22.605998Z","time spent":"361.908604ms","remote":"127.0.0.1:55358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1393,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-09-19T01:55:22.968138Z","caller":"traceutil/trace.go:171","msg":"trace[1310287272] transaction","detail":"{read_only:false; response_revision:2843; number_of_response:1; }","duration":"372.77415ms","start":"2026-09-19T01:55:22.595351Z","end":"2026-09-19T01:55:22.968125Z","steps":["trace[1310287272] 'process raft request' (duration: 105.038592ms)","trace[1310287272] 'compare' (duration: 266.506348ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:55:22.9682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:22.595325Z","time spent":"372.844833ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:59:03.051213Z","caller":"traceutil/trace.go:171","msg":"trace[291297542] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4086; }","duration":"120.366982ms","start":"2026-09-19T01:59:02.930787Z","end":"2026-09-19T01:59:03.051154Z","steps":["trace[291297542] 'process raft request' (duration: 61.079959ms)","trace[291297542] 'compare' (duration: 59.054508ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:03.05123Z","caller":"traceutil/trace.go:171","msg":"trace[380484454] transaction","detail":"{read_only:false; response_revision:4087; number_of_response:1; }","duration":"118.428013ms","start":"2026-09-19T01:59:02.932782Z","end":"2026-09-19T01:59:03.05121Z","steps":["trace[380484454] 'process raft request' (duration: 118.190468ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:53.514676Z","caller":"traceutil/trace.go:171","msg":"trace[1378830729] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"118.473147ms","start":"2026-09-19T01:59:53.396176Z","end":"2026-09-19T01:59:53.514649Z","steps":["trace[1378830729] 'process raft request' (duration: 118.277103ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:56.535218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.106086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:59:56.535308Z","caller":"traceutil/trace.go:171","msg":"trace[317323236] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:4961; }","duration":"117.237608ms","start":"2026-09-19T01:59:56.418053Z","end":"2026-09-19T01:59:56.535291Z","steps":["trace[317323236] 'count revisions from in-memory index tree' (duration: 117.042645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:00.333555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.313021ms","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-19T02:00:00.334524Z","caller":"traceutil/trace.go:171","msg":"trace[1197923598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5030; }","duration":"143.335311ms","start":"2026-09-19T02:00:00.191169Z","end":"2026-09-19T02:00:00.334504Z","steps":["trace[1197923598] 'range keys from in-memory index tree' (duration: 142.110157ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:06.669954Z","caller":"traceutil/trace.go:171","msg":"trace[514564810] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"168.766544ms","start":"2026-09-19T02:00:06.501155Z","end":"2026-09-19T02:00:06.669922Z","steps":["trace[514564810] 'process raft request' (duration: 148.460187ms)","trace[514564810] 'compare' (duration: 20.159514ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:07.258535Z","caller":"traceutil/trace.go:171","msg":"trace[1227737870] linearizableReadLoop","detail":"{readStateIndex:5331; appliedIndex:5330; }","duration":"341.856447ms","start":"2026-09-19T02:00:06.916656Z","end":"2026-09-19T02:00:07.258512Z","steps":["trace[1227737870] 'read index received' (duration: 341.669493ms)","trace[1227737870] 'applied index is now lower than readState.Index' (duration: 186.084µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T02:00:07.258916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.251924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-19T02:00:07.25896Z","caller":"traceutil/trace.go:171","msg":"trace[444739629] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5140; }","duration":"342.346456ms","start":"2026-09-19T02:00:06.916601Z","end":"2026-09-19T02:00:07.258947Z","steps":["trace[444739629] 'agreement among raft nodes before linearized reading' (duration: 342.160453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:07.258991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:00:06.91658Z","time spent":"342.402237ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-09-19T02:00:07.259053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.322498ms","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-09-19T02:00:07.259167Z","caller":"traceutil/trace.go:171","msg":"trace[166175877] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"349.510122ms","start":"2026-09-19T02:00:06.909646Z","end":"2026-09-19T02:00:07.259156Z","steps":["trace[166175877] 'process raft request' (duration: 348.734287ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:07.259174Z","caller":"traceutil/trace.go:171","msg":"trace[1248275779] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5140; }","duration":"122.46184ms","start":"2026-09-19T02:00:07.136687Z","end":"2026-09-19T02:00:07.259149Z","steps":["trace[1248275779] 'agreement among raft nodes before linearized reading' (duration: 122.273856ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:07.259247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:00:06.909616Z","time spent":"349.575433ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T02:00:07.259244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.299568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:00:07.259303Z","caller":"traceutil/trace.go:171","msg":"trace[1719023301] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5140; }","duration":"297.437561ms","start":"2026-09-19T02:00:06.961847Z","end":"2026-09-19T02:00:07.259284Z","steps":["trace[1719023301] 'agreement among raft nodes before linearized reading' (duration: 297.333359ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:07.25905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.545043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4ca2a55-a1f2-4ede-b8e2-6a859ace2df8\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-19T02:00:07.259768Z","caller":"traceutil/trace.go:171","msg":"trace[1048573319] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c4ca2a55-a1f2-4ede-b8e2-6a859ace2df8; range_end:; response_count:1; response_revision:5140; }","duration":"308.299357ms","start":"2026-09-19T02:00:06.951443Z","end":"2026-09-19T02:00:07.259742Z","steps":["trace[1048573319] 'agreement among raft nodes before linearized reading' (duration: 307.317199ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:07.259851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:00:06.951426Z","time spent":"308.394409ms","remote":"127.0.0.1:55348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4ca2a55-a1f2-4ede-b8e2-6a859ace2df8\" "} {"level":"warn","ts":"2026-09-19T02:00:07.738027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.713321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T02:00:07.738335Z","caller":"traceutil/trace.go:171","msg":"trace[603014414] linearizableReadLoop","detail":"{readStateIndex:5336; appliedIndex:5334; }","duration":"244.84491ms","start":"2026-09-19T02:00:07.493469Z","end":"2026-09-19T02:00:07.738314Z","steps":["trace[603014414] 'read index received' (duration: 96.788602ms)","trace[603014414] 'applied index is now lower than readState.Index' (duration: 148.055088ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:07.738412Z","caller":"traceutil/trace.go:171","msg":"trace[834693296] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"255.662855ms","start":"2026-09-19T02:00:07.482724Z","end":"2026-09-19T02:00:07.738387Z","steps":["trace[834693296] 'process raft request' (duration: 255.429621ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:07.738423Z","caller":"traceutil/trace.go:171","msg":"trace[179113480] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"298.356798ms","start":"2026-09-19T02:00:07.440027Z","end":"2026-09-19T02:00:07.738384Z","steps":["trace[179113480] 'process raft request' (duration: 150.165218ms)","trace[179113480] 'compare' (duration: 147.255782ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:07.738526Z","caller":"traceutil/trace.go:171","msg":"trace[278004909] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"171.480953ms","start":"2026-09-19T02:00:07.567023Z","end":"2026-09-19T02:00:07.738504Z","steps":["trace[278004909] 'process raft request' (duration: 171.216178ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:07.738558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.091234ms","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-19T02:00:07.738614Z","caller":"traceutil/trace.go:171","msg":"trace[161255620] 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:5146; }","duration":"245.181096ms","start":"2026-09-19T02:00:07.493414Z","end":"2026-09-19T02:00:07.738595Z","steps":["trace[161255620] 'agreement among raft nodes before linearized reading' (duration: 245.005663ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:07.918746Z","caller":"traceutil/trace.go:171","msg":"trace[1222642920] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"105.333505ms","start":"2026-09-19T02:00:07.813394Z","end":"2026-09-19T02:00:07.918727Z","steps":["trace[1222642920] 'process raft request' (duration: 100.684806ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:07.918779Z","caller":"traceutil/trace.go:171","msg":"trace[621348367] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"100.271878ms","start":"2026-09-19T02:00:07.818486Z","end":"2026-09-19T02:00:07.918758Z","steps":["trace[621348367] 'process raft request' (duration: 100.226607ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:07.918967Z","caller":"traceutil/trace.go:171","msg":"trace[893879468] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"101.747146ms","start":"2026-09-19T02:00:07.817212Z","end":"2026-09-19T02:00:07.918959Z","steps":["trace[893879468] 'process raft request' (duration: 101.382629ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:07.919056Z","caller":"traceutil/trace.go:171","msg":"trace[1449583817] linearizableReadLoop","detail":"{readStateIndex:5340; appliedIndex:5339; }","duration":"102.931639ms","start":"2026-09-19T02:00:07.816117Z","end":"2026-09-19T02:00:07.919048Z","steps":["trace[1449583817] 'read index received' (duration: 97.950594ms)","trace[1449583817] 'applied index is now lower than readState.Index' (duration: 4.979985ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T02:00:07.919212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.079881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:00:07.91924Z","caller":"traceutil/trace.go:171","msg":"trace[1241513694] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:5151; }","duration":"103.151183ms","start":"2026-09-19T02:00:07.81608Z","end":"2026-09-19T02:00:07.919231Z","steps":["trace[1241513694] 'agreement among raft nodes before linearized reading' (duration: 103.066952ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:20.735262Z","caller":"traceutil/trace.go:171","msg":"trace[1155876514] linearizableReadLoop","detail":"{readStateIndex:5501; appliedIndex:5500; }","duration":"143.10071ms","start":"2026-09-19T02:00:20.592137Z","end":"2026-09-19T02:00:20.735238Z","steps":["trace[1155876514] 'read index received' (duration: 142.792714ms)","trace[1155876514] 'applied index is now lower than readState.Index' (duration: 307.056µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:20.735314Z","caller":"traceutil/trace.go:171","msg":"trace[40648359] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"145.667889ms","start":"2026-09-19T02:00:20.589624Z","end":"2026-09-19T02:00:20.735292Z","steps":["trace[40648359] 'process raft request' (duration: 145.407534ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:20.735532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.321004ms","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-09-19T02:00:20.735577Z","caller":"traceutil/trace.go:171","msg":"trace[1819911665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5304; }","duration":"143.455077ms","start":"2026-09-19T02:00:20.592108Z","end":"2026-09-19T02:00:20.735563Z","steps":["trace[1819911665] 'agreement among raft nodes before linearized reading' (duration: 143.252433ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:20.735577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.897628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-19T02:00:20.735637Z","caller":"traceutil/trace.go:171","msg":"trace[1146078691] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5304; }","duration":"106.00135ms","start":"2026-09-19T02:00:20.62962Z","end":"2026-09-19T02:00:20.735621Z","steps":["trace[1146078691] 'agreement among raft nodes before linearized reading' (duration: 105.860158ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:21.039034Z","caller":"traceutil/trace.go:171","msg":"trace[1947775735] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"295.874123ms","start":"2026-09-19T02:00:20.743135Z","end":"2026-09-19T02:00:21.039009Z","steps":["trace[1947775735] 'process raft request' (duration: 295.74151ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:21.049991Z","caller":"traceutil/trace.go:171","msg":"trace[1033745369] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"306.773718ms","start":"2026-09-19T02:00:20.743184Z","end":"2026-09-19T02:00:21.049958Z","steps":["trace[1033745369] 'process raft request' (duration: 306.498633ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:21.050076Z","caller":"traceutil/trace.go:171","msg":"trace[1640153128] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"306.832509ms","start":"2026-09-19T02:00:20.743217Z","end":"2026-09-19T02:00:21.050049Z","steps":["trace[1640153128] 'process raft request' (duration: 306.616645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:21.050273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:00:20.743157Z","time spent":"306.91781ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T02:00:21.050334Z","caller":"traceutil/trace.go:171","msg":"trace[1350275470] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"307.024333ms","start":"2026-09-19T02:00:20.743288Z","end":"2026-09-19T02:00:21.050312Z","steps":["trace[1350275470] 'process raft request' (duration: 306.616915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:21.050564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:00:20.743044Z","time spent":"307.338198ms","remote":"127.0.0.1:55448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T02:00:21.052605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:00:20.743042Z","time spent":"309.500719ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T02:00:21.050076Z","caller":"traceutil/trace.go:171","msg":"trace[627921019] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"306.037474ms","start":"2026-09-19T02:00:20.744015Z","end":"2026-09-19T02:00:21.050052Z","steps":["trace[627921019] 'process raft request' (duration: 305.963602ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:21.053009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:00:20.74398Z","time spent":"308.929359ms","remote":"127.0.0.1:55448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T02:00:21.523084Z","caller":"traceutil/trace.go:171","msg":"trace[766393377] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"106.60219ms","start":"2026-09-19T02:00:21.416449Z","end":"2026-09-19T02:00:21.523052Z","steps":["trace[766393377] 'process raft request' (duration: 36.798454ms)","trace[766393377] 'compare' (duration: 69.673684ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:21.577581Z","caller":"traceutil/trace.go:171","msg":"trace[1560176888] linearizableReadLoop","detail":"{readStateIndex:5509; appliedIndex:5508; }","duration":"108.300822ms","start":"2026-09-19T02:00:21.469255Z","end":"2026-09-19T02:00:21.577556Z","steps":["trace[1560176888] 'read index received' (duration: 107.817803ms)","trace[1560176888] 'applied index is now lower than readState.Index' (duration: 482.049µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:21.577676Z","caller":"traceutil/trace.go:171","msg":"trace[1935500845] transaction","detail":"{read_only:false; response_revision:5312; number_of_response:1; }","duration":"150.555879ms","start":"2026-09-19T02:00:21.427059Z","end":"2026-09-19T02:00:21.577615Z","steps":["trace[1935500845] 'process raft request' (duration: 150.192692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:21.577918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.464266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:00:21.57799Z","caller":"traceutil/trace.go:171","msg":"trace[869892719] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:5312; }","duration":"108.762951ms","start":"2026-09-19T02:00:21.469208Z","end":"2026-09-19T02:00:21.577971Z","steps":["trace[869892719] 'agreement among raft nodes before linearized reading' (duration: 108.443575ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:21.719276Z","caller":"traceutil/trace.go:171","msg":"trace[1852606951] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"134.118099ms","start":"2026-09-19T02:00:21.585131Z","end":"2026-09-19T02:00:21.719249Z","steps":["trace[1852606951] 'process raft request' (duration: 74.377892ms)","trace[1852606951] 'compare' (duration: 59.38472ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:21.725095Z","caller":"traceutil/trace.go:171","msg":"trace[467768627] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"139.894668ms","start":"2026-09-19T02:00:21.585184Z","end":"2026-09-19T02:00:21.725079Z","steps":["trace[467768627] 'process raft request' (duration: 139.691684ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:21.72535Z","caller":"traceutil/trace.go:171","msg":"trace[445089164] linearizableReadLoop","detail":"{readStateIndex:5512; appliedIndex:5509; }","duration":"125.680921ms","start":"2026-09-19T02:00:21.599601Z","end":"2026-09-19T02:00:21.725282Z","steps":["trace[445089164] 'read index received' (duration: 59.88143ms)","trace[445089164] 'applied index is now lower than readState.Index' (duration: 65.79741ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:21.72543Z","caller":"traceutil/trace.go:171","msg":"trace[1693146682] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"136.226899ms","start":"2026-09-19T02:00:21.589179Z","end":"2026-09-19T02:00:21.725406Z","steps":["trace[1693146682] 'process raft request' (duration: 135.828211ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:21.725576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.952706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.84\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-19T02:00:21.72563Z","caller":"traceutil/trace.go:171","msg":"trace[2064709286] range","detail":"{range_begin:/registry/masterleases/162.253.55.84; range_end:; response_count:1; response_revision:5315; }","duration":"126.053537ms","start":"2026-09-19T02:00:21.599561Z","end":"2026-09-19T02:00:21.725615Z","steps":["trace[2064709286] 'agreement among raft nodes before linearized reading' (duration: 125.889754ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:28.315254Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872} {"level":"info","ts":"2026-09-19T02:00:28.398717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"81.679724ms","hash":3721784186,"current-db-size-bytes":52166656,"current-db-size":"52 MB","current-db-size-in-use-bytes":27545600,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-19T02:00:28.398778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3721784186,"revision":2872,"compact-revision":-1} {"level":"info","ts":"2026-09-19T02:01:11.133268Z","caller":"traceutil/trace.go:171","msg":"trace[128921221] transaction","detail":"{read_only:false; response_revision:5743; number_of_response:1; }","duration":"188.193438ms","start":"2026-09-19T02:01:10.945033Z","end":"2026-09-19T02:01:11.133226Z","steps":["trace[128921221] 'process raft request' (duration: 187.998685ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:01:11.466209Z","caller":"traceutil/trace.go:171","msg":"trace[582750321] transaction","detail":"{read_only:false; response_revision:5744; number_of_response:1; }","duration":"101.24714ms","start":"2026-09-19T02:01:11.364922Z","end":"2026-09-19T02:01:11.466169Z","steps":["trace[582750321] 'process raft request' (duration: 101.053107ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:05:28.324456Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5376} {"level":"info","ts":"2026-09-19T02:05:28.417434Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5376,"took":"91.100584ms","hash":1769257234,"current-db-size-bytes":52166656,"current-db-size":"52 MB","current-db-size-in-use-bytes":18751488,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T02:05:28.417502Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1769257234,"revision":5376,"compact-revision":2872}