{"level":"warn","ts":"2026-04-27T04:01:12.030659Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T04:01:12.030901Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T04:01:12.031113Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T04:01:12.031167Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-27T04:01:12.031256Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T04:01:12.033138Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-04-27T04:01:12.036546Z","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.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T04:01:12.040849Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.844224ms"} {"level":"info","ts":"2026-04-27T04:01:12.046789Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-04-27T04:01:12.046914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T04:01:12.047055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-04-27T04:01:12.047073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T04:01:12.047161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-04-27T04:01:12.047244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-04-27T04:01:12.055964Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T04:01:12.057559Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T04:01:12.059341Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T04:01:12.062065Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T04:01:12.062742Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T04:01:12.06277Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T04:01:12.062857Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T04:01:12.062867Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T04:01:12.063069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-04-27T04:01:12.063178Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-27T04:01:12.069898Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T04:01:12.070121Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-27T04:01:12.070177Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-27T04:01:12.070467Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T04:01:12.070538Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T04:01:12.147742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T04:01:12.147815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T04:01:12.147894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-04-27T04:01:12.147916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-04-27T04:01:12.147927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-27T04:01:12.148133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-04-27T04:01:12.148153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-27T04:01:12.149161Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T04:01:12.150175Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T04:01:12.150162Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T04:01:12.150244Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T04:01:12.150628Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T04:01:12.150777Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T04:01:12.150846Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T04:01:12.150796Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T04:01:12.150958Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T04:01:12.153106Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-04-27T04:01:12.15529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T04:01:14.108833Z","caller":"traceutil/trace.go:171","msg":"trace[66465497] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"102.217856ms","start":"2026-04-27T04:01:14.006552Z","end":"2026-04-27T04:01:14.10877Z","steps":["trace[66465497] 'process raft request' (duration: 101.855213ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:14.109044Z","caller":"traceutil/trace.go:171","msg":"trace[251849722] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:6; }","duration":"101.434361ms","start":"2026-04-27T04:01:14.007506Z","end":"2026-04-27T04:01:14.10894Z","steps":["trace[251849722] 'read index received' (duration: 100.964708ms)","trace[251849722] 'applied index is now lower than readState.Index' (duration: 467.843µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T04:01:14.110153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.586208ms","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-04-27T04:01:14.111172Z","caller":"traceutil/trace.go:171","msg":"trace[670013182] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:4; }","duration":"103.465834ms","start":"2026-04-27T04:01:14.007446Z","end":"2026-04-27T04:01:14.110912Z","steps":["trace[670013182] 'agreement among raft nodes before linearized reading' (duration: 101.721933ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:14.185926Z","caller":"traceutil/trace.go:171","msg":"trace[2006506223] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"175.706453ms","start":"2026-04-27T04:01:14.010181Z","end":"2026-04-27T04:01:14.185888Z","steps":["trace[2006506223] 'process raft request' (duration: 164.873606ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:14.186006Z","caller":"traceutil/trace.go:171","msg":"trace[721644270] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"157.62791ms","start":"2026-04-27T04:01:14.028366Z","end":"2026-04-27T04:01:14.185994Z","steps":["trace[721644270] 'process raft request' (duration: 157.57606ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:14.185927Z","caller":"traceutil/trace.go:171","msg":"trace[173454615] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"175.557672ms","start":"2026-04-27T04:01:14.010338Z","end":"2026-04-27T04:01:14.185896Z","steps":["trace[173454615] 'process raft request' (duration: 175.464612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:01:14.186137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.545404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T04:01:14.18621Z","caller":"traceutil/trace.go:171","msg":"trace[1961377069] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"175.153779ms","start":"2026-04-27T04:01:14.011047Z","end":"2026-04-27T04:01:14.1862Z","steps":["trace[1961377069] 'process raft request' (duration: 174.833317ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:14.186174Z","caller":"traceutil/trace.go:171","msg":"trace[630465401] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"165.037907ms","start":"2026-04-27T04:01:14.021125Z","end":"2026-04-27T04:01:14.186162Z","steps":["trace[630465401] 'process raft request' (duration: 164.784415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:01:14.186394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.732812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T04:01:14.186521Z","caller":"traceutil/trace.go:171","msg":"trace[506315192] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"109.874933ms","start":"2026-04-27T04:01:14.076638Z","end":"2026-04-27T04:01:14.186513Z","steps":["trace[506315192] 'agreement among raft nodes before linearized reading' (duration: 109.714372ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:14.186508Z","caller":"traceutil/trace.go:171","msg":"trace[1657552010] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"175.943635ms","start":"2026-04-27T04:01:14.01047Z","end":"2026-04-27T04:01:14.186414Z","steps":["trace[1657552010] 'process raft request' (duration: 175.385981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:01:14.186653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.440211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T04:01:14.186697Z","caller":"traceutil/trace.go:171","msg":"trace[1476224115] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"154.501731ms","start":"2026-04-27T04:01:14.032181Z","end":"2026-04-27T04:01:14.186683Z","steps":["trace[1476224115] 'agreement among raft nodes before linearized reading' (duration: 154.436911ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:14.186218Z","caller":"traceutil/trace.go:171","msg":"trace[1830724955] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:0; response_revision:11; }","duration":"177.697735ms","start":"2026-04-27T04:01:14.008508Z","end":"2026-04-27T04:01:14.186205Z","steps":["trace[1830724955] 'agreement among raft nodes before linearized reading' (duration: 177.469554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:01:14.186428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.673721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T04:01:14.186525Z","caller":"traceutil/trace.go:171","msg":"trace[414278505] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"176.087655ms","start":"2026-04-27T04:01:14.010425Z","end":"2026-04-27T04:01:14.186512Z","steps":["trace[414278505] 'process raft request' (duration: 175.408881ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:14.186915Z","caller":"traceutil/trace.go:171","msg":"trace[1393804927] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"126.193956ms","start":"2026-04-27T04:01:14.060708Z","end":"2026-04-27T04:01:14.186902Z","steps":["trace[1393804927] 'agreement among raft nodes before linearized reading' (duration: 125.671962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:01:14.186474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.435509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T04:01:14.186991Z","caller":"traceutil/trace.go:171","msg":"trace[1786906279] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"112.996543ms","start":"2026-04-27T04:01:14.073982Z","end":"2026-04-27T04:01:14.186979Z","steps":["trace[1786906279] 'agreement among raft nodes before linearized reading' (duration: 112.47039ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:18.153317Z","caller":"traceutil/trace.go:171","msg":"trace[1844856618] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"167.356851ms","start":"2026-04-27T04:01:17.985918Z","end":"2026-04-27T04:01:18.153275Z","steps":["trace[1844856618] 'process raft request' (duration: 147.365977ms)","trace[1844856618] 'compare' (duration: 19.32929ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:01:18.153593Z","caller":"traceutil/trace.go:171","msg":"trace[1290370267] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"159.039739ms","start":"2026-04-27T04:01:17.994526Z","end":"2026-04-27T04:01:18.153565Z","steps":["trace[1290370267] 'process raft request' (duration: 158.677037ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:19.004899Z","caller":"traceutil/trace.go:171","msg":"trace[129295827] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"114.791783ms","start":"2026-04-27T04:01:18.890076Z","end":"2026-04-27T04:01:19.004868Z","steps":["trace[129295827] 'process raft request' (duration: 114.622532ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:19.017129Z","caller":"traceutil/trace.go:171","msg":"trace[6876748] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"100.739726ms","start":"2026-04-27T04:01:18.916345Z","end":"2026-04-27T04:01:19.017085Z","steps":["trace[6876748] 'process raft request' (duration: 100.554055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:01:23.368661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.372883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-27T04:01:23.36874Z","caller":"traceutil/trace.go:171","msg":"trace[2104525572] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:358; }","duration":"103.491774ms","start":"2026-04-27T04:01:23.265233Z","end":"2026-04-27T04:01:23.368725Z","steps":["trace[2104525572] 'range keys from in-memory index tree' (duration: 103.228983ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:39.230721Z","caller":"traceutil/trace.go:171","msg":"trace[908599866] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"103.644643ms","start":"2026-04-27T04:01:39.127053Z","end":"2026-04-27T04:01:39.230697Z","steps":["trace[908599866] 'process raft request' (duration: 103.354239ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:39.232674Z","caller":"traceutil/trace.go:171","msg":"trace[1264487856] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"103.857732ms","start":"2026-04-27T04:01:39.128635Z","end":"2026-04-27T04:01:39.232493Z","steps":["trace[1264487856] 'process raft request' (duration: 101.872303ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:01:48.135415Z","caller":"traceutil/trace.go:171","msg":"trace[1601644118] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"102.092466ms","start":"2026-04-27T04:01:48.033288Z","end":"2026-04-27T04:01:48.135381Z","steps":["trace[1601644118] 'process raft request' (duration: 40.165108ms)","trace[1601644118] 'compare' (duration: 61.784195ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:02:02.720046Z","caller":"traceutil/trace.go:171","msg":"trace[1759830313] linearizableReadLoop","detail":"{readStateIndex:800; appliedIndex:799; }","duration":"185.726844ms","start":"2026-04-27T04:02:02.534297Z","end":"2026-04-27T04:02:02.720024Z","steps":["trace[1759830313] 'read index received' (duration: 185.570441ms)","trace[1759830313] 'applied index is now lower than readState.Index' (duration: 155.193µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:02:02.72036Z","caller":"traceutil/trace.go:171","msg":"trace[2022148895] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"336.46791ms","start":"2026-04-27T04:02:02.383884Z","end":"2026-04-27T04:02:02.720352Z","steps":["trace[2022148895] 'process raft request' (duration: 336.02542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:02:02.720742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:02:02.383872Z","time spent":"336.51373ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T04:02:02.720987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.689626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T04:02:02.721016Z","caller":"traceutil/trace.go:171","msg":"trace[322800275] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:778; }","duration":"186.741958ms","start":"2026-04-27T04:02:02.534267Z","end":"2026-04-27T04:02:02.721009Z","steps":["trace[322800275] 'agreement among raft nodes before linearized reading' (duration: 186.658236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:02:02.721132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.164519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T04:02:02.721156Z","caller":"traceutil/trace.go:171","msg":"trace[1875932876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:778; }","duration":"145.22025ms","start":"2026-04-27T04:02:02.57593Z","end":"2026-04-27T04:02:02.721151Z","steps":["trace[1875932876] 'agreement among raft nodes before linearized reading' (duration: 145.165189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:02:02.72138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.253157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T04:02:02.721407Z","caller":"traceutil/trace.go:171","msg":"trace[1797010514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:778; }","duration":"101.311938ms","start":"2026-04-27T04:02:02.620089Z","end":"2026-04-27T04:02:02.721401Z","steps":["trace[1797010514] 'agreement among raft nodes before linearized reading' (duration: 101.257517ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:03:53.475073Z","caller":"traceutil/trace.go:171","msg":"trace[1730232458] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"105.311321ms","start":"2026-04-27T04:03:53.369737Z","end":"2026-04-27T04:03:53.475048Z","steps":["trace[1730232458] 'process raft request' (duration: 105.178398ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:05:31.347393Z","caller":"traceutil/trace.go:171","msg":"trace[2021230501] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"208.659624ms","start":"2026-04-27T04:05:31.138715Z","end":"2026-04-27T04:05:31.347375Z","steps":["trace[2021230501] 'process raft request' (duration: 208.542951ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:05:58.445143Z","caller":"traceutil/trace.go:171","msg":"trace[1999578088] linearizableReadLoop","detail":"{readStateIndex:1722; appliedIndex:1721; }","duration":"286.510906ms","start":"2026-04-27T04:05:58.158608Z","end":"2026-04-27T04:05:58.445119Z","steps":["trace[1999578088] 'read index received' (duration: 286.306491ms)","trace[1999578088] 'applied index is now lower than readState.Index' (duration: 203.385µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:05:58.445207Z","caller":"traceutil/trace.go:171","msg":"trace[1140911893] transaction","detail":"{read_only:false; response_revision:1651; number_of_response:1; }","duration":"289.715139ms","start":"2026-04-27T04:05:58.155462Z","end":"2026-04-27T04:05:58.445177Z","steps":["trace[1140911893] 'process raft request' (duration: 289.523845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:05:58.445352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.92185ms","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-04-27T04:05:58.445386Z","caller":"traceutil/trace.go:171","msg":"trace[689087853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1651; }","duration":"181.035374ms","start":"2026-04-27T04:05:58.26434Z","end":"2026-04-27T04:05:58.445376Z","steps":["trace[689087853] 'agreement among raft nodes before linearized reading' (duration: 180.911651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:05:58.445464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.822243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T04:05:58.445523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.019285ms","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-04-27T04:05:58.445555Z","caller":"traceutil/trace.go:171","msg":"trace[894360923] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1651; }","duration":"135.113717ms","start":"2026-04-27T04:05:58.310429Z","end":"2026-04-27T04:05:58.445543Z","steps":["trace[894360923] 'agreement among raft nodes before linearized reading' (duration: 135.037216ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:05:58.445559Z","caller":"traceutil/trace.go:171","msg":"trace[318925700] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1651; }","duration":"286.999147ms","start":"2026-04-27T04:05:58.158533Z","end":"2026-04-27T04:05:58.445532Z","steps":["trace[318925700] 'agreement among raft nodes before linearized reading' (duration: 286.709161ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:05:58.666237Z","caller":"traceutil/trace.go:171","msg":"trace[462946566] transaction","detail":"{read_only:false; response_revision:1652; number_of_response:1; }","duration":"216.635585ms","start":"2026-04-27T04:05:58.449578Z","end":"2026-04-27T04:05:58.666213Z","steps":["trace[462946566] 'process raft request' (duration: 216.490672ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:05:58.678081Z","caller":"traceutil/trace.go:171","msg":"trace[298080018] linearizableReadLoop","detail":"{readStateIndex:1725; appliedIndex:1722; }","duration":"223.02208ms","start":"2026-04-27T04:05:58.45504Z","end":"2026-04-27T04:05:58.678062Z","steps":["trace[298080018] 'read index received' (duration: 211.120559ms)","trace[298080018] 'applied index is now lower than readState.Index' (duration: 11.900411ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:05:58.678298Z","caller":"traceutil/trace.go:171","msg":"trace[1159651404] transaction","detail":"{read_only:false; response_revision:1653; number_of_response:1; }","duration":"228.484485ms","start":"2026-04-27T04:05:58.449789Z","end":"2026-04-27T04:05:58.678274Z","steps":["trace[1159651404] 'process raft request' (duration: 228.162277ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:05:58.678436Z","caller":"traceutil/trace.go:171","msg":"trace[1355820497] transaction","detail":"{read_only:false; response_revision:1654; number_of_response:1; }","duration":"228.566616ms","start":"2026-04-27T04:05:58.449827Z","end":"2026-04-27T04:05:58.678394Z","steps":["trace[1355820497] 'process raft request' (duration: 228.199278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:05:58.678503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.428649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-27T04:05:58.678515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.517501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T04:05:58.678565Z","caller":"traceutil/trace.go:171","msg":"trace[2086056845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1654; }","duration":"223.528851ms","start":"2026-04-27T04:05:58.455021Z","end":"2026-04-27T04:05:58.67855Z","steps":["trace[2086056845] 'agreement among raft nodes before linearized reading' (duration: 223.219124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:05:58.678523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.501468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T04:05:58.678596Z","caller":"traceutil/trace.go:171","msg":"trace[1422371409] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1654; }","duration":"151.655725ms","start":"2026-04-27T04:05:58.526921Z","end":"2026-04-27T04:05:58.678577Z","steps":["trace[1422371409] 'agreement among raft nodes before linearized reading' (duration: 151.4515ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:05:58.678634Z","caller":"traceutil/trace.go:171","msg":"trace[353798776] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1654; }","duration":"168.694322ms","start":"2026-04-27T04:05:58.509911Z","end":"2026-04-27T04:05:58.678605Z","steps":["trace[353798776] 'agreement among raft nodes before linearized reading' (duration: 168.438326ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:00.049244Z","caller":"traceutil/trace.go:171","msg":"trace[1068622384] transaction","detail":"{read_only:false; response_revision:1657; number_of_response:1; }","duration":"457.623203ms","start":"2026-04-27T04:05:59.591593Z","end":"2026-04-27T04:06:00.049216Z","steps":["trace[1068622384] 'process raft request' (duration: 457.374457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:00.049386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:05:59.591572Z","time spent":"457.736426ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T04:06:13.936748Z","caller":"traceutil/trace.go:171","msg":"trace[531019168] linearizableReadLoop","detail":"{readStateIndex:1831; appliedIndex:1830; }","duration":"354.594227ms","start":"2026-04-27T04:06:13.582124Z","end":"2026-04-27T04:06:13.936718Z","steps":["trace[531019168] 'read index received' (duration: 354.29188ms)","trace[531019168] 'applied index is now lower than readState.Index' (duration: 301.037µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T04:06:13.936897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.74244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T04:06:13.936945Z","caller":"traceutil/trace.go:171","msg":"trace[1824576106] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1755; }","duration":"354.837942ms","start":"2026-04-27T04:06:13.582093Z","end":"2026-04-27T04:06:13.936931Z","steps":["trace[1824576106] 'agreement among raft nodes before linearized reading' (duration: 354.73666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:13.936993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:13.582076Z","time spent":"354.903354ms","remote":"127.0.0.1:56210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-27T04:06:13.937175Z","caller":"traceutil/trace.go:171","msg":"trace[1981053298] transaction","detail":"{read_only:false; response_revision:1755; number_of_response:1; }","duration":"356.02527ms","start":"2026-04-27T04:06:13.581111Z","end":"2026-04-27T04:06:13.937136Z","steps":["trace[1981053298] 'process raft request' (duration: 355.413276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:13.937378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:13.581089Z","time spent":"356.160682ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T04:06:14.326616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.846169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T04:06:14.326678Z","caller":"traceutil/trace.go:171","msg":"trace[1533446520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1755; }","duration":"317.956172ms","start":"2026-04-27T04:06:14.008705Z","end":"2026-04-27T04:06:14.326662Z","steps":["trace[1533446520] 'range keys from in-memory index tree' (duration: 317.773488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:14.326727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:14.008689Z","time spent":"318.023903ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T04:06:14.326904Z","caller":"traceutil/trace.go:171","msg":"trace[1631923935] transaction","detail":"{read_only:false; response_revision:1756; number_of_response:1; }","duration":"117.832334ms","start":"2026-04-27T04:06:14.209049Z","end":"2026-04-27T04:06:14.326881Z","steps":["trace[1631923935] 'process raft request' (duration: 95.857864ms)","trace[1631923935] 'compare' (duration: 21.629192ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:06:26.7601Z","caller":"traceutil/trace.go:171","msg":"trace[782869556] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"114.715392ms","start":"2026-04-27T04:06:26.645307Z","end":"2026-04-27T04:06:26.760022Z","steps":["trace[782869556] 'process raft request' (duration: 114.460046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:34.638447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.614296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T04:06:34.63854Z","caller":"traceutil/trace.go:171","msg":"trace[2042706144] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1870; }","duration":"260.77217ms","start":"2026-04-27T04:06:34.377745Z","end":"2026-04-27T04:06:34.638517Z","steps":["trace[2042706144] 'range keys from in-memory index tree' (duration: 260.476992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.162494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.244164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T04:06:35.162603Z","caller":"traceutil/trace.go:171","msg":"trace[1284179550] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"570.525925ms","start":"2026-04-27T04:06:34.592059Z","end":"2026-04-27T04:06:35.162585Z","steps":["trace[1284179550] 'process raft request' (duration: 177.961484ms)","trace[1284179550] 'compare' (duration: 391.999028ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T04:06:35.162663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.592028Z","time spent":"570.609656ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T04:06:35.421055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.989507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T04:06:35.421367Z","caller":"traceutil/trace.go:171","msg":"trace[1313899983] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"778.173435ms","start":"2026-04-27T04:06:34.643157Z","end":"2026-04-27T04:06:35.42133Z","steps":["trace[1313899983] 'process raft request' (duration: 641.775878ms)","trace[1313899983] 'compare' (duration: 135.764212ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:06:35.421421Z","caller":"traceutil/trace.go:171","msg":"trace[1081506097] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"546.410745ms","start":"2026-04-27T04:06:34.874985Z","end":"2026-04-27T04:06:35.421396Z","steps":["trace[1081506097] 'process raft request' (duration: 546.347914ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.42145Z","caller":"traceutil/trace.go:171","msg":"trace[916653694] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"777.959229ms","start":"2026-04-27T04:06:34.643442Z","end":"2026-04-27T04:06:35.421402Z","steps":["trace[916653694] 'process raft request' (duration: 777.803996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.421512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.874957Z","time spent":"546.520068ms","remote":"127.0.0.1:58148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T04:06:35.421544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.643137Z","time spent":"778.318408ms","remote":"127.0.0.1:58148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":656,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T04:06:35.421518Z","caller":"traceutil/trace.go:171","msg":"trace[533783343] linearizableReadLoop","detail":"{readStateIndex:1954; appliedIndex:1951; }","duration":"777.10658ms","start":"2026-04-27T04:06:34.644373Z","end":"2026-04-27T04:06:35.421479Z","steps":["trace[533783343] 'read index received' (duration: 125.5696ms)","trace[533783343] 'applied index is now lower than readState.Index' (duration: 651.53456ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T04:06:35.421586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.643404Z","time spent":"778.116723ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T04:06:35.421879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.481659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1783"} {"level":"info","ts":"2026-04-27T04:06:35.421929Z","caller":"traceutil/trace.go:171","msg":"trace[486764924] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1875; }","duration":"777.566141ms","start":"2026-04-27T04:06:34.644346Z","end":"2026-04-27T04:06:35.421912Z","steps":["trace[486764924] 'agreement among raft nodes before linearized reading' (duration: 777.323295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.421961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.055683ms","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-04-27T04:06:35.421981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.644337Z","time spent":"777.633262ms","remote":"127.0.0.1:58260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":1806,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"info","ts":"2026-04-27T04:06:35.421994Z","caller":"traceutil/trace.go:171","msg":"trace[1807453003] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1875; }","duration":"404.099644ms","start":"2026-04-27T04:06:35.017884Z","end":"2026-04-27T04:06:35.421983Z","steps":["trace[1807453003] 'agreement among raft nodes before linearized reading' (duration: 403.888559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.42202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.018163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T04:06:35.422061Z","caller":"traceutil/trace.go:171","msg":"trace[1881499802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1875; }","duration":"415.094734ms","start":"2026-04-27T04:06:35.006955Z","end":"2026-04-27T04:06:35.42205Z","steps":["trace[1881499802] 'agreement among raft nodes before linearized reading' (duration: 415.021862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.422092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:35.006934Z","time spent":"415.151456ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T04:06:35.422122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.978601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-27T04:06:35.422149Z","caller":"traceutil/trace.go:171","msg":"trace[1261098911] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1875; }","duration":"469.059853ms","start":"2026-04-27T04:06:34.953081Z","end":"2026-04-27T04:06:35.422141Z","steps":["trace[1261098911] 'agreement among raft nodes before linearized reading' (duration: 468.860429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.422175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.95306Z","time spent":"469.108685ms","remote":"127.0.0.1:58346","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-04-27T04:06:35.422209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.435783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-04-27T04:06:35.422248Z","caller":"traceutil/trace.go:171","msg":"trace[515010182] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1875; }","duration":"696.510974ms","start":"2026-04-27T04:06:34.725723Z","end":"2026-04-27T04:06:35.422233Z","steps":["trace[515010182] 'agreement among raft nodes before linearized reading' (duration: 695.962552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.422029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:35.017876Z","time spent":"404.146576ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T04:06:35.422276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.725702Z","time spent":"696.567806ms","remote":"127.0.0.1:58282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":235,"request content":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" "} {"level":"warn","ts":"2026-04-27T04:06:35.42187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.213724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-27T04:06:35.4224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.767458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"} {"level":"info","ts":"2026-04-27T04:06:35.422402Z","caller":"traceutil/trace.go:171","msg":"trace[129686714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1875; }","duration":"403.747126ms","start":"2026-04-27T04:06:35.018627Z","end":"2026-04-27T04:06:35.422374Z","steps":["trace[129686714] 'agreement among raft nodes before linearized reading' (duration: 403.127022ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.422438Z","caller":"traceutil/trace.go:171","msg":"trace[1404746438] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1875; }","duration":"688.84003ms","start":"2026-04-27T04:06:34.733589Z","end":"2026-04-27T04:06:35.422429Z","steps":["trace[1404746438] 'agreement among raft nodes before linearized reading' (duration: 688.735757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.422467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.73357Z","time spent":"688.890181ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":1266,"request content":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" "} {"level":"warn","ts":"2026-04-27T04:06:35.422495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:35.018622Z","time spent":"403.835888ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T04:06:35.422685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.492567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-27T04:06:35.422747Z","caller":"traceutil/trace.go:171","msg":"trace[1711505220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1875; }","duration":"409.62767ms","start":"2026-04-27T04:06:35.013102Z","end":"2026-04-27T04:06:35.42273Z","steps":["trace[1711505220] 'agreement among raft nodes before linearized reading' (duration: 408.803501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.422785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:35.013085Z","time spent":"409.691192ms","remote":"127.0.0.1:58346","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-04-27T04:06:35.422973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.15166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T04:06:35.423014Z","caller":"traceutil/trace.go:171","msg":"trace[6889247] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1875; }","duration":"629.249802ms","start":"2026-04-27T04:06:34.793754Z","end":"2026-04-27T04:06:35.423004Z","steps":["trace[6889247] 'agreement among raft nodes before linearized reading' (duration: 628.29394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.423034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:34.793729Z","time spent":"629.300043ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T04:06:35.61649Z","caller":"traceutil/trace.go:171","msg":"trace[908011646] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"187.922391ms","start":"2026-04-27T04:06:35.428539Z","end":"2026-04-27T04:06:35.616462Z","steps":["trace[908011646] 'process raft request' (duration: 187.634814ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.616822Z","caller":"traceutil/trace.go:171","msg":"trace[152471335] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"188.163966ms","start":"2026-04-27T04:06:35.428632Z","end":"2026-04-27T04:06:35.616796Z","steps":["trace[152471335] 'process raft request' (duration: 187.839319ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.616885Z","caller":"traceutil/trace.go:171","msg":"trace[1097666926] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"187.111182ms","start":"2026-04-27T04:06:35.429747Z","end":"2026-04-27T04:06:35.616858Z","steps":["trace[1097666926] 'process raft request' (duration: 186.760524ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.616891Z","caller":"traceutil/trace.go:171","msg":"trace[216289548] linearizableReadLoop","detail":"{readStateIndex:1963; appliedIndex:1956; }","duration":"156.128377ms","start":"2026-04-27T04:06:35.460738Z","end":"2026-04-27T04:06:35.616866Z","steps":["trace[216289548] 'read index received' (duration: 155.469242ms)","trace[216289548] 'applied index is now lower than readState.Index' (duration: 657.955µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:06:35.617163Z","caller":"traceutil/trace.go:171","msg":"trace[106729835] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"186.834025ms","start":"2026-04-27T04:06:35.430309Z","end":"2026-04-27T04:06:35.617143Z","steps":["trace[106729835] 'process raft request' (duration: 186.301823ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.617196Z","caller":"traceutil/trace.go:171","msg":"trace[1061637912] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"188.558915ms","start":"2026-04-27T04:06:35.428611Z","end":"2026-04-27T04:06:35.61717Z","steps":["trace[1061637912] 'process raft request' (duration: 187.781227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.617211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.500201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-04-27T04:06:35.617332Z","caller":"traceutil/trace.go:171","msg":"trace[712390794] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"187.05084ms","start":"2026-04-27T04:06:35.430263Z","end":"2026-04-27T04:06:35.617313Z","steps":["trace[712390794] 'process raft request' (duration: 186.314003ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.617354Z","caller":"traceutil/trace.go:171","msg":"trace[1644181112] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1883; }","duration":"187.671794ms","start":"2026-04-27T04:06:35.429667Z","end":"2026-04-27T04:06:35.617339Z","steps":["trace[1644181112] 'agreement among raft nodes before linearized reading' (duration: 187.47087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.617562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.177575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"warn","ts":"2026-04-27T04:06:35.617573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.948961ms","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:535"} {"level":"info","ts":"2026-04-27T04:06:35.617618Z","caller":"traceutil/trace.go:171","msg":"trace[127707768] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1883; }","duration":"137.277217ms","start":"2026-04-27T04:06:35.480329Z","end":"2026-04-27T04:06:35.617606Z","steps":["trace[127707768] 'agreement among raft nodes before linearized reading' (duration: 137.112723ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.617638Z","caller":"traceutil/trace.go:171","msg":"trace[279946409] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1883; }","duration":"188.050213ms","start":"2026-04-27T04:06:35.429565Z","end":"2026-04-27T04:06:35.617615Z","steps":["trace[279946409] 'agreement among raft nodes before linearized reading' (duration: 187.880439ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.618029Z","caller":"traceutil/trace.go:171","msg":"trace[537619052] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"187.857058ms","start":"2026-04-27T04:06:35.430131Z","end":"2026-04-27T04:06:35.617988Z","steps":["trace[537619052] 'process raft request' (duration: 186.418375ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:35.872862Z","caller":"traceutil/trace.go:171","msg":"trace[1498405465] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"246.020514ms","start":"2026-04-27T04:06:35.6268Z","end":"2026-04-27T04:06:35.87282Z","steps":["trace[1498405465] 'process raft request' (duration: 189.029976ms)","trace[1498405465] 'compare' (duration: 56.618409ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:06:35.873507Z","caller":"traceutil/trace.go:171","msg":"trace[1074700832] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1964; }","duration":"151.719526ms","start":"2026-04-27T04:06:35.721688Z","end":"2026-04-27T04:06:35.873408Z","steps":["trace[1074700832] 'read index received' (duration: 94.194776ms)","trace[1074700832] 'applied index is now lower than readState.Index' (duration: 57.52348ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:06:35.873574Z","caller":"traceutil/trace.go:171","msg":"trace[1360150630] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"245.786339ms","start":"2026-04-27T04:06:35.62774Z","end":"2026-04-27T04:06:35.873527Z","steps":["trace[1360150630] 'process raft request' (duration: 244.96693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:35.874042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.949701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T04:06:35.87412Z","caller":"traceutil/trace.go:171","msg":"trace[1940965389] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1886; }","duration":"152.433873ms","start":"2026-04-27T04:06:35.721648Z","end":"2026-04-27T04:06:35.874082Z","steps":["trace[1940965389] 'agreement among raft nodes before linearized reading' (duration: 151.954672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:36.173205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.438204ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-27T04:06:36.173289Z","caller":"traceutil/trace.go:171","msg":"trace[1629096573] linearizableReadLoop","detail":"{readStateIndex:1967; appliedIndex:1966; }","duration":"165.96774ms","start":"2026-04-27T04:06:36.007308Z","end":"2026-04-27T04:06:36.173275Z","steps":["trace[1629096573] 'read index received' (duration: 16.395874ms)","trace[1629096573] 'applied index is now lower than readState.Index' (duration: 149.570726ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T04:06:36.173346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.040261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T04:06:36.173364Z","caller":"traceutil/trace.go:171","msg":"trace[930823712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1886; }","duration":"166.089483ms","start":"2026-04-27T04:06:36.007268Z","end":"2026-04-27T04:06:36.173358Z","steps":["trace[930823712] 'agreement among raft nodes before linearized reading' (duration: 166.041862ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:36.257994Z","caller":"traceutil/trace.go:171","msg":"trace[1393417472] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"162.642464ms","start":"2026-04-27T04:06:36.095326Z","end":"2026-04-27T04:06:36.257968Z","steps":["trace[1393417472] 'process raft request' (duration: 162.472291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:36.627127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.440184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T04:06:36.627241Z","caller":"traceutil/trace.go:171","msg":"trace[2047989354] linearizableReadLoop","detail":"{readStateIndex:1969; appliedIndex:1968; }","duration":"132.207822ms","start":"2026-04-27T04:06:36.495014Z","end":"2026-04-27T04:06:36.627222Z","steps":["trace[2047989354] 'read index received' (duration: 59.922µs)","trace[2047989354] 'applied index is now lower than readState.Index' (duration: 132.14579ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:06:36.627402Z","caller":"traceutil/trace.go:171","msg":"trace[1754793874] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"451.730899ms","start":"2026-04-27T04:06:36.175542Z","end":"2026-04-27T04:06:36.627273Z","steps":["trace[1754793874] 'process raft request' (duration: 133.0472ms)","trace[1754793874] 'compare' (duration: 318.158007ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T04:06:36.627793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:36.175497Z","time spent":"452.086127ms","remote":"127.0.0.1:58120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T04:06:36.627964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.832656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2722"} {"level":"info","ts":"2026-04-27T04:06:36.628197Z","caller":"traceutil/trace.go:171","msg":"trace[1844901751] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1888; }","duration":"133.169524ms","start":"2026-04-27T04:06:36.494953Z","end":"2026-04-27T04:06:36.628123Z","steps":["trace[1844901751] 'agreement among raft nodes before linearized reading' (duration: 132.385596ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:53.991253Z","caller":"traceutil/trace.go:171","msg":"trace[1748333019] linearizableReadLoop","detail":"{readStateIndex:2077; appliedIndex:2076; }","duration":"278.229877ms","start":"2026-04-27T04:06:53.712985Z","end":"2026-04-27T04:06:53.991215Z","steps":["trace[1748333019] 'read index received' (duration: 277.92529ms)","trace[1748333019] 'applied index is now lower than readState.Index' (duration: 303.137µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T04:06:53.99129Z","caller":"traceutil/trace.go:171","msg":"trace[107900557] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"448.517567ms","start":"2026-04-27T04:06:53.542736Z","end":"2026-04-27T04:06:53.991253Z","steps":["trace[107900557] 'process raft request' (duration: 448.257461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:53.991617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.937021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T04:06:53.991783Z","caller":"traceutil/trace.go:171","msg":"trace[1904534416] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1993; }","duration":"163.186517ms","start":"2026-04-27T04:06:53.828569Z","end":"2026-04-27T04:06:53.991756Z","steps":["trace[1904534416] 'agreement among raft nodes before linearized reading' (duration: 162.938641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:53.991663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T04:06:53.54271Z","time spent":"448.789802ms","remote":"127.0.0.1:58346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T04:06:53.991823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.504323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-27T04:06:53.991892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.575616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-27T04:06:53.991946Z","caller":"traceutil/trace.go:171","msg":"trace[1739441209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1993; }","duration":"267.638716ms","start":"2026-04-27T04:06:53.724284Z","end":"2026-04-27T04:06:53.991922Z","steps":["trace[1739441209] 'agreement among raft nodes before linearized reading' (duration: 267.433841ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:53.991971Z","caller":"traceutil/trace.go:171","msg":"trace[30229205] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1993; }","duration":"264.680519ms","start":"2026-04-27T04:06:53.727274Z","end":"2026-04-27T04:06:53.991955Z","steps":["trace[30229205] 'agreement among raft nodes before linearized reading' (duration: 264.407042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T04:06:53.992117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.29239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-27T04:06:53.991509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.508174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-27T04:06:53.9923Z","caller":"traceutil/trace.go:171","msg":"trace[938065228] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1993; }","duration":"279.379723ms","start":"2026-04-27T04:06:53.712906Z","end":"2026-04-27T04:06:53.992286Z","steps":["trace[938065228] 'agreement among raft nodes before linearized reading' (duration: 278.406601ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T04:06:53.99257Z","caller":"traceutil/trace.go:171","msg":"trace[1659718097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1993; }","duration":"268.867954ms","start":"2026-04-27T04:06:53.72328Z","end":"2026-04-27T04:06:53.992148Z","steps":["trace[1659718097] 'agreement among raft nodes before linearized reading' (duration: 268.211829ms)"],"step_count":1}