{"level":"warn","ts":"2026-04-07T12:55:27.605166Z","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-07T12:55:27.60533Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-07T12:55:27.605412Z","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-07T12:55:27.605421Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-07T12:55:27.605448Z","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-07T12:55:27.6068Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-04-07T12:55:27.606882Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-07T12:55:27.611376Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.28452ms"} {"level":"info","ts":"2026-04-07T12:55:27.619246Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-04-07T12:55:27.619333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T12:55:27.619351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-04-07T12:55:27.619391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T12:55:27.619404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-04-07T12:55:27.619439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-04-07T12:55:27.627789Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T12:55:27.629688Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T12:55:27.630698Z","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-07T12:55:27.632489Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T12:55:27.633031Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T12:55:27.633124Z","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-07T12:55:27.634046Z","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-07T12:55:27.634195Z","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-07T12:55:27.634163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-04-07T12:55:27.634399Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-07T12:55:27.637487Z","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-07T12:55:27.637619Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-07T12:55:27.637712Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-07T12:55:27.637719Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T12:55:27.637772Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T12:55:27.720432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T12:55:27.720485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T12:55:27.720505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-04-07T12:55:27.720608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-04-07T12:55:27.720625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-07T12:55:27.720673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-04-07T12:55:27.720692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-07T12:55:27.721503Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T12:55:27.721575Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T12:55:27.721676Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T12:55:27.721823Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:55:27.721884Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T12:55:27.721941Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T12:55:27.723725Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T12:55:27.725272Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-04-07T12:55:27.725566Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:55:27.72575Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:55:27.725792Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:55:29.803142Z","caller":"traceutil/trace.go:171","msg":"trace[2020199593] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"197.143899ms","start":"2026-04-07T12:55:29.605972Z","end":"2026-04-07T12:55:29.803115Z","steps":["trace[2020199593] 'process raft request' (duration: 145.97452ms)","trace[2020199593] 'compare' (duration: 51.028165ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:55:29.803115Z","caller":"traceutil/trace.go:171","msg":"trace[1138130180] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"196.154853ms","start":"2026-04-07T12:55:29.606933Z","end":"2026-04-07T12:55:29.803088Z","steps":["trace[1138130180] 'read index received' (duration: 145.188459ms)","trace[1138130180] 'applied index is now lower than readState.Index' (duration: 50.965314ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:55:29.803329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.376378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T12:55:29.803409Z","caller":"traceutil/trace.go:171","msg":"trace[1376530718] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:3; }","duration":"196.508882ms","start":"2026-04-07T12:55:29.606888Z","end":"2026-04-07T12:55:29.803397Z","steps":["trace[1376530718] 'agreement among raft nodes before linearized reading' (duration: 196.291906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:55:29.80572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.58187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T12:55:29.805795Z","caller":"traceutil/trace.go:171","msg":"trace[1944235631] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"167.381674ms","start":"2026-04-07T12:55:29.638388Z","end":"2026-04-07T12:55:29.805769Z","steps":["trace[1944235631] 'process raft request' (duration: 167.178939ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.805806Z","caller":"traceutil/trace.go:171","msg":"trace[308022884] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"198.691644ms","start":"2026-04-07T12:55:29.607096Z","end":"2026-04-07T12:55:29.805787Z","steps":["trace[308022884] 'agreement among raft nodes before linearized reading' (duration: 198.539359ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.805978Z","caller":"traceutil/trace.go:171","msg":"trace[1241968226] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"186.982957ms","start":"2026-04-07T12:55:29.618976Z","end":"2026-04-07T12:55:29.805959Z","steps":["trace[1241968226] 'process raft request' (duration: 186.517525ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.806148Z","caller":"traceutil/trace.go:171","msg":"trace[420924307] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"187.087981ms","start":"2026-04-07T12:55:29.619041Z","end":"2026-04-07T12:55:29.806129Z","steps":["trace[420924307] 'process raft request' (duration: 186.472984ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.806133Z","caller":"traceutil/trace.go:171","msg":"trace[106752369] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"187.609476ms","start":"2026-04-07T12:55:29.618472Z","end":"2026-04-07T12:55:29.806081Z","steps":["trace[106752369] 'process raft request' (duration: 186.952598ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.806302Z","caller":"traceutil/trace.go:171","msg":"trace[2130107075] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"187.356379ms","start":"2026-04-07T12:55:29.61889Z","end":"2026-04-07T12:55:29.806246Z","steps":["trace[2130107075] 'process raft request' (duration: 186.572177ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.806517Z","caller":"traceutil/trace.go:171","msg":"trace[1608147135] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"188.048019ms","start":"2026-04-07T12:55:29.618453Z","end":"2026-04-07T12:55:29.806501Z","steps":["trace[1608147135] 'process raft request' (duration: 186.862876ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.806574Z","caller":"traceutil/trace.go:171","msg":"trace[1698805606] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"162.785137ms","start":"2026-04-07T12:55:29.643774Z","end":"2026-04-07T12:55:29.80656Z","steps":["trace[1698805606] 'process raft request' (duration: 161.818889ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.806592Z","caller":"traceutil/trace.go:171","msg":"trace[1690787019] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"170.025458ms","start":"2026-04-07T12:55:29.636528Z","end":"2026-04-07T12:55:29.806553Z","steps":["trace[1690787019] 'process raft request' (duration: 169.012179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:55:29.806715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.284629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T12:55:29.806751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.239551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T12:55:29.806785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.951416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T12:55:29.806795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.305851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T12:55:29.806911Z","caller":"traceutil/trace.go:171","msg":"trace[260121503] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"110.492366ms","start":"2026-04-07T12:55:29.696404Z","end":"2026-04-07T12:55:29.806896Z","steps":["trace[260121503] 'agreement among raft nodes before linearized reading' (duration: 110.301841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:55:29.806939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.352181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T12:55:29.806811Z","caller":"traceutil/trace.go:171","msg":"trace[234857608] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"186.439974ms","start":"2026-04-07T12:55:29.620351Z","end":"2026-04-07T12:55:29.806791Z","steps":["trace[234857608] 'agreement among raft nodes before linearized reading' (duration: 186.27998ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.806997Z","caller":"traceutil/trace.go:171","msg":"trace[1944584372] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:0; response_revision:11; }","duration":"164.447093ms","start":"2026-04-07T12:55:29.642536Z","end":"2026-04-07T12:55:29.806984Z","steps":["trace[1944584372] 'agreement among raft nodes before linearized reading' (duration: 164.30425ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.80681Z","caller":"traceutil/trace.go:171","msg":"trace[1730463725] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"136.325483ms","start":"2026-04-07T12:55:29.670469Z","end":"2026-04-07T12:55:29.806794Z","steps":["trace[1730463725] 'agreement among raft nodes before linearized reading' (duration: 136.239801ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:29.806822Z","caller":"traceutil/trace.go:171","msg":"trace[1659859218] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"187.990477ms","start":"2026-04-07T12:55:29.618821Z","end":"2026-04-07T12:55:29.806811Z","steps":["trace[1659859218] 'agreement among raft nodes before linearized reading' (duration: 187.931465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:55:29.806864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.285281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T12:55:29.808103Z","caller":"traceutil/trace.go:171","msg":"trace[1430953074] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"111.555646ms","start":"2026-04-07T12:55:29.69651Z","end":"2026-04-07T12:55:29.808065Z","steps":["trace[1430953074] 'agreement among raft nodes before linearized reading' (duration: 110.332523ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:37.000959Z","caller":"traceutil/trace.go:171","msg":"trace[1295521587] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"160.910495ms","start":"2026-04-07T12:55:36.839998Z","end":"2026-04-07T12:55:37.000909Z","steps":["trace[1295521587] 'read index received' (duration: 159.959078ms)","trace[1295521587] 'applied index is now lower than readState.Index' (duration: 949.977µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:55:37.001127Z","caller":"traceutil/trace.go:171","msg":"trace[618553798] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"169.376441ms","start":"2026-04-07T12:55:36.831732Z","end":"2026-04-07T12:55:37.001109Z","steps":["trace[618553798] 'process raft request' (duration: 168.167557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:55:37.001418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.399159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-07T12:55:37.001486Z","caller":"traceutil/trace.go:171","msg":"trace[1676613448] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:293; }","duration":"161.488832ms","start":"2026-04-07T12:55:36.839982Z","end":"2026-04-07T12:55:37.001471Z","steps":["trace[1676613448] 'agreement among raft nodes before linearized reading' (duration: 161.392239ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:56:02.983488Z","caller":"traceutil/trace.go:171","msg":"trace[1586046774] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"402.251964ms","start":"2026-04-07T12:56:02.581172Z","end":"2026-04-07T12:56:02.983424Z","steps":["trace[1586046774] 'process raft request' (duration: 328.079123ms)","trace[1586046774] 'compare' (duration: 74.015786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:56:02.984383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:56:02.581153Z","time spent":"402.437948ms","remote":"127.0.0.1:34708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T12:56:17.379704Z","caller":"traceutil/trace.go:171","msg":"trace[77460377] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"183.824086ms","start":"2026-04-07T12:56:17.195857Z","end":"2026-04-07T12:56:17.379682Z","steps":["trace[77460377] 'process raft request' (duration: 183.665702ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:56:17.46141Z","caller":"traceutil/trace.go:171","msg":"trace[1891318425] linearizableReadLoop","detail":"{readStateIndex:760; appliedIndex:758; }","duration":"254.543372ms","start":"2026-04-07T12:56:17.206847Z","end":"2026-04-07T12:56:17.461391Z","steps":["trace[1891318425] 'read index received' (duration: 172.785263ms)","trace[1891318425] 'applied index is now lower than readState.Index' (duration: 81.757288ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:56:17.461538Z","caller":"traceutil/trace.go:171","msg":"trace[726999664] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"263.947849ms","start":"2026-04-07T12:56:17.197569Z","end":"2026-04-07T12:56:17.461517Z","steps":["trace[726999664] 'process raft request' (duration: 256.712459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:56:17.461599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.729666ms","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-04-07T12:56:17.461625Z","caller":"traceutil/trace.go:171","msg":"trace[1397143503] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:734; }","duration":"254.796038ms","start":"2026-04-07T12:56:17.206818Z","end":"2026-04-07T12:56:17.461614Z","steps":["trace[1397143503] 'agreement among raft nodes before linearized reading' (duration: 254.644413ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:56:51.452196Z","caller":"traceutil/trace.go:171","msg":"trace[381444720] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"216.124234ms","start":"2026-04-07T12:56:51.23604Z","end":"2026-04-07T12:56:51.452165Z","steps":["trace[381444720] 'process raft request' (duration: 122.040277ms)","trace[381444720] 'compare' (duration: 93.948223ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:56:51.453029Z","caller":"traceutil/trace.go:171","msg":"trace[1364567099] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"195.25569ms","start":"2026-04-07T12:56:51.257763Z","end":"2026-04-07T12:56:51.453019Z","steps":["trace[1364567099] 'process raft request' (duration: 195.191298ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:13.93286Z","caller":"traceutil/trace.go:171","msg":"trace[2121999288] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"126.02105ms","start":"2026-04-07T12:57:13.806806Z","end":"2026-04-07T12:57:13.932827Z","steps":["trace[2121999288] 'process raft request' (duration: 114.516316ms)","trace[2121999288] 'compare' (duration: 11.395001ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:24.833379Z","caller":"traceutil/trace.go:171","msg":"trace[912140337] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"208.486479ms","start":"2026-04-07T12:57:24.624873Z","end":"2026-04-07T12:57:24.833359Z","steps":["trace[912140337] 'process raft request' (duration: 208.381336ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:38.003595Z","caller":"traceutil/trace.go:171","msg":"trace[90529247] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"100.716769ms","start":"2026-04-07T12:57:37.902858Z","end":"2026-04-07T12:57:38.003575Z","steps":["trace[90529247] 'process raft request' (duration: 100.0634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:41.723211Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868573964176684,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-07T12:57:41.860637Z","caller":"traceutil/trace.go:171","msg":"trace[1581788599] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1229; }","duration":"638.070453ms","start":"2026-04-07T12:57:41.22255Z","end":"2026-04-07T12:57:41.86062Z","steps":["trace[1581788599] 'read index received' (duration: 638.032112ms)","trace[1581788599] 'applied index is now lower than readState.Index' (duration: 37.751µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:41.860672Z","caller":"traceutil/trace.go:171","msg":"trace[1187878499] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"861.160392ms","start":"2026-04-07T12:57:40.999481Z","end":"2026-04-07T12:57:41.860641Z","steps":["trace[1187878499] 'process raft request' (duration: 861.045639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:41.860811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.249249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-07T12:57:41.860845Z","caller":"traceutil/trace.go:171","msg":"trace[1172911333] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:1185; }","duration":"638.335721ms","start":"2026-04-07T12:57:41.222499Z","end":"2026-04-07T12:57:41.860835Z","steps":["trace[1172911333] 'agreement among raft nodes before linearized reading' (duration: 638.196527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:41.860874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:57:40.999444Z","time spent":"861.293216ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T12:57:41.86093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:57:41.222481Z","time spent":"638.435064ms","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"info","ts":"2026-04-07T12:57:41.862283Z","caller":"traceutil/trace.go:171","msg":"trace[30799817] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"132.683021ms","start":"2026-04-07T12:57:41.729585Z","end":"2026-04-07T12:57:41.862268Z","steps":["trace[30799817] 'process raft request' (duration: 132.569568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:44.024779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.226705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T12:57:44.024882Z","caller":"traceutil/trace.go:171","msg":"trace[240812841] linearizableReadLoop","detail":"{readStateIndex:1243; appliedIndex:1241; }","duration":"146.233361ms","start":"2026-04-07T12:57:43.878631Z","end":"2026-04-07T12:57:44.024865Z","steps":["trace[240812841] 'read index received' (duration: 4.723699ms)","trace[240812841] 'applied index is now lower than readState.Index' (duration: 141.508482ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:44.024911Z","caller":"traceutil/trace.go:171","msg":"trace[703044754] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"158.000832ms","start":"2026-04-07T12:57:43.86687Z","end":"2026-04-07T12:57:44.024871Z","steps":["trace[703044754] 'process raft request' (duration: 27.375607ms)","trace[703044754] 'compare' (duration: 130.057389ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:57:44.02501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.379714ms","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-07T12:57:44.025057Z","caller":"traceutil/trace.go:171","msg":"trace[514033256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1197; }","duration":"146.408615ms","start":"2026-04-07T12:57:43.878621Z","end":"2026-04-07T12:57:44.025029Z","steps":["trace[514033256] 'agreement among raft nodes before linearized reading' (duration: 146.289382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:56.603918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.138138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T12:57:56.604311Z","caller":"traceutil/trace.go:171","msg":"trace[499068767] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1329; }","duration":"130.137211ms","start":"2026-04-07T12:57:56.474154Z","end":"2026-04-07T12:57:56.604291Z","steps":["trace[499068767] 'read index received' (duration: 69.065645ms)","trace[499068767] 'applied index is now lower than readState.Index' (duration: 61.070136ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:56.604507Z","caller":"traceutil/trace.go:171","msg":"trace[1415832853] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"422.8206ms","start":"2026-04-07T12:57:56.181647Z","end":"2026-04-07T12:57:56.604468Z","steps":["trace[1415832853] 'process raft request' (duration: 110.040283ms)","trace[1415832853] 'compare' (duration: 312.002655ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:57:56.604707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:57:56.18162Z","time spent":"423.021945ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T12:57:56.605059Z","caller":"traceutil/trace.go:171","msg":"trace[126678161] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"423.344453ms","start":"2026-04-07T12:57:56.181694Z","end":"2026-04-07T12:57:56.605038Z","steps":["trace[126678161] 'process raft request' (duration: 422.53686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:56.605201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:57:56.18167Z","time spent":"423.462877ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T12:57:56.605019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.860622ms","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-04-07T12:57:56.606161Z","caller":"traceutil/trace.go:171","msg":"trace[744627257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1283; }","duration":"131.770627ms","start":"2026-04-07T12:57:56.473909Z","end":"2026-04-07T12:57:56.605679Z","steps":["trace[744627257] 'agreement among raft nodes before linearized reading' (duration: 130.7902ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:06.319657Z","caller":"traceutil/trace.go:171","msg":"trace[1200327351] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"132.317969ms","start":"2026-04-07T12:58:06.187314Z","end":"2026-04-07T12:58:06.319632Z","steps":["trace[1200327351] 'process raft request' (duration: 132.132804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.153535Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868573964176993,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-07T12:58:07.238622Z","caller":"traceutil/trace.go:171","msg":"trace[378778603] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1376; }","duration":"585.208023ms","start":"2026-04-07T12:58:06.653397Z","end":"2026-04-07T12:58:07.238605Z","steps":["trace[378778603] 'read index received' (duration: 544.515017ms)","trace[378778603] 'applied index is now lower than readState.Index' (duration: 40.692386ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:58:07.238677Z","caller":"traceutil/trace.go:171","msg":"trace[624527416] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"584.501583ms","start":"2026-04-07T12:58:06.654147Z","end":"2026-04-07T12:58:07.238648Z","steps":["trace[624527416] 'process raft request' (duration: 584.37871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.238819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:06.654126Z","time spent":"584.612227ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T12:58:07.238862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.150465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T12:58:07.238909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.97006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-07T12:58:07.238935Z","caller":"traceutil/trace.go:171","msg":"trace[112969578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1327; }","duration":"162.239477ms","start":"2026-04-07T12:58:07.076675Z","end":"2026-04-07T12:58:07.238914Z","steps":["trace[112969578] 'agreement among raft nodes before linearized reading' (duration: 162.142294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.238963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.093105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-04-07T12:58:07.239017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.261344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-07T12:58:07.238835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.218113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T12:58:07.239038Z","caller":"traceutil/trace.go:171","msg":"trace[1470686603] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1327; }","duration":"519.197509ms","start":"2026-04-07T12:58:06.719822Z","end":"2026-04-07T12:58:07.23902Z","steps":["trace[1470686603] 'agreement among raft nodes before linearized reading' (duration: 518.980313ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:07.239043Z","caller":"traceutil/trace.go:171","msg":"trace[29122137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1327; }","duration":"585.302156ms","start":"2026-04-07T12:58:06.653733Z","end":"2026-04-07T12:58:07.239035Z","steps":["trace[29122137] 'agreement among raft nodes before linearized reading' (duration: 585.225964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.239082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:06.719811Z","time spent":"519.26195ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-07T12:58:07.239079Z","caller":"traceutil/trace.go:171","msg":"trace[941022654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1327; }","duration":"585.484401ms","start":"2026-04-07T12:58:06.653578Z","end":"2026-04-07T12:58:07.239063Z","steps":["trace[941022654] 'agreement among raft nodes before linearized reading' (duration: 585.129211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.239078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:06.653726Z","time spent":"585.344987ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T12:58:07.238946Z","caller":"traceutil/trace.go:171","msg":"trace[590650849] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1327; }","duration":"562.032832ms","start":"2026-04-07T12:58:06.676904Z","end":"2026-04-07T12:58:07.238937Z","steps":["trace[590650849] 'agreement among raft nodes before linearized reading' (duration: 561.95481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.239283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:06.676892Z","time spent":"562.384113ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T12:58:07.239132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:06.653564Z","time spent":"585.552222ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T12:58:07.239313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.229226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-07T12:58:07.239362Z","caller":"traceutil/trace.go:171","msg":"trace[274175716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1327; }","duration":"226.313039ms","start":"2026-04-07T12:58:07.013036Z","end":"2026-04-07T12:58:07.239349Z","steps":["trace[274175716] 'agreement among raft nodes before linearized reading' (duration: 226.174325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.239378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.581752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-07T12:58:07.239557Z","caller":"traceutil/trace.go:171","msg":"trace[1037134182] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1327; }","duration":"326.946422ms","start":"2026-04-07T12:58:06.912587Z","end":"2026-04-07T12:58:07.239534Z","steps":["trace[1037134182] 'agreement among raft nodes before linearized reading' (duration: 326.195661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.24033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:06.912566Z","time spent":"327.742264ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T12:58:07.239423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.013395ms","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-04-07T12:58:07.24044Z","caller":"traceutil/trace.go:171","msg":"trace[462462089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1327; }","duration":"587.092325ms","start":"2026-04-07T12:58:06.653332Z","end":"2026-04-07T12:58:07.240424Z","steps":["trace[462462089] 'agreement among raft nodes before linearized reading' (duration: 585.378938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.239657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.015047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-07T12:58:07.240502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:06.653312Z","time spent":"587.168966ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T12:58:07.240512Z","caller":"traceutil/trace.go:171","msg":"trace[793862506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1327; }","duration":"526.88528ms","start":"2026-04-07T12:58:06.713613Z","end":"2026-04-07T12:58:07.240498Z","steps":["trace[793862506] 'agreement among raft nodes before linearized reading' (duration: 525.946544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:07.240561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:06.713603Z","time spent":"526.945411ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}