{"level":"warn","ts":"2026-05-05T13:45:45.426221Z","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-05T13:45:45.426323Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-05T13:45:45.426388Z","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-05T13:45:45.426396Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-05-05T13:45:45.426414Z","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-05T13:45:45.427009Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-05-05T13:45:45.427077Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-05T13:45:45.430466Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.207882ms"} {"level":"info","ts":"2026-05-05T13:45:45.438209Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-05-05T13:45:45.438298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T13:45:45.438319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-05-05T13:45:45.438333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T13:45:45.438341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-05-05T13:45:45.438381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-05-05T13:45:45.443821Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T13:45:45.444704Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T13:45:45.446078Z","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-05T13:45:45.447881Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T13:45:45.448097Z","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-05T13:45:45.448126Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T13:45:45.448189Z","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-05T13:45:45.448245Z","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-05T13:45:45.449664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-05-05T13:45:45.450587Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-05-05T13:45:45.45225Z","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-05T13:45:45.452481Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-05-05T13:45:45.452498Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T13:45:45.452528Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T13:45:45.452515Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-05-05T13:45:45.838545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T13:45:45.838728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T13:45:45.838866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-05-05T13:45:45.838921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-05-05T13:45:45.838968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-05-05T13:45:45.839031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-05-05T13:45:45.839076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-05-05T13:45:45.840022Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T13:45:45.840055Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T13:45:45.840218Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T13:45:45.841172Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T13:45:45.841229Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T13:45:45.841341Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T13:45:45.841904Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T13:45:45.842044Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T13:45:45.842087Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T13:45:45.845036Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-05-05T13:45:45.846085Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-05T13:45:59.825322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.908725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-05-05T13:45:59.825439Z","caller":"traceutil/trace.go:171","msg":"trace[416076819] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:406; }","duration":"249.072276ms","start":"2026-05-05T13:45:59.576341Z","end":"2026-05-05T13:45:59.825414Z","steps":["trace[416076819] 'range keys from in-memory index tree' (duration: 248.707493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:45:59.825928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.635436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T13:45:59.826039Z","caller":"traceutil/trace.go:171","msg":"trace[2054585790] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:406; }","duration":"189.768557ms","start":"2026-05-05T13:45:59.636255Z","end":"2026-05-05T13:45:59.826024Z","steps":["trace[2054585790] 'range keys from in-memory index tree' (duration: 188.9183ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:46:00.001397Z","caller":"traceutil/trace.go:171","msg":"trace[713866489] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"172.032899ms","start":"2026-05-05T13:45:59.829332Z","end":"2026-05-05T13:46:00.001365Z","steps":["trace[713866489] 'process raft request' (duration: 171.785958ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:46:00.134033Z","caller":"traceutil/trace.go:171","msg":"trace[1091032796] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"303.20646ms","start":"2026-05-05T13:45:59.830801Z","end":"2026-05-05T13:46:00.134007Z","steps":["trace[1091032796] 'process raft request' (duration: 302.957688ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:46:00.134279Z","caller":"traceutil/trace.go:171","msg":"trace[1034712264] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:419; }","duration":"179.299322ms","start":"2026-05-05T13:45:59.954953Z","end":"2026-05-05T13:46:00.134252Z","steps":["trace[1034712264] 'read index received' (duration: 46.202728ms)","trace[1034712264] 'applied index is now lower than readState.Index' (duration: 133.094454ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:46:00.134483Z","caller":"traceutil/trace.go:171","msg":"trace[1376745729] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"301.238105ms","start":"2026-05-05T13:45:59.833195Z","end":"2026-05-05T13:46:00.134433Z","steps":["trace[1376745729] 'process raft request' (duration: 300.7569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:46:00.135164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:45:59.833178Z","time spent":"301.400146ms","remote":"127.0.0.1:43602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T13:46:00.135199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.18924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4374"} {"level":"info","ts":"2026-05-05T13:46:00.135486Z","caller":"traceutil/trace.go:171","msg":"trace[1506678696] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:409; }","duration":"180.553022ms","start":"2026-05-05T13:45:59.954903Z","end":"2026-05-05T13:46:00.135456Z","steps":["trace[1506678696] 'agreement among raft nodes before linearized reading' (duration: 179.434323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:46:00.13555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:45:59.830778Z","time spent":"303.506472ms","remote":"127.0.0.1:43704","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-05-05T13:46:14.29386Z","caller":"traceutil/trace.go:171","msg":"trace[349612159] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"187.17367ms","start":"2026-05-05T13:46:14.106657Z","end":"2026-05-05T13:46:14.293831Z","steps":["trace[349612159] 'process raft request' (duration: 179.182489ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:46:14.294036Z","caller":"traceutil/trace.go:171","msg":"trace[423027654] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:564; }","duration":"102.102634ms","start":"2026-05-05T13:46:14.191895Z","end":"2026-05-05T13:46:14.293997Z","steps":["trace[423027654] 'read index received' (duration: 94.028142ms)","trace[423027654] 'applied index is now lower than readState.Index' (duration: 8.072372ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:46:14.294159Z","caller":"traceutil/trace.go:171","msg":"trace[1268022689] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"170.145752ms","start":"2026-05-05T13:46:14.123956Z","end":"2026-05-05T13:46:14.294102Z","steps":["trace[1268022689] 'process raft request' (duration: 169.80416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:46:14.29427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.346436ms","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-05-05T13:46:14.294312Z","caller":"traceutil/trace.go:171","msg":"trace[1130068804] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"102.451906ms","start":"2026-05-05T13:46:14.191849Z","end":"2026-05-05T13:46:14.294301Z","steps":["trace[1130068804] 'agreement among raft nodes before linearized reading' (duration: 102.311845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:46:20.842495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.456877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T13:46:20.843651Z","caller":"traceutil/trace.go:171","msg":"trace[2059064159] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"435.428039ms","start":"2026-05-05T13:46:20.408173Z","end":"2026-05-05T13:46:20.843601Z","steps":["trace[2059064159] 'process raft request' (duration: 106.625364ms)","trace[2059064159] 'compare' (duration: 327.308726ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:46:20.843793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:46:20.408159Z","time spent":"435.55619ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T13:46:20.844267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.07087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tczb5\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-05T13:46:20.844365Z","caller":"traceutil/trace.go:171","msg":"trace[267957878] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tczb5; range_end:; response_count:1; response_revision:616; }","duration":"217.18152ms","start":"2026-05-05T13:46:20.62715Z","end":"2026-05-05T13:46:20.844331Z","steps":["trace[267957878] 'agreement among raft nodes before linearized reading' (duration: 216.542646ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:46:20.843661Z","caller":"traceutil/trace.go:171","msg":"trace[1486049226] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"216.440186ms","start":"2026-05-05T13:46:20.62718Z","end":"2026-05-05T13:46:20.84362Z","steps":["trace[1486049226] 'read index received' (duration: 25.46µs)","trace[1486049226] 'applied index is now lower than readState.Index' (duration: 216.411306ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:46:20.84935Z","caller":"traceutil/trace.go:171","msg":"trace[2057008307] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"195.220299ms","start":"2026-05-05T13:46:20.65411Z","end":"2026-05-05T13:46:20.84933Z","steps":["trace[2057008307] 'process raft request' (duration: 189.388864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:46:21.332049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.383017ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T13:46:21.332355Z","caller":"traceutil/trace.go:171","msg":"trace[1474455057] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"471.247527ms","start":"2026-05-05T13:46:20.861082Z","end":"2026-05-05T13:46:21.33233Z","steps":["trace[1474455057] 'process raft request' (duration: 250.514207ms)","trace[1474455057] 'compare' (duration: 220.233837ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:46:21.332396Z","caller":"traceutil/trace.go:171","msg":"trace[2121266750] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"428.038836ms","start":"2026-05-05T13:46:20.904333Z","end":"2026-05-05T13:46:21.332372Z","steps":["trace[2121266750] 'process raft request' (duration: 427.811424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:46:21.33252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:46:20.861063Z","time spent":"471.360798ms","remote":"127.0.0.1:43602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T13:46:21.332645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:46:20.904308Z","time spent":"428.137036ms","remote":"127.0.0.1:43664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:46:21.333285Z","caller":"traceutil/trace.go:171","msg":"trace[874157070] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"156.510467ms","start":"2026-05-05T13:46:21.176746Z","end":"2026-05-05T13:46:21.333256Z","steps":["trace[874157070] 'process raft request' (duration: 156.348506ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:46:37.106045Z","caller":"traceutil/trace.go:171","msg":"trace[965204993] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"136.536283ms","start":"2026-05-05T13:46:36.969484Z","end":"2026-05-05T13:46:37.106021Z","steps":["trace[965204993] 'process raft request' (duration: 136.354182ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:47:32.169348Z","caller":"traceutil/trace.go:171","msg":"trace[762186737] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"153.74457ms","start":"2026-05-05T13:47:32.01558Z","end":"2026-05-05T13:47:32.169324Z","steps":["trace[762186737] 'process raft request' (duration: 153.594216ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:47:54.504631Z","caller":"traceutil/trace.go:171","msg":"trace[2103632748] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"230.395401ms","start":"2026-05-05T13:47:54.274199Z","end":"2026-05-05T13:47:54.504594Z","steps":["trace[2103632748] 'process raft request' (duration: 230.232617ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:47:54.570199Z","caller":"traceutil/trace.go:171","msg":"trace[270928259] linearizableReadLoop","detail":"{readStateIndex:1892; appliedIndex:1891; }","duration":"248.462765ms","start":"2026-05-05T13:47:54.32171Z","end":"2026-05-05T13:47:54.570173Z","steps":["trace[270928259] 'read index received' (duration: 182.936431ms)","trace[270928259] 'applied index is now lower than readState.Index' (duration: 65.525214ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:47:54.570327Z","caller":"traceutil/trace.go:171","msg":"trace[1111380395] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"228.787378ms","start":"2026-05-05T13:47:54.341529Z","end":"2026-05-05T13:47:54.570316Z","steps":["trace[1111380395] 'process raft request' (duration: 228.589374ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:47:54.570436Z","caller":"traceutil/trace.go:171","msg":"trace[315390689] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"295.247852ms","start":"2026-05-05T13:47:54.275003Z","end":"2026-05-05T13:47:54.570251Z","steps":["trace[315390689] 'process raft request' (duration: 294.956116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:47:54.570726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.012226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:47:54.570775Z","caller":"traceutil/trace.go:171","msg":"trace[1287491060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1838; }","duration":"249.124088ms","start":"2026-05-05T13:47:54.321638Z","end":"2026-05-05T13:47:54.570762Z","steps":["trace[1287491060] 'agreement among raft nodes before linearized reading' (duration: 249.043217ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.753902Z","caller":"traceutil/trace.go:171","msg":"trace[1680579618] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"104.177707ms","start":"2026-05-05T13:48:02.649697Z","end":"2026-05-05T13:48:02.753875Z","steps":["trace[1680579618] 'process raft request' (duration: 83.280846ms)","trace[1680579618] 'compare' (duration: 20.750208ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:48:26.822488Z","caller":"traceutil/trace.go:171","msg":"trace[33135191] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"168.830498ms","start":"2026-05-05T13:48:26.653632Z","end":"2026-05-05T13:48:26.822463Z","steps":["trace[33135191] 'process raft request' (duration: 168.661595ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:26.828103Z","caller":"traceutil/trace.go:171","msg":"trace[2019746252] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"151.390392ms","start":"2026-05-05T13:48:26.676681Z","end":"2026-05-05T13:48:26.828071Z","steps":["trace[2019746252] 'process raft request' (duration: 151.27215ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:49:19.134699Z","caller":"traceutil/trace.go:171","msg":"trace[1920350429] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"128.543811ms","start":"2026-05-05T13:49:19.006118Z","end":"2026-05-05T13:49:19.134662Z","steps":["trace[1920350429] 'process raft request' (duration: 128.298759ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:49:46.913885Z","caller":"traceutil/trace.go:171","msg":"trace[1897937949] transaction","detail":"{read_only:false; response_revision:2760; number_of_response:1; }","duration":"144.697918ms","start":"2026-05-05T13:49:46.769168Z","end":"2026-05-05T13:49:46.913866Z","steps":["trace[1897937949] 'process raft request' (duration: 144.597497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:47.11604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.793963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18acaf8cc1ba150d\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-05-05T13:49:47.116125Z","caller":"traceutil/trace.go:171","msg":"trace[1211354689] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18acaf8cc1ba150d; range_end:; response_count:1; response_revision:2760; }","duration":"128.932784ms","start":"2026-05-05T13:49:46.987171Z","end":"2026-05-05T13:49:47.116103Z","steps":["trace[1211354689] 'range keys from in-memory index tree' (duration: 128.598281ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:52:13.831921Z","caller":"traceutil/trace.go:171","msg":"trace[345672136] transaction","detail":"{read_only:false; response_revision:4522; number_of_response:1; }","duration":"110.606133ms","start":"2026-05-05T13:52:13.721289Z","end":"2026-05-05T13:52:13.831896Z","steps":["trace[345672136] 'process raft request' (duration: 110.456916ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:52:13.865883Z","caller":"traceutil/trace.go:171","msg":"trace[1154748426] transaction","detail":"{read_only:false; response_revision:4523; number_of_response:1; }","duration":"110.74255ms","start":"2026-05-05T13:52:13.755101Z","end":"2026-05-05T13:52:13.865843Z","steps":["trace[1154748426] 'process raft request' (duration: 110.503238ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:52:30.065419Z","caller":"traceutil/trace.go:171","msg":"trace[116763512] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"135.660257ms","start":"2026-05-05T13:52:29.929724Z","end":"2026-05-05T13:52:30.065385Z","steps":["trace[116763512] 'process raft request' (duration: 133.375824ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:55:45.869442Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3250} {"level":"info","ts":"2026-05-05T13:55:45.989132Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3250,"took":"118.603473ms","hash":3457988460,"current-db-size-bytes":58462208,"current-db-size":"58 MB","current-db-size-in-use-bytes":31420416,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-05T13:55:45.989214Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3457988460,"revision":3250,"compact-revision":-1} {"level":"info","ts":"2026-05-05T13:56:43.271404Z","caller":"traceutil/trace.go:171","msg":"trace[1490237050] transaction","detail":"{read_only:false; response_revision:6896; number_of_response:1; }","duration":"158.333693ms","start":"2026-05-05T13:56:43.113029Z","end":"2026-05-05T13:56:43.271363Z","steps":["trace[1490237050] 'process raft request' (duration: 125.277411ms)","trace[1490237050] 'compare' (duration: 32.835839ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:56:47.318548Z","caller":"traceutil/trace.go:171","msg":"trace[892922768] transaction","detail":"{read_only:false; response_revision:6922; number_of_response:1; }","duration":"202.576271ms","start":"2026-05-05T13:56:47.115958Z","end":"2026-05-05T13:56:47.318534Z","steps":["trace[892922768] 'process raft request' (duration: 202.46869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:56:47.639287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.205697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T13:56:47.639532Z","caller":"traceutil/trace.go:171","msg":"trace[166463718] transaction","detail":"{read_only:false; response_revision:6923; number_of_response:1; }","duration":"312.306268ms","start":"2026-05-05T13:56:47.327201Z","end":"2026-05-05T13:56:47.639507Z","steps":["trace[166463718] 'process raft request' (duration: 209.765765ms)","trace[166463718] 'compare' (duration: 102.051085ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:56:47.639628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:56:47.327177Z","time spent":"312.408179ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T13:56:49.492637Z","caller":"traceutil/trace.go:171","msg":"trace[489448995] transaction","detail":"{read_only:false; response_revision:6934; number_of_response:1; }","duration":"168.834719ms","start":"2026-05-05T13:56:49.32378Z","end":"2026-05-05T13:56:49.492615Z","steps":["trace[489448995] 'process raft request' (duration: 168.629176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T14:00:03.344561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.242268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/ingress-nginx/ingress-nginx\" ","response":"range_response_count:1 size:1159"} {"level":"info","ts":"2026-05-05T14:00:03.344635Z","caller":"traceutil/trace.go:171","msg":"trace[732066891] range","detail":"{range_begin:/registry/rolebindings/ingress-nginx/ingress-nginx; range_end:; response_count:1; response_revision:8200; }","duration":"132.345921ms","start":"2026-05-05T14:00:03.212273Z","end":"2026-05-05T14:00:03.344619Z","steps":["trace[732066891] 'range keys from in-memory index tree' (duration: 132.172848ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T14:00:45.875918Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6346} {"level":"info","ts":"2026-05-05T14:00:45.962234Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6346,"took":"85.034346ms","hash":1855417434,"current-db-size-bytes":58462208,"current-db-size":"58 MB","current-db-size-in-use-bytes":18259968,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-05T14:00:45.9623Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1855417434,"revision":6346,"compact-revision":3250}