{"level":"warn","ts":"2026-04-20T05:50:08.394654Z","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-20T05:50:08.394736Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-20T05:50:08.394797Z","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-20T05:50:08.394809Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-20T05:50:08.394834Z","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-20T05:50:08.395365Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-04-20T05:50:08.395432Z","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":16,"max-cpu-available":16,"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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-20T05:50:08.39944Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.827045ms"} {"level":"info","ts":"2026-04-20T05:50:08.409215Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-04-20T05:50:08.409289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T05:50:08.409311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-04-20T05:50:08.409321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T05:50:08.409329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-04-20T05:50:08.409366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-04-20T05:50:08.416459Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T05:50:08.421656Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T05:50:08.423396Z","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-20T05:50:08.426722Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T05:50:08.426975Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T05:50:08.426993Z","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-20T05:50:08.427176Z","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-20T05:50:08.42719Z","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-20T05:50:08.428009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-04-20T05:50:08.428128Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-20T05:50:08.429457Z","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-20T05:50:08.429597Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-20T05:50:08.42967Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-20T05:50:08.42975Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T05:50:08.429804Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T05:50:09.010237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T05:50:09.010328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T05:50:09.01038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-04-20T05:50:09.010409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-04-20T05:50:09.010421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-20T05:50:09.01044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-04-20T05:50:09.010456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-20T05:50:09.012333Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T05:50:09.012367Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:50:09.012407Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:50:09.012592Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:50:09.012731Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T05:50:09.012787Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T05:50:09.01377Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:50:09.013905Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:50:09.013941Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:50:09.015174Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T05:50:09.016322Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-04-20T05:50:44.831402Z","caller":"traceutil/trace.go:171","msg":"trace[827217186] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"122.147142ms","start":"2026-04-20T05:50:44.709213Z","end":"2026-04-20T05:50:44.83136Z","steps":["trace[827217186] 'process raft request' (duration: 121.359932ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:45.068871Z","caller":"traceutil/trace.go:171","msg":"trace[994201672] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"162.161066ms","start":"2026-04-20T05:50:44.906675Z","end":"2026-04-20T05:50:45.068836Z","steps":["trace[994201672] 'read index received' (duration: 148.579689ms)","trace[994201672] 'applied index is now lower than readState.Index' (duration: 13.580087ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:45.069002Z","caller":"traceutil/trace.go:171","msg":"trace[1190224340] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"175.471767ms","start":"2026-04-20T05:50:44.893473Z","end":"2026-04-20T05:50:45.068945Z","steps":["trace[1190224340] 'process raft request' (duration: 161.830158ms)","trace[1190224340] 'compare' (duration: 13.362112ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:50:45.069429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.39302ms","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-20T05:50:45.069541Z","caller":"traceutil/trace.go:171","msg":"trace[1255075639] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"110.749419ms","start":"2026-04-20T05:50:44.958771Z","end":"2026-04-20T05:50:45.06952Z","steps":["trace[1255075639] 'agreement among raft nodes before linearized reading' (duration: 110.276837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:45.069548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.602506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-67jm7\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T05:50:45.069689Z","caller":"traceutil/trace.go:171","msg":"trace[753287468] range","detail":"{range_begin:/registry/pods/kube-system/cilium-67jm7; range_end:; response_count:1; response_revision:627; }","duration":"163.052647ms","start":"2026-04-20T05:50:44.906605Z","end":"2026-04-20T05:50:45.069658Z","steps":["trace[753287468] 'agreement among raft nodes before linearized reading' (duration: 162.35993ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:45.58367Z","caller":"traceutil/trace.go:171","msg":"trace[1625310521] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"122.46383ms","start":"2026-04-20T05:50:45.461174Z","end":"2026-04-20T05:50:45.583638Z","steps":["trace[1625310521] 'process raft request' (duration: 121.868165ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:00.869918Z","caller":"traceutil/trace.go:171","msg":"trace[1604528570] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"225.818374ms","start":"2026-04-20T05:51:00.644069Z","end":"2026-04-20T05:51:00.869888Z","steps":["trace[1604528570] 'process raft request' (duration: 225.67233ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:00.882588Z","caller":"traceutil/trace.go:171","msg":"trace[364548629] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"237.783286ms","start":"2026-04-20T05:51:00.644786Z","end":"2026-04-20T05:51:00.882569Z","steps":["trace[364548629] 'process raft request' (duration: 237.595362ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:18.582924Z","caller":"traceutil/trace.go:171","msg":"trace[909778065] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"167.499964ms","start":"2026-04-20T05:52:18.415401Z","end":"2026-04-20T05:52:18.582901Z","steps":["trace[909778065] 'process raft request' (duration: 167.35296ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:18.594773Z","caller":"traceutil/trace.go:171","msg":"trace[1056915250] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"178.725587ms","start":"2026-04-20T05:52:18.416002Z","end":"2026-04-20T05:52:18.594727Z","steps":["trace[1056915250] 'process raft request' (duration: 178.481492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:53:03.954608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.30093ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:53:03.95485Z","caller":"traceutil/trace.go:171","msg":"trace[2013616033] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"311.937622ms","start":"2026-04-20T05:53:03.64289Z","end":"2026-04-20T05:53:03.954828Z","steps":["trace[2013616033] 'process raft request' (duration: 311.84848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:53:03.954954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:53:03.642866Z","time spent":"312.036795ms","remote":"127.0.0.1:33416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:53:03.955204Z","caller":"traceutil/trace.go:171","msg":"trace[362284244] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"357.203402ms","start":"2026-04-20T05:53:03.597979Z","end":"2026-04-20T05:53:03.955183Z","steps":["trace[362284244] 'process raft request' (duration: 248.732193ms)","trace[362284244] 'compare' (duration: 107.191717ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:53:03.955261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:53:03.597953Z","time spent":"357.278413ms","remote":"127.0.0.1:33416","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-20T05:53:03.955417Z","caller":"traceutil/trace.go:171","msg":"trace[568988915] linearizableReadLoop","detail":"{readStateIndex:2244; appliedIndex:2243; }","duration":"312.800703ms","start":"2026-04-20T05:53:03.642607Z","end":"2026-04-20T05:53:03.955407Z","steps":["trace[568988915] 'read index received' (duration: 204.120249ms)","trace[568988915] 'applied index is now lower than readState.Index' (duration: 108.679224ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:53:03.955575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.971857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:53:03.95561Z","caller":"traceutil/trace.go:171","msg":"trace[2050138957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2165; }","duration":"313.042769ms","start":"2026-04-20T05:53:03.642559Z","end":"2026-04-20T05:53:03.955601Z","steps":["trace[2050138957] 'agreement among raft nodes before linearized reading' (duration: 312.918056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:53:03.955637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:53:03.642542Z","time spent":"313.08865ms","remote":"127.0.0.1:33134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T05:53:58.679651Z","caller":"traceutil/trace.go:171","msg":"trace[143809254] transaction","detail":"{read_only:false; response_revision:2632; number_of_response:1; }","duration":"214.512559ms","start":"2026-04-20T05:53:58.465117Z","end":"2026-04-20T05:53:58.67963Z","steps":["trace[143809254] 'process raft request' (duration: 214.370356ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:53:58.684222Z","caller":"traceutil/trace.go:171","msg":"trace[1241958944] linearizableReadLoop","detail":"{readStateIndex:2731; appliedIndex:2729; }","duration":"129.507215ms","start":"2026-04-20T05:53:58.554691Z","end":"2026-04-20T05:53:58.684198Z","steps":["trace[1241958944] 'read index received' (duration: 124.880644ms)","trace[1241958944] 'applied index is now lower than readState.Index' (duration: 4.625331ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:53:58.68425Z","caller":"traceutil/trace.go:171","msg":"trace[14270732] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"165.085821ms","start":"2026-04-20T05:53:58.519149Z","end":"2026-04-20T05:53:58.684235Z","steps":["trace[14270732] 'process raft request' (duration: 164.936057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:53:58.684419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.718969ms","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-20T05:53:58.684463Z","caller":"traceutil/trace.go:171","msg":"trace[106110488] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2633; }","duration":"129.813962ms","start":"2026-04-20T05:53:58.554638Z","end":"2026-04-20T05:53:58.684452Z","steps":["trace[106110488] 'agreement among raft nodes before linearized reading' (duration: 129.644878ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:32.255097Z","caller":"traceutil/trace.go:171","msg":"trace[672868350] transaction","detail":"{read_only:false; response_revision:2835; number_of_response:1; }","duration":"122.229874ms","start":"2026-04-20T05:54:32.132847Z","end":"2026-04-20T05:54:32.255076Z","steps":["trace[672868350] 'process raft request' (duration: 122.101871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:54:32.7454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.51272ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:54:32.745546Z","caller":"traceutil/trace.go:171","msg":"trace[99571899] linearizableReadLoop","detail":"{readStateIndex:2943; appliedIndex:2942; }","duration":"190.337149ms","start":"2026-04-20T05:54:32.555186Z","end":"2026-04-20T05:54:32.745523Z","steps":["trace[99571899] 'read index received' (duration: 175.438512ms)","trace[99571899] 'applied index is now lower than readState.Index' (duration: 14.897617ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:54:32.745567Z","caller":"traceutil/trace.go:171","msg":"trace[2074357710] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2836; }","duration":"189.698974ms","start":"2026-04-20T05:54:32.555849Z","end":"2026-04-20T05:54:32.745548Z","steps":["trace[2074357710] 'range keys from in-memory index tree' (duration: 189.493369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:54:32.745686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.461099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:54:32.745716Z","caller":"traceutil/trace.go:171","msg":"trace[702363673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2837; }","duration":"102.536161ms","start":"2026-04-20T05:54:32.64317Z","end":"2026-04-20T05:54:32.745706Z","steps":["trace[702363673] 'agreement among raft nodes before linearized reading' (duration: 102.476939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:54:32.745762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.574295ms","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-20T05:54:32.745854Z","caller":"traceutil/trace.go:171","msg":"trace[1442158572] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2837; }","duration":"190.731779ms","start":"2026-04-20T05:54:32.555101Z","end":"2026-04-20T05:54:32.745833Z","steps":["trace[1442158572] 'agreement among raft nodes before linearized reading' (duration: 190.517094ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:32.745796Z","caller":"traceutil/trace.go:171","msg":"trace[704442023] transaction","detail":"{read_only:false; response_revision:2837; number_of_response:1; }","duration":"276.58203ms","start":"2026-04-20T05:54:32.469007Z","end":"2026-04-20T05:54:32.745589Z","steps":["trace[704442023] 'process raft request' (duration: 261.601611ms)","trace[704442023] 'compare' (duration: 14.671292ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:56:57.536749Z","caller":"traceutil/trace.go:171","msg":"trace[813040872] transaction","detail":"{read_only:false; response_revision:3799; number_of_response:1; }","duration":"269.191226ms","start":"2026-04-20T05:56:57.267537Z","end":"2026-04-20T05:56:57.536729Z","steps":["trace[813040872] 'process raft request' (duration: 269.045732ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:56:57.538971Z","caller":"traceutil/trace.go:171","msg":"trace[1941598253] linearizableReadLoop","detail":"{readStateIndex:3941; appliedIndex:3939; }","duration":"121.84372ms","start":"2026-04-20T05:56:57.4171Z","end":"2026-04-20T05:56:57.538944Z","steps":["trace[1941598253] 'read index received' (duration: 119.570785ms)","trace[1941598253] 'applied index is now lower than readState.Index' (duration: 2.271505ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:56:57.539173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.051684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T05:56:57.539231Z","caller":"traceutil/trace.go:171","msg":"trace[603972458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3799; }","duration":"122.163107ms","start":"2026-04-20T05:56:57.417055Z","end":"2026-04-20T05:56:57.539218Z","steps":["trace[603972458] 'agreement among raft nodes before linearized reading' (duration: 121.982443ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:12.266288Z","caller":"traceutil/trace.go:171","msg":"trace[1689982454] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"106.52928ms","start":"2026-04-20T05:58:12.159728Z","end":"2026-04-20T05:58:12.266258Z","steps":["trace[1689982454] 'process raft request' (duration: 106.267554ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:17.671727Z","caller":"traceutil/trace.go:171","msg":"trace[540328300] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"170.714801ms","start":"2026-04-20T05:58:17.500969Z","end":"2026-04-20T05:58:17.671684Z","steps":["trace[540328300] 'process raft request' (duration: 170.440924ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:21.963939Z","caller":"traceutil/trace.go:171","msg":"trace[775899378] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"131.72633ms","start":"2026-04-20T05:58:21.832185Z","end":"2026-04-20T05:58:21.963911Z","steps":["trace[775899378] 'process raft request' (duration: 131.549196ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:22.109568Z","caller":"traceutil/trace.go:171","msg":"trace[2064376738] linearizableReadLoop","detail":"{readStateIndex:5175; appliedIndex:5174; }","duration":"124.177092ms","start":"2026-04-20T05:58:21.985361Z","end":"2026-04-20T05:58:22.109538Z","steps":["trace[2064376738] 'read index received' (duration: 105.974367ms)","trace[2064376738] 'applied index is now lower than readState.Index' (duration: 18.201235ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:58:22.109597Z","caller":"traceutil/trace.go:171","msg":"trace[1894788286] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"135.8509ms","start":"2026-04-20T05:58:21.973708Z","end":"2026-04-20T05:58:22.109559Z","steps":["trace[1894788286] 'process raft request' (duration: 117.635845ms)","trace[1894788286] 'compare' (duration: 17.934598ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:58:22.109761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.268846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:58:22.109826Z","caller":"traceutil/trace.go:171","msg":"trace[405544211] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:4990; }","duration":"122.383199ms","start":"2026-04-20T05:58:21.987418Z","end":"2026-04-20T05:58:22.109802Z","steps":["trace[405544211] 'agreement among raft nodes before linearized reading' (duration: 122.281946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:22.109919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.518549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T05:58:22.110052Z","caller":"traceutil/trace.go:171","msg":"trace[2091405571] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:4990; }","duration":"124.680604ms","start":"2026-04-20T05:58:21.985327Z","end":"2026-04-20T05:58:22.110008Z","steps":["trace[2091405571] 'agreement among raft nodes before linearized reading' (duration: 124.322215ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:22.34825Z","caller":"traceutil/trace.go:171","msg":"trace[20614081] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"113.529308ms","start":"2026-04-20T05:58:22.234701Z","end":"2026-04-20T05:58:22.34823Z","steps":["trace[20614081] 'process raft request' (duration: 113.401265ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:31.569669Z","caller":"traceutil/trace.go:171","msg":"trace[1661769020] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"127.249397ms","start":"2026-04-20T05:58:31.44237Z","end":"2026-04-20T05:58:31.569619Z","steps":["trace[1661769020] 'process raft request' (duration: 126.93202ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:39.32236Z","caller":"traceutil/trace.go:171","msg":"trace[1327820652] linearizableReadLoop","detail":"{readStateIndex:5552; appliedIndex:5551; }","duration":"174.819214ms","start":"2026-04-20T05:58:39.147515Z","end":"2026-04-20T05:58:39.322334Z","steps":["trace[1327820652] 'read index received' (duration: 174.521427ms)","trace[1327820652] 'applied index is now lower than readState.Index' (duration: 296.447µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:58:39.322415Z","caller":"traceutil/trace.go:171","msg":"trace[1095410347] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"189.433803ms","start":"2026-04-20T05:58:39.132947Z","end":"2026-04-20T05:58:39.322381Z","steps":["trace[1095410347] 'process raft request' (duration: 189.197457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:39.322647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.10227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2b72464a-bca2-4428-aeb6-d6b5ca1836f6\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-20T05:58:39.322774Z","caller":"traceutil/trace.go:171","msg":"trace[922928768] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2b72464a-bca2-4428-aeb6-d6b5ca1836f6; range_end:; response_count:1; response_revision:5356; }","duration":"175.270563ms","start":"2026-04-20T05:58:39.147485Z","end":"2026-04-20T05:58:39.322756Z","steps":["trace[922928768] 'agreement among raft nodes before linearized reading' (duration: 174.991347ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:39.554578Z","caller":"traceutil/trace.go:171","msg":"trace[2033323187] linearizableReadLoop","detail":"{readStateIndex:5555; appliedIndex:5553; }","duration":"160.921733ms","start":"2026-04-20T05:58:39.39363Z","end":"2026-04-20T05:58:39.554552Z","steps":["trace[2033323187] 'read index received' (duration: 160.717558ms)","trace[2033323187] 'applied index is now lower than readState.Index' (duration: 203.145µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:58:39.554605Z","caller":"traceutil/trace.go:171","msg":"trace[336914017] transaction","detail":"{read_only:false; response_revision:5358; number_of_response:1; }","duration":"227.179864ms","start":"2026-04-20T05:58:39.327392Z","end":"2026-04-20T05:58:39.554572Z","steps":["trace[336914017] 'process raft request' (duration: 226.933269ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:39.554605Z","caller":"traceutil/trace.go:171","msg":"trace[406886686] transaction","detail":"{read_only:false; response_revision:5359; number_of_response:1; }","duration":"225.73135ms","start":"2026-04-20T05:58:39.328853Z","end":"2026-04-20T05:58:39.554585Z","steps":["trace[406886686] 'process raft request' (duration: 225.646978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:39.554922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.269481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2b72464a-bca2-4428-aeb6-d6b5ca1836f6\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-20T05:58:39.55507Z","caller":"traceutil/trace.go:171","msg":"trace[205164204] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2b72464a-bca2-4428-aeb6-d6b5ca1836f6; range_end:; response_count:1; response_revision:5359; }","duration":"161.411884ms","start":"2026-04-20T05:58:39.393575Z","end":"2026-04-20T05:58:39.554987Z","steps":["trace[205164204] 'agreement among raft nodes before linearized reading' (duration: 161.101277ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:49.813342Z","caller":"traceutil/trace.go:171","msg":"trace[27798775] linearizableReadLoop","detail":"{readStateIndex:5707; appliedIndex:5706; }","duration":"133.088168ms","start":"2026-04-20T05:58:49.680223Z","end":"2026-04-20T05:58:49.813311Z","steps":["trace[27798775] 'read index received' (duration: 96.225418ms)","trace[27798775] 'applied index is now lower than readState.Index' (duration: 36.85936ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:58:49.813491Z","caller":"traceutil/trace.go:171","msg":"trace[617416292] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"133.399676ms","start":"2026-04-20T05:58:49.680068Z","end":"2026-04-20T05:58:49.813467Z","steps":["trace[617416292] 'process raft request' (duration: 96.438683ms)","trace[617416292] 'compare' (duration: 36.690736ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:58:49.813672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.424446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:81498"} {"level":"info","ts":"2026-04-20T05:58:49.813721Z","caller":"traceutil/trace.go:171","msg":"trace[744906045] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5509; }","duration":"133.510798ms","start":"2026-04-20T05:58:49.680198Z","end":"2026-04-20T05:58:49.813709Z","steps":["trace[744906045] 'agreement among raft nodes before linearized reading' (duration: 133.224251ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:00:09.042544Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3037} {"level":"info","ts":"2026-04-20T06:00:09.125075Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3037,"took":"81.18063ms","hash":4148215741,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":31682560,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-20T06:00:09.125141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4148215741,"revision":3037,"compact-revision":-1} {"level":"info","ts":"2026-04-20T06:04:23.280575Z","caller":"traceutil/trace.go:171","msg":"trace[258168673] transaction","detail":"{read_only:false; response_revision:8079; number_of_response:1; }","duration":"120.009567ms","start":"2026-04-20T06:04:23.160538Z","end":"2026-04-20T06:04:23.280548Z","steps":["trace[258168673] 'process raft request' (duration: 105.684681ms)","trace[258168673] 'compare' (duration: 13.851974ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:04:35.892057Z","caller":"traceutil/trace.go:171","msg":"trace[1931232717] transaction","detail":"{read_only:false; response_revision:8146; number_of_response:1; }","duration":"362.393127ms","start":"2026-04-20T06:04:35.529615Z","end":"2026-04-20T06:04:35.892008Z","steps":["trace[1931232717] 'process raft request' (duration: 316.900838ms)","trace[1931232717] 'compare' (duration: 45.211152ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:04:35.892184Z","caller":"traceutil/trace.go:171","msg":"trace[368042266] linearizableReadLoop","detail":"{readStateIndex:8425; appliedIndex:8424; }","duration":"294.005215ms","start":"2026-04-20T06:04:35.598146Z","end":"2026-04-20T06:04:35.892151Z","steps":["trace[368042266] 'read index received' (duration: 248.389833ms)","trace[368042266] 'applied index is now lower than readState.Index' (duration: 45.613992ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:04:35.892291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:35.52959Z","time spent":"362.58102ms","remote":"127.0.0.1:33416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:04:35.892371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.20968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T06:04:35.892407Z","caller":"traceutil/trace.go:171","msg":"trace[578797924] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8147; }","duration":"294.330583ms","start":"2026-04-20T06:04:35.598067Z","end":"2026-04-20T06:04:35.892397Z","steps":["trace[578797924] 'agreement among raft nodes before linearized reading' (duration: 294.22785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:35.892723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.029924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-crbcf\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-20T06:04:35.892716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.328319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:04:35.892815Z","caller":"traceutil/trace.go:171","msg":"trace[1744170358] range","detail":"{range_begin:/registry/pods/openstack/keepalived-crbcf; range_end:; response_count:1; response_revision:8147; }","duration":"221.167857ms","start":"2026-04-20T06:04:35.671622Z","end":"2026-04-20T06:04:35.89279Z","steps":["trace[1744170358] 'agreement among raft nodes before linearized reading' (duration: 220.924381ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:35.892839Z","caller":"traceutil/trace.go:171","msg":"trace[1645062908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8147; }","duration":"206.509743ms","start":"2026-04-20T06:04:35.686295Z","end":"2026-04-20T06:04:35.892804Z","steps":["trace[1645062908] 'agreement among raft nodes before linearized reading' (duration: 206.258688ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:02.935453Z","caller":"traceutil/trace.go:171","msg":"trace[1686408058] linearizableReadLoop","detail":"{readStateIndex:8630; appliedIndex:8629; }","duration":"209.539244ms","start":"2026-04-20T06:05:02.725884Z","end":"2026-04-20T06:05:02.935423Z","steps":["trace[1686408058] 'read index received' (duration: 209.322539ms)","trace[1686408058] 'applied index is now lower than readState.Index' (duration: 215.635µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:05:02.935549Z","caller":"traceutil/trace.go:171","msg":"trace[908490231] transaction","detail":"{read_only:false; response_revision:8343; number_of_response:1; }","duration":"254.728194ms","start":"2026-04-20T06:05:02.680781Z","end":"2026-04-20T06:05:02.935509Z","steps":["trace[908490231] 'process raft request' (duration: 254.456227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:02.935636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.698897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:05:02.935686Z","caller":"traceutil/trace.go:171","msg":"trace[932314954] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:8343; }","duration":"209.836181ms","start":"2026-04-20T06:05:02.725835Z","end":"2026-04-20T06:05:02.935671Z","steps":["trace[932314954] 'agreement among raft nodes before linearized reading' (duration: 209.711358ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:09.048125Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6156} {"level":"info","ts":"2026-04-20T06:05:09.149087Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6156,"took":"99.543211ms","hash":744928921,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":23252992,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-20T06:05:09.149162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":744928921,"revision":6156,"compact-revision":3037} {"level":"info","ts":"2026-04-20T06:05:15.154695Z","caller":"traceutil/trace.go:171","msg":"trace[1511612981] transaction","detail":"{read_only:false; response_revision:8447; number_of_response:1; }","duration":"145.813127ms","start":"2026-04-20T06:05:15.008855Z","end":"2026-04-20T06:05:15.154668Z","steps":["trace[1511612981] 'process raft request' (duration: 145.621812ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:15.186735Z","caller":"traceutil/trace.go:171","msg":"trace[11861040] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8448; }","duration":"123.900689ms","start":"2026-04-20T06:05:15.062802Z","end":"2026-04-20T06:05:15.186703Z","steps":["trace[11861040] 'process raft request' (duration: 120.486876ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:15.661458Z","caller":"traceutil/trace.go:171","msg":"trace[2009175136] transaction","detail":"{read_only:false; response_revision:8451; number_of_response:1; }","duration":"138.08438ms","start":"2026-04-20T06:05:15.523345Z","end":"2026-04-20T06:05:15.661429Z","steps":["trace[2009175136] 'process raft request' (duration: 137.919206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:15.822742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.905087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T06:05:15.822936Z","caller":"traceutil/trace.go:171","msg":"trace[1717545695] linearizableReadLoop","detail":"{readStateIndex:8744; appliedIndex:8742; }","duration":"237.076759ms","start":"2026-04-20T06:05:15.585842Z","end":"2026-04-20T06:05:15.822919Z","steps":["trace[1717545695] 'read index received' (duration: 75.516202ms)","trace[1717545695] 'applied index is now lower than readState.Index' (duration: 161.559257ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:05:15.823019Z","caller":"traceutil/trace.go:171","msg":"trace[1689075352] transaction","detail":"{read_only:false; response_revision:8452; number_of_response:1; }","duration":"259.026168ms","start":"2026-04-20T06:05:15.563956Z","end":"2026-04-20T06:05:15.822982Z","steps":["trace[1689075352] 'process raft request' (duration: 149.784793ms)","trace[1689075352] 'compare' (duration: 108.795125ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:05:15.8232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.907919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-pj6fx\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-20T06:05:15.823242Z","caller":"traceutil/trace.go:171","msg":"trace[1544364106] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-pj6fx; range_end:; response_count:1; response_revision:8453; }","duration":"179.988751ms","start":"2026-04-20T06:05:15.643242Z","end":"2026-04-20T06:05:15.823231Z","steps":["trace[1544364106] 'agreement among raft nodes before linearized reading' (duration: 179.792187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:15.82324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.376026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T06:05:15.823257Z","caller":"traceutil/trace.go:171","msg":"trace[864899905] transaction","detail":"{read_only:false; response_revision:8453; number_of_response:1; }","duration":"180.084974ms","start":"2026-04-20T06:05:15.643126Z","end":"2026-04-20T06:05:15.823211Z","steps":["trace[864899905] 'process raft request' (duration: 179.715105ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:15.823327Z","caller":"traceutil/trace.go:171","msg":"trace[1208952515] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8453; }","duration":"237.470968ms","start":"2026-04-20T06:05:15.585837Z","end":"2026-04-20T06:05:15.823308Z","steps":["trace[1208952515] 'agreement among raft nodes before linearized reading' (duration: 237.187451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:15.823409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.874625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:05:15.823489Z","caller":"traceutil/trace.go:171","msg":"trace[1913998425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8453; }","duration":"137.999348ms","start":"2026-04-20T06:05:15.685473Z","end":"2026-04-20T06:05:15.823472Z","steps":["trace[1913998425] 'agreement among raft nodes before linearized reading' (duration: 137.878635ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:15.958047Z","caller":"traceutil/trace.go:171","msg":"trace[1992650609] linearizableReadLoop","detail":"{readStateIndex:8748; appliedIndex:8745; }","duration":"112.189336ms","start":"2026-04-20T06:05:15.845837Z","end":"2026-04-20T06:05:15.958026Z","steps":["trace[1992650609] 'read index received' (duration: 57.103217ms)","trace[1992650609] 'applied index is now lower than readState.Index' (duration: 55.085389ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:05:15.958079Z","caller":"traceutil/trace.go:171","msg":"trace[1776727647] transaction","detail":"{read_only:false; response_revision:8455; number_of_response:1; }","duration":"127.439064ms","start":"2026-04-20T06:05:15.830617Z","end":"2026-04-20T06:05:15.958056Z","steps":["trace[1776727647] 'process raft request' (duration: 121.930691ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:15.958201Z","caller":"traceutil/trace.go:171","msg":"trace[869092203] transaction","detail":"{read_only:false; response_revision:8456; number_of_response:1; }","duration":"126.84106ms","start":"2026-04-20T06:05:15.831321Z","end":"2026-04-20T06:05:15.958162Z","steps":["trace[869092203] 'process raft request' (duration: 126.657376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:15.958289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.415972ms","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-20T06:05:15.958324Z","caller":"traceutil/trace.go:171","msg":"trace[1982247487] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:8456; }","duration":"112.514334ms","start":"2026-04-20T06:05:15.845798Z","end":"2026-04-20T06:05:15.958312Z","steps":["trace[1982247487] 'agreement among raft nodes before linearized reading' (duration: 112.308339ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:16.693145Z","caller":"traceutil/trace.go:171","msg":"trace[680284718] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"143.367508ms","start":"2026-04-20T06:05:16.549753Z","end":"2026-04-20T06:05:16.69312Z","steps":["trace[680284718] 'process raft request' (duration: 142.695922ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:27.850997Z","caller":"traceutil/trace.go:171","msg":"trace[1651879594] transaction","detail":"{read_only:false; response_revision:9113; number_of_response:1; }","duration":"105.164826ms","start":"2026-04-20T06:06:27.745788Z","end":"2026-04-20T06:06:27.850953Z","steps":["trace[1651879594] 'process raft request' (duration: 104.938931ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:34.509009Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002512.wal"} {"level":"info","ts":"2026-04-20T06:07:34.105253Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T06:07:34.110598Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T06:07:34.110701Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T06:10:09.054555Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8376} {"level":"info","ts":"2026-04-20T06:10:09.134062Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8376,"took":"77.087284ms","hash":2672130194,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":24756224,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-20T06:10:09.134136Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2672130194,"revision":8376,"compact-revision":6156} {"level":"info","ts":"2026-04-20T06:15:09.060928Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10750} {"level":"info","ts":"2026-04-20T06:15:09.135921Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10750,"took":"73.117111ms","hash":3600487077,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":20463616,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-20T06:15:09.135989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3600487077,"revision":10750,"compact-revision":8376}