{"level":"warn","ts":"2026-05-07T01:59:21.847682Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T01:59:21.847766Z","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-05-07T01:59:21.847837Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T01:59:21.84785Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-07T01:59:21.847871Z","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-05-07T01:59:21.848465Z","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-05-07T01:59:21.848538Z","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-05-07T01:59:21.853755Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.332233ms"} {"level":"info","ts":"2026-05-07T01:59:21.862711Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-05-07T01:59:21.862774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T01:59:21.8628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-05-07T01:59:21.862821Z","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-05-07T01:59:21.862832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-05-07T01:59:21.862867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-05-07T01:59:21.871033Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T01:59:21.872373Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T01:59:21.874512Z","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-05-07T01:59:21.876433Z","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-05-07T01:59:21.876564Z","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-05-07T01:59:21.876707Z","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-05-07T01:59:21.876754Z","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-05-07T01:59:21.876764Z","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-05-07T01:59:21.877282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-05-07T01:59:21.877369Z","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-05-07T01:59:21.882616Z","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-05-07T01:59:21.882805Z","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-05-07T01:59:21.882829Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T01:59:21.882777Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-07T01:59:21.88289Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-07T01:59:21.963717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T01:59:21.963761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T01:59:21.963782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-05-07T01:59:21.963795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-05-07T01:59:21.963802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-07T01:59:21.963812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-05-07T01:59:21.963821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-07T01:59:21.964554Z","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-05-07T01:59:21.964676Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T01:59:21.964757Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T01:59:21.965042Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T01:59:21.965153Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T01:59:21.965171Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T01:59:21.966471Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-05-07T01:59:21.966664Z","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-05-07T01:59:21.966816Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T01:59:21.96689Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T01:59:21.968231Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-07T01:59:57.228225Z","caller":"traceutil/trace.go:171","msg":"trace[1196001659] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"117.381727ms","start":"2026-05-07T01:59:57.110814Z","end":"2026-05-07T01:59:57.228195Z","steps":["trace[1196001659] 'read index received' (duration: 116.601436ms)","trace[1196001659] 'applied index is now lower than readState.Index' (duration: 779.451µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T01:59:57.228366Z","caller":"traceutil/trace.go:171","msg":"trace[654537644] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"400.506674ms","start":"2026-05-07T01:59:56.827816Z","end":"2026-05-07T01:59:57.228323Z","steps":["trace[654537644] 'process raft request' (duration: 399.814574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T01:59:57.228489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.653941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mtzfv\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-07T01:59:57.228637Z","caller":"traceutil/trace.go:171","msg":"trace[1404455127] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mtzfv; range_end:; response_count:1; response_revision:577; }","duration":"117.859444ms","start":"2026-05-07T01:59:57.110763Z","end":"2026-05-07T01:59:57.228623Z","steps":["trace[1404455127] 'agreement among raft nodes before linearized reading' (duration: 117.58907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T01:59:57.229158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T01:59:56.827784Z","time spent":"400.670017ms","remote":"127.0.0.1:38574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T01:59:57.79834Z","caller":"traceutil/trace.go:171","msg":"trace[904229723] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"500.737078ms","start":"2026-05-07T01:59:57.297575Z","end":"2026-05-07T01:59:57.798312Z","steps":["trace[904229723] 'process raft request' (duration: 484.759374ms)","trace[904229723] 'compare' (duration: 15.574449ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T01:59:57.798452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T01:59:57.297556Z","time spent":"500.842799ms","remote":"127.0.0.1:38928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T01:59:57.798513Z","caller":"traceutil/trace.go:171","msg":"trace[641775041] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"326.894879ms","start":"2026-05-07T01:59:57.471611Z","end":"2026-05-07T01:59:57.798506Z","steps":["trace[641775041] 'process raft request' (duration: 326.609385ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T01:59:57.798499Z","caller":"traceutil/trace.go:171","msg":"trace[49110950] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"297.236522ms","start":"2026-05-07T01:59:57.501135Z","end":"2026-05-07T01:59:57.798371Z","steps":["trace[49110950] 'process raft request' (duration: 297.184021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T01:59:57.798583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T01:59:57.471585Z","time spent":"326.967899ms","remote":"127.0.0.1:38698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:01:39.103821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.923951ms","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-05-07T02:01:39.104002Z","caller":"traceutil/trace.go:171","msg":"trace[251321007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1823; }","duration":"105.165116ms","start":"2026-05-07T02:01:38.998815Z","end":"2026-05-07T02:01:39.10398Z","steps":["trace[251321007] 'range keys from in-memory index tree' (duration: 104.540633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:01:39.104039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.159076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-07T02:01:39.104431Z","caller":"traceutil/trace.go:171","msg":"trace[1486906953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1823; }","duration":"105.288818ms","start":"2026-05-07T02:01:38.998807Z","end":"2026-05-07T02:01:39.104095Z","steps":["trace[1486906953] 'range keys from in-memory index tree' (duration: 104.700346ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:21.109823Z","caller":"traceutil/trace.go:171","msg":"trace[1494741242] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"109.177315ms","start":"2026-05-07T02:02:21.000603Z","end":"2026-05-07T02:02:21.10978Z","steps":["trace[1494741242] 'process raft request' (duration: 109.003042ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:21.115537Z","caller":"traceutil/trace.go:171","msg":"trace[159051165] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"114.809589ms","start":"2026-05-07T02:02:21.000701Z","end":"2026-05-07T02:02:21.115511Z","steps":["trace[159051165] 'process raft request' (duration: 114.700037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:21.430052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.255834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:21.430136Z","caller":"traceutil/trace.go:171","msg":"trace[1985762435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2162; }","duration":"198.354926ms","start":"2026-05-07T02:02:21.231739Z","end":"2026-05-07T02:02:21.430094Z","steps":["trace[1985762435] 'range keys from in-memory index tree' (duration: 198.135722ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:21.571867Z","caller":"traceutil/trace.go:171","msg":"trace[1373623170] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"137.099988ms","start":"2026-05-07T02:02:21.434742Z","end":"2026-05-07T02:02:21.571842Z","steps":["trace[1373623170] 'process raft request' (duration: 126.427151ms)","trace[1373623170] 'compare' (duration: 10.463024ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:31.574076Z","caller":"traceutil/trace.go:171","msg":"trace[346845563] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"120.307928ms","start":"2026-05-07T02:03:31.453726Z","end":"2026-05-07T02:03:31.574034Z","steps":["trace[346845563] 'process raft request' (duration: 104.3963ms)","trace[346845563] 'compare' (duration: 15.423281ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:31.859698Z","caller":"traceutil/trace.go:171","msg":"trace[2111051354] linearizableReadLoop","detail":"{readStateIndex:2857; appliedIndex:2856; }","duration":"222.715438ms","start":"2026-05-07T02:03:31.636946Z","end":"2026-05-07T02:03:31.859661Z","steps":["trace[2111051354] 'read index received' (duration: 222.626897ms)","trace[2111051354] 'applied index is now lower than readState.Index' (duration: 87.541µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:31.860012Z","caller":"traceutil/trace.go:171","msg":"trace[1916850551] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"278.476281ms","start":"2026-05-07T02:03:31.581319Z","end":"2026-05-07T02:03:31.859795Z","steps":["trace[1916850551] 'process raft request' (duration: 278.177597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:31.860019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.044953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ad262b9ca53b5a\" ","response":"range_response_count:1 size:779"} {"level":"warn","ts":"2026-05-07T02:03:31.860269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.931388ms","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-05-07T02:03:31.86037Z","caller":"traceutil/trace.go:171","msg":"trace[655661647] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ad262b9ca53b5a; range_end:; response_count:1; response_revision:2748; }","duration":"223.393299ms","start":"2026-05-07T02:03:31.636939Z","end":"2026-05-07T02:03:31.860332Z","steps":["trace[655661647] 'agreement among raft nodes before linearized reading' (duration: 222.883372ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:31.860461Z","caller":"traceutil/trace.go:171","msg":"trace[1530435366] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2748; }","duration":"117.236642ms","start":"2026-05-07T02:03:31.743203Z","end":"2026-05-07T02:03:31.860439Z","steps":["trace[1530435366] 'agreement among raft nodes before linearized reading' (duration: 116.837196ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:32.032794Z","caller":"traceutil/trace.go:171","msg":"trace[1312590739] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"168.522218ms","start":"2026-05-07T02:03:31.864235Z","end":"2026-05-07T02:03:32.032758Z","steps":["trace[1312590739] 'process raft request' (duration: 149.99162ms)","trace[1312590739] 'compare' (duration: 18.334725ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:32.033101Z","caller":"traceutil/trace.go:171","msg":"trace[1675906994] transaction","detail":"{read_only:false; response_revision:2750; number_of_response:1; }","duration":"161.392131ms","start":"2026-05-07T02:03:31.871686Z","end":"2026-05-07T02:03:32.033078Z","steps":["trace[1675906994] 'process raft request' (duration: 161.009876ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:32.033162Z","caller":"traceutil/trace.go:171","msg":"trace[85007142] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"159.105957ms","start":"2026-05-07T02:03:31.874037Z","end":"2026-05-07T02:03:32.033143Z","steps":["trace[85007142] 'process raft request' (duration: 158.949245ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:52.941417Z","caller":"traceutil/trace.go:171","msg":"trace[1730754899] linearizableReadLoop","detail":"{readStateIndex:4504; appliedIndex:4502; }","duration":"163.929115ms","start":"2026-05-07T02:05:52.77747Z","end":"2026-05-07T02:05:52.941399Z","steps":["trace[1730754899] 'read index received' (duration: 163.739652ms)","trace[1730754899] 'applied index is now lower than readState.Index' (duration: 188.823µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:05:52.941633Z","caller":"traceutil/trace.go:171","msg":"trace[1275708102] transaction","detail":"{read_only:false; response_revision:4317; number_of_response:1; }","duration":"200.946876ms","start":"2026-05-07T02:05:52.740678Z","end":"2026-05-07T02:05:52.941625Z","steps":["trace[1275708102] 'process raft request' (duration: 200.58132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:52.941797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.152869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:05:52.941823Z","caller":"traceutil/trace.go:171","msg":"trace[1634185313] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4318; }","duration":"160.21072ms","start":"2026-05-07T02:05:52.781603Z","end":"2026-05-07T02:05:52.941814Z","steps":["trace[1634185313] 'agreement among raft nodes before linearized reading' (duration: 160.159099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:52.941907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.215344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11495"} {"level":"info","ts":"2026-05-07T02:05:52.941989Z","caller":"traceutil/trace.go:171","msg":"trace[1635758088] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4318; }","duration":"170.350006ms","start":"2026-05-07T02:05:52.771618Z","end":"2026-05-07T02:05:52.941968Z","steps":["trace[1635758088] 'agreement among raft nodes before linearized reading' (duration: 170.078831ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:52.94224Z","caller":"traceutil/trace.go:171","msg":"trace[1010173565] transaction","detail":"{read_only:false; response_revision:4318; number_of_response:1; }","duration":"200.997236ms","start":"2026-05-07T02:05:52.741235Z","end":"2026-05-07T02:05:52.942232Z","steps":["trace[1010173565] 'process raft request' (duration: 200.114841ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:59.732101Z","caller":"traceutil/trace.go:171","msg":"trace[1088839960] transaction","detail":"{read_only:false; response_revision:4498; number_of_response:1; }","duration":"101.004213ms","start":"2026-05-07T02:05:59.631053Z","end":"2026-05-07T02:05:59.732057Z","steps":["trace[1088839960] 'process raft request' (duration: 31.828496ms)","trace[1088839960] 'compare' (duration: 69.021775ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:05:59.916845Z","caller":"traceutil/trace.go:171","msg":"trace[498830755] transaction","detail":"{read_only:false; response_revision:4499; number_of_response:1; }","duration":"108.638205ms","start":"2026-05-07T02:05:59.808173Z","end":"2026-05-07T02:05:59.916811Z","steps":["trace[498830755] 'process raft request' (duration: 108.448091ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:59.945954Z","caller":"traceutil/trace.go:171","msg":"trace[440040356] transaction","detail":"{read_only:false; response_revision:4500; number_of_response:1; }","duration":"134.554428ms","start":"2026-05-07T02:05:59.811368Z","end":"2026-05-07T02:05:59.945922Z","steps":["trace[440040356] 'process raft request' (duration: 134.274434ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:11.304637Z","caller":"traceutil/trace.go:171","msg":"trace[2089277511] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"130.850287ms","start":"2026-05-07T02:06:11.173765Z","end":"2026-05-07T02:06:11.304615Z","steps":["trace[2089277511] 'process raft request' (duration: 130.727615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:06:11.526353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.155153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:06:11.526539Z","caller":"traceutil/trace.go:171","msg":"trace[505545111] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:4670; }","duration":"137.431277ms","start":"2026-05-07T02:06:11.389088Z","end":"2026-05-07T02:06:11.526519Z","steps":["trace[505545111] 'count revisions from in-memory index tree' (duration: 136.99255ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:11.981092Z","caller":"traceutil/trace.go:171","msg":"trace[116483300] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"116.697317ms","start":"2026-05-07T02:06:11.864359Z","end":"2026-05-07T02:06:11.981056Z","steps":["trace[116483300] 'process raft request' (duration: 89.079019ms)","trace[116483300] 'compare' (duration: 27.368573ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:06:49.368929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.242767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:06:49.369028Z","caller":"traceutil/trace.go:171","msg":"trace[1903327457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5082; }","duration":"137.40286ms","start":"2026-05-07T02:06:49.231605Z","end":"2026-05-07T02:06:49.369008Z","steps":["trace[1903327457] 'range keys from in-memory index tree' (duration: 137.114555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:06:49.369234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.53924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-07T02:06:49.369401Z","caller":"traceutil/trace.go:171","msg":"trace[48086601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5082; }","duration":"151.767664ms","start":"2026-05-07T02:06:49.21758Z","end":"2026-05-07T02:06:49.369348Z","steps":["trace[48086601] 'range keys from in-memory index tree' (duration: 151.117894ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:49.734927Z","caller":"traceutil/trace.go:171","msg":"trace[1771007933] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"176.190974ms","start":"2026-05-07T02:06:49.55871Z","end":"2026-05-07T02:06:49.734901Z","steps":["trace[1771007933] 'process raft request' (duration: 134.732616ms)","trace[1771007933] 'compare' (duration: 41.076422ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:06:50.332711Z","caller":"traceutil/trace.go:171","msg":"trace[1177302254] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"109.848387ms","start":"2026-05-07T02:06:50.222839Z","end":"2026-05-07T02:06:50.332688Z","steps":["trace[1177302254] 'process raft request' (duration: 109.707415ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:50.502777Z","caller":"traceutil/trace.go:171","msg":"trace[366246123] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"116.362164ms","start":"2026-05-07T02:06:50.386374Z","end":"2026-05-07T02:06:50.502736Z","steps":["trace[366246123] 'process raft request' (duration: 64.429674ms)","trace[366246123] 'compare' (duration: 51.740346ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:07:05.20413Z","caller":"traceutil/trace.go:171","msg":"trace[1671163154] linearizableReadLoop","detail":"{readStateIndex:5441; appliedIndex:5440; }","duration":"100.521925ms","start":"2026-05-07T02:07:05.103575Z","end":"2026-05-07T02:07:05.204097Z","steps":["trace[1671163154] 'read index received' (duration: 68.606139ms)","trace[1671163154] 'applied index is now lower than readState.Index' (duration: 31.914106ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:07:05.204321Z","caller":"traceutil/trace.go:171","msg":"trace[1597779223] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5216; }","duration":"109.726616ms","start":"2026-05-07T02:07:05.09456Z","end":"2026-05-07T02:07:05.204287Z","steps":["trace[1597779223] 'process raft request' (duration: 77.566115ms)","trace[1597779223] 'compare' (duration: 31.908386ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:07:05.204508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.892592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:07:05.204591Z","caller":"traceutil/trace.go:171","msg":"trace[994843880] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:5216; }","duration":"101.009634ms","start":"2026-05-07T02:07:05.103561Z","end":"2026-05-07T02:07:05.20457Z","steps":["trace[994843880] 'agreement among raft nodes before linearized reading' (duration: 100.657007ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:09:22.333911Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3181} {"level":"info","ts":"2026-05-07T02:09:22.430498Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3181,"took":"94.384707ms","hash":2143093850,"current-db-size-bytes":57352192,"current-db-size":"57 MB","current-db-size-in-use-bytes":31420416,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-07T02:09:22.430569Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2143093850,"revision":3181,"compact-revision":-1}