{"level":"warn","ts":"2026-04-18T09:02:10.192294Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T09:02:10.192385Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-04-18T09:02:10.192462Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T09:02:10.192472Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-18T09:02:10.192496Z","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-04-18T09:02:10.193251Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-04-18T09:02:10.193338Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-04-18T09:02:10.197446Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.873016ms"} {"level":"info","ts":"2026-04-18T09:02:10.206166Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-04-18T09:02:10.206301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T09:02:10.206347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-04-18T09:02:10.206379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T09:02:10.206408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-04-18T09:02:10.206468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-04-18T09:02:10.212828Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T09:02:10.2144Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T09:02:10.215681Z","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-04-18T09:02:10.21884Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T09:02:10.219085Z","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-04-18T09:02:10.219176Z","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-04-18T09:02:10.219193Z","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-04-18T09:02:10.219222Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T09:02:10.220055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-04-18T09:02:10.220699Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-18T09:02:10.224627Z","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-04-18T09:02:10.224732Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-04-18T09:02:10.224761Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-04-18T09:02:10.224893Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T09:02:10.224925Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T09:02:10.50758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T09:02:10.507637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T09:02:10.507661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-04-18T09:02:10.50768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-04-18T09:02:10.507692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-04-18T09:02:10.507746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-04-18T09:02:10.507777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-04-18T09:02:10.508603Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T09:02:10.508683Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T09:02:10.508713Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T09:02:10.508881Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:02:10.508978Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T09:02:10.50911Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T09:02:10.509802Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:02:10.509906Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:02:10.509955Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:02:10.510517Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-04-18T09:02:10.513134Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T09:02:39.402445Z","caller":"traceutil/trace.go:171","msg":"trace[1918671480] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"102.915223ms","start":"2026-04-18T09:02:39.299485Z","end":"2026-04-18T09:02:39.402401Z","steps":["trace[1918671480] 'process raft request' (duration: 102.145538ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:02:45.390556Z","caller":"traceutil/trace.go:171","msg":"trace[1619085722] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"130.518148ms","start":"2026-04-18T09:02:45.260013Z","end":"2026-04-18T09:02:45.390531Z","steps":["trace[1619085722] 'process raft request' (duration: 112.912441ms)","trace[1619085722] 'compare' (duration: 17.505387ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:02:45.677899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.278335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hnn74\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-18T09:02:45.678037Z","caller":"traceutil/trace.go:171","msg":"trace[1248708009] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hnn74; range_end:; response_count:1; response_revision:618; }","duration":"183.480536ms","start":"2026-04-18T09:02:45.494513Z","end":"2026-04-18T09:02:45.677994Z","steps":["trace[1248708009] 'range keys from in-memory index tree' (duration: 183.135624ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:02:46.236571Z","caller":"traceutil/trace.go:171","msg":"trace[1526522353] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"102.00456ms","start":"2026-04-18T09:02:46.134542Z","end":"2026-04-18T09:02:46.236547Z","steps":["trace[1526522353] 'read index received' (duration: 101.601677ms)","trace[1526522353] 'applied index is now lower than readState.Index' (duration: 401.703µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:02:46.236644Z","caller":"traceutil/trace.go:171","msg":"trace[595202917] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"440.322715ms","start":"2026-04-18T09:02:45.796282Z","end":"2026-04-18T09:02:46.236605Z","steps":["trace[595202917] 'process raft request' (duration: 439.6634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:02:46.236777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.205572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:02:46.2369Z","caller":"traceutil/trace.go:171","msg":"trace[1806894922] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"102.388043ms","start":"2026-04-18T09:02:46.134479Z","end":"2026-04-18T09:02:46.236867Z","steps":["trace[1806894922] 'agreement among raft nodes before linearized reading' (duration: 102.171252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:02:46.237321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:02:45.796245Z","time spent":"440.475325ms","remote":"127.0.0.1:32806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:03:52.981921Z","caller":"traceutil/trace.go:171","msg":"trace[866887012] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"115.53265ms","start":"2026-04-18T09:03:52.866363Z","end":"2026-04-18T09:03:52.981896Z","steps":["trace[866887012] 'process raft request' (duration: 111.902562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:04:16.771421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.320645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-18T09:04:16.771521Z","caller":"traceutil/trace.go:171","msg":"trace[1917478696] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1859; }","duration":"211.494849ms","start":"2026-04-18T09:04:16.560004Z","end":"2026-04-18T09:04:16.771499Z","steps":["trace[1917478696] 'range keys from in-memory index tree' (duration: 211.12091ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:04:17.189001Z","caller":"traceutil/trace.go:171","msg":"trace[715603340] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"232.32432ms","start":"2026-04-18T09:04:16.956648Z","end":"2026-04-18T09:04:17.188972Z","steps":["trace[715603340] 'process raft request' (duration: 215.240938ms)","trace[715603340] 'compare' (duration: 16.950589ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:04:17.193501Z","caller":"traceutil/trace.go:171","msg":"trace[1515083588] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1927; }","duration":"173.573252ms","start":"2026-04-18T09:04:17.019907Z","end":"2026-04-18T09:04:17.19348Z","steps":["trace[1515083588] 'read index received' (duration: 151.955127ms)","trace[1515083588] 'applied index is now lower than readState.Index' (duration: 21.617145ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:04:17.193561Z","caller":"traceutil/trace.go:171","msg":"trace[1906225917] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"222.158173ms","start":"2026-04-18T09:04:16.971364Z","end":"2026-04-18T09:04:17.193522Z","steps":["trace[1906225917] 'process raft request' (duration: 222.03067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:04:17.193878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.95567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-18T09:04:17.193942Z","caller":"traceutil/trace.go:171","msg":"trace[1210431877] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1863; }","duration":"174.062823ms","start":"2026-04-18T09:04:17.019863Z","end":"2026-04-18T09:04:17.193926Z","steps":["trace[1210431877] 'agreement among raft nodes before linearized reading' (duration: 173.734566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:04:17.193878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.583452ms","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-04-18T09:04:17.194054Z","caller":"traceutil/trace.go:171","msg":"trace[1817119237] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1863; }","duration":"112.805118ms","start":"2026-04-18T09:04:17.08123Z","end":"2026-04-18T09:04:17.194035Z","steps":["trace[1817119237] 'agreement among raft nodes before linearized reading' (duration: 112.47184ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:04:29.21739Z","caller":"traceutil/trace.go:171","msg":"trace[456600977] linearizableReadLoop","detail":"{readStateIndex:2035; appliedIndex:2034; }","duration":"147.523983ms","start":"2026-04-18T09:04:29.069841Z","end":"2026-04-18T09:04:29.217365Z","steps":["trace[456600977] 'read index received' (duration: 147.278778ms)","trace[456600977] 'applied index is now lower than readState.Index' (duration: 244.295µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:04:29.217515Z","caller":"traceutil/trace.go:171","msg":"trace[1790884433] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"151.956585ms","start":"2026-04-18T09:04:29.065522Z","end":"2026-04-18T09:04:29.217479Z","steps":["trace[1790884433] 'process raft request' (duration: 151.658189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:04:29.217717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.852991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-18T09:04:29.217779Z","caller":"traceutil/trace.go:171","msg":"trace[1233495108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1965; }","duration":"147.982164ms","start":"2026-04-18T09:04:29.069782Z","end":"2026-04-18T09:04:29.217764Z","steps":["trace[1233495108] 'agreement among raft nodes before linearized reading' (duration: 147.709687ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:04:51.711401Z","caller":"traceutil/trace.go:171","msg":"trace[1387393878] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"281.975797ms","start":"2026-04-18T09:04:51.4294Z","end":"2026-04-18T09:04:51.711376Z","steps":["trace[1387393878] 'process raft request' (duration: 281.798804ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:04:51.780182Z","caller":"traceutil/trace.go:171","msg":"trace[993745145] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"350.592459ms","start":"2026-04-18T09:04:51.42956Z","end":"2026-04-18T09:04:51.780153Z","steps":["trace[993745145] 'process raft request' (duration: 325.472057ms)","trace[993745145] 'compare' (duration: 24.96633ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:04:51.78036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:04:51.429509Z","time spent":"350.752372ms","remote":"127.0.0.1:32974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:04:51.780449Z","caller":"traceutil/trace.go:171","msg":"trace[2026770800] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"285.565779ms","start":"2026-04-18T09:04:51.494845Z","end":"2026-04-18T09:04:51.780411Z","steps":["trace[2026770800] 'process raft request' (duration: 285.260364ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:04:51.780538Z","caller":"traceutil/trace.go:171","msg":"trace[1613637156] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2176; }","duration":"170.404045ms","start":"2026-04-18T09:04:51.610104Z","end":"2026-04-18T09:04:51.780508Z","steps":["trace[1613637156] 'read index received' (duration: 101.043791ms)","trace[1613637156] 'applied index is now lower than readState.Index' (duration: 69.357834ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:04:51.780699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.578158ms","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-04-18T09:04:51.780741Z","caller":"traceutil/trace.go:171","msg":"trace[1461735067] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2105; }","duration":"170.672219ms","start":"2026-04-18T09:04:51.610059Z","end":"2026-04-18T09:04:51.780731Z","steps":["trace[1461735067] 'agreement among raft nodes before linearized reading' (duration: 170.534977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:04:51.780799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.170842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:04:51.780875Z","caller":"traceutil/trace.go:171","msg":"trace[794665141] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2105; }","duration":"112.314624ms","start":"2026-04-18T09:04:51.668548Z","end":"2026-04-18T09:04:51.780863Z","steps":["trace[794665141] 'agreement among raft nodes before linearized reading' (duration: 112.151312ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:05:47.637997Z","caller":"traceutil/trace.go:171","msg":"trace[1864697478] linearizableReadLoop","detail":"{readStateIndex:2595; appliedIndex:2593; }","duration":"108.459084ms","start":"2026-04-18T09:05:47.529515Z","end":"2026-04-18T09:05:47.637974Z","steps":["trace[1864697478] 'read index received' (duration: 80.992061ms)","trace[1864697478] 'applied index is now lower than readState.Index' (duration: 27.466243ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:05:47.63809Z","caller":"traceutil/trace.go:171","msg":"trace[1691170596] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"206.416037ms","start":"2026-04-18T09:05:47.431644Z","end":"2026-04-18T09:05:47.638061Z","steps":["trace[1691170596] 'process raft request' (duration: 178.868983ms)","trace[1691170596] 'compare' (duration: 26.402661ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:05:47.638094Z","caller":"traceutil/trace.go:171","msg":"trace[1178333052] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"139.502223ms","start":"2026-04-18T09:05:47.498563Z","end":"2026-04-18T09:05:47.638065Z","steps":["trace[1178333052] 'process raft request' (duration: 139.26906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:05:47.638442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.9025ms","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-04-18T09:05:47.638493Z","caller":"traceutil/trace.go:171","msg":"trace[1332614628] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2508; }","duration":"109.012971ms","start":"2026-04-18T09:05:47.529466Z","end":"2026-04-18T09:05:47.638479Z","steps":["trace[1332614628] 'agreement among raft nodes before linearized reading' (duration: 108.605096ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:06:20.60198Z","caller":"traceutil/trace.go:171","msg":"trace[2085388103] transaction","detail":"{read_only:false; response_revision:2693; number_of_response:1; }","duration":"223.571819ms","start":"2026-04-18T09:06:20.378367Z","end":"2026-04-18T09:06:20.601939Z","steps":["trace[2085388103] 'process raft request' (duration: 123.676187ms)","trace[2085388103] 'compare' (duration: 99.6413ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:06:20.602233Z","caller":"traceutil/trace.go:171","msg":"trace[363312446] linearizableReadLoop","detail":"{readStateIndex:2787; appliedIndex:2786; }","duration":"100.51629ms","start":"2026-04-18T09:06:20.501663Z","end":"2026-04-18T09:06:20.602179Z","steps":["trace[363312446] 'read index received' (duration: 311.874µs)","trace[363312446] 'applied index is now lower than readState.Index' (duration: 100.198396ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:06:20.602584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.924394ms","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-04-18T09:06:20.602625Z","caller":"traceutil/trace.go:171","msg":"trace[1870803199] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2694; }","duration":"101.023035ms","start":"2026-04-18T09:06:20.501587Z","end":"2026-04-18T09:06:20.60261Z","steps":["trace[1870803199] 'agreement among raft nodes before linearized reading' (duration: 100.712021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:06:20.911451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.30773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-18T09:06:20.911551Z","caller":"traceutil/trace.go:171","msg":"trace[1886101651] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2695; }","duration":"172.469131ms","start":"2026-04-18T09:06:20.73906Z","end":"2026-04-18T09:06:20.911529Z","steps":["trace[1886101651] 'range keys from in-memory index tree' (duration: 172.099947ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:09:12.045643Z","caller":"traceutil/trace.go:171","msg":"trace[1865709947] transaction","detail":"{read_only:false; response_revision:3738; number_of_response:1; }","duration":"136.51891ms","start":"2026-04-18T09:09:11.909092Z","end":"2026-04-18T09:09:12.04561Z","steps":["trace[1865709947] 'process raft request' (duration: 136.173491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:08.88046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.807619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:10:08.880877Z","caller":"traceutil/trace.go:171","msg":"trace[1042365628] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"257.280323ms","start":"2026-04-18T09:10:08.623555Z","end":"2026-04-18T09:10:08.880835Z","steps":["trace[1042365628] 'process raft request' (duration: 257.1029ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:08.881045Z","caller":"traceutil/trace.go:171","msg":"trace[1221326587] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"258.013559ms","start":"2026-04-18T09:10:08.623009Z","end":"2026-04-18T09:10:08.881023Z","steps":["trace[1221326587] 'process raft request' (duration: 50.335411ms)","trace[1221326587] 'compare' (duration: 206.717827ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:10:08.881045Z","caller":"traceutil/trace.go:171","msg":"trace[2050989315] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"257.249313ms","start":"2026-04-18T09:10:08.623767Z","end":"2026-04-18T09:10:08.881016Z","steps":["trace[2050989315] 'process raft request' (duration: 256.918216ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:08.881149Z","caller":"traceutil/trace.go:171","msg":"trace[1452125493] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"257.842276ms","start":"2026-04-18T09:10:08.623296Z","end":"2026-04-18T09:10:08.881138Z","steps":["trace[1452125493] 'process raft request' (duration: 257.302603ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:08.881227Z","caller":"traceutil/trace.go:171","msg":"trace[1116469847] transaction","detail":"{read_only:false; response_revision:4686; number_of_response:1; }","duration":"250.865436ms","start":"2026-04-18T09:10:08.630349Z","end":"2026-04-18T09:10:08.881215Z","steps":["trace[1116469847] 'process raft request' (duration: 250.362576ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:08.881239Z","caller":"traceutil/trace.go:171","msg":"trace[1047782060] linearizableReadLoop","detail":"{readStateIndex:4859; appliedIndex:4855; }","duration":"253.191447ms","start":"2026-04-18T09:10:08.628034Z","end":"2026-04-18T09:10:08.881225Z","steps":["trace[1047782060] 'read index received' (duration: 45.328424ms)","trace[1047782060] 'applied index is now lower than readState.Index' (duration: 207.861243ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:10:08.954403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.331127ms","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-04-18T09:10:08.954479Z","caller":"traceutil/trace.go:171","msg":"trace[1774300316] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"128.729474ms","start":"2026-04-18T09:10:08.825729Z","end":"2026-04-18T09:10:08.954458Z","steps":["trace[1774300316] 'process raft request' (duration: 128.345956ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:08.954495Z","caller":"traceutil/trace.go:171","msg":"trace[545420769] 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:4686; }","duration":"326.458149ms","start":"2026-04-18T09:10:08.628013Z","end":"2026-04-18T09:10:08.954471Z","steps":["trace[545420769] 'agreement among raft nodes before linearized reading' (duration: 253.272998ms)","trace[545420769] 'range keys from in-memory index tree' (duration: 72.903255ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:10:08.954662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:10:08.628006Z","time spent":"326.598362ms","remote":"127.0.0.1:32872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-04-18T09:10:08.954965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.20839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T09:10:08.955284Z","caller":"traceutil/trace.go:171","msg":"trace[411530059] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:4688; }","duration":"153.578787ms","start":"2026-04-18T09:10:08.801691Z","end":"2026-04-18T09:10:08.95527Z","steps":["trace[411530059] 'agreement among raft nodes before linearized reading' (duration: 152.941773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:08.956684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.288629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7581"} {"level":"info","ts":"2026-04-18T09:10:08.956731Z","caller":"traceutil/trace.go:171","msg":"trace[284920558] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4688; }","duration":"328.36039ms","start":"2026-04-18T09:10:08.628359Z","end":"2026-04-18T09:10:08.95672Z","steps":["trace[284920558] 'agreement among raft nodes before linearized reading' (duration: 326.277876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:08.956757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:10:08.628355Z","time spent":"328.395341ms","remote":"127.0.0.1:60182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":7603,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" "} {"level":"info","ts":"2026-04-18T09:10:09.23277Z","caller":"traceutil/trace.go:171","msg":"trace[1346937063] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"143.600393ms","start":"2026-04-18T09:10:09.089149Z","end":"2026-04-18T09:10:09.232749Z","steps":["trace[1346937063] 'process raft request' (duration: 103.490285ms)","trace[1346937063] 'compare' (duration: 39.953075ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:10:09.232997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.657446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd9d0e5d-0ca5-4795-b44a-91467968edc9\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-18T09:10:09.232764Z","caller":"traceutil/trace.go:171","msg":"trace[458262745] linearizableReadLoop","detail":"{readStateIndex:4867; appliedIndex:4866; }","duration":"116.420291ms","start":"2026-04-18T09:10:09.11632Z","end":"2026-04-18T09:10:09.23274Z","steps":["trace[458262745] 'read index received' (duration: 76.268932ms)","trace[458262745] 'applied index is now lower than readState.Index' (duration: 40.150229ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:10:09.233072Z","caller":"traceutil/trace.go:171","msg":"trace[1512639194] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cd9d0e5d-0ca5-4795-b44a-91467968edc9; range_end:; response_count:1; response_revision:4692; }","duration":"116.772129ms","start":"2026-04-18T09:10:09.116285Z","end":"2026-04-18T09:10:09.233057Z","steps":["trace[1512639194] 'agreement among raft nodes before linearized reading' (duration: 116.528764ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:21.195588Z","caller":"traceutil/trace.go:171","msg":"trace[1532972601] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"126.498421ms","start":"2026-04-18T09:10:21.06905Z","end":"2026-04-18T09:10:21.195548Z","steps":["trace[1532972601] 'process raft request' (duration: 126.109752ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:21.886351Z","caller":"traceutil/trace.go:171","msg":"trace[2119581960] linearizableReadLoop","detail":"{readStateIndex:5045; appliedIndex:5044; }","duration":"123.602839ms","start":"2026-04-18T09:10:21.762707Z","end":"2026-04-18T09:10:21.886309Z","steps":["trace[2119581960] 'read index received' (duration: 50.43306ms)","trace[2119581960] 'applied index is now lower than readState.Index' (duration: 73.168699ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:10:21.886704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.983578ms","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-04-18T09:10:21.886756Z","caller":"traceutil/trace.go:171","msg":"trace[689616264] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4865; }","duration":"124.068469ms","start":"2026-04-18T09:10:21.762673Z","end":"2026-04-18T09:10:21.886741Z","steps":["trace[689616264] 'agreement among raft nodes before linearized reading' (duration: 123.763883ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:21.887948Z","caller":"traceutil/trace.go:171","msg":"trace[1688657791] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"129.594473ms","start":"2026-04-18T09:10:21.75725Z","end":"2026-04-18T09:10:21.886845Z","steps":["trace[1688657791] 'process raft request' (duration: 55.924764ms)","trace[1688657791] 'compare' (duration: 72.997796ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:12:10.811248Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2958} {"level":"info","ts":"2026-04-18T09:12:10.969267Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2958,"took":"156.556299ms","hash":3345833765,"current-db-size-bytes":54181888,"current-db-size":"54 MB","current-db-size-in-use-bytes":29466624,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-18T09:12:10.969339Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3345833765,"revision":2958,"compact-revision":-1} {"level":"info","ts":"2026-04-18T09:17:10.816432Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5691} {"level":"info","ts":"2026-04-18T09:17:10.899101Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5691,"took":"81.1528ms","hash":4266742362,"current-db-size-bytes":54181888,"current-db-size":"54 MB","current-db-size-in-use-bytes":18358272,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-18T09:17:10.899149Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4266742362,"revision":5691,"compact-revision":2958}