{"level":"warn","ts":"2026-06-20T01:24:22.074867Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-20T01:24:22.075038Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238: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.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-20T01:24:22.075173Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-20T01:24:22.075228Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-06-20T01:24:22.075283Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-20T01:24:22.076257Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-06-20T01:24:22.076457Z","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.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-20T01:24:22.07931Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.442238ms"} {"level":"info","ts":"2026-06-20T01:24:22.084605Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-06-20T01:24:22.085788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-20T01:24:22.085845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-06-20T01:24:22.085858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-20T01:24:22.085875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-06-20T01:24:22.08592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-06-20T01:24:22.092607Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-20T01:24:22.094698Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-20T01:24:22.09592Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-20T01:24:22.09832Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-20T01:24:22.104301Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-20T01:24:22.106828Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-20T01:24:22.106982Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-06-20T01:24:22.107857Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-20T01:24:22.107911Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-20T01:24:22.107921Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-20T01:24:22.107176Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-06-20T01:24:22.108417Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-20T01:24:22.106902Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-20T01:24:22.109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-06-20T01:24:22.109108Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-06-20T01:24:22.486474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-20T01:24:22.486533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-20T01:24:22.486674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-06-20T01:24:22.486749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-06-20T01:24:22.486841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-06-20T01:24:22.48687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-06-20T01:24:22.486934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-06-20T01:24:22.487873Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-20T01:24:22.488028Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-20T01:24:22.488185Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T01:24:22.488163Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-20T01:24:22.489568Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T01:24:22.489802Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T01:24:22.49042Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-20T01:24:22.490493Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-20T01:24:22.491814Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-06-20T01:24:22.492748Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T01:24:22.492782Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-20T01:24:57.138726Z","caller":"traceutil/trace.go:171","msg":"trace[1773455786] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"327.796905ms","start":"2026-06-20T01:24:56.810888Z","end":"2026-06-20T01:24:57.138685Z","steps":["trace[1773455786] 'process raft request' (duration: 327.63242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:24:57.139221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:24:56.810867Z","time spent":"327.961789ms","remote":"127.0.0.1:47248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T01:24:57.149423Z","caller":"traceutil/trace.go:171","msg":"trace[2126084643] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"325.314846ms","start":"2026-06-20T01:24:56.824077Z","end":"2026-06-20T01:24:57.149392Z","steps":["trace[2126084643] 'process raft request' (duration: 325.045739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:24:57.149595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:24:56.824061Z","time spent":"325.442469ms","remote":"127.0.0.1:47248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T01:24:57.149794Z","caller":"traceutil/trace.go:171","msg":"trace[15585031] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"321.602474ms","start":"2026-06-20T01:24:56.828179Z","end":"2026-06-20T01:24:57.149782Z","steps":["trace[15585031] 'process raft request' (duration: 321.206323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:24:57.149844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:24:56.828173Z","time spent":"321.644855ms","remote":"127.0.0.1:47248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T01:24:57.14993Z","caller":"traceutil/trace.go:171","msg":"trace[617990582] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"325.797849ms","start":"2026-06-20T01:24:56.824124Z","end":"2026-06-20T01:24:57.149922Z","steps":["trace[617990582] 'process raft request' (duration: 325.161211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:24:57.149969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:24:56.824121Z","time spent":"325.828079ms","remote":"127.0.0.1:47248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T01:24:57.150041Z","caller":"traceutil/trace.go:171","msg":"trace[1103880690] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"322.90399ms","start":"2026-06-20T01:24:56.827128Z","end":"2026-06-20T01:24:57.150032Z","steps":["trace[1103880690] 'process raft request' (duration: 322.208891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:24:57.150081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:24:56.827123Z","time spent":"322.93696ms","remote":"127.0.0.1:47248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T01:24:57.150152Z","caller":"traceutil/trace.go:171","msg":"trace[557914540] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"313.531792ms","start":"2026-06-20T01:24:56.836611Z","end":"2026-06-20T01:24:57.150143Z","steps":["trace[557914540] 'process raft request' (duration: 313.034039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:24:57.1502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:24:56.836602Z","time spent":"313.579354ms","remote":"127.0.0.1:47248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T01:24:57.150285Z","caller":"traceutil/trace.go:171","msg":"trace[93934281] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"318.55919ms","start":"2026-06-20T01:24:56.831717Z","end":"2026-06-20T01:24:57.150276Z","steps":["trace[93934281] 'process raft request' (duration: 317.711858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:24:57.150331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:24:56.831711Z","time spent":"318.601872ms","remote":"127.0.0.1:47248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T01:24:57.150349Z","caller":"traceutil/trace.go:171","msg":"trace[1248469065] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"147.131126ms","start":"2026-06-20T01:24:57.0032Z","end":"2026-06-20T01:24:57.150331Z","steps":["trace[1248469065] 'process raft request' (duration: 146.989033ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:24:57.150415Z","caller":"traceutil/trace.go:171","msg":"trace[1027992288] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"316.183246ms","start":"2026-06-20T01:24:56.834212Z","end":"2026-06-20T01:24:57.150395Z","steps":["trace[1027992288] 'process raft request' (duration: 315.339762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:24:57.150459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:24:56.834202Z","time spent":"316.238957ms","remote":"127.0.0.1:47248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T01:24:57.150482Z","caller":"traceutil/trace.go:171","msg":"trace[1537596696] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"288.080462ms","start":"2026-06-20T01:24:56.862392Z","end":"2026-06-20T01:24:57.150472Z","steps":["trace[1537596696] 'process raft request' (duration: 287.329511ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:24:57.150556Z","caller":"traceutil/trace.go:171","msg":"trace[373009323] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"285.074739ms","start":"2026-06-20T01:24:56.865472Z","end":"2026-06-20T01:24:57.150547Z","steps":["trace[373009323] 'process raft request' (duration: 284.346699ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:24:57.15063Z","caller":"traceutil/trace.go:171","msg":"trace[1362737928] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"261.709177ms","start":"2026-06-20T01:24:56.888914Z","end":"2026-06-20T01:24:57.150623Z","steps":["trace[1362737928] 'process raft request' (duration: 261.074429ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:25:03.057206Z","caller":"traceutil/trace.go:171","msg":"trace[441543498] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"115.60609ms","start":"2026-06-20T01:25:02.941565Z","end":"2026-06-20T01:25:03.057171Z","steps":["trace[441543498] 'process raft request' (duration: 111.021103ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:25:03.30565Z","caller":"traceutil/trace.go:171","msg":"trace[1849965605] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"232.632727ms","start":"2026-06-20T01:25:03.072986Z","end":"2026-06-20T01:25:03.305618Z","steps":["trace[1849965605] 'process raft request' (duration: 232.453882ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:25:03.313104Z","caller":"traceutil/trace.go:171","msg":"trace[764271279] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"149.274845ms","start":"2026-06-20T01:25:03.1638Z","end":"2026-06-20T01:25:03.313075Z","steps":["trace[764271279] 'read index received' (duration: 141.736767ms)","trace[764271279] 'applied index is now lower than readState.Index' (duration: 7.537148ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T01:25:03.313352Z","caller":"traceutil/trace.go:171","msg":"trace[248207072] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"199.080214ms","start":"2026-06-20T01:25:03.114259Z","end":"2026-06-20T01:25:03.313339Z","steps":["trace[248207072] 'process raft request' (duration: 198.713004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:25:03.313585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.760957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T01:25:03.313634Z","caller":"traceutil/trace.go:171","msg":"trace[679231156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"149.866101ms","start":"2026-06-20T01:25:03.163757Z","end":"2026-06-20T01:25:03.313623Z","steps":["trace[679231156] 'agreement among raft nodes before linearized reading' (duration: 149.742458ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:25:04.014415Z","caller":"traceutil/trace.go:171","msg":"trace[301888010] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"265.091999ms","start":"2026-06-20T01:25:03.749304Z","end":"2026-06-20T01:25:04.014396Z","steps":["trace[301888010] 'process raft request' (duration: 264.643147ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:25:05.218051Z","caller":"traceutil/trace.go:171","msg":"trace[1222270827] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"135.695922ms","start":"2026-06-20T01:25:05.082332Z","end":"2026-06-20T01:25:05.218028Z","steps":["trace[1222270827] 'process raft request' (duration: 135.587709ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:25:05.220499Z","caller":"traceutil/trace.go:171","msg":"trace[609680796] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"136.942955ms","start":"2026-06-20T01:25:05.083541Z","end":"2026-06-20T01:25:05.220484Z","steps":["trace[609680796] 'process raft request' (duration: 136.913085ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:25:05.220687Z","caller":"traceutil/trace.go:171","msg":"trace[532710119] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"137.286016ms","start":"2026-06-20T01:25:05.083384Z","end":"2026-06-20T01:25:05.22067Z","steps":["trace[532710119] 'process raft request' (duration: 137.011938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:25:18.885063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.473529ms","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-06-20T01:25:18.885147Z","caller":"traceutil/trace.go:171","msg":"trace[259031284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:747; }","duration":"182.609292ms","start":"2026-06-20T01:25:18.702516Z","end":"2026-06-20T01:25:18.885126Z","steps":["trace[259031284] 'range keys from in-memory index tree' (duration: 182.314755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:25:18.885175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.294522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-20T01:25:18.885262Z","caller":"traceutil/trace.go:171","msg":"trace[1641124948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:747; }","duration":"255.432115ms","start":"2026-06-20T01:25:18.629811Z","end":"2026-06-20T01:25:18.885243Z","steps":["trace[1641124948] 'range keys from in-memory index tree' (duration: 255.135018ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:26:12.803774Z","caller":"traceutil/trace.go:171","msg":"trace[1290428204] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"213.41779ms","start":"2026-06-20T01:26:12.590321Z","end":"2026-06-20T01:26:12.803739Z","steps":["trace[1290428204] 'process raft request' (duration: 213.198744ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:26:13.899624Z","caller":"traceutil/trace.go:171","msg":"trace[1682061096] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"165.332077ms","start":"2026-06-20T01:26:13.734262Z","end":"2026-06-20T01:26:13.899595Z","steps":["trace[1682061096] 'process raft request' (duration: 165.152212ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:26:29.082512Z","caller":"traceutil/trace.go:171","msg":"trace[1305286580] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"119.975421ms","start":"2026-06-20T01:26:28.962512Z","end":"2026-06-20T01:26:29.082487Z","steps":["trace[1305286580] 'process raft request' (duration: 119.848675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:26:29.291797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.998005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T01:26:29.291885Z","caller":"traceutil/trace.go:171","msg":"trace[855167072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1138; }","duration":"128.139611ms","start":"2026-06-20T01:26:29.163725Z","end":"2026-06-20T01:26:29.291865Z","steps":["trace[855167072] 'range keys from in-memory index tree' (duration: 127.928973ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:26:47.732683Z","caller":"traceutil/trace.go:171","msg":"trace[1337372788] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"146.291495ms","start":"2026-06-20T01:26:47.586369Z","end":"2026-06-20T01:26:47.732661Z","steps":["trace[1337372788] 'process raft request' (duration: 146.100459ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:26:48.684492Z","caller":"traceutil/trace.go:171","msg":"trace[5032756] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"169.891762ms","start":"2026-06-20T01:26:48.514559Z","end":"2026-06-20T01:26:48.684451Z","steps":["trace[5032756] 'process raft request' (duration: 169.52186ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:26:49.674058Z","caller":"traceutil/trace.go:171","msg":"trace[785171186] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"168.161933ms","start":"2026-06-20T01:26:49.505872Z","end":"2026-06-20T01:26:49.674034Z","steps":["trace[785171186] 'process raft request' (duration: 158.744358ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:26:49.844804Z","caller":"traceutil/trace.go:171","msg":"trace[1406173565] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"102.473169ms","start":"2026-06-20T01:26:49.742289Z","end":"2026-06-20T01:26:49.844762Z","steps":["trace[1406173565] 'process raft request' (duration: 63.490675ms)","trace[1406173565] 'compare' (duration: 38.837669ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T01:26:58.799025Z","caller":"traceutil/trace.go:171","msg":"trace[675806285] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"199.329066ms","start":"2026-06-20T01:26:58.599669Z","end":"2026-06-20T01:26:58.798998Z","steps":["trace[675806285] 'process raft request' (duration: 199.099719ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:26:59.200632Z","caller":"traceutil/trace.go:171","msg":"trace[1629066601] linearizableReadLoop","detail":"{readStateIndex:1355; appliedIndex:1354; }","duration":"367.186184ms","start":"2026-06-20T01:26:58.833414Z","end":"2026-06-20T01:26:59.2006Z","steps":["trace[1629066601] 'read index received' (duration: 309.928282ms)","trace[1629066601] 'applied index is now lower than readState.Index' (duration: 57.256632ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T01:26:59.201102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.701517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T01:26:59.201307Z","caller":"traceutil/trace.go:171","msg":"trace[1852922279] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"479.60367ms","start":"2026-06-20T01:26:58.721637Z","end":"2026-06-20T01:26:59.201241Z","steps":["trace[1852922279] 'process raft request' (duration: 421.827374ms)","trace[1852922279] 'compare' (duration: 56.653764ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T01:26:59.201207Z","caller":"traceutil/trace.go:171","msg":"trace[740298975] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1298; }","duration":"367.863981ms","start":"2026-06-20T01:26:58.833317Z","end":"2026-06-20T01:26:59.201181Z","steps":["trace[740298975] 'agreement among raft nodes before linearized reading' (duration: 367.672726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:26:59.201831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:26:58.833296Z","time spent":"368.490179ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-06-20T01:26:59.201992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:26:58.721601Z","time spent":"479.889136ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T01:29:14.977088Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533189791700769,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T01:29:15.478011Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533189791700769,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T01:29:15.978685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533189791700769,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T01:29:16.111985Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.81539071s","expected-duration":"1s"} {"level":"info","ts":"2026-06-20T01:29:16.112585Z","caller":"traceutil/trace.go:171","msg":"trace[1177727315] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"1.816059945s","start":"2026-06-20T01:29:14.296501Z","end":"2026-06-20T01:29:16.112561Z","steps":["trace[1177727315] 'process raft request' (duration: 1.815921801s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.112769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:14.296485Z","time spent":"1.816203679s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T01:29:16.115916Z","caller":"traceutil/trace.go:171","msg":"trace[839460793] linearizableReadLoop","detail":"{readStateIndex:2004; appliedIndex:2002; }","duration":"1.782487336s","start":"2026-06-20T01:29:14.333415Z","end":"2026-06-20T01:29:16.115902Z","steps":["trace[839460793] 'read index received' (duration: 1.779014916s)","trace[839460793] 'applied index is now lower than readState.Index' (duration: 3.47169ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T01:29:16.116125Z","caller":"traceutil/trace.go:171","msg":"trace[712476242] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"300.327334ms","start":"2026-06-20T01:29:15.815767Z","end":"2026-06-20T01:29:16.116095Z","steps":["trace[712476242] 'process raft request' (duration: 300.078809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.782721941s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-20T01:29:16.1162Z","caller":"traceutil/trace.go:171","msg":"trace[182604583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1920; }","duration":"1.782799572s","start":"2026-06-20T01:29:14.333387Z","end":"2026-06-20T01:29:16.116186Z","steps":["trace[182604583] 'agreement among raft nodes before linearized reading' (duration: 1.782639699s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:14.333373Z","time spent":"1.782851844s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-20T01:29:16.116268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:15.81575Z","time spent":"300.431816ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T01:29:16.116275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.583754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T01:29:16.116307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139308084s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-20T01:29:16.116385Z","caller":"traceutil/trace.go:171","msg":"trace[1793680621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1920; }","duration":"1.139443778s","start":"2026-06-20T01:29:14.976927Z","end":"2026-06-20T01:29:16.11637Z","steps":["trace[1793680621] 'agreement among raft nodes before linearized reading' (duration: 1.139234843s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:14.97691Z","time spent":"1.139501058s","remote":"127.0.0.1:47496","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-06-20T01:29:16.116427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.781249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T01:29:16.116454Z","caller":"traceutil/trace.go:171","msg":"trace[1528689547] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1920; }","duration":"458.835951ms","start":"2026-06-20T01:29:15.65761Z","end":"2026-06-20T01:29:16.116446Z","steps":["trace[1528689547] 'agreement among raft nodes before linearized reading' (duration: 458.793539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:15.657593Z","time spent":"458.871831ms","remote":"127.0.0.1:33018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-06-20T01:29:16.116364Z","caller":"traceutil/trace.go:171","msg":"trace[2090063521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1920; }","duration":"805.718819ms","start":"2026-06-20T01:29:15.310633Z","end":"2026-06-20T01:29:16.116352Z","steps":["trace[2090063521] 'agreement among raft nodes before linearized reading' (duration: 805.567895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:15.31062Z","time spent":"805.921243ms","remote":"127.0.0.1:47222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T01:29:16.11662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.928116ms","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-06-20T01:29:16.116627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.693117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-06-20T01:29:16.116658Z","caller":"traceutil/trace.go:171","msg":"trace[1573660826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1920; }","duration":"269.994318ms","start":"2026-06-20T01:29:15.846654Z","end":"2026-06-20T01:29:16.116648Z","steps":["trace[1573660826] 'agreement among raft nodes before linearized reading' (duration: 269.891876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.484616ms","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":"info","ts":"2026-06-20T01:29:16.116705Z","caller":"traceutil/trace.go:171","msg":"trace[154749798] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1920; }","duration":"810.521136ms","start":"2026-06-20T01:29:15.306179Z","end":"2026-06-20T01:29:16.1167Z","steps":["trace[154749798] 'agreement among raft nodes before linearized reading' (duration: 810.464865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:15.306176Z","time spent":"810.547296ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-20T01:29:16.116791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.613148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-20T01:29:16.116818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.6652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-06-20T01:29:16.116822Z","caller":"traceutil/trace.go:171","msg":"trace[89157766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1920; }","duration":"810.650889ms","start":"2026-06-20T01:29:15.306164Z","end":"2026-06-20T01:29:16.116815Z","steps":["trace[89157766] 'agreement among raft nodes before linearized reading' (duration: 810.556536ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:29:16.116662Z","caller":"traceutil/trace.go:171","msg":"trace[1111300168] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1920; }","duration":"679.768249ms","start":"2026-06-20T01:29:15.436884Z","end":"2026-06-20T01:29:16.116652Z","steps":["trace[1111300168] 'agreement among raft nodes before linearized reading' (duration: 679.645706ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:29:16.116835Z","caller":"traceutil/trace.go:171","msg":"trace[374351645] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1920; }","duration":"810.706521ms","start":"2026-06-20T01:29:15.306124Z","end":"2026-06-20T01:29:16.11683Z","steps":["trace[374351645] 'agreement among raft nodes before linearized reading' (duration: 810.66001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:15.306161Z","time spent":"810.68047ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-20T01:29:16.116853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:15.306109Z","time spent":"810.740581ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-20T01:29:16.116861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:15.436863Z","time spent":"679.986473ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-20T01:29:16.116632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.302501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-20T01:29:16.116956Z","caller":"traceutil/trace.go:171","msg":"trace[1259383204] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:1920; }","duration":"810.659319ms","start":"2026-06-20T01:29:15.306287Z","end":"2026-06-20T01:29:16.116946Z","steps":["trace[1259383204] 'agreement among raft nodes before linearized reading' (duration: 810.305622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:16.116983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:15.306253Z","time spent":"810.723221ms","remote":"127.0.0.1:47236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.238\" "} {"level":"warn","ts":"2026-06-20T01:29:18.628252Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533189791700798,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T01:29:19.128412Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533189791700798,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T01:29:19.452047Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.329435376s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-20T01:29:19.453885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.337385456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-20T01:29:19.453945Z","caller":"traceutil/trace.go:171","msg":"trace[75874518] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1930; }","duration":"1.337485388s","start":"2026-06-20T01:29:18.116447Z","end":"2026-06-20T01:29:19.453933Z","steps":["trace[75874518] 'range keys from in-memory index tree' (duration: 1.337268923s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:19.454006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:18.116431Z","time spent":"1.337567109s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-20T01:29:19.454768Z","caller":"traceutil/trace.go:171","msg":"trace[1196065836] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"1.332219839s","start":"2026-06-20T01:29:18.12251Z","end":"2026-06-20T01:29:19.45473Z","steps":["trace[1196065836] 'process raft request' (duration: 1.329718872s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:19.454933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:18.122486Z","time spent":"1.332349953s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T01:29:19.455038Z","caller":"traceutil/trace.go:171","msg":"trace[1217309291] linearizableReadLoop","detail":"{readStateIndex:2016; appliedIndex:2015; }","duration":"1.327575813s","start":"2026-06-20T01:29:18.12744Z","end":"2026-06-20T01:29:19.455016Z","steps":["trace[1217309291] 'read index received' (duration: 1.32480087s)","trace[1217309291] 'applied index is now lower than readState.Index' (duration: 2.772573ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T01:29:19.455651Z","caller":"traceutil/trace.go:171","msg":"trace[1063108035] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"176.79298ms","start":"2026-06-20T01:29:19.278846Z","end":"2026-06-20T01:29:19.455639Z","steps":["trace[1063108035] 'process raft request' (duration: 176.715958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:19.456041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.328601398s","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-06-20T01:29:19.456079Z","caller":"traceutil/trace.go:171","msg":"trace[1788727301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1932; }","duration":"1.328660528s","start":"2026-06-20T01:29:18.127411Z","end":"2026-06-20T01:29:19.456071Z","steps":["trace[1788727301] 'agreement among raft nodes before linearized reading' (duration: 1.328563876s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:19.456878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.328691159s","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":"info","ts":"2026-06-20T01:29:19.456947Z","caller":"traceutil/trace.go:171","msg":"trace[1304756668] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1932; }","duration":"1.328772441s","start":"2026-06-20T01:29:18.128159Z","end":"2026-06-20T01:29:19.456931Z","steps":["trace[1304756668] 'agreement among raft nodes before linearized reading' (duration: 1.328583636s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:19.456995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:18.128154Z","time spent":"1.328825231s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-20T01:29:19.457015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:18.127401Z","time spent":"1.32960301s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-20T01:29:19.457128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326095491s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-20T01:29:19.457148Z","caller":"traceutil/trace.go:171","msg":"trace[618149821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1932; }","duration":"1.326124751s","start":"2026-06-20T01:29:18.131017Z","end":"2026-06-20T01:29:19.457141Z","steps":["trace[618149821] 'agreement among raft nodes before linearized reading' (duration: 1.32606493s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:19.457168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:18.131011Z","time spent":"1.326152922s","remote":"127.0.0.1:47496","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-06-20T01:29:19.457254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.327629545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-20T01:29:19.457297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.306437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T01:29:19.457305Z","caller":"traceutil/trace.go:171","msg":"trace[1526469952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1932; }","duration":"1.327702836s","start":"2026-06-20T01:29:18.129589Z","end":"2026-06-20T01:29:19.457292Z","steps":["trace[1526469952] 'agreement among raft nodes before linearized reading' (duration: 1.327584764s)"],"step_count":1} {"level":"info","ts":"2026-06-20T01:29:19.457319Z","caller":"traceutil/trace.go:171","msg":"trace[197173290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1932; }","duration":"294.356049ms","start":"2026-06-20T01:29:19.162957Z","end":"2026-06-20T01:29:19.457313Z","steps":["trace[197173290] 'agreement among raft nodes before linearized reading' (duration: 294.322238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:19.457345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:18.129574Z","time spent":"1.327761408s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-20T01:29:19.457611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.328055225s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-20T01:29:19.45766Z","caller":"traceutil/trace.go:171","msg":"trace[1680159099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1932; }","duration":"1.328111746s","start":"2026-06-20T01:29:18.129536Z","end":"2026-06-20T01:29:19.457648Z","steps":["trace[1680159099] 'agreement among raft nodes before linearized reading' (duration: 1.327995264s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T01:29:19.45772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T01:29:18.129532Z","time spent":"1.328179147s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}