{"level":"warn","ts":"2026-10-02T15:13:20.263417Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-02T15:13:20.263507Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.46: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://199.204.45.46:2380","--initial-cluster=instance=https://199.204.45.46:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.46:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.46: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-10-02T15:13:20.263582Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-02T15:13:20.263593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.46:2380"]} {"level":"info","ts":"2026-10-02T15:13:20.263616Z","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-10-02T15:13:20.264356Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.46:2379"]} {"level":"info","ts":"2026-10-02T15:13:20.264447Z","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://199.204.45.46:2380"],"listen-peer-urls":["https://199.204.45.46:2380"],"advertise-client-urls":["https://199.204.45.46:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.46:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.46: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-10-02T15:13:20.268912Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.226211ms"} {"level":"info","ts":"2026-10-02T15:13:20.278649Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c4a2defa8b654d42","cluster-id":"d1fec3b29a16c311"} {"level":"info","ts":"2026-10-02T15:13:20.278728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 switched to configuration voters=()"} {"level":"info","ts":"2026-10-02T15:13:20.278751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 became follower at term 0"} {"level":"info","ts":"2026-10-02T15:13:20.278764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c4a2defa8b654d42 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-02T15:13:20.278772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 became follower at term 1"} {"level":"info","ts":"2026-10-02T15:13:20.278811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 switched to configuration voters=(14169132545322863938)"} {"level":"warn","ts":"2026-10-02T15:13:20.289912Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-02T15:13:20.291867Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-02T15:13:20.2933Z","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-10-02T15:13:20.300129Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c4a2defa8b654d42","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-02T15:13:20.301102Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c4a2defa8b654d42","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-02T15:13:20.301608Z","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-10-02T15:13:20.301684Z","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-10-02T15:13:20.301696Z","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-10-02T15:13:20.302635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 switched to configuration voters=(14169132545322863938)"} {"level":"info","ts":"2026-10-02T15:13:20.302756Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d1fec3b29a16c311","local-member-id":"c4a2defa8b654d42","added-peer-id":"c4a2defa8b654d42","added-peer-peer-urls":["https://199.204.45.46:2380"]} {"level":"info","ts":"2026-10-02T15:13:20.304435Z","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-10-02T15:13:20.304711Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c4a2defa8b654d42","initial-advertise-peer-urls":["https://199.204.45.46:2380"],"listen-peer-urls":["https://199.204.45.46:2380"],"advertise-client-urls":["https://199.204.45.46:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.46:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-02T15:13:20.304747Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-02T15:13:20.305057Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.46:2380"} {"level":"info","ts":"2026-10-02T15:13:20.305076Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.46:2380"} {"level":"info","ts":"2026-10-02T15:13:20.38041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 is starting a new election at term 1"} {"level":"info","ts":"2026-10-02T15:13:20.380463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-02T15:13:20.380482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 received MsgPreVoteResp from c4a2defa8b654d42 at term 1"} {"level":"info","ts":"2026-10-02T15:13:20.380522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 became candidate at term 2"} {"level":"info","ts":"2026-10-02T15:13:20.380536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 received MsgVoteResp from c4a2defa8b654d42 at term 2"} {"level":"info","ts":"2026-10-02T15:13:20.380619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c4a2defa8b654d42 became leader at term 2"} {"level":"info","ts":"2026-10-02T15:13:20.380635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c4a2defa8b654d42 elected leader c4a2defa8b654d42 at term 2"} {"level":"info","ts":"2026-10-02T15:13:20.381945Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T15:13:20.382723Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c4a2defa8b654d42","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.46:2379]}","request-path":"/0/members/c4a2defa8b654d42/attributes","cluster-id":"d1fec3b29a16c311","publish-timeout":"7s"} {"level":"info","ts":"2026-10-02T15:13:20.382889Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T15:13:20.38288Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T15:13:20.383109Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-02T15:13:20.383158Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-02T15:13:20.383613Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d1fec3b29a16c311","local-member-id":"c4a2defa8b654d42","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T15:13:20.383792Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T15:13:20.383841Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T15:13:20.385417Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-02T15:13:20.387077Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.46:2379"} {"level":"warn","ts":"2026-10-02T15:13:23.761665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.911593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-02T15:13:23.761754Z","caller":"traceutil/trace.go:171","msg":"trace[39937270] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"171.144858ms","start":"2026-10-02T15:13:23.590596Z","end":"2026-10-02T15:13:23.761741Z","steps":["trace[39937270] 'process raft request' (duration: 26.762336ms)","trace[39937270] 'compare' (duration: 143.803219ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:13:59.141577Z","caller":"traceutil/trace.go:171","msg":"trace[147324935] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"134.817421ms","start":"2026-10-02T15:13:59.006735Z","end":"2026-10-02T15:13:59.141553Z","steps":["trace[147324935] 'process raft request' (duration: 134.666391ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:13:59.155662Z","caller":"traceutil/trace.go:171","msg":"trace[1086613389] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"146.22406ms","start":"2026-10-02T15:13:59.009408Z","end":"2026-10-02T15:13:59.155632Z","steps":["trace[1086613389] 'process raft request' (duration: 139.546328ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:13:59.155723Z","caller":"traceutil/trace.go:171","msg":"trace[1599009748] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"134.988851ms","start":"2026-10-02T15:13:59.020707Z","end":"2026-10-02T15:13:59.155695Z","steps":["trace[1599009748] 'process raft request' (duration: 134.878255ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:13:59.155791Z","caller":"traceutil/trace.go:171","msg":"trace[2014831537] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"134.406907ms","start":"2026-10-02T15:13:59.021379Z","end":"2026-10-02T15:13:59.155786Z","steps":["trace[2014831537] 'process raft request' (duration: 134.235937ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:13:59.155803Z","caller":"traceutil/trace.go:171","msg":"trace[496436323] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"132.109343ms","start":"2026-10-02T15:13:59.023632Z","end":"2026-10-02T15:13:59.155741Z","steps":["trace[496436323] 'process raft request' (duration: 132.037059ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:13:59.155747Z","caller":"traceutil/trace.go:171","msg":"trace[1268959962] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"133.311053ms","start":"2026-10-02T15:13:59.022413Z","end":"2026-10-02T15:13:59.155724Z","steps":["trace[1268959962] 'process raft request' (duration: 133.223768ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:13:59.156077Z","caller":"traceutil/trace.go:171","msg":"trace[1906274626] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"127.840892ms","start":"2026-10-02T15:13:59.028227Z","end":"2026-10-02T15:13:59.156068Z","steps":["trace[1906274626] 'process raft request' (duration: 127.725935ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:13:59.156057Z","caller":"traceutil/trace.go:171","msg":"trace[627183208] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"130.901872ms","start":"2026-10-02T15:13:59.025093Z","end":"2026-10-02T15:13:59.155995Z","steps":["trace[627183208] 'process raft request' (duration: 130.602074ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:13:59.156439Z","caller":"traceutil/trace.go:171","msg":"trace[1121167603] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"102.283314ms","start":"2026-10-02T15:13:59.054145Z","end":"2026-10-02T15:13:59.156428Z","steps":["trace[1121167603] 'process raft request' (duration: 101.86776ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:14:05.652086Z","caller":"traceutil/trace.go:171","msg":"trace[1476531398] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"190.070411ms","start":"2026-10-02T15:14:05.461993Z","end":"2026-10-02T15:14:05.652064Z","steps":["trace[1476531398] 'read index received' (duration: 189.942573ms)","trace[1476531398] 'applied index is now lower than readState.Index' (duration: 126.918µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:14:05.652381Z","caller":"traceutil/trace.go:171","msg":"trace[108632549] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"333.191861ms","start":"2026-10-02T15:14:05.31918Z","end":"2026-10-02T15:14:05.652372Z","steps":["trace[108632549] 'process raft request' (duration: 332.768574ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:14:05.652529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.506919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:14:05.652557Z","caller":"traceutil/trace.go:171","msg":"trace[1835274928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"190.613715ms","start":"2026-10-02T15:14:05.461934Z","end":"2026-10-02T15:14:05.652548Z","steps":["trace[1835274928] 'agreement among raft nodes before linearized reading' (duration: 190.512709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:14:05.652633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.954897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bjn27\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-02T15:14:05.652676Z","caller":"traceutil/trace.go:171","msg":"trace[705353216] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bjn27; range_end:; response_count:1; response_revision:638; }","duration":"103.00338ms","start":"2026-10-02T15:14:05.549662Z","end":"2026-10-02T15:14:05.652665Z","steps":["trace[705353216] 'agreement among raft nodes before linearized reading' (duration: 102.746235ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:14:05.652882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:14:05.319149Z","time spent":"333.696401ms","remote":"127.0.0.1:46292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T15:14:06.038111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.832319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-02T15:14:06.038234Z","caller":"traceutil/trace.go:171","msg":"trace[1012768962] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"364.827296ms","start":"2026-10-02T15:14:05.673383Z","end":"2026-10-02T15:14:06.038211Z","steps":["trace[1012768962] 'read index received' (duration: 33.669616ms)","trace[1012768962] 'applied index is now lower than readState.Index' (duration: 331.15582ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:14:06.038385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.996596ms","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":"info","ts":"2026-10-02T15:14:06.038713Z","caller":"traceutil/trace.go:171","msg":"trace[1489368803] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:639; }","duration":"365.320646ms","start":"2026-10-02T15:14:05.673372Z","end":"2026-10-02T15:14:06.038693Z","steps":["trace[1489368803] 'agreement among raft nodes before linearized reading' (duration: 364.907711ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:14:06.038817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:14:05.673322Z","time spent":"365.477837ms","remote":"127.0.0.1:46026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-10-02T15:14:06.038413Z","caller":"traceutil/trace.go:171","msg":"trace[476298899] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"365.156896ms","start":"2026-10-02T15:14:05.673226Z","end":"2026-10-02T15:14:06.038383Z","steps":["trace[476298899] 'process raft request' (duration: 33.754822ms)","trace[476298899] 'compare' (duration: 330.51589ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:14:06.039434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:14:05.673172Z","time spent":"366.205061ms","remote":"127.0.0.1:45974","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-10-02T15:14:07.844005Z","caller":"traceutil/trace.go:171","msg":"trace[133306719] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"113.708588ms","start":"2026-10-02T15:14:07.730268Z","end":"2026-10-02T15:14:07.843977Z","steps":["trace[133306719] 'process raft request' (duration: 113.554398ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:14:21.811699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.761119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6zrm6\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-10-02T15:14:21.811792Z","caller":"traceutil/trace.go:171","msg":"trace[69451678] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6zrm6; range_end:; response_count:1; response_revision:800; }","duration":"155.907838ms","start":"2026-10-02T15:14:21.655863Z","end":"2026-10-02T15:14:21.811771Z","steps":["trace[69451678] 'range keys from in-memory index tree' (duration: 155.544125ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:14:21.811814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.107981ms","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-10-02T15:14:21.812166Z","caller":"traceutil/trace.go:171","msg":"trace[506139727] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:800; }","duration":"223.518529ms","start":"2026-10-02T15:14:21.588623Z","end":"2026-10-02T15:14:21.812141Z","steps":["trace[506139727] 'range keys from in-memory index tree' (duration: 222.62919ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:15:08.207601Z","caller":"traceutil/trace.go:171","msg":"trace[561501373] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"100.233187ms","start":"2026-10-02T15:15:08.107346Z","end":"2026-10-02T15:15:08.20758Z","steps":["trace[561501373] 'process raft request' (duration: 100.124159ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:15:26.877796Z","caller":"traceutil/trace.go:171","msg":"trace[171812980] linearizableReadLoop","detail":"{readStateIndex:1751; appliedIndex:1750; }","duration":"102.0719ms","start":"2026-10-02T15:15:26.775704Z","end":"2026-10-02T15:15:26.877776Z","steps":["trace[171812980] 'read index received' (duration: 101.94486ms)","trace[171812980] 'applied index is now lower than readState.Index' (duration: 126.22µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:15:26.877875Z","caller":"traceutil/trace.go:171","msg":"trace[1723479356] transaction","detail":"{read_only:false; response_revision:1688; number_of_response:1; }","duration":"123.184207ms","start":"2026-10-02T15:15:26.754673Z","end":"2026-10-02T15:15:26.877858Z","steps":["trace[1723479356] 'process raft request' (duration: 122.977491ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:15:26.877966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.238902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-02T15:15:26.878008Z","caller":"traceutil/trace.go:171","msg":"trace[681485289] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1688; }","duration":"102.319489ms","start":"2026-10-02T15:15:26.775676Z","end":"2026-10-02T15:15:26.877996Z","steps":["trace[681485289] 'agreement among raft nodes before linearized reading' (duration: 102.20662ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:15:28.187784Z","caller":"traceutil/trace.go:171","msg":"trace[1023295648] transaction","detail":"{read_only:false; response_revision:1703; number_of_response:1; }","duration":"153.77742ms","start":"2026-10-02T15:15:28.03399Z","end":"2026-10-02T15:15:28.187767Z","steps":["trace[1023295648] 'process raft request' (duration: 132.238275ms)","trace[1023295648] 'compare' (duration: 21.036176ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:15:44.250794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.297504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d453e97e-d2dd-4002-918e-9426ff16794a\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-02T15:15:44.250898Z","caller":"traceutil/trace.go:171","msg":"trace[196637896] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d453e97e-d2dd-4002-918e-9426ff16794a; range_end:; response_count:1; response_revision:1901; }","duration":"186.485029ms","start":"2026-10-02T15:15:44.064387Z","end":"2026-10-02T15:15:44.250872Z","steps":["trace[196637896] 'range keys from in-memory index tree' (duration: 186.128981ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:15:44.680141Z","caller":"traceutil/trace.go:171","msg":"trace[54606458] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1972; }","duration":"215.94824ms","start":"2026-10-02T15:15:44.464166Z","end":"2026-10-02T15:15:44.680115Z","steps":["trace[54606458] 'read index received' (duration: 215.768956ms)","trace[54606458] 'applied index is now lower than readState.Index' (duration: 177.864µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:15:44.680292Z","caller":"traceutil/trace.go:171","msg":"trace[522730555] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"249.480199ms","start":"2026-10-02T15:15:44.430797Z","end":"2026-10-02T15:15:44.680277Z","steps":["trace[522730555] 'process raft request' (duration: 249.109201ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:15:44.680505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.330729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:15:44.680562Z","caller":"traceutil/trace.go:171","msg":"trace[1697875803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1903; }","duration":"216.437408ms","start":"2026-10-02T15:15:44.464111Z","end":"2026-10-02T15:15:44.680549Z","steps":["trace[1697875803] 'agreement among raft nodes before linearized reading' (duration: 216.33643ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:15:44.680603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.639361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d453e97e-d2dd-4002-918e-9426ff16794a\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-10-02T15:15:44.680678Z","caller":"traceutil/trace.go:171","msg":"trace[1999983207] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d453e97e-d2dd-4002-918e-9426ff16794a; range_end:; response_count:1; response_revision:1903; }","duration":"100.754241ms","start":"2026-10-02T15:15:44.579905Z","end":"2026-10-02T15:15:44.680659Z","steps":["trace[1999983207] 'agreement among raft nodes before linearized reading' (duration: 100.530563ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:15:56.439202Z","caller":"traceutil/trace.go:171","msg":"trace[59604087] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"446.134136ms","start":"2026-10-02T15:15:55.993036Z","end":"2026-10-02T15:15:56.43917Z","steps":["trace[59604087] 'process raft request' (duration: 445.93315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:15:56.439414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:15:55.992999Z","time spent":"446.299619ms","remote":"127.0.0.1:45974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5622,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T15:16:17.682318Z","caller":"traceutil/trace.go:171","msg":"trace[370616638] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2216; }","duration":"175.611399ms","start":"2026-10-02T15:16:17.50668Z","end":"2026-10-02T15:16:17.682292Z","steps":["trace[370616638] 'read index received' (duration: 83.795239ms)","trace[370616638] 'applied index is now lower than readState.Index' (duration: 91.81488ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:16:17.682336Z","caller":"traceutil/trace.go:171","msg":"trace[1209199834] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"185.237996ms","start":"2026-10-02T15:16:17.497069Z","end":"2026-10-02T15:16:17.682307Z","steps":["trace[1209199834] 'process raft request' (duration: 93.487784ms)","trace[1209199834] 'compare' (duration: 91.558601ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:16:17.682611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.871097ms","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-10-02T15:16:17.682685Z","caller":"traceutil/trace.go:171","msg":"trace[893320776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2139; }","duration":"176.018721ms","start":"2026-10-02T15:16:17.506642Z","end":"2026-10-02T15:16:17.682661Z","steps":["trace[893320776] 'agreement among raft nodes before linearized reading' (duration: 175.769092ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:17.869181Z","caller":"traceutil/trace.go:171","msg":"trace[118781997] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"145.184202ms","start":"2026-10-02T15:16:17.723977Z","end":"2026-10-02T15:16:17.869161Z","steps":["trace[118781997] 'process raft request' (duration: 145.059157ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:17.898029Z","caller":"traceutil/trace.go:171","msg":"trace[1311481676] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"126.759179ms","start":"2026-10-02T15:16:17.771243Z","end":"2026-10-02T15:16:17.898002Z","steps":["trace[1311481676] 'process raft request' (duration: 126.600457ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:18.125085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.960037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-02T15:16:18.125186Z","caller":"traceutil/trace.go:171","msg":"trace[1493917976] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2142; }","duration":"134.123461ms","start":"2026-10-02T15:16:17.991038Z","end":"2026-10-02T15:16:18.125162Z","steps":["trace[1493917976] 'count revisions from in-memory index tree' (duration: 133.821543ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:19.037062Z","caller":"traceutil/trace.go:171","msg":"trace[1215638269] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"184.516544ms","start":"2026-10-02T15:16:18.852523Z","end":"2026-10-02T15:16:19.03704Z","steps":["trace[1215638269] 'process raft request' (duration: 184.38607ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:19.072757Z","caller":"traceutil/trace.go:171","msg":"trace[629421058] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"132.276255ms","start":"2026-10-02T15:16:18.940453Z","end":"2026-10-02T15:16:19.072729Z","steps":["trace[629421058] 'process raft request' (duration: 132.108582ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:19.578721Z","caller":"traceutil/trace.go:171","msg":"trace[1935292845] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"137.517879ms","start":"2026-10-02T15:16:19.441171Z","end":"2026-10-02T15:16:19.578689Z","steps":["trace[1935292845] 'process raft request' (duration: 137.333407ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:17:28.056909Z","caller":"traceutil/trace.go:171","msg":"trace[1424218559] linearizableReadLoop","detail":"{readStateIndex:2710; appliedIndex:2709; }","duration":"152.090772ms","start":"2026-10-02T15:17:27.904798Z","end":"2026-10-02T15:17:28.056889Z","steps":["trace[1424218559] 'read index received' (duration: 151.913672ms)","trace[1424218559] 'applied index is now lower than readState.Index' (duration: 176.31µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:17:28.057158Z","caller":"traceutil/trace.go:171","msg":"trace[294280574] transaction","detail":"{read_only:false; response_revision:2616; number_of_response:1; }","duration":"161.10869ms","start":"2026-10-02T15:17:27.896038Z","end":"2026-10-02T15:17:28.057147Z","steps":["trace[294280574] 'process raft request' (duration: 160.723959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:17:28.057369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.553093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:17:28.0574Z","caller":"traceutil/trace.go:171","msg":"trace[844333544] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2616; }","duration":"152.624263ms","start":"2026-10-02T15:17:27.904766Z","end":"2026-10-02T15:17:28.057391Z","steps":["trace[844333544] 'agreement among raft nodes before linearized reading' (duration: 152.559303ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:17:59.930404Z","caller":"traceutil/trace.go:171","msg":"trace[652300435] transaction","detail":"{read_only:false; response_revision:2791; number_of_response:1; }","duration":"186.636317ms","start":"2026-10-02T15:17:59.743741Z","end":"2026-10-02T15:17:59.930377Z","steps":["trace[652300435] 'process raft request' (duration: 180.477984ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:20:36.117015Z","caller":"traceutil/trace.go:171","msg":"trace[593228852] transaction","detail":"{read_only:false; response_revision:3689; number_of_response:1; }","duration":"114.036841ms","start":"2026-10-02T15:20:36.002953Z","end":"2026-10-02T15:20:36.11699Z","steps":["trace[593228852] 'process raft request' (duration: 113.891104ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:19.348654Z","caller":"traceutil/trace.go:171","msg":"trace[1162513035] transaction","detail":"{read_only:false; response_revision:4340; number_of_response:1; }","duration":"187.498229ms","start":"2026-10-02T15:22:19.161107Z","end":"2026-10-02T15:22:19.348605Z","steps":["trace[1162513035] 'process raft request' (duration: 187.277026ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:19.348654Z","caller":"traceutil/trace.go:171","msg":"trace[1897495565] transaction","detail":"{read_only:false; response_revision:4339; number_of_response:1; }","duration":"221.519177ms","start":"2026-10-02T15:22:19.127063Z","end":"2026-10-02T15:22:19.348583Z","steps":["trace[1897495565] 'process raft request' (duration: 152.887686ms)","trace[1897495565] 'compare' (duration: 68.160481ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:22:24.85953Z","caller":"traceutil/trace.go:171","msg":"trace[516202167] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"117.226218ms","start":"2026-10-02T15:22:24.742245Z","end":"2026-10-02T15:22:24.859471Z","steps":["trace[516202167] 'process raft request' (duration: 24.569906ms)","trace[516202167] 'compare' (duration: 82.18627ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:22:33.513871Z","caller":"traceutil/trace.go:171","msg":"trace[1081064227] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"256.310358ms","start":"2026-10-02T15:22:33.257491Z","end":"2026-10-02T15:22:33.513801Z","steps":["trace[1081064227] 'process raft request' (duration: 245.963379ms)","trace[1081064227] 'compare' (duration: 10.009279ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:22:33.570737Z","caller":"traceutil/trace.go:171","msg":"trace[1713879148] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"146.493078ms","start":"2026-10-02T15:22:33.424226Z","end":"2026-10-02T15:22:33.57072Z","steps":["trace[1713879148] 'process raft request' (duration: 146.416723ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:33.57073Z","caller":"traceutil/trace.go:171","msg":"trace[1817410714] linearizableReadLoop","detail":"{readStateIndex:5095; appliedIndex:5091; }","duration":"129.937195ms","start":"2026-10-02T15:22:33.440774Z","end":"2026-10-02T15:22:33.570711Z","steps":["trace[1817410714] 'read index received' (duration: 62.691592ms)","trace[1817410714] 'applied index is now lower than readState.Index' (duration: 67.244863ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:22:33.570765Z","caller":"traceutil/trace.go:171","msg":"trace[1820538218] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"306.674359ms","start":"2026-10-02T15:22:33.264052Z","end":"2026-10-02T15:22:33.570726Z","steps":["trace[1820538218] 'process raft request' (duration: 306.474057ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:33.570877Z","caller":"traceutil/trace.go:171","msg":"trace[750239153] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"138.895878ms","start":"2026-10-02T15:22:33.431925Z","end":"2026-10-02T15:22:33.570821Z","steps":["trace[750239153] 'process raft request' (duration: 138.752669ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:33.570924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.138887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-02T15:22:33.570956Z","caller":"traceutil/trace.go:171","msg":"trace[881976629] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4908; }","duration":"130.214021ms","start":"2026-10-02T15:22:33.440733Z","end":"2026-10-02T15:22:33.570947Z","steps":["trace[881976629] 'agreement among raft nodes before linearized reading' (duration: 130.076193ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:33.570946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:33.264037Z","time spent":"306.825058ms","remote":"127.0.0.1:54282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7449,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-02T15:22:33.579116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.549135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:22:33.579272Z","caller":"traceutil/trace.go:171","msg":"trace[1058062059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4910; }","duration":"115.681673ms","start":"2026-10-02T15:22:33.463496Z","end":"2026-10-02T15:22:33.579178Z","steps":["trace[1058062059] 'agreement among raft nodes before linearized reading' (duration: 115.553265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:39.610638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.099343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-02T15:22:39.610889Z","caller":"traceutil/trace.go:171","msg":"trace[1769217838] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"373.178438ms","start":"2026-10-02T15:22:39.237664Z","end":"2026-10-02T15:22:39.610842Z","steps":["trace[1769217838] 'process raft request' (duration: 127.793417ms)","trace[1769217838] 'compare' (duration: 244.695918ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:39.611031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.237654Z","time spent":"373.313056ms","remote":"127.0.0.1:45878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T15:22:39.611558Z","caller":"traceutil/trace.go:171","msg":"trace[1210633990] linearizableReadLoop","detail":"{readStateIndex:5182; appliedIndex:5181; }","duration":"370.045733ms","start":"2026-10-02T15:22:39.241498Z","end":"2026-10-02T15:22:39.611544Z","steps":["trace[1210633990] 'read index received' (duration: 123.992091ms)","trace[1210633990] 'applied index is now lower than readState.Index' (duration: 246.051272ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:22:39.611732Z","caller":"traceutil/trace.go:171","msg":"trace[1895439101] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"350.181571ms","start":"2026-10-02T15:22:39.261523Z","end":"2026-10-02T15:22:39.611704Z","steps":["trace[1895439101] 'process raft request' (duration: 349.232733ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:39.611758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.246096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-10-02T15:22:39.611792Z","caller":"traceutil/trace.go:171","msg":"trace[603727292] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4993; }","duration":"370.30188ms","start":"2026-10-02T15:22:39.241481Z","end":"2026-10-02T15:22:39.611783Z","steps":["trace[603727292] 'agreement among raft nodes before linearized reading' (duration: 370.132868ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:39.611819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.241475Z","time spent":"370.338312ms","remote":"127.0.0.1:46146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1148,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"warn","ts":"2026-10-02T15:22:39.611839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.261504Z","time spent":"350.279588ms","remote":"127.0.0.1:46044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-02T15:22:39.61574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.7025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61056"} {"level":"info","ts":"2026-10-02T15:22:39.615791Z","caller":"traceutil/trace.go:171","msg":"trace[862087553] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4996; }","duration":"373.758044ms","start":"2026-10-02T15:22:39.242022Z","end":"2026-10-02T15:22:39.61578Z","steps":["trace[862087553] 'agreement among raft nodes before linearized reading' (duration: 373.506028ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:39.615821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.241999Z","time spent":"373.813627ms","remote":"127.0.0.1:45974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":6,"response size":61080,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"warn","ts":"2026-10-02T15:22:39.616471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.018546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:22:39.616627Z","caller":"traceutil/trace.go:171","msg":"trace[556735371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4996; }","duration":"155.198767ms","start":"2026-10-02T15:22:39.461403Z","end":"2026-10-02T15:22:39.616601Z","steps":["trace[556735371] 'agreement among raft nodes before linearized reading' (duration: 155.017566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:39.617433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.426297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-10-02T15:22:39.617488Z","caller":"traceutil/trace.go:171","msg":"trace[855354556] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4996; }","duration":"232.483091ms","start":"2026-10-02T15:22:39.384992Z","end":"2026-10-02T15:22:39.617475Z","steps":["trace[855354556] 'agreement among raft nodes before linearized reading' (duration: 231.67361ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:39.61791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.49931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:22:39.61803Z","caller":"traceutil/trace.go:171","msg":"trace[1940534367] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:0; response_revision:4996; }","duration":"374.621557ms","start":"2026-10-02T15:22:39.243389Z","end":"2026-10-02T15:22:39.61801Z","steps":["trace[1940534367] 'agreement among raft nodes before linearized reading' (duration: 374.475078ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:39.618202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.243385Z","time spent":"374.800238ms","remote":"127.0.0.1:45952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-10-02T15:22:39.618452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.77934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-10-02T15:22:39.618529Z","caller":"traceutil/trace.go:171","msg":"trace[264022497] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4996; }","duration":"356.872346ms","start":"2026-10-02T15:22:39.261639Z","end":"2026-10-02T15:22:39.618511Z","steps":["trace[264022497] 'agreement among raft nodes before linearized reading' (duration: 356.658543ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:39.618574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.261634Z","time spent":"356.925389ms","remote":"127.0.0.1:45974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-02T15:22:40.099526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.282658ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-02T15:22:40.099866Z","caller":"traceutil/trace.go:171","msg":"trace[451296754] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"321.960025ms","start":"2026-10-02T15:22:39.777876Z","end":"2026-10-02T15:22:40.099836Z","steps":["trace[451296754] 'process raft request' (duration: 321.733411ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:40.099901Z","caller":"traceutil/trace.go:171","msg":"trace[1821658702] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"320.622072ms","start":"2026-10-02T15:22:39.779258Z","end":"2026-10-02T15:22:40.09988Z","steps":["trace[1821658702] 'process raft request' (duration: 320.403679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.09997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.777864Z","time spent":"322.059411ms","remote":"127.0.0.1:45878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":799,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T15:22:40.100003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.779245Z","time spent":"320.702687ms","remote":"127.0.0.1:45974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9164,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T15:22:40.100251Z","caller":"traceutil/trace.go:171","msg":"trace[1429094219] linearizableReadLoop","detail":"{readStateIndex:5198; appliedIndex:5195; }","duration":"298.731053ms","start":"2026-10-02T15:22:39.801498Z","end":"2026-10-02T15:22:40.10023Z","steps":["trace[1429094219] 'read index received' (duration: 185.655166ms)","trace[1429094219] 'applied index is now lower than readState.Index' (duration: 113.057546ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:22:40.100408Z","caller":"traceutil/trace.go:171","msg":"trace[318750436] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"322.928764ms","start":"2026-10-02T15:22:39.777361Z","end":"2026-10-02T15:22:40.100289Z","steps":["trace[318750436] 'process raft request' (duration: 209.778352ms)","trace[318750436] 'compare' (duration: 111.804518ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:40.100558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.777321Z","time spent":"323.188252ms","remote":"127.0.0.1:45878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T15:22:40.147575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.557821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-02T15:22:40.147648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.172841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:22:40.147665Z","caller":"traceutil/trace.go:171","msg":"trace[2052093818] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:5009; }","duration":"395.69857ms","start":"2026-10-02T15:22:39.75194Z","end":"2026-10-02T15:22:40.147638Z","steps":["trace[2052093818] 'agreement among raft nodes before linearized reading' (duration: 348.436476ms)","trace[2052093818] 'count revisions from in-memory index tree' (duration: 47.143527ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:40.147725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.751929Z","time spent":"395.780695ms","remote":"127.0.0.1:45974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":32,"response size":31,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-10-02T15:22:40.147937Z","caller":"traceutil/trace.go:171","msg":"trace[210460677] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5009; }","duration":"347.252606ms","start":"2026-10-02T15:22:39.800425Z","end":"2026-10-02T15:22:40.147678Z","steps":["trace[210460677] 'agreement among raft nodes before linearized reading' (duration: 299.925388ms)","trace[210460677] 'range keys from in-memory index tree' (duration: 47.277704ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:40.148001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.800403Z","time spent":"347.585126ms","remote":"127.0.0.1:46236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-10-02T15:22:40.148135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.893224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:22:40.148189Z","caller":"traceutil/trace.go:171","msg":"trace[134583965] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:5009; }","duration":"336.970138ms","start":"2026-10-02T15:22:39.811203Z","end":"2026-10-02T15:22:40.148173Z","steps":["trace[134583965] 'agreement among raft nodes before linearized reading' (duration: 336.864992ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.14821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.900394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3296"} {"level":"warn","ts":"2026-10-02T15:22:40.148231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.81119Z","time spent":"337.027752ms","remote":"127.0.0.1:49510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-10-02T15:22:40.148262Z","caller":"traceutil/trace.go:171","msg":"trace[673961335] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5009; }","duration":"337.029832ms","start":"2026-10-02T15:22:39.811217Z","end":"2026-10-02T15:22:40.148247Z","steps":["trace[673961335] 'agreement among raft nodes before linearized reading' (duration: 336.789107ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.1483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.599048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-02T15:22:40.14833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.811191Z","time spent":"337.127908ms","remote":"127.0.0.1:43470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3320,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-10-02T15:22:40.148359Z","caller":"traceutil/trace.go:171","msg":"trace[1949529072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5009; }","duration":"263.658422ms","start":"2026-10-02T15:22:39.884684Z","end":"2026-10-02T15:22:40.148343Z","steps":["trace[1949529072] 'agreement among raft nodes before linearized reading' (duration: 263.511733ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.148339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.473001ms","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-10-02T15:22:40.148419Z","caller":"traceutil/trace.go:171","msg":"trace[1776457323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5009; }","duration":"259.588959ms","start":"2026-10-02T15:22:39.888812Z","end":"2026-10-02T15:22:40.148401Z","steps":["trace[1776457323] 'agreement among raft nodes before linearized reading' (duration: 259.336954ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.148377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.379058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-10-02T15:22:40.148612Z","caller":"traceutil/trace.go:171","msg":"trace[73061450] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:5009; }","duration":"339.696808ms","start":"2026-10-02T15:22:39.808843Z","end":"2026-10-02T15:22:40.14854Z","steps":["trace[73061450] 'agreement among raft nodes before linearized reading' (duration: 339.158485ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.148646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.872244ms","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":"warn","ts":"2026-10-02T15:22:40.148671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.808807Z","time spent":"339.849447ms","remote":"127.0.0.1:45900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":1,"response size":674,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" "} {"level":"info","ts":"2026-10-02T15:22:40.148697Z","caller":"traceutil/trace.go:171","msg":"trace[1603465519] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5009; }","duration":"401.969869ms","start":"2026-10-02T15:22:39.746712Z","end":"2026-10-02T15:22:40.148682Z","steps":["trace[1603465519] 'agreement among raft nodes before linearized reading' (duration: 353.674722ms)","trace[1603465519] 'count revisions from in-memory index tree' (duration: 48.229514ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:40.147588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.77573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-10-02T15:22:40.148741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.746689Z","time spent":"402.038444ms","remote":"127.0.0.1:46216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-10-02T15:22:40.148715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.574698ms","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-10-02T15:22:40.148785Z","caller":"traceutil/trace.go:171","msg":"trace[330603941] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5009; }","duration":"407.676074ms","start":"2026-10-02T15:22:39.741094Z","end":"2026-10-02T15:22:40.14877Z","steps":["trace[330603941] 'agreement among raft nodes before linearized reading' (duration: 359.300292ms)","trace[330603941] 'range keys from in-memory index tree' (duration: 48.219583ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:40.148872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.741047Z","time spent":"407.809882ms","remote":"127.0.0.1:45900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3530,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-10-02T15:22:40.149005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.57402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-02T15:22:40.149054Z","caller":"traceutil/trace.go:171","msg":"trace[1736472715] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:5009; }","duration":"285.658376ms","start":"2026-10-02T15:22:39.863384Z","end":"2026-10-02T15:22:40.149043Z","steps":["trace[1736472715] 'agreement among raft nodes before linearized reading' (duration: 284.534536ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:40.149046Z","caller":"traceutil/trace.go:171","msg":"trace[363135307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5009; }","duration":"370.273363ms","start":"2026-10-02T15:22:39.778751Z","end":"2026-10-02T15:22:40.149024Z","steps":["trace[363135307] 'agreement among raft nodes before linearized reading' (duration: 321.616243ms)","trace[363135307] 'range keys from in-memory index tree' (duration: 47.083583ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:40.149305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:39.778737Z","time spent":"370.548911ms","remote":"127.0.0.1:46044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-02T15:22:40.284895Z","caller":"traceutil/trace.go:171","msg":"trace[1112202901] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"130.812839ms","start":"2026-10-02T15:22:40.154054Z","end":"2026-10-02T15:22:40.284867Z","steps":["trace[1112202901] 'process raft request' (duration: 128.621904ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:40.284915Z","caller":"traceutil/trace.go:171","msg":"trace[1133586655] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"130.690312ms","start":"2026-10-02T15:22:40.154199Z","end":"2026-10-02T15:22:40.284889Z","steps":["trace[1133586655] 'process raft request' (duration: 130.593376ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:40.285135Z","caller":"traceutil/trace.go:171","msg":"trace[104249138] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"130.122017ms","start":"2026-10-02T15:22:40.154985Z","end":"2026-10-02T15:22:40.285107Z","steps":["trace[104249138] 'process raft request' (duration: 129.856251ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:40.285395Z","caller":"traceutil/trace.go:171","msg":"trace[768468331] linearizableReadLoop","detail":"{readStateIndex:5205; appliedIndex:5201; }","duration":"122.082008ms","start":"2026-10-02T15:22:40.163289Z","end":"2026-10-02T15:22:40.285371Z","steps":["trace[768468331] 'read index received' (duration: 119.397132ms)","trace[768468331] 'applied index is now lower than readState.Index' (duration: 2.683656ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:22:40.285482Z","caller":"traceutil/trace.go:171","msg":"trace[263954951] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"126.2871ms","start":"2026-10-02T15:22:40.159175Z","end":"2026-10-02T15:22:40.285462Z","steps":["trace[263954951] 'process raft request' (duration: 125.827181ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.285558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.630071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3296"} {"level":"info","ts":"2026-10-02T15:22:40.285626Z","caller":"traceutil/trace.go:171","msg":"trace[2090711330] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5015; }","duration":"127.384378ms","start":"2026-10-02T15:22:40.158219Z","end":"2026-10-02T15:22:40.285604Z","steps":["trace[2090711330] 'agreement among raft nodes before linearized reading' (duration: 127.217597ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.285613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.857105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:22:40.285689Z","caller":"traceutil/trace.go:171","msg":"trace[1662601728] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:5015; }","duration":"132.850587ms","start":"2026-10-02T15:22:40.152821Z","end":"2026-10-02T15:22:40.285672Z","steps":["trace[1662601728] 'agreement among raft nodes before linearized reading' (duration: 132.636244ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.285719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.179483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:22:40.285814Z","caller":"traceutil/trace.go:171","msg":"trace[63834065] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5015; }","duration":"131.280149ms","start":"2026-10-02T15:22:40.154484Z","end":"2026-10-02T15:22:40.285764Z","steps":["trace[63834065] 'agreement among raft nodes before linearized reading' (duration: 131.162122ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.285819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.496963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-10-02T15:22:40.285953Z","caller":"traceutil/trace.go:171","msg":"trace[573917286] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5015; }","duration":"131.734747ms","start":"2026-10-02T15:22:40.154204Z","end":"2026-10-02T15:22:40.285939Z","steps":["trace[573917286] 'agreement among raft nodes before linearized reading' (duration: 131.428608ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:40.286009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.544368ms","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-10-02T15:22:40.286151Z","caller":"traceutil/trace.go:171","msg":"trace[1147193977] 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:5015; }","duration":"123.688947ms","start":"2026-10-02T15:22:40.16244Z","end":"2026-10-02T15:22:40.286129Z","steps":["trace[1147193977] 'agreement among raft nodes before linearized reading' (duration: 123.268411ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:40.30345Z","caller":"traceutil/trace.go:171","msg":"trace[247450045] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"136.668844ms","start":"2026-10-02T15:22:40.166757Z","end":"2026-10-02T15:22:40.303426Z","steps":["trace[247450045] 'process raft request' (duration: 136.395396ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:40.303501Z","caller":"traceutil/trace.go:171","msg":"trace[94263569] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"126.314471ms","start":"2026-10-02T15:22:40.177162Z","end":"2026-10-02T15:22:40.303477Z","steps":["trace[94263569] 'process raft request' (duration: 126.162791ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:40.303865Z","caller":"traceutil/trace.go:171","msg":"trace[1446180725] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"120.694463ms","start":"2026-10-02T15:22:40.182966Z","end":"2026-10-02T15:22:40.303661Z","steps":["trace[1446180725] 'process raft request' (duration: 120.459468ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:54.913379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.419221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-02T15:22:54.913464Z","caller":"traceutil/trace.go:171","msg":"trace[110512468] linearizableReadLoop","detail":"{readStateIndex:5409; appliedIndex:5408; }","duration":"508.464799ms","start":"2026-10-02T15:22:54.404985Z","end":"2026-10-02T15:22:54.91345Z","steps":["trace[110512468] 'read index received' (duration: 69.778681ms)","trace[110512468] 'applied index is now lower than readState.Index' (duration: 438.685048ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:54.913606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.614409ms","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-10-02T15:22:54.913701Z","caller":"traceutil/trace.go:171","msg":"trace[755420632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5214; }","duration":"508.739067ms","start":"2026-10-02T15:22:54.404944Z","end":"2026-10-02T15:22:54.913683Z","steps":["trace[755420632] 'agreement among raft nodes before linearized reading' (duration: 508.556625ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:54.913742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:54.404925Z","time spent":"508.809581ms","remote":"127.0.0.1:46044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-02T15:22:54.913859Z","caller":"traceutil/trace.go:171","msg":"trace[671709541] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"510.496668ms","start":"2026-10-02T15:22:54.403008Z","end":"2026-10-02T15:22:54.913505Z","steps":["trace[671709541] 'process raft request' (duration: 71.874774ms)","trace[671709541] 'compare' (duration: 438.194617ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:22:54.914219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:54.402986Z","time spent":"511.114036ms","remote":"127.0.0.1:46044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T15:22:54.956368Z","caller":"traceutil/trace.go:171","msg":"trace[406880888] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"295.323724ms","start":"2026-10-02T15:22:54.661011Z","end":"2026-10-02T15:22:54.956335Z","steps":["trace[406880888] 'process raft request' (duration: 294.857565ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:54.956401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.398751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:22:54.956457Z","caller":"traceutil/trace.go:171","msg":"trace[136034060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5215; }","duration":"491.472846ms","start":"2026-10-02T15:22:54.464967Z","end":"2026-10-02T15:22:54.95644Z","steps":["trace[136034060] 'agreement among raft nodes before linearized reading' (duration: 491.304185ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:54.956488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:54.464916Z","time spent":"491.563862ms","remote":"127.0.0.1:45794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-02T15:22:54.956548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.729297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.46\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-02T15:22:54.956616Z","caller":"traceutil/trace.go:171","msg":"trace[236835336] range","detail":"{range_begin:/registry/masterleases/199.204.45.46; range_end:; response_count:1; response_revision:5215; }","duration":"132.841654ms","start":"2026-10-02T15:22:54.823756Z","end":"2026-10-02T15:22:54.956598Z","steps":["trace[236835336] 'agreement among raft nodes before linearized reading' (duration: 132.602048ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:55.827756Z","caller":"traceutil/trace.go:171","msg":"trace[1920040918] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"142.74343ms","start":"2026-10-02T15:22:55.684973Z","end":"2026-10-02T15:22:55.827717Z","steps":["trace[1920040918] 'process raft request' (duration: 142.600471ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:55.827793Z","caller":"traceutil/trace.go:171","msg":"trace[28304021] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"147.321717ms","start":"2026-10-02T15:22:55.680418Z","end":"2026-10-02T15:22:55.827739Z","steps":["trace[28304021] 'process raft request' (duration: 85.539153ms)","trace[28304021] 'compare' (duration: 61.417611ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:22:55.828129Z","caller":"traceutil/trace.go:171","msg":"trace[1397191964] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"120.320684ms","start":"2026-10-02T15:22:55.707753Z","end":"2026-10-02T15:22:55.828074Z","steps":["trace[1397191964] 'process raft request' (duration: 119.880507ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:22:56.179532Z","caller":"traceutil/trace.go:171","msg":"trace[1321059122] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"344.316936ms","start":"2026-10-02T15:22:55.835184Z","end":"2026-10-02T15:22:56.179501Z","steps":["trace[1321059122] 'process raft request' (duration: 344.135254ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:22:56.179825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:22:55.83516Z","time spent":"344.542169ms","remote":"127.0.0.1:46044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T15:23:20.771851Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2906} {"level":"info","ts":"2026-10-02T15:23:20.894504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2906,"took":"121.138483ms","hash":1206523713,"current-db-size-bytes":51568640,"current-db-size":"52 MB","current-db-size-in-use-bytes":27803648,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-02T15:23:20.894561Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1206523713,"revision":2906,"compact-revision":-1} {"level":"info","ts":"2026-10-02T15:23:54.826978Z","caller":"traceutil/trace.go:171","msg":"trace[740567624] transaction","detail":"{read_only:false; response_revision:5690; number_of_response:1; }","duration":"131.026958ms","start":"2026-10-02T15:23:54.695901Z","end":"2026-10-02T15:23:54.826928Z","steps":["trace[740567624] 'process raft request' (duration: 130.866638ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:23:55.024874Z","caller":"traceutil/trace.go:171","msg":"trace[1273320432] transaction","detail":"{read_only:false; response_revision:5692; number_of_response:1; }","duration":"182.16712ms","start":"2026-10-02T15:23:54.842676Z","end":"2026-10-02T15:23:55.024843Z","steps":["trace[1273320432] 'process raft request' (duration: 120.302416ms)","trace[1273320432] 'compare' (duration: 61.477629ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:27:06.398735Z","caller":"traceutil/trace.go:171","msg":"trace[1649728053] transaction","detail":"{read_only:false; response_revision:7031; number_of_response:1; }","duration":"105.021651ms","start":"2026-10-02T15:27:06.293241Z","end":"2026-10-02T15:27:06.398262Z","steps":["trace[1649728053] 'process raft request' (duration: 20.280102ms)","trace[1649728053] 'compare' (duration: 84.463637ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:27:26.435346Z","caller":"traceutil/trace.go:171","msg":"trace[718883179] linearizableReadLoop","detail":"{readStateIndex:7396; appliedIndex:7395; }","duration":"114.040188ms","start":"2026-10-02T15:27:26.321288Z","end":"2026-10-02T15:27:26.435328Z","steps":["trace[718883179] 'read index received' (duration: 113.885636ms)","trace[718883179] 'applied index is now lower than readState.Index' (duration: 150.322µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:27:26.435467Z","caller":"traceutil/trace.go:171","msg":"trace[390833027] transaction","detail":"{read_only:false; response_revision:7135; number_of_response:1; }","duration":"119.767957ms","start":"2026-10-02T15:27:26.315647Z","end":"2026-10-02T15:27:26.435415Z","steps":["trace[390833027] 'process raft request' (duration: 119.571384ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:27:26.435562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.26103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-10-02T15:27:26.435591Z","caller":"traceutil/trace.go:171","msg":"trace[1260105336] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:7135; }","duration":"114.33623ms","start":"2026-10-02T15:27:26.321244Z","end":"2026-10-02T15:27:26.435581Z","steps":["trace[1260105336] 'agreement among raft nodes before linearized reading' (duration: 114.188579ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:28:20.778387Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5386} {"level":"info","ts":"2026-10-02T15:28:20.866718Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5386,"took":"86.817578ms","hash":2771812732,"current-db-size-bytes":51568640,"current-db-size":"52 MB","current-db-size-in-use-bytes":18731008,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-02T15:28:20.866797Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2771812732,"revision":5386,"compact-revision":2906} {"level":"info","ts":"2026-10-02T15:33:20.784002Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7431} {"level":"info","ts":"2026-10-02T15:33:20.840799Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7431,"took":"55.747383ms","hash":143292738,"current-db-size-bytes":51568640,"current-db-size":"52 MB","current-db-size-in-use-bytes":15380480,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-10-02T15:33:20.84084Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":143292738,"revision":7431,"compact-revision":5386}