{"level":"warn","ts":"2026-02-26T01:35:37.745415Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T01:35:37.745511Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-02-26T01:35:37.745576Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T01:35:37.745583Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-02-26T01:35:37.745598Z","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-02-26T01:35:37.746256Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]} {"level":"info","ts":"2026-02-26T01:35:37.746325Z","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.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-02-26T01:35:37.753615Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.094691ms"} {"level":"info","ts":"2026-02-26T01:35:37.770493Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"} {"level":"info","ts":"2026-02-26T01:35:37.770577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T01:35:37.770598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"} {"level":"info","ts":"2026-02-26T01:35:37.770615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T01:35:37.770622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"} {"level":"info","ts":"2026-02-26T01:35:37.77065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"warn","ts":"2026-02-26T01:35:37.776426Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T01:35:37.778067Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T01:35:37.779771Z","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-02-26T01:35:37.78148Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T01:35:37.782564Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T01:35:37.784827Z","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-02-26T01:35:37.784918Z","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-02-26T01:35:37.784931Z","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-02-26T01:35:37.785363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"info","ts":"2026-02-26T01:35:37.789251Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-02-26T01:35:37.790453Z","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-02-26T01:35:37.79086Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T01:35:37.790905Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T01:35:37.791283Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-02-26T01:35:37.791308Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-02-26T01:35:38.271512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T01:35:38.27158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T01:35:38.271606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"} {"level":"info","ts":"2026-02-26T01:35:38.27162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"} {"level":"info","ts":"2026-02-26T01:35:38.271626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-02-26T01:35:38.271635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"} {"level":"info","ts":"2026-02-26T01:35:38.271642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-02-26T01:35:38.274067Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T01:35:38.274316Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T01:35:38.274528Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T01:35:38.274625Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T01:35:38.277223Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"} {"level":"info","ts":"2026-02-26T01:35:38.277624Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T01:35:38.277673Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T01:35:38.278661Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T01:35:38.285496Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T01:35:38.285632Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T01:35:38.285674Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T01:35:39.811374Z","caller":"traceutil/trace.go:171","msg":"trace[586555222] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"101.24116ms","start":"2026-02-26T01:35:39.7101Z","end":"2026-02-26T01:35:39.811341Z","steps":["trace[586555222] 'process raft request' (duration: 80.879438ms)","trace[586555222] 'compare' (duration: 20.157337ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T01:35:39.812448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.428052ms","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":"info","ts":"2026-02-26T01:35:39.812603Z","caller":"traceutil/trace.go:171","msg":"trace[1118302274] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:15; }","duration":"106.003813ms","start":"2026-02-26T01:35:39.706561Z","end":"2026-02-26T01:35:39.812565Z","steps":["trace[1118302274] 'agreement among raft nodes before linearized reading' (duration: 105.071595ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:35:56.86147Z","caller":"traceutil/trace.go:171","msg":"trace[71250188] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"168.282652ms","start":"2026-02-26T01:35:56.693169Z","end":"2026-02-26T01:35:56.861452Z","steps":["trace[71250188] 'process raft request' (duration: 168.16105ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:35:57.396976Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142197943461555604,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T01:35:57.502516Z","caller":"traceutil/trace.go:171","msg":"trace[1982053091] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"606.078138ms","start":"2026-02-26T01:35:56.896413Z","end":"2026-02-26T01:35:57.502491Z","steps":["trace[1982053091] 'read index received' (duration: 551.46958ms)","trace[1982053091] 'applied index is now lower than readState.Index' (duration: 54.607238ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T01:35:57.502683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.237551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T01:35:57.502723Z","caller":"traceutil/trace.go:171","msg":"trace[682822290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:410; }","duration":"606.305653ms","start":"2026-02-26T01:35:56.896406Z","end":"2026-02-26T01:35:57.502711Z","steps":["trace[682822290] 'agreement among raft nodes before linearized reading' (duration: 606.211411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:35:57.502758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:35:56.89634Z","time spent":"606.410304ms","remote":"127.0.0.1:52124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T01:35:57.502805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.618498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T01:35:57.502885Z","caller":"traceutil/trace.go:171","msg":"trace[1934163709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:410; }","duration":"489.765901ms","start":"2026-02-26T01:35:57.013096Z","end":"2026-02-26T01:35:57.502862Z","steps":["trace[1934163709] 'agreement among raft nodes before linearized reading' (duration: 489.598447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:35:57.50293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:35:57.013081Z","time spent":"489.841313ms","remote":"127.0.0.1:52134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T01:35:57.503152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.172552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-26T01:35:57.503187Z","caller":"traceutil/trace.go:171","msg":"trace[379908512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:410; }","duration":"125.241843ms","start":"2026-02-26T01:35:57.377936Z","end":"2026-02-26T01:35:57.503178Z","steps":["trace[379908512] 'agreement among raft nodes before linearized reading' (duration: 125.168591ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:35:57.70175Z","caller":"traceutil/trace.go:171","msg":"trace[1401365467] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"194.610173ms","start":"2026-02-26T01:35:57.507104Z","end":"2026-02-26T01:35:57.701714Z","steps":["trace[1401365467] 'process raft request' (duration: 194.46124ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:14.660115Z","caller":"traceutil/trace.go:171","msg":"trace[617079800] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"293.387263ms","start":"2026-02-26T01:36:14.366709Z","end":"2026-02-26T01:36:14.660096Z","steps":["trace[617079800] 'process raft request' (duration: 293.25775ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:16.06157Z","caller":"traceutil/trace.go:171","msg":"trace[1811470240] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"243.741263ms","start":"2026-02-26T01:36:15.817793Z","end":"2026-02-26T01:36:16.061535Z","steps":["trace[1811470240] 'process raft request' (duration: 239.137341ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:21.52107Z","caller":"traceutil/trace.go:171","msg":"trace[1004654317] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"111.89014ms","start":"2026-02-26T01:36:21.409139Z","end":"2026-02-26T01:36:21.521029Z","steps":["trace[1004654317] 'process raft request' (duration: 111.764007ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:21.596823Z","caller":"traceutil/trace.go:171","msg":"trace[248974974] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"176.526126ms","start":"2026-02-26T01:36:21.420269Z","end":"2026-02-26T01:36:21.596795Z","steps":["trace[248974974] 'process raft request' (duration: 176.382473ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:26.406492Z","caller":"traceutil/trace.go:171","msg":"trace[1374699567] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"226.677676ms","start":"2026-02-26T01:36:26.179754Z","end":"2026-02-26T01:36:26.406432Z","steps":["trace[1374699567] 'process raft request' (duration: 223.492422ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:29.098894Z","caller":"traceutil/trace.go:171","msg":"trace[1522030116] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"107.218508ms","start":"2026-02-26T01:36:28.991656Z","end":"2026-02-26T01:36:29.098874Z","steps":["trace[1522030116] 'process raft request' (duration: 106.918282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:36:29.664782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.058733ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T01:36:29.664887Z","caller":"traceutil/trace.go:171","msg":"trace[115581195] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"216.154958ms","start":"2026-02-26T01:36:29.448717Z","end":"2026-02-26T01:36:29.664872Z","steps":["trace[115581195] 'process raft request' (duration: 63.576214ms)","trace[115581195] 'compare' (duration: 151.94029ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:36:29.671645Z","caller":"traceutil/trace.go:171","msg":"trace[21615156] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"137.944094ms","start":"2026-02-26T01:36:29.533683Z","end":"2026-02-26T01:36:29.671627Z","steps":["trace[21615156] 'process raft request' (duration: 137.868402ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:29.809316Z","caller":"traceutil/trace.go:171","msg":"trace[1539304050] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"134.150949ms","start":"2026-02-26T01:36:29.675117Z","end":"2026-02-26T01:36:29.809268Z","steps":["trace[1539304050] 'process raft request' (duration: 132.720851ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:30.514212Z","caller":"traceutil/trace.go:171","msg":"trace[1213320250] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"118.848358ms","start":"2026-02-26T01:36:30.395332Z","end":"2026-02-26T01:36:30.51418Z","steps":["trace[1213320250] 'process raft request' (duration: 101.574047ms)","trace[1213320250] 'compare' (duration: 17.085827ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:36:35.340478Z","caller":"traceutil/trace.go:171","msg":"trace[1627072901] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"328.010991ms","start":"2026-02-26T01:36:35.012441Z","end":"2026-02-26T01:36:35.340452Z","steps":["trace[1627072901] 'read index received' (duration: 327.805397ms)","trace[1627072901] 'applied index is now lower than readState.Index' (duration: 204.684µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:36:35.34059Z","caller":"traceutil/trace.go:171","msg":"trace[1003944641] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"333.48391ms","start":"2026-02-26T01:36:35.007075Z","end":"2026-02-26T01:36:35.340559Z","steps":["trace[1003944641] 'process raft request' (duration: 333.225455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:36:35.340654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.177534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T01:36:35.340694Z","caller":"traceutil/trace.go:171","msg":"trace[2118300238] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:633; }","duration":"328.257555ms","start":"2026-02-26T01:36:35.012425Z","end":"2026-02-26T01:36:35.340682Z","steps":["trace[2118300238] 'agreement among raft nodes before linearized reading' (duration: 328.167433ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:36:35.340715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:36:35.007058Z","time spent":"333.591072ms","remote":"127.0.0.1:49046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2318,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T01:36:35.340733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:36:35.012417Z","time spent":"328.306496ms","remote":"127.0.0.1:49094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 "} {"level":"warn","ts":"2026-02-26T01:36:35.340711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.187904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T01:36:35.340764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.175854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T01:36:35.340795Z","caller":"traceutil/trace.go:171","msg":"trace[138909101] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:633; }","duration":"328.284356ms","start":"2026-02-26T01:36:35.012487Z","end":"2026-02-26T01:36:35.340771Z","steps":["trace[138909101] 'agreement among raft nodes before linearized reading' (duration: 328.140993ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:35.340831Z","caller":"traceutil/trace.go:171","msg":"trace[1848247972] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:633; }","duration":"328.253306ms","start":"2026-02-26T01:36:35.012556Z","end":"2026-02-26T01:36:35.34081Z","steps":["trace[1848247972] 'agreement among raft nodes before linearized reading' (duration: 328.147834ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:36:35.340844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:36:35.012462Z","time spent":"328.371448ms","remote":"127.0.0.1:49094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-02-26T01:36:35.340875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:36:35.012552Z","time spent":"328.312327ms","remote":"127.0.0.1:49094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 "} {"level":"warn","ts":"2026-02-26T01:36:35.341049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.786676ms","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-02-26T01:36:35.341197Z","caller":"traceutil/trace.go:171","msg":"trace[1501430533] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"199.049401ms","start":"2026-02-26T01:36:35.142107Z","end":"2026-02-26T01:36:35.341156Z","steps":["trace[1501430533] 'agreement among raft nodes before linearized reading' (duration: 198.569072ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:35.546426Z","caller":"traceutil/trace.go:171","msg":"trace[229875142] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"201.306826ms","start":"2026-02-26T01:36:35.345088Z","end":"2026-02-26T01:36:35.546394Z","steps":["trace[229875142] 'process raft request' (duration: 188.308969ms)","trace[229875142] 'compare' (duration: 12.61955ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:36:45.703698Z","caller":"traceutil/trace.go:171","msg":"trace[739650120] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"114.409601ms","start":"2026-02-26T01:36:45.589265Z","end":"2026-02-26T01:36:45.703675Z","steps":["trace[739650120] 'process raft request' (duration: 114.269669ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:46.518367Z","caller":"traceutil/trace.go:171","msg":"trace[57820904] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"162.600248ms","start":"2026-02-26T01:36:46.355394Z","end":"2026-02-26T01:36:46.517994Z","steps":["trace[57820904] 'process raft request' (duration: 162.397064ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:46.558513Z","caller":"traceutil/trace.go:171","msg":"trace[851598864] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"203.040601ms","start":"2026-02-26T01:36:46.355442Z","end":"2026-02-26T01:36:46.558483Z","steps":["trace[851598864] 'process raft request' (duration: 202.881468ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:49.054054Z","caller":"traceutil/trace.go:171","msg":"trace[1429457963] linearizableReadLoop","detail":"{readStateIndex:747; appliedIndex:746; }","duration":"390.151755ms","start":"2026-02-26T01:36:48.663876Z","end":"2026-02-26T01:36:49.054028Z","steps":["trace[1429457963] 'read index received' (duration: 389.92203ms)","trace[1429457963] 'applied index is now lower than readState.Index' (duration: 228.855µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:36:49.054092Z","caller":"traceutil/trace.go:171","msg":"trace[4561011] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"394.779277ms","start":"2026-02-26T01:36:48.65928Z","end":"2026-02-26T01:36:49.054059Z","steps":["trace[4561011] 'process raft request' (duration: 394.569242ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:36:49.054239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.356829ms","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":"warn","ts":"2026-02-26T01:36:49.054247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:36:48.659243Z","time spent":"394.94123ms","remote":"127.0.0.1:52420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T01:36:49.054276Z","caller":"traceutil/trace.go:171","msg":"trace[1143068861] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:718; }","duration":"390.43218ms","start":"2026-02-26T01:36:48.663836Z","end":"2026-02-26T01:36:49.054268Z","steps":["trace[1143068861] 'agreement among raft nodes before linearized reading' (duration: 390.289327ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:36:49.054302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:36:48.66382Z","time spent":"390.477101ms","remote":"127.0.0.1:52420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-26T01:36:49.168578Z","caller":"traceutil/trace.go:171","msg":"trace[574882479] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"110.868161ms","start":"2026-02-26T01:36:49.057684Z","end":"2026-02-26T01:36:49.168552Z","steps":["trace[574882479] 'process raft request' (duration: 108.994374ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:49.982273Z","caller":"traceutil/trace.go:171","msg":"trace[2141870163] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"259.720795ms","start":"2026-02-26T01:36:49.722524Z","end":"2026-02-26T01:36:49.982244Z","steps":["trace[2141870163] 'process raft request' (duration: 245.029993ms)","trace[2141870163] 'compare' (duration: 14.580529ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:36:50.782558Z","caller":"traceutil/trace.go:171","msg":"trace[1487879635] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"160.245231ms","start":"2026-02-26T01:36:50.622292Z","end":"2026-02-26T01:36:50.782537Z","steps":["trace[1487879635] 'process raft request' (duration: 160.158039ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:50.782787Z","caller":"traceutil/trace.go:171","msg":"trace[872373810] transaction","detail":"{read_only:false; number_of_response:1; response_revision:725; }","duration":"163.277681ms","start":"2026-02-26T01:36:50.6195Z","end":"2026-02-26T01:36:50.782778Z","steps":["trace[872373810] 'process raft request' (duration: 155.454445ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:36:50.782757Z","caller":"traceutil/trace.go:171","msg":"trace[61543204] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"159.743031ms","start":"2026-02-26T01:36:50.622988Z","end":"2026-02-26T01:36:50.782731Z","steps":["trace[61543204] 'process raft request' (duration: 159.503926ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:37:03.557445Z","caller":"traceutil/trace.go:171","msg":"trace[232282912] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"319.084784ms","start":"2026-02-26T01:37:03.238308Z","end":"2026-02-26T01:37:03.557392Z","steps":["trace[232282912] 'process raft request' (duration: 318.861399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:03.557634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:37:03.238285Z","time spent":"319.256147ms","remote":"127.0.0.1:52420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T01:37:17.64503Z","caller":"traceutil/trace.go:171","msg":"trace[1029583086] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"384.220857ms","start":"2026-02-26T01:37:17.260779Z","end":"2026-02-26T01:37:17.645Z","steps":["trace[1029583086] 'process raft request' (duration: 384.052853ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:17.645234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:37:17.26076Z","time spent":"384.353669ms","remote":"127.0.0.1:52420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T01:37:17.982497Z","caller":"traceutil/trace.go:171","msg":"trace[563789706] linearizableReadLoop","detail":"{readStateIndex:890; appliedIndex:889; }","duration":"129.248507ms","start":"2026-02-26T01:37:17.853224Z","end":"2026-02-26T01:37:17.982472Z","steps":["trace[563789706] 'read index received' (duration: 129.043032ms)","trace[563789706] 'applied index is now lower than readState.Index' (duration: 204.005µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:37:17.982605Z","caller":"traceutil/trace.go:171","msg":"trace[1525028468] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"333.671035ms","start":"2026-02-26T01:37:17.648901Z","end":"2026-02-26T01:37:17.982572Z","steps":["trace[1525028468] 'process raft request' (duration: 333.430359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:17.982634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.377929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T01:37:17.982687Z","caller":"traceutil/trace.go:171","msg":"trace[250537133] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:854; }","duration":"129.487441ms","start":"2026-02-26T01:37:17.853185Z","end":"2026-02-26T01:37:17.982673Z","steps":["trace[250537133] 'agreement among raft nodes before linearized reading' (duration: 129.386369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:17.982758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:37:17.648882Z","time spent":"333.795987ms","remote":"127.0.0.1:52420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T01:37:32.783586Z","caller":"traceutil/trace.go:171","msg":"trace[237325334] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"371.652268ms","start":"2026-02-26T01:37:32.411914Z","end":"2026-02-26T01:37:32.783566Z","steps":["trace[237325334] 'process raft request' (duration: 371.514246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:32.783706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:37:32.411904Z","time spent":"371.73896ms","remote":"127.0.0.1:52336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5310,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T01:37:33.20081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.450778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T01:37:33.200901Z","caller":"traceutil/trace.go:171","msg":"trace[780852293] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:953; }","duration":"189.380439ms","start":"2026-02-26T01:37:33.011506Z","end":"2026-02-26T01:37:33.200886Z","steps":["trace[780852293] 'read index received' (duration: 48.723697ms)","trace[780852293] 'applied index is now lower than readState.Index' (duration: 140.655792ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:37:33.200911Z","caller":"traceutil/trace.go:171","msg":"trace[1114140245] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"409.6119ms","start":"2026-02-26T01:37:32.791278Z","end":"2026-02-26T01:37:33.20089Z","steps":["trace[1114140245] 'process raft request' (duration: 269.004519ms)","trace[1114140245] 'compare' (duration: 140.325326ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T01:37:33.200995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.492312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T01:37:33.201023Z","caller":"traceutil/trace.go:171","msg":"trace[2039286817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:915; }","duration":"189.544383ms","start":"2026-02-26T01:37:33.011469Z","end":"2026-02-26T01:37:33.201013Z","steps":["trace[2039286817] 'agreement among raft nodes before linearized reading' (duration: 189.497052ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:33.201029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:37:32.791264Z","time spent":"409.699413ms","remote":"127.0.0.1:52546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":797,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T01:37:33.201243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.777452ms","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-02-26T01:37:33.201392Z","caller":"traceutil/trace.go:171","msg":"trace[118905198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:915; }","duration":"152.961416ms","start":"2026-02-26T01:37:33.048413Z","end":"2026-02-26T01:37:33.201374Z","steps":["trace[118905198] 'agreement among raft nodes before linearized reading' (duration: 152.697051ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:33.201243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.683772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-26T01:37:33.201606Z","caller":"traceutil/trace.go:171","msg":"trace[1268380271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:915; }","duration":"142.06422ms","start":"2026-02-26T01:37:33.059525Z","end":"2026-02-26T01:37:33.20159Z","steps":["trace[1268380271] 'agreement among raft nodes before linearized reading' (duration: 141.589131ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:37:33.416808Z","caller":"traceutil/trace.go:171","msg":"trace[979476308] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"206.009259ms","start":"2026-02-26T01:37:33.210775Z","end":"2026-02-26T01:37:33.416784Z","steps":["trace[979476308] 'process raft request' (duration: 192.685864ms)","trace[979476308] 'compare' (duration: 13.221353ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:37:33.455018Z","caller":"traceutil/trace.go:171","msg":"trace[1628408823] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"243.505033ms","start":"2026-02-26T01:37:33.211483Z","end":"2026-02-26T01:37:33.454988Z","steps":["trace[1628408823] 'process raft request' (duration: 243.34419ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:37:34.33527Z","caller":"traceutil/trace.go:171","msg":"trace[2102552974] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"234.981804ms","start":"2026-02-26T01:37:34.100262Z","end":"2026-02-26T01:37:34.335243Z","steps":["trace[2102552974] 'process raft request' (duration: 234.848252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:34.647107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.36111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T01:37:34.647177Z","caller":"traceutil/trace.go:171","msg":"trace[1913376994] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:958; }","duration":"233.21287ms","start":"2026-02-26T01:37:34.413954Z","end":"2026-02-26T01:37:34.647167Z","steps":["trace[1913376994] 'read index received' (duration: 118.567134ms)","trace[1913376994] 'applied index is now lower than readState.Index' (duration: 114.644846ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T01:37:34.647233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.278211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T01:37:34.647249Z","caller":"traceutil/trace.go:171","msg":"trace[1601756696] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:920; }","duration":"233.319741ms","start":"2026-02-26T01:37:34.413922Z","end":"2026-02-26T01:37:34.647242Z","steps":["trace[1601756696] 'agreement among raft nodes before linearized reading' (duration: 233.27134ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:37:34.647287Z","caller":"traceutil/trace.go:171","msg":"trace[2010046528] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"278.397706ms","start":"2026-02-26T01:37:34.368838Z","end":"2026-02-26T01:37:34.647235Z","steps":["trace[2010046528] 'process raft request' (duration: 163.638758ms)","trace[2010046528] 'compare' (duration: 114.243658ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:37:35.611806Z","caller":"traceutil/trace.go:171","msg":"trace[1139451741] linearizableReadLoop","detail":"{readStateIndex:961; appliedIndex:960; }","duration":"192.033392ms","start":"2026-02-26T01:37:35.41975Z","end":"2026-02-26T01:37:35.611783Z","steps":["trace[1139451741] 'read index received' (duration: 191.845678ms)","trace[1139451741] 'applied index is now lower than readState.Index' (duration: 187.034µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:37:35.611896Z","caller":"traceutil/trace.go:171","msg":"trace[1261391885] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"286.375116ms","start":"2026-02-26T01:37:35.325481Z","end":"2026-02-26T01:37:35.611857Z","steps":["trace[1261391885] 'process raft request' (duration: 286.165091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:35.612032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.271587ms","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-02-26T01:37:35.612068Z","caller":"traceutil/trace.go:171","msg":"trace[1123184594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:922; }","duration":"192.352349ms","start":"2026-02-26T01:37:35.419704Z","end":"2026-02-26T01:37:35.612057Z","steps":["trace[1123184594] 'agreement among raft nodes before linearized reading' (duration: 192.208656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:35.612229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.890626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-26T01:37:35.612263Z","caller":"traceutil/trace.go:171","msg":"trace[987814430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:922; }","duration":"152.951716ms","start":"2026-02-26T01:37:35.459305Z","end":"2026-02-26T01:37:35.612257Z","steps":["trace[987814430] 'agreement among raft nodes before linearized reading' (duration: 152.861005ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:37:35.883207Z","caller":"traceutil/trace.go:171","msg":"trace[1195283748] linearizableReadLoop","detail":"{readStateIndex:964; appliedIndex:962; }","duration":"180.483194ms","start":"2026-02-26T01:37:35.7027Z","end":"2026-02-26T01:37:35.883183Z","steps":["trace[1195283748] 'read index received' (duration: 173.528535ms)","trace[1195283748] 'applied index is now lower than readState.Index' (duration: 6.953669ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:37:35.88346Z","caller":"traceutil/trace.go:171","msg":"trace[1235515687] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"263.680964ms","start":"2026-02-26T01:37:35.619764Z","end":"2026-02-26T01:37:35.883445Z","steps":["trace[1235515687] 'process raft request' (duration: 256.584482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:35.883525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.79997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T01:37:35.883606Z","caller":"traceutil/trace.go:171","msg":"trace[425751035] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:925; }","duration":"180.914741ms","start":"2026-02-26T01:37:35.70267Z","end":"2026-02-26T01:37:35.883585Z","steps":["trace[425751035] 'agreement among raft nodes before linearized reading' (duration: 180.720718ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:37:35.88355Z","caller":"traceutil/trace.go:171","msg":"trace[987677991] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"263.49764ms","start":"2026-02-26T01:37:35.61996Z","end":"2026-02-26T01:37:35.883457Z","steps":["trace[987677991] 'process raft request' (duration: 263.152203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:36.091666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.577276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T01:37:36.091956Z","caller":"traceutil/trace.go:171","msg":"trace[504975517] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"140.304205ms","start":"2026-02-26T01:37:35.951593Z","end":"2026-02-26T01:37:36.091897Z","steps":["trace[504975517] 'process raft request' (duration: 38.404003ms)","trace[504975517] 'compare' (duration: 101.416092ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:37:36.092028Z","caller":"traceutil/trace.go:171","msg":"trace[1108251818] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"134.884557ms","start":"2026-02-26T01:37:35.957113Z","end":"2026-02-26T01:37:36.091997Z","steps":["trace[1108251818] 'process raft request' (duration: 134.732044ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:37:36.092164Z","caller":"traceutil/trace.go:171","msg":"trace[679584468] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"136.454609ms","start":"2026-02-26T01:37:35.955684Z","end":"2026-02-26T01:37:36.092139Z","steps":["trace[679584468] 'process raft request' (duration: 136.092422ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T01:37:45.886812Z","caller":"traceutil/trace.go:171","msg":"trace[969928135] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"201.996157ms","start":"2026-02-26T01:37:45.684793Z","end":"2026-02-26T01:37:45.886789Z","steps":["trace[969928135] 'read index received' (duration: 201.880684ms)","trace[969928135] 'applied index is now lower than readState.Index' (duration: 114.653µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T01:37:45.886882Z","caller":"traceutil/trace.go:171","msg":"trace[873733099] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"414.459832ms","start":"2026-02-26T01:37:45.472397Z","end":"2026-02-26T01:37:45.886857Z","steps":["trace[873733099] 'process raft request' (duration: 414.250707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T01:37:45.887018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T01:37:45.472368Z","time spent":"414.575465ms","remote":"127.0.0.1:52420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T01:37:45.887064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.203381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-26T01:37:45.887106Z","caller":"traceutil/trace.go:171","msg":"trace[322688988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"202.341064ms","start":"2026-02-26T01:37:45.684755Z","end":"2026-02-26T01:37:45.887096Z","steps":["trace[322688988] 'agreement among raft nodes before linearized reading' (duration: 202.14471ms)"],"step_count":1}