{"level":"warn","ts":"2026-05-06T14:33:00.258685Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T14:33:00.258824Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.67: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.19.213.67:2380","--initial-cluster=instance=https://199.19.213.67:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.67:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.67:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-06T14:33:00.258934Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T14:33:00.258983Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.67:2380"]} {"level":"info","ts":"2026-05-06T14:33:00.259011Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-06T14:33:00.261947Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.67:2379"]} {"level":"info","ts":"2026-05-06T14:33:00.262082Z","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.19.213.67:2380"],"listen-peer-urls":["https://199.19.213.67:2380"],"advertise-client-urls":["https://199.19.213.67:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.67:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.67:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-06T14:33:00.266445Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.116781ms"} {"level":"info","ts":"2026-05-06T14:33:00.273228Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fba6d6d8cd5f215c","cluster-id":"f3c660457a1c2c72"} {"level":"info","ts":"2026-05-06T14:33:00.273312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T14:33:00.273337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became follower at term 0"} {"level":"info","ts":"2026-05-06T14:33:00.273357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fba6d6d8cd5f215c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T14:33:00.273367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became follower at term 1"} {"level":"info","ts":"2026-05-06T14:33:00.273412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c switched to configuration voters=(18133417176300724572)"} {"level":"warn","ts":"2026-05-06T14:33:00.280343Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T14:33:00.281563Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T14:33:00.28255Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-06T14:33:00.284533Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fba6d6d8cd5f215c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T14:33:00.291618Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T14:33:00.291759Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T14:33:00.291774Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T14:33:00.291663Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fba6d6d8cd5f215c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T14:33:00.293322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c switched to configuration voters=(18133417176300724572)"} {"level":"info","ts":"2026-05-06T14:33:00.294582Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f3c660457a1c2c72","local-member-id":"fba6d6d8cd5f215c","added-peer-id":"fba6d6d8cd5f215c","added-peer-peer-urls":["https://199.19.213.67:2380"]} {"level":"info","ts":"2026-05-06T14:33:00.296525Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-06T14:33:00.296751Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.67:2380"} {"level":"info","ts":"2026-05-06T14:33:00.296907Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.67:2380"} {"level":"info","ts":"2026-05-06T14:33:00.297606Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fba6d6d8cd5f215c","initial-advertise-peer-urls":["https://199.19.213.67:2380"],"listen-peer-urls":["https://199.19.213.67:2380"],"advertise-client-urls":["https://199.19.213.67:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.67:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T14:33:00.297671Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T14:33:00.673647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T14:33:00.673716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T14:33:00.673767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c received MsgPreVoteResp from fba6d6d8cd5f215c at term 1"} {"level":"info","ts":"2026-05-06T14:33:00.673827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became candidate at term 2"} {"level":"info","ts":"2026-05-06T14:33:00.673842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c received MsgVoteResp from fba6d6d8cd5f215c at term 2"} {"level":"info","ts":"2026-05-06T14:33:00.673855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fba6d6d8cd5f215c became leader at term 2"} {"level":"info","ts":"2026-05-06T14:33:00.673898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fba6d6d8cd5f215c elected leader fba6d6d8cd5f215c at term 2"} {"level":"info","ts":"2026-05-06T14:33:00.674931Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fba6d6d8cd5f215c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.67:2379]}","request-path":"/0/members/fba6d6d8cd5f215c/attributes","cluster-id":"f3c660457a1c2c72","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T14:33:00.67497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T14:33:00.67508Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T14:33:00.675094Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T14:33:00.675336Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T14:33:00.675367Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T14:33:00.676212Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f3c660457a1c2c72","local-member-id":"fba6d6d8cd5f215c","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T14:33:00.676394Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T14:33:00.676447Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T14:33:00.678018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T14:33:00.678957Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.67:2379"} {"level":"info","ts":"2026-05-06T14:33:35.803532Z","caller":"traceutil/trace.go:171","msg":"trace[2067733159] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"211.032855ms","start":"2026-05-06T14:33:35.592474Z","end":"2026-05-06T14:33:35.803507Z","steps":["trace[2067733159] 'process raft request' (duration: 210.882791ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.810382Z","caller":"traceutil/trace.go:171","msg":"trace[2117073954] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"120.042872ms","start":"2026-05-06T14:33:35.690309Z","end":"2026-05-06T14:33:35.810352Z","steps":["trace[2117073954] 'process raft request' (duration: 119.96295ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.810549Z","caller":"traceutil/trace.go:171","msg":"trace[128978306] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"174.094132ms","start":"2026-05-06T14:33:35.636351Z","end":"2026-05-06T14:33:35.810445Z","steps":["trace[128978306] 'process raft request' (duration: 173.565668ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.810688Z","caller":"traceutil/trace.go:171","msg":"trace[1562119732] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"150.642963ms","start":"2026-05-06T14:33:35.660038Z","end":"2026-05-06T14:33:35.810681Z","steps":["trace[1562119732] 'process raft request' (duration: 150.060797ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.810793Z","caller":"traceutil/trace.go:171","msg":"trace[1328780852] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"150.669363ms","start":"2026-05-06T14:33:35.660113Z","end":"2026-05-06T14:33:35.810782Z","steps":["trace[1328780852] 'process raft request' (duration: 150.079118ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.810938Z","caller":"traceutil/trace.go:171","msg":"trace[1925273725] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"190.672227ms","start":"2026-05-06T14:33:35.620259Z","end":"2026-05-06T14:33:35.810931Z","steps":["trace[1925273725] 'process raft request' (duration: 189.565568ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.810995Z","caller":"traceutil/trace.go:171","msg":"trace[1808092161] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"214.6222ms","start":"2026-05-06T14:33:35.596368Z","end":"2026-05-06T14:33:35.81099Z","steps":["trace[1808092161] 'process raft request' (duration: 213.200852ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.811054Z","caller":"traceutil/trace.go:171","msg":"trace[360820843] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"214.626319ms","start":"2026-05-06T14:33:35.596422Z","end":"2026-05-06T14:33:35.811048Z","steps":["trace[360820843] 'process raft request' (duration: 213.334445ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.811115Z","caller":"traceutil/trace.go:171","msg":"trace[54643964] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"178.716086ms","start":"2026-05-06T14:33:35.632394Z","end":"2026-05-06T14:33:35.81111Z","steps":["trace[54643964] 'process raft request' (duration: 177.475673ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.810637Z","caller":"traceutil/trace.go:171","msg":"trace[2480014] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"170.015303ms","start":"2026-05-06T14:33:35.640613Z","end":"2026-05-06T14:33:35.810629Z","steps":["trace[2480014] 'process raft request' (duration: 169.349726ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:35.810667Z","caller":"traceutil/trace.go:171","msg":"trace[801385942] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"169.997362ms","start":"2026-05-06T14:33:35.640663Z","end":"2026-05-06T14:33:35.81066Z","steps":["trace[801385942] 'process raft request' (duration: 169.343015ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:43.288557Z","caller":"traceutil/trace.go:171","msg":"trace[1533174229] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"229.88973ms","start":"2026-05-06T14:33:43.058188Z","end":"2026-05-06T14:33:43.288078Z","steps":["trace[1533174229] 'process raft request' (duration: 229.690665ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:43.520585Z","caller":"traceutil/trace.go:171","msg":"trace[399350317] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:602; }","duration":"236.060442ms","start":"2026-05-06T14:33:43.284439Z","end":"2026-05-06T14:33:43.520499Z","steps":["trace[399350317] 'read index received' (duration: 3.378263ms)","trace[399350317] 'applied index is now lower than readState.Index' (duration: 232.679689ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T14:33:43.523535Z","caller":"traceutil/trace.go:171","msg":"trace[9703288] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"266.41849ms","start":"2026-05-06T14:33:43.257063Z","end":"2026-05-06T14:33:43.523481Z","steps":["trace[9703288] 'process raft request' (duration: 263.247972ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:33:43.524887Z","caller":"traceutil/trace.go:171","msg":"trace[1337670588] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"348.407179ms","start":"2026-05-06T14:33:43.176456Z","end":"2026-05-06T14:33:43.524863Z","steps":["trace[1337670588] 'process raft request' (duration: 341.057538ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:33:43.525098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.555123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T14:33:43.52524Z","caller":"traceutil/trace.go:171","msg":"trace[252750654] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:583; }","duration":"240.8202ms","start":"2026-05-06T14:33:43.28439Z","end":"2026-05-06T14:33:43.52521Z","steps":["trace[252750654] 'agreement among raft nodes before linearized reading' (duration: 239.315952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:33:43.525382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.541207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-06T14:33:43.525465Z","caller":"traceutil/trace.go:171","msg":"trace[830819981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:583; }","duration":"228.65347ms","start":"2026-05-06T14:33:43.296791Z","end":"2026-05-06T14:33:43.525444Z","steps":["trace[830819981] 'agreement among raft nodes before linearized reading' (duration: 227.144953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:33:43.525835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:33:43.176426Z","time spent":"348.517592ms","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T14:33:43.897983Z","caller":"traceutil/trace.go:171","msg":"trace[1394537346] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"250.322473ms","start":"2026-05-06T14:33:43.647623Z","end":"2026-05-06T14:33:43.897945Z","steps":["trace[1394537346] 'read index received' (duration: 205.826727ms)","trace[1394537346] 'applied index is now lower than readState.Index' (duration: 44.494356ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T14:33:43.898053Z","caller":"traceutil/trace.go:171","msg":"trace[338312586] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"313.260123ms","start":"2026-05-06T14:33:43.584726Z","end":"2026-05-06T14:33:43.897986Z","steps":["trace[338312586] 'process raft request' (duration: 268.831929ms)","trace[338312586] 'compare' (duration: 44.100606ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T14:33:43.898224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:33:43.584697Z","time spent":"313.450758ms","remote":"127.0.0.1:46286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T14:33:43.898234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.577629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T14:33:43.898289Z","caller":"traceutil/trace.go:171","msg":"trace[989299403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"250.720293ms","start":"2026-05-06T14:33:43.647552Z","end":"2026-05-06T14:33:43.898273Z","steps":["trace[989299403] 'agreement among raft nodes before linearized reading' (duration: 250.537819ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:34:31.589944Z","caller":"traceutil/trace.go:171","msg":"trace[95929703] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"197.674777ms","start":"2026-05-06T14:34:31.392224Z","end":"2026-05-06T14:34:31.589899Z","steps":["trace[95929703] 'process raft request' (duration: 197.544595ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:34:31.590204Z","caller":"traceutil/trace.go:171","msg":"trace[903505332] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"335.653956ms","start":"2026-05-06T14:34:31.254503Z","end":"2026-05-06T14:34:31.590157Z","steps":["trace[903505332] 'process raft request' (duration: 312.525078ms)","trace[903505332] 'compare' (duration: 22.278144ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T14:34:31.590878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:34:31.254469Z","time spent":"335.816049ms","remote":"127.0.0.1:46204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T14:35:22.192773Z","caller":"traceutil/trace.go:171","msg":"trace[238113230] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"335.630337ms","start":"2026-05-06T14:35:21.857106Z","end":"2026-05-06T14:35:22.192737Z","steps":["trace[238113230] 'process raft request' (duration: 254.482217ms)","trace[238113230] 'compare' (duration: 80.685435ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T14:35:22.192953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:35:21.857077Z","time spent":"335.785779ms","remote":"127.0.0.1:46204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T14:35:22.8243Z","caller":"traceutil/trace.go:171","msg":"trace[764340275] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"491.275793ms","start":"2026-05-06T14:35:22.332999Z","end":"2026-05-06T14:35:22.824274Z","steps":["trace[764340275] 'process raft request' (duration: 491.125121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:35:22.824504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:35:22.332969Z","time spent":"491.424934ms","remote":"127.0.0.1:46204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T14:35:22.824341Z","caller":"traceutil/trace.go:171","msg":"trace[948205067] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1930; }","duration":"392.851561ms","start":"2026-05-06T14:35:22.431438Z","end":"2026-05-06T14:35:22.82429Z","steps":["trace[948205067] 'read index received' (duration: 392.832051ms)","trace[948205067] 'applied index is now lower than readState.Index' (duration: 17.04µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T14:35:22.824841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.335986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cda33947-dcd0-426d-8102-e2fdc1b5d5e1\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-05-06T14:35:22.824983Z","caller":"traceutil/trace.go:171","msg":"trace[1409103548] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cda33947-dcd0-426d-8102-e2fdc1b5d5e1; range_end:; response_count:1; response_revision:1856; }","duration":"393.58649ms","start":"2026-05-06T14:35:22.431369Z","end":"2026-05-06T14:35:22.824955Z","steps":["trace[1409103548] 'agreement among raft nodes before linearized reading' (duration: 393.042134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:35:22.825083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:35:22.43134Z","time spent":"393.723881ms","remote":"127.0.0.1:46104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cda33947-dcd0-426d-8102-e2fdc1b5d5e1\" "} {"level":"info","ts":"2026-05-06T14:35:22.880831Z","caller":"traceutil/trace.go:171","msg":"trace[79058502] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"169.417353ms","start":"2026-05-06T14:35:22.711385Z","end":"2026-05-06T14:35:22.880803Z","steps":["trace[79058502] 'process raft request' (duration: 167.277168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:35:22.881065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.701841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T14:35:22.881271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.165283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cda33947-dcd0-426d-8102-e2fdc1b5d5e1\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-05-06T14:35:22.881338Z","caller":"traceutil/trace.go:171","msg":"trace[970090798] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cda33947-dcd0-426d-8102-e2fdc1b5d5e1; range_end:; response_count:1; response_revision:1858; }","duration":"316.284264ms","start":"2026-05-06T14:35:22.565035Z","end":"2026-05-06T14:35:22.881319Z","steps":["trace[970090798] 'agreement among raft nodes before linearized reading' (duration: 315.852139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:35:22.881414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:35:22.565008Z","time spent":"316.393725ms","remote":"127.0.0.1:46104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cda33947-dcd0-426d-8102-e2fdc1b5d5e1\" "} {"level":"info","ts":"2026-05-06T14:35:22.881488Z","caller":"traceutil/trace.go:171","msg":"trace[235041100] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1858; }","duration":"311.846763ms","start":"2026-05-06T14:35:22.569266Z","end":"2026-05-06T14:35:22.881112Z","steps":["trace[235041100] 'agreement among raft nodes before linearized reading' (duration: 311.716961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:35:22.881575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:35:22.569228Z","time spent":"312.301148ms","remote":"127.0.0.1:35470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-05-06T14:35:35.655079Z","caller":"traceutil/trace.go:171","msg":"trace[98910011] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"129.649719ms","start":"2026-05-06T14:35:35.525386Z","end":"2026-05-06T14:35:35.655035Z","steps":["trace[98910011] 'process raft request' (duration: 129.367426ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:36:02.292607Z","caller":"traceutil/trace.go:171","msg":"trace[1504182548] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"248.506926ms","start":"2026-05-06T14:36:02.044075Z","end":"2026-05-06T14:36:02.292582Z","steps":["trace[1504182548] 'process raft request' (duration: 247.953051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:36:02.773464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.705831ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T14:36:02.773556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.886948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-06T14:36:02.773699Z","caller":"traceutil/trace.go:171","msg":"trace[2022333887] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2125; }","duration":"304.09535ms","start":"2026-05-06T14:36:02.469583Z","end":"2026-05-06T14:36:02.773679Z","steps":["trace[2022333887] 'range keys from in-memory index tree' (duration: 303.686215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:36:02.773797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:36:02.469557Z","time spent":"304.206481ms","remote":"127.0.0.1:46004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-05-06T14:36:02.773622Z","caller":"traceutil/trace.go:171","msg":"trace[97337406] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2125; }","duration":"176.873214ms","start":"2026-05-06T14:36:02.59671Z","end":"2026-05-06T14:36:02.773583Z","steps":["trace[97337406] 'range keys from in-memory index tree' (duration: 176.680911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:36:02.774004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.018789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:99576"} {"level":"info","ts":"2026-05-06T14:36:02.774058Z","caller":"traceutil/trace.go:171","msg":"trace[1206808950] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2125; }","duration":"306.150171ms","start":"2026-05-06T14:36:02.467894Z","end":"2026-05-06T14:36:02.774044Z","steps":["trace[1206808950] 'range keys from in-memory index tree' (duration: 305.734757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:36:02.774094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:36:02.467872Z","time spent":"306.211841ms","remote":"127.0.0.1:45994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":99600,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-05-06T14:36:03.179149Z","caller":"traceutil/trace.go:171","msg":"trace[1357114450] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2208; }","duration":"130.277054ms","start":"2026-05-06T14:36:03.048841Z","end":"2026-05-06T14:36:03.179118Z","steps":["trace[1357114450] 'read index received' (duration: 119.124074ms)","trace[1357114450] 'applied index is now lower than readState.Index' (duration: 11.15187ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T14:36:03.179415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.557967ms","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-05-06T14:36:03.17947Z","caller":"traceutil/trace.go:171","msg":"trace[1111880259] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2127; }","duration":"130.664658ms","start":"2026-05-06T14:36:03.048792Z","end":"2026-05-06T14:36:03.179457Z","steps":["trace[1111880259] 'agreement among raft nodes before linearized reading' (duration: 130.435405ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:36:03.179621Z","caller":"traceutil/trace.go:171","msg":"trace[1835080999] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"146.056521ms","start":"2026-05-06T14:36:03.033547Z","end":"2026-05-06T14:36:03.179604Z","steps":["trace[1835080999] 'process raft request' (duration: 134.421706ms)","trace[1835080999] 'compare' (duration: 10.998749ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T14:41:33.667116Z","caller":"traceutil/trace.go:171","msg":"trace[2075879978] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"136.098422ms","start":"2026-05-06T14:41:33.530968Z","end":"2026-05-06T14:41:33.667066Z","steps":["trace[2075879978] 'process raft request' (duration: 135.959311ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:41:33.672768Z","caller":"traceutil/trace.go:171","msg":"trace[1397133271] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"138.446483ms","start":"2026-05-06T14:41:33.534279Z","end":"2026-05-06T14:41:33.672725Z","steps":["trace[1397133271] 'process raft request' (duration: 138.259501ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:41:33.673002Z","caller":"traceutil/trace.go:171","msg":"trace[1568686342] linearizableReadLoop","detail":"{readStateIndex:4870; appliedIndex:4868; }","duration":"132.879351ms","start":"2026-05-06T14:41:33.53981Z","end":"2026-05-06T14:41:33.672689Z","steps":["trace[1568686342] 'read index received' (duration: 127.159436ms)","trace[1568686342] 'applied index is now lower than readState.Index' (duration: 5.719095ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T14:41:33.67292Z","caller":"traceutil/trace.go:171","msg":"trace[1463376580] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"112.829148ms","start":"2026-05-06T14:41:33.56007Z","end":"2026-05-06T14:41:33.672899Z","steps":["trace[1463376580] 'process raft request' (duration: 112.575525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:41:33.673124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.303756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T14:41:33.673161Z","caller":"traceutil/trace.go:171","msg":"trace[1689172654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4691; }","duration":"133.367587ms","start":"2026-05-06T14:41:33.539787Z","end":"2026-05-06T14:41:33.673155Z","steps":["trace[1689172654] 'agreement among raft nodes before linearized reading' (duration: 133.242345ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:41:54.785496Z","caller":"traceutil/trace.go:171","msg":"trace[364758686] linearizableReadLoop","detail":"{readStateIndex:5183; appliedIndex:5182; }","duration":"177.833998ms","start":"2026-05-06T14:41:54.607638Z","end":"2026-05-06T14:41:54.785472Z","steps":["trace[364758686] 'read index received' (duration: 177.718267ms)","trace[364758686] 'applied index is now lower than readState.Index' (duration: 114.701µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T14:41:54.785631Z","caller":"traceutil/trace.go:171","msg":"trace[212208083] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"276.882245ms","start":"2026-05-06T14:41:54.508714Z","end":"2026-05-06T14:41:54.785596Z","steps":["trace[212208083] 'process raft request' (duration: 276.626212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:41:54.785733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.089442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16397"} {"level":"info","ts":"2026-05-06T14:41:54.785796Z","caller":"traceutil/trace.go:171","msg":"trace[1421253054] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4995; }","duration":"178.193293ms","start":"2026-05-06T14:41:54.607591Z","end":"2026-05-06T14:41:54.785784Z","steps":["trace[1421253054] 'agreement among raft nodes before linearized reading' (duration: 177.98403ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:41:54.806691Z","caller":"traceutil/trace.go:171","msg":"trace[383821830] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"149.955659ms","start":"2026-05-06T14:41:54.656715Z","end":"2026-05-06T14:41:54.80667Z","steps":["trace[383821830] 'process raft request' (duration: 149.847837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T14:41:54.806878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.854491ms","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-05-06T14:41:54.806938Z","caller":"traceutil/trace.go:171","msg":"trace[2125309345] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4996; }","duration":"143.960222ms","start":"2026-05-06T14:41:54.662966Z","end":"2026-05-06T14:41:54.806926Z","steps":["trace[2125309345] 'agreement among raft nodes before linearized reading' (duration: 143.79699ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T14:43:00.871241Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-05-06T14:43:00.971241Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"98.232212ms","hash":3494450963,"current-db-size-bytes":53555200,"current-db-size":"54 MB","current-db-size-in-use-bytes":28778496,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-06T14:43:00.971439Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3494450963,"revision":2868,"compact-revision":-1} {"level":"info","ts":"2026-05-06T14:48:00.876841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5530} {"level":"info","ts":"2026-05-06T14:48:00.951335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5530,"took":"72.793641ms","hash":4101271214,"current-db-size-bytes":53555200,"current-db-size":"54 MB","current-db-size-in-use-bytes":18456576,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-06T14:48:00.951412Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4101271214,"revision":5530,"compact-revision":2868}