{"level":"warn","ts":"2026-06-17T15:29:56.574798Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T15:29:56.57489Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-06-17T15:29:56.574956Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T15:29:56.574969Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-06-17T15:29:56.574992Z","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-06-17T15:29:56.575632Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-06-17T15:29:56.575762Z","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.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49: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-06-17T15:29:56.5795Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.531623ms"} {"level":"info","ts":"2026-06-17T15:29:56.585368Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-06-17T15:29:56.585514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-06-17T15:29:56.585555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-06-17T15:29:56.585577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-17T15:29:56.585607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-06-17T15:29:56.585666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-06-17T15:29:56.590161Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-17T15:29:56.59139Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-17T15:29:56.592417Z","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-06-17T15:29:56.594324Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-17T15:29:56.594427Z","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-06-17T15:29:56.594492Z","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-06-17T15:29:56.594502Z","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-06-17T15:29:56.594811Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-17T15:29:56.595325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-06-17T15:29:56.595674Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-06-17T15:29:56.59853Z","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-06-17T15:29:56.598714Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-17T15:29:56.59874Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-17T15:29:56.59883Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-06-17T15:29:56.598846Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-06-17T15:29:57.58639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-06-17T15:29:57.586449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-06-17T15:29:57.58649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-06-17T15:29:57.586519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-06-17T15:29:57.586533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-06-17T15:29:57.586557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-06-17T15:29:57.586577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-06-17T15:29:57.587631Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T15:29:57.588428Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-06-17T15:29:57.588433Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T15:29:57.588514Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T15:29:57.588862Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-17T15:29:57.588871Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T15:29:57.588908Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-17T15:29:57.589113Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T15:29:57.589182Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T15:29:57.59171Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-17T15:29:57.593185Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-06-17T15:30:11.408415Z","caller":"traceutil/trace.go:171","msg":"trace[1690710632] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"123.969666ms","start":"2026-06-17T15:30:11.284418Z","end":"2026-06-17T15:30:11.408387Z","steps":["trace[1690710632] 'process raft request' (duration: 123.783371ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:30:11.705274Z","caller":"traceutil/trace.go:171","msg":"trace[70831804] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"130.832808ms","start":"2026-06-17T15:30:11.574411Z","end":"2026-06-17T15:30:11.705243Z","steps":["trace[70831804] 'process raft request' (duration: 130.668403ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:30:11.814488Z","caller":"traceutil/trace.go:171","msg":"trace[508028476] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"102.627858ms","start":"2026-06-17T15:30:11.711829Z","end":"2026-06-17T15:30:11.814456Z","steps":["trace[508028476] 'process raft request' (duration: 102.337479ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:30:40.552031Z","caller":"traceutil/trace.go:171","msg":"trace[760827540] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"162.906828ms","start":"2026-06-17T15:30:40.389107Z","end":"2026-06-17T15:30:40.552014Z","steps":["trace[760827540] 'read index received' (duration: 73.40559ms)","trace[760827540] 'applied index is now lower than readState.Index' (duration: 89.500348ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:30:40.552129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.01818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-17T15:30:40.552185Z","caller":"traceutil/trace.go:171","msg":"trace[473872861] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:588; }","duration":"163.120564ms","start":"2026-06-17T15:30:40.389057Z","end":"2026-06-17T15:30:40.552178Z","steps":["trace[473872861] 'agreement among raft nodes before linearized reading' (duration: 163.019261ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:30:40.552336Z","caller":"traceutil/trace.go:171","msg":"trace[1678524974] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"181.027223ms","start":"2026-06-17T15:30:40.371302Z","end":"2026-06-17T15:30:40.55233Z","steps":["trace[1678524974] 'process raft request' (duration: 149.959542ms)","trace[1678524974] 'compare' (duration: 30.664442ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:30:40.919674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.686134ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T15:30:40.919826Z","caller":"traceutil/trace.go:171","msg":"trace[192154724] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"190.05265ms","start":"2026-06-17T15:30:40.72975Z","end":"2026-06-17T15:30:40.919803Z","steps":["trace[192154724] 'read index received' (duration: 36.611µs)","trace[192154724] 'applied index is now lower than readState.Index' (duration: 190.014569ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:30:40.920051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.295655ms","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-06-17T15:30:40.920088Z","caller":"traceutil/trace.go:171","msg":"trace[1325396517] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:590; }","duration":"190.352396ms","start":"2026-06-17T15:30:40.729725Z","end":"2026-06-17T15:30:40.920078Z","steps":["trace[1325396517] 'agreement among raft nodes before linearized reading' (duration: 190.142011ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:30:40.920453Z","caller":"traceutil/trace.go:171","msg":"trace[599300017] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"326.0114ms","start":"2026-06-17T15:30:40.594428Z","end":"2026-06-17T15:30:40.920439Z","steps":["trace[599300017] 'process raft request' (duration: 112.73691ms)","trace[599300017] 'compare' (duration: 211.444189ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:30:40.92054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:30:40.594414Z","time spent":"326.084572ms","remote":"127.0.0.1:45234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T15:30:41.271578Z","caller":"traceutil/trace.go:171","msg":"trace[23949695] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"269.854618ms","start":"2026-06-17T15:30:41.0017Z","end":"2026-06-17T15:30:41.271555Z","steps":["trace[23949695] 'read index received' (duration: 269.028469ms)","trace[23949695] 'applied index is now lower than readState.Index' (duration: 825.179µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:30:41.271653Z","caller":"traceutil/trace.go:171","msg":"trace[45896005] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"277.265967ms","start":"2026-06-17T15:30:40.994347Z","end":"2026-06-17T15:30:41.271613Z","steps":["trace[45896005] 'process raft request' (duration: 276.634832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:30:41.271861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.124415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:30:41.271966Z","caller":"traceutil/trace.go:171","msg":"trace[1358059784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"270.255368ms","start":"2026-06-17T15:30:41.001684Z","end":"2026-06-17T15:30:41.271939Z","steps":["trace[1358059784] 'agreement among raft nodes before linearized reading' (duration: 270.035383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:30:41.271966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.221747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-17T15:30:41.272311Z","caller":"traceutil/trace.go:171","msg":"trace[802299480] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:592; }","duration":"270.588465ms","start":"2026-06-17T15:30:41.001708Z","end":"2026-06-17T15:30:41.272296Z","steps":["trace[802299480] 'agreement among raft nodes before linearized reading' (duration: 270.147855ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:30:41.49748Z","caller":"traceutil/trace.go:171","msg":"trace[741401253] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"170.893534ms","start":"2026-06-17T15:30:41.326564Z","end":"2026-06-17T15:30:41.497458Z","steps":["trace[741401253] 'process raft request' (duration: 170.756201ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:13.122381Z","caller":"traceutil/trace.go:171","msg":"trace[79781668] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1901; }","duration":"176.633714ms","start":"2026-06-17T15:32:12.945729Z","end":"2026-06-17T15:32:13.122362Z","steps":["trace[79781668] 'read index received' (duration: 176.42667ms)","trace[79781668] 'applied index is now lower than readState.Index' (duration: 206.404µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:32:13.122566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.824586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-17T15:32:13.122601Z","caller":"traceutil/trace.go:171","msg":"trace[569550152] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1832; }","duration":"176.875627ms","start":"2026-06-17T15:32:12.945715Z","end":"2026-06-17T15:32:13.122591Z","steps":["trace[569550152] 'agreement among raft nodes before linearized reading' (duration: 176.742465ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:13.122502Z","caller":"traceutil/trace.go:171","msg":"trace[197705643] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"318.3167ms","start":"2026-06-17T15:32:12.804127Z","end":"2026-06-17T15:32:13.122444Z","steps":["trace[197705643] 'process raft request' (duration: 318.112186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:32:13.123313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:32:12.804113Z","time spent":"318.996009ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10969,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T15:32:13.270295Z","caller":"traceutil/trace.go:171","msg":"trace[2130823770] linearizableReadLoop","detail":"{readStateIndex:1903; appliedIndex:1902; }","duration":"147.817614ms","start":"2026-06-17T15:32:13.122443Z","end":"2026-06-17T15:32:13.27026Z","steps":["trace[2130823770] 'read index received' (duration: 90.623983ms)","trace[2130823770] 'applied index is now lower than readState.Index' (duration: 57.192571ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:32:13.270475Z","caller":"traceutil/trace.go:171","msg":"trace[472078475] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"200.669704ms","start":"2026-06-17T15:32:13.069752Z","end":"2026-06-17T15:32:13.270422Z","steps":["trace[472078475] 'process raft request' (duration: 143.29493ms)","trace[472078475] 'compare' (duration: 57.093931ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:32:13.270589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.976531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:32:13.271328Z","caller":"traceutil/trace.go:171","msg":"trace[1789522985] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1833; }","duration":"285.759031ms","start":"2026-06-17T15:32:12.985539Z","end":"2026-06-17T15:32:13.271298Z","steps":["trace[1789522985] 'agreement among raft nodes before linearized reading' (duration: 284.93194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:32:13.270643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.008445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-17T15:32:13.271762Z","caller":"traceutil/trace.go:171","msg":"trace[1725407402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1833; }","duration":"161.154459ms","start":"2026-06-17T15:32:13.110588Z","end":"2026-06-17T15:32:13.271742Z","steps":["trace[1725407402] 'agreement among raft nodes before linearized reading' (duration: 159.825892ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:13.28477Z","caller":"traceutil/trace.go:171","msg":"trace[1382703103] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"153.455364ms","start":"2026-06-17T15:32:13.131289Z","end":"2026-06-17T15:32:13.284744Z","steps":["trace[1382703103] 'process raft request' (duration: 153.270402ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:13.285218Z","caller":"traceutil/trace.go:171","msg":"trace[1874055631] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"153.876639ms","start":"2026-06-17T15:32:13.131321Z","end":"2026-06-17T15:32:13.285197Z","steps":["trace[1874055631] 'process raft request' (duration: 153.362662ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:13.285428Z","caller":"traceutil/trace.go:171","msg":"trace[748824712] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"153.922621ms","start":"2026-06-17T15:32:13.13145Z","end":"2026-06-17T15:32:13.285373Z","steps":["trace[748824712] 'process raft request' (duration: 153.323952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:32:13.285681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.414746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5d9cd0d-2c9f-4838-910c-7d519194cf64\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-17T15:32:13.285754Z","caller":"traceutil/trace.go:171","msg":"trace[1219263979] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f5d9cd0d-2c9f-4838-910c-7d519194cf64; range_end:; response_count:1; response_revision:1837; }","duration":"154.527858ms","start":"2026-06-17T15:32:13.131207Z","end":"2026-06-17T15:32:13.285735Z","steps":["trace[1219263979] 'agreement among raft nodes before linearized reading' (duration: 154.326415ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:13.285474Z","caller":"traceutil/trace.go:171","msg":"trace[1585063344] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"154.065343ms","start":"2026-06-17T15:32:13.131389Z","end":"2026-06-17T15:32:13.285455Z","steps":["trace[1585063344] 'process raft request' (duration: 153.344683ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:13.543706Z","caller":"traceutil/trace.go:171","msg":"trace[1425952169] linearizableReadLoop","detail":"{readStateIndex:1908; appliedIndex:1907; }","duration":"258.760538ms","start":"2026-06-17T15:32:13.284914Z","end":"2026-06-17T15:32:13.543675Z","steps":["trace[1425952169] 'read index received' (duration: 245.91019ms)","trace[1425952169] 'applied index is now lower than readState.Index' (duration: 12.848958ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:32:13.543855Z","caller":"traceutil/trace.go:171","msg":"trace[2104822677] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"267.03144ms","start":"2026-06-17T15:32:13.276805Z","end":"2026-06-17T15:32:13.543837Z","steps":["trace[2104822677] 'process raft request' (duration: 253.99224ms)","trace[2104822677] 'compare' (duration: 12.730006ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:32:13.544108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.802489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:32:13.54419Z","caller":"traceutil/trace.go:171","msg":"trace[1010472825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1838; }","duration":"271.92427ms","start":"2026-06-17T15:32:13.27225Z","end":"2026-06-17T15:32:13.544174Z","steps":["trace[1010472825] 'agreement among raft nodes before linearized reading' (duration: 271.785338ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:13.554903Z","caller":"traceutil/trace.go:171","msg":"trace[952667635] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"260.659962ms","start":"2026-06-17T15:32:13.294213Z","end":"2026-06-17T15:32:13.554873Z","steps":["trace[952667635] 'process raft request' (duration: 260.421929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:32:13.554923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.408276ms","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-06-17T15:32:13.554995Z","caller":"traceutil/trace.go:171","msg":"trace[265035610] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1839; }","duration":"158.537488ms","start":"2026-06-17T15:32:13.396439Z","end":"2026-06-17T15:32:13.554977Z","steps":["trace[265035610] 'agreement among raft nodes before linearized reading' (duration: 158.329115ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:25.439413Z","caller":"traceutil/trace.go:171","msg":"trace[1338889349] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"105.68776ms","start":"2026-06-17T15:32:25.333691Z","end":"2026-06-17T15:32:25.439379Z","steps":["trace[1338889349] 'process raft request' (duration: 105.521098ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:25.761642Z","caller":"traceutil/trace.go:171","msg":"trace[58849130] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"141.788714ms","start":"2026-06-17T15:32:25.619828Z","end":"2026-06-17T15:32:25.761617Z","steps":["trace[58849130] 'process raft request' (duration: 135.258277ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:32:52.051353Z","caller":"traceutil/trace.go:171","msg":"trace[1670445570] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"128.32005ms","start":"2026-06-17T15:32:51.923Z","end":"2026-06-17T15:32:52.05132Z","steps":["trace[1670445570] 'process raft request' (duration: 96.82456ms)","trace[1670445570] 'compare' (duration: 30.979255ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:34:16.107393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.82689ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-17T15:34:16.107855Z","caller":"traceutil/trace.go:171","msg":"trace[1600380913] linearizableReadLoop","detail":"{readStateIndex:2759; appliedIndex:2758; }","duration":"122.621845ms","start":"2026-06-17T15:34:15.985211Z","end":"2026-06-17T15:34:16.107832Z","steps":["trace[1600380913] 'read index received' (duration: 40.661µs)","trace[1600380913] 'applied index is now lower than readState.Index' (duration: 122.579534ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:34:16.107963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.735387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:34:16.108051Z","caller":"traceutil/trace.go:171","msg":"trace[1921836123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2661; }","duration":"122.86545ms","start":"2026-06-17T15:34:15.985161Z","end":"2026-06-17T15:34:16.108026Z","steps":["trace[1921836123] 'agreement among raft nodes before linearized reading' (duration: 122.736537ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:37:58.244563Z","caller":"traceutil/trace.go:171","msg":"trace[2027873816] transaction","detail":"{read_only:false; response_revision:4556; number_of_response:1; }","duration":"113.994745ms","start":"2026-06-17T15:37:58.130541Z","end":"2026-06-17T15:37:58.244536Z","steps":["trace[2027873816] 'process raft request' (duration: 112.788538ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:38:03.647157Z","caller":"traceutil/trace.go:171","msg":"trace[694048256] linearizableReadLoop","detail":"{readStateIndex:4822; appliedIndex:4821; }","duration":"276.547719ms","start":"2026-06-17T15:38:03.37059Z","end":"2026-06-17T15:38:03.647138Z","steps":["trace[694048256] 'read index received' (duration: 195.348358ms)","trace[694048256] 'applied index is now lower than readState.Index' (duration: 81.17676ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:38:03.647324Z","caller":"traceutil/trace.go:171","msg":"trace[54639988] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"279.002444ms","start":"2026-06-17T15:38:03.368277Z","end":"2026-06-17T15:38:03.647279Z","steps":["trace[54639988] 'process raft request' (duration: 197.649619ms)","trace[54639988] 'compare' (duration: 81.118441ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:38:03.647669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.077257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-17T15:38:03.647696Z","caller":"traceutil/trace.go:171","msg":"trace[1867815943] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4650; }","duration":"277.149468ms","start":"2026-06-17T15:38:03.37054Z","end":"2026-06-17T15:38:03.647689Z","steps":["trace[1867815943] 'agreement among raft nodes before linearized reading' (duration: 276.765703ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:38:03.660939Z","caller":"traceutil/trace.go:171","msg":"trace[2021122651] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"170.763998ms","start":"2026-06-17T15:38:03.490156Z","end":"2026-06-17T15:38:03.66092Z","steps":["trace[2021122651] 'process raft request' (duration: 170.659576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:38:03.661147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.998536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T15:38:03.661175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.00441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bd7697c3-ce61-43a8-99e5-4ac9406900fb\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-17T15:38:03.66123Z","caller":"traceutil/trace.go:171","msg":"trace[2025790228] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:4651; }","duration":"144.18571ms","start":"2026-06-17T15:38:03.517027Z","end":"2026-06-17T15:38:03.661213Z","steps":["trace[2025790228] 'agreement among raft nodes before linearized reading' (duration: 144.003817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:38:03.661172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.122941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-6c4fdf4495-lkpl5\" ","response":"range_response_count:1 size:11256"} {"level":"info","ts":"2026-06-17T15:38:03.661291Z","caller":"traceutil/trace.go:171","msg":"trace[1860970705] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-6c4fdf4495-lkpl5; range_end:; response_count:1; response_revision:4651; }","duration":"171.290175ms","start":"2026-06-17T15:38:03.489991Z","end":"2026-06-17T15:38:03.661281Z","steps":["trace[1860970705] 'agreement among raft nodes before linearized reading' (duration: 170.98372ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:38:03.661253Z","caller":"traceutil/trace.go:171","msg":"trace[946096940] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bd7697c3-ce61-43a8-99e5-4ac9406900fb; range_end:; response_count:1; response_revision:4651; }","duration":"119.137804ms","start":"2026-06-17T15:38:03.542098Z","end":"2026-06-17T15:38:03.661236Z","steps":["trace[946096940] 'agreement among raft nodes before linearized reading' (duration: 118.893019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:38:04.101066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.653488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T15:38:04.10121Z","caller":"traceutil/trace.go:171","msg":"trace[1021025045] linearizableReadLoop","detail":"{readStateIndex:4829; appliedIndex:4827; }","duration":"153.434822ms","start":"2026-06-17T15:38:03.947761Z","end":"2026-06-17T15:38:04.101196Z","steps":["trace[1021025045] 'read index received' (duration: 61.48µs)","trace[1021025045] 'applied index is now lower than readState.Index' (duration: 153.372402ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:38:04.101372Z","caller":"traceutil/trace.go:171","msg":"trace[376355990] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"378.127544ms","start":"2026-06-17T15:38:03.723236Z","end":"2026-06-17T15:38:04.101363Z","steps":["trace[376355990] 'process raft request' (duration: 203.116001ms)","trace[376355990] 'compare' (duration: 174.543226ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:38:04.101412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:38:03.723228Z","time spent":"378.162674ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3747,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T15:38:04.101667Z","caller":"traceutil/trace.go:171","msg":"trace[67350779] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"376.845748ms","start":"2026-06-17T15:38:03.72479Z","end":"2026-06-17T15:38:04.101636Z","steps":["trace[67350779] 'process raft request' (duration: 376.360671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:38:04.101803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:38:03.724777Z","time spent":"376.952879ms","remote":"127.0.0.1:45528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1563,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T15:38:04.101836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.084621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-17T15:38:04.101829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.57331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:38:04.101859Z","caller":"traceutil/trace.go:171","msg":"trace[1756054120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4657; }","duration":"154.148501ms","start":"2026-06-17T15:38:03.947703Z","end":"2026-06-17T15:38:04.101852Z","steps":["trace[1756054120] 'agreement among raft nodes before linearized reading' (duration: 154.05847ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:38:04.101865Z","caller":"traceutil/trace.go:171","msg":"trace[1592846678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4657; }","duration":"117.64007ms","start":"2026-06-17T15:38:03.984215Z","end":"2026-06-17T15:38:04.101855Z","steps":["trace[1592846678] 'agreement among raft nodes before linearized reading' (duration: 117.57281ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:38:19.437746Z","caller":"traceutil/trace.go:171","msg":"trace[1450967153] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"132.676035ms","start":"2026-06-17T15:38:19.305034Z","end":"2026-06-17T15:38:19.43771Z","steps":["trace[1450967153] 'process raft request' (duration: 132.457793ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:39:57.616117Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2881} {"level":"info","ts":"2026-06-17T15:39:57.700704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2881,"took":"83.209517ms","hash":825306421,"current-db-size-bytes":54439936,"current-db-size":"54 MB","current-db-size-in-use-bytes":29487104,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-17T15:39:57.700876Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":825306421,"revision":2881,"compact-revision":-1} {"level":"info","ts":"2026-06-17T15:44:57.620988Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5622} {"level":"info","ts":"2026-06-17T15:44:57.711206Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5622,"took":"89.201003ms","hash":2723412473,"current-db-size-bytes":54439936,"current-db-size":"54 MB","current-db-size-in-use-bytes":18259968,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-17T15:44:57.711274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2723412473,"revision":5622,"compact-revision":2881}