{"level":"warn","ts":"2026-04-14T07:28:33.532603Z","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-14T07:28:33.532688Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.118: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.118:2380","--initial-cluster=instance=https://199.19.213.118:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.118:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.118: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-14T07:28:33.532755Z","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-14T07:28:33.53277Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.118:2380"]} {"level":"info","ts":"2026-04-14T07:28:33.532793Z","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-14T07:28:33.534074Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"]} {"level":"info","ts":"2026-04-14T07:28:33.534167Z","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.118:2380"],"listen-peer-urls":["https://199.19.213.118:2380"],"advertise-client-urls":["https://199.19.213.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.118: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-14T07:28:33.539299Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.934273ms"} {"level":"info","ts":"2026-04-14T07:28:33.546881Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"511d8c552db01fa8","cluster-id":"8d545d29b73b98f3"} {"level":"info","ts":"2026-04-14T07:28:33.546955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T07:28:33.546977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became follower at term 0"} {"level":"info","ts":"2026-04-14T07:28:33.54699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 511d8c552db01fa8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T07:28:33.546999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became follower at term 1"} {"level":"info","ts":"2026-04-14T07:28:33.547033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=(5844982188863397800)"} {"level":"warn","ts":"2026-04-14T07:28:33.556412Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T07:28:33.558111Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T07:28:33.559359Z","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-14T07:28:33.562474Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"511d8c552db01fa8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T07:28:33.563643Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"511d8c552db01fa8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T07:28:33.564544Z","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-14T07:28:33.564916Z","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-14T07:28:33.564942Z","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-14T07:28:33.566951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=(5844982188863397800)"} {"level":"info","ts":"2026-04-14T07:28:33.567092Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8d545d29b73b98f3","local-member-id":"511d8c552db01fa8","added-peer-id":"511d8c552db01fa8","added-peer-peer-urls":["https://199.19.213.118:2380"]} {"level":"info","ts":"2026-04-14T07:28:33.56836Z","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-14T07:28:33.568487Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.118:2380"} {"level":"info","ts":"2026-04-14T07:28:33.568552Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.118:2380"} {"level":"info","ts":"2026-04-14T07:28:33.568919Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"511d8c552db01fa8","initial-advertise-peer-urls":["https://199.19.213.118:2380"],"listen-peer-urls":["https://199.19.213.118:2380"],"advertise-client-urls":["https://199.19.213.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T07:28:33.568971Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T07:28:34.148156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T07:28:34.148202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T07:28:34.148226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 received MsgPreVoteResp from 511d8c552db01fa8 at term 1"} {"level":"info","ts":"2026-04-14T07:28:34.148241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became candidate at term 2"} {"level":"info","ts":"2026-04-14T07:28:34.148248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 received MsgVoteResp from 511d8c552db01fa8 at term 2"} {"level":"info","ts":"2026-04-14T07:28:34.148256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became leader at term 2"} {"level":"info","ts":"2026-04-14T07:28:34.148263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 511d8c552db01fa8 elected leader 511d8c552db01fa8 at term 2"} {"level":"info","ts":"2026-04-14T07:28:34.152478Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T07:28:34.153229Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"511d8c552db01fa8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.118:2379]}","request-path":"/0/members/511d8c552db01fa8/attributes","cluster-id":"8d545d29b73b98f3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T07:28:34.153436Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T07:28:34.153489Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T07:28:34.15415Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T07:28:34.154179Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T07:28:34.156893Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8d545d29b73b98f3","local-member-id":"511d8c552db01fa8","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T07:28:34.157008Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T07:28:34.157058Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T07:28:34.157087Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T07:28:34.157285Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.118:2379"} {"level":"warn","ts":"2026-04-14T07:28:37.016263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.140544ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-14T07:28:37.016562Z","caller":"traceutil/trace.go:171","msg":"trace[1545753784] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:77; }","duration":"486.956986ms","start":"2026-04-14T07:28:36.52958Z","end":"2026-04-14T07:28:37.016537Z","steps":["trace[1545753784] 'read index received' (duration: 181.779807ms)","trace[1545753784] 'applied index is now lower than readState.Index' (duration: 305.175289ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T07:28:37.016847Z","caller":"traceutil/trace.go:171","msg":"trace[1256390902] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"491.169759ms","start":"2026-04-14T07:28:36.52561Z","end":"2026-04-14T07:28:37.01678Z","steps":["trace[1256390902] 'process raft request' (duration: 185.803105ms)","trace[1256390902] 'compare' (duration: 303.929949ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T07:28:37.016918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.301144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-14T07:28:37.016928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.878426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-14T07:28:37.017062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T07:28:36.525597Z","time spent":"491.355334ms","remote":"127.0.0.1:40292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T07:28:37.017251Z","caller":"traceutil/trace.go:171","msg":"trace[1420127117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"411.254246ms","start":"2026-04-14T07:28:36.605981Z","end":"2026-04-14T07:28:37.017235Z","steps":["trace[1420127117] 'agreement among raft nodes before linearized reading' (duration: 410.845685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:28:37.017427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T07:28:36.605953Z","time spent":"411.459631ms","remote":"127.0.0.1:39926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T07:28:37.01701Z","caller":"traceutil/trace.go:171","msg":"trace[901093717] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:73; }","duration":"487.418937ms","start":"2026-04-14T07:28:36.529568Z","end":"2026-04-14T07:28:37.016987Z","steps":["trace[901093717] 'agreement among raft nodes before linearized reading' (duration: 487.231552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:28:37.017581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T07:28:36.529561Z","time spent":"487.978101ms","remote":"127.0.0.1:40276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"info","ts":"2026-04-14T07:28:37.260509Z","caller":"traceutil/trace.go:171","msg":"trace[1838752410] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"232.708608ms","start":"2026-04-14T07:28:37.027762Z","end":"2026-04-14T07:28:37.26047Z","steps":["trace[1838752410] 'process raft request' (duration: 171.32127ms)","trace[1838752410] 'compare' (duration: 60.792614ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T07:29:11.12755Z","caller":"traceutil/trace.go:171","msg":"trace[605636468] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"126.682097ms","start":"2026-04-14T07:29:11.00084Z","end":"2026-04-14T07:29:11.127522Z","steps":["trace[605636468] 'process raft request' (duration: 126.566774ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.140509Z","caller":"traceutil/trace.go:171","msg":"trace[112715441] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"120.553144ms","start":"2026-04-14T07:29:11.019907Z","end":"2026-04-14T07:29:11.14046Z","steps":["trace[112715441] 'process raft request' (duration: 120.349429ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.140575Z","caller":"traceutil/trace.go:171","msg":"trace[505030131] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"138.599116ms","start":"2026-04-14T07:29:11.00197Z","end":"2026-04-14T07:29:11.140569Z","steps":["trace[505030131] 'process raft request' (duration: 138.087493ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.140609Z","caller":"traceutil/trace.go:171","msg":"trace[1247210192] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"116.511313ms","start":"2026-04-14T07:29:11.024069Z","end":"2026-04-14T07:29:11.14058Z","steps":["trace[1247210192] 'process raft request' (duration: 116.270546ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.140525Z","caller":"traceutil/trace.go:171","msg":"trace[473223710] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"136.860311ms","start":"2026-04-14T07:29:11.003634Z","end":"2026-04-14T07:29:11.140495Z","steps":["trace[473223710] 'process raft request' (duration: 136.495712ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.1408Z","caller":"traceutil/trace.go:171","msg":"trace[942541670] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"129.321893ms","start":"2026-04-14T07:29:11.011393Z","end":"2026-04-14T07:29:11.140715Z","steps":["trace[942541670] 'process raft request' (duration: 128.767509ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.140943Z","caller":"traceutil/trace.go:171","msg":"trace[1410657305] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"116.445032ms","start":"2026-04-14T07:29:11.02449Z","end":"2026-04-14T07:29:11.140935Z","steps":["trace[1410657305] 'process raft request' (duration: 115.879918ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.141301Z","caller":"traceutil/trace.go:171","msg":"trace[1678129299] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"111.228152ms","start":"2026-04-14T07:29:11.03006Z","end":"2026-04-14T07:29:11.141289Z","steps":["trace[1678129299] 'process raft request' (duration: 110.344759ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.141557Z","caller":"traceutil/trace.go:171","msg":"trace[1291725524] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"125.19311ms","start":"2026-04-14T07:29:11.015222Z","end":"2026-04-14T07:29:11.140415Z","steps":["trace[1291725524] 'process raft request' (duration: 124.970855ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:11.140733Z","caller":"traceutil/trace.go:171","msg":"trace[2055126094] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"120.918103ms","start":"2026-04-14T07:29:11.0198Z","end":"2026-04-14T07:29:11.140718Z","steps":["trace[2055126094] 'process raft request' (duration: 120.41856ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:17.242265Z","caller":"traceutil/trace.go:171","msg":"trace[971373208] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"222.184075ms","start":"2026-04-14T07:29:17.020051Z","end":"2026-04-14T07:29:17.242235Z","steps":["trace[971373208] 'process raft request' (duration: 221.644322ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:17.467248Z","caller":"traceutil/trace.go:171","msg":"trace[2124536885] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"166.36561ms","start":"2026-04-14T07:29:17.300858Z","end":"2026-04-14T07:29:17.467224Z","steps":["trace[2124536885] 'process raft request' (duration: 166.314869ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:29:17.467292Z","caller":"traceutil/trace.go:171","msg":"trace[1666981506] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"203.730665ms","start":"2026-04-14T07:29:17.263518Z","end":"2026-04-14T07:29:17.467249Z","steps":["trace[1666981506] 'process raft request' (duration: 148.108374ms)","trace[1666981506] 'compare' (duration: 55.399624ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T07:29:18.104127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.083403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T07:29:18.10424Z","caller":"traceutil/trace.go:171","msg":"trace[1536013316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"320.241057ms","start":"2026-04-14T07:29:17.783974Z","end":"2026-04-14T07:29:18.104215Z","steps":["trace[1536013316] 'range keys from in-memory index tree' (duration: 320.012871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:29:18.104312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T07:29:17.783958Z","time spent":"320.344539ms","remote":"127.0.0.1:39928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T07:29:18.10449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.875583ms","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-14T07:29:18.104739Z","caller":"traceutil/trace.go:171","msg":"trace[1532954553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"445.209801ms","start":"2026-04-14T07:29:17.659496Z","end":"2026-04-14T07:29:18.104706Z","steps":["trace[1532954553] 'range keys from in-memory index tree' (duration: 444.491203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:29:18.104836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T07:29:17.659481Z","time spent":"445.336284ms","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T07:29:18.104969Z","caller":"traceutil/trace.go:171","msg":"trace[1195655294] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"203.356975ms","start":"2026-04-14T07:29:17.901534Z","end":"2026-04-14T07:29:18.104891Z","steps":["trace[1195655294] 'read index received' (duration: 200.211166ms)","trace[1195655294] 'applied index is now lower than readState.Index' (duration: 3.143639ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T07:29:18.105002Z","caller":"traceutil/trace.go:171","msg":"trace[908397889] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"223.810156ms","start":"2026-04-14T07:29:17.881164Z","end":"2026-04-14T07:29:18.104974Z","steps":["trace[908397889] 'process raft request' (duration: 220.78391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:29:18.105251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.695253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x7wnj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-14T07:29:18.10531Z","caller":"traceutil/trace.go:171","msg":"trace[1543170125] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x7wnj; range_end:; response_count:1; response_revision:637; }","duration":"203.806026ms","start":"2026-04-14T07:29:17.901485Z","end":"2026-04-14T07:29:18.105291Z","steps":["trace[1543170125] 'agreement among raft nodes before linearized reading' (duration: 203.655902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:29:33.821266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.407786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T07:29:33.821331Z","caller":"traceutil/trace.go:171","msg":"trace[2077338197] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:795; }","duration":"303.524189ms","start":"2026-04-14T07:29:33.517794Z","end":"2026-04-14T07:29:33.821318Z","steps":["trace[2077338197] 'range keys from in-memory index tree' (duration: 303.267973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:29:33.821372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T07:29:33.517775Z","time spent":"303.59115ms","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T07:29:33.821522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.412951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T07:29:33.821605Z","caller":"traceutil/trace.go:171","msg":"trace[1335307218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:795; }","duration":"280.541835ms","start":"2026-04-14T07:29:33.541048Z","end":"2026-04-14T07:29:33.82159Z","steps":["trace[1335307218] 'range keys from in-memory index tree' (duration: 280.211786ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:30:08.139316Z","caller":"traceutil/trace.go:171","msg":"trace[1051979824] linearizableReadLoop","detail":"{readStateIndex:1050; appliedIndex:1049; }","duration":"132.567272ms","start":"2026-04-14T07:30:08.006728Z","end":"2026-04-14T07:30:08.139295Z","steps":["trace[1051979824] 'read index received' (duration: 132.44897ms)","trace[1051979824] 'applied index is now lower than readState.Index' (duration: 117.712µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T07:30:08.139422Z","caller":"traceutil/trace.go:171","msg":"trace[1548479883] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"138.637896ms","start":"2026-04-14T07:30:08.000777Z","end":"2026-04-14T07:30:08.139415Z","steps":["trace[1548479883] 'process raft request' (duration: 138.409591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:30:08.139555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.748231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.118\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-14T07:30:08.139608Z","caller":"traceutil/trace.go:171","msg":"trace[192450751] range","detail":"{range_begin:/registry/masterleases/199.19.213.118; range_end:; response_count:1; response_revision:1012; }","duration":"131.821424ms","start":"2026-04-14T07:30:08.007774Z","end":"2026-04-14T07:30:08.139596Z","steps":["trace[192450751] 'agreement among raft nodes before linearized reading' (duration: 131.704221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T07:30:08.139723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.989093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T07:30:08.13975Z","caller":"traceutil/trace.go:171","msg":"trace[1083466826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1012; }","duration":"133.067665ms","start":"2026-04-14T07:30:08.006676Z","end":"2026-04-14T07:30:08.139744Z","steps":["trace[1083466826] 'agreement among raft nodes before linearized reading' (duration: 132.964363ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:30:08.268495Z","caller":"traceutil/trace.go:171","msg":"trace[1937447607] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"124.789637ms","start":"2026-04-14T07:30:08.143675Z","end":"2026-04-14T07:30:08.268465Z","steps":["trace[1937447607] 'process raft request' (duration: 122.741525ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:30:08.268833Z","caller":"traceutil/trace.go:171","msg":"trace[64457920] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"114.250623ms","start":"2026-04-14T07:30:08.154571Z","end":"2026-04-14T07:30:08.268822Z","steps":["trace[64457920] 'process raft request' (duration: 113.846823ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:30:46.563193Z","caller":"traceutil/trace.go:171","msg":"trace[829130535] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"152.626757ms","start":"2026-04-14T07:30:46.410538Z","end":"2026-04-14T07:30:46.563165Z","steps":["trace[829130535] 'process raft request' (duration: 152.490193ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:31:03.468006Z","caller":"traceutil/trace.go:171","msg":"trace[1507764966] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"182.151161ms","start":"2026-04-14T07:31:03.28582Z","end":"2026-04-14T07:31:03.467972Z","steps":["trace[1507764966] 'read index received' (duration: 123.672521ms)","trace[1507764966] 'applied index is now lower than readState.Index' (duration: 58.47692ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T07:31:03.468206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.375567ms","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-14T07:31:03.468264Z","caller":"traceutil/trace.go:171","msg":"trace[675948260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1280; }","duration":"182.484272ms","start":"2026-04-14T07:31:03.285766Z","end":"2026-04-14T07:31:03.46825Z","steps":["trace[675948260] 'agreement among raft nodes before linearized reading' (duration: 182.288296ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:31:04.827424Z","caller":"traceutil/trace.go:171","msg":"trace[638392182] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"146.545925ms","start":"2026-04-14T07:31:04.680841Z","end":"2026-04-14T07:31:04.827387Z","steps":["trace[638392182] 'process raft request' (duration: 144.984365ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T07:31:04.827453Z","caller":"traceutil/trace.go:171","msg":"trace[1537559193] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"146.236587ms","start":"2026-04-14T07:31:04.681193Z","end":"2026-04-14T07:31:04.82743Z","steps":["trace[1537559193] 'process raft request' (duration: 145.854457ms)"],"step_count":1}