{"level":"warn","ts":"2026-06-26T02:10:40.234338Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T02:10:40.234434Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.112:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.112:2380","--initial-cluster=instance=https://199.19.213.112:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.112:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.112:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-26T02:10:40.234506Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T02:10:40.234519Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.112:2380"]} {"level":"info","ts":"2026-06-26T02:10:40.234538Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-26T02:10:40.236172Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"]} {"level":"info","ts":"2026-06-26T02:10:40.23626Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.112:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-26T02:10:40.240225Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.742036ms"} {"level":"info","ts":"2026-06-26T02:10:40.247458Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"197930edc5411b2e","cluster-id":"8165613f50a6d530"} {"level":"info","ts":"2026-06-26T02:10:40.247618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T02:10:40.247666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 0"} {"level":"info","ts":"2026-06-26T02:10:40.247696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 197930edc5411b2e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T02:10:40.247726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 1"} {"level":"info","ts":"2026-06-26T02:10:40.247793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"} {"level":"warn","ts":"2026-06-26T02:10:40.254521Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T02:10:40.256523Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T02:10:40.258906Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-26T02:10:40.261555Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"197930edc5411b2e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T02:10:40.261724Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"197930edc5411b2e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T02:10:40.26185Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-26T02:10:40.262112Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-26T02:10:40.262182Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-26T02:10:40.263861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"} {"level":"info","ts":"2026-06-26T02:10:40.264061Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","added-peer-id":"197930edc5411b2e","added-peer-peer-urls":["https://199.19.213.112:2380"]} {"level":"info","ts":"2026-06-26T02:10:40.267932Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-26T02:10:40.268147Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"197930edc5411b2e","initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T02:10:40.268275Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T02:10:40.268461Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.112:2380"} {"level":"info","ts":"2026-06-26T02:10:40.268524Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.112:2380"} {"level":"info","ts":"2026-06-26T02:10:40.647985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T02:10:40.648122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T02:10:40.648177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgPreVoteResp from 197930edc5411b2e at term 1"} {"level":"info","ts":"2026-06-26T02:10:40.648273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became candidate at term 2"} {"level":"info","ts":"2026-06-26T02:10:40.648362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgVoteResp from 197930edc5411b2e at term 2"} {"level":"info","ts":"2026-06-26T02:10:40.648412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became leader at term 2"} {"level":"info","ts":"2026-06-26T02:10:40.64846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 197930edc5411b2e elected leader 197930edc5411b2e at term 2"} {"level":"info","ts":"2026-06-26T02:10:40.662223Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"197930edc5411b2e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.112:2379]}","request-path":"/0/members/197930edc5411b2e/attributes","cluster-id":"8165613f50a6d530","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T02:10:40.662482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:10:40.662563Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:10:40.662768Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T02:10:40.662825Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T02:10:40.663051Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:10:40.663908Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:10:40.664088Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:10:40.664177Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:10:40.665688Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T02:10:40.666609Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.112:2379"} {"level":"warn","ts":"2026-06-26T02:10:43.546293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.849318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:10:43.546836Z","caller":"traceutil/trace.go:171","msg":"trace[214054169] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"367.19186ms","start":"2026-06-26T02:10:43.179626Z","end":"2026-06-26T02:10:43.546818Z","steps":["trace[214054169] 'process raft request' (duration: 133.336186ms)","trace[214054169] 'compare' (duration: 232.677937ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:43.546906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.179612Z","time spent":"367.267921ms","remote":"127.0.0.1:45096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":828,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:43.644243Z","caller":"traceutil/trace.go:171","msg":"trace[1453018060] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"192.036468ms","start":"2026-06-26T02:10:43.452129Z","end":"2026-06-26T02:10:43.644166Z","steps":["trace[1453018060] 'process raft request' (duration: 191.851036ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:43.777206Z","caller":"traceutil/trace.go:171","msg":"trace[289213926] transaction","detail":"{read_only:false; response_revision:156; number_of_response:1; }","duration":"129.53867ms","start":"2026-06-26T02:10:43.647641Z","end":"2026-06-26T02:10:43.777179Z","steps":["trace[289213926] 'process raft request' (duration: 128.257431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:16.998165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.00143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:11:16.998304Z","caller":"traceutil/trace.go:171","msg":"trace[1203904668] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"152.499945ms","start":"2026-06-26T02:11:16.845781Z","end":"2026-06-26T02:11:16.998281Z","steps":["trace[1203904668] 'process raft request' (duration: 40.300697ms)","trace[1203904668] 'compare' (duration: 111.818672ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:17.000802Z","caller":"traceutil/trace.go:171","msg":"trace[1214826453] transaction","detail":"{read_only:false; number_of_response:1; response_revision:533; }","duration":"154.693456ms","start":"2026-06-26T02:11:16.846087Z","end":"2026-06-26T02:11:17.000781Z","steps":["trace[1214826453] 'process raft request' (duration: 154.5461ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.000887Z","caller":"traceutil/trace.go:171","msg":"trace[1987673821] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"154.827021ms","start":"2026-06-26T02:11:16.846034Z","end":"2026-06-26T02:11:17.000861Z","steps":["trace[1987673821] 'process raft request' (duration: 154.484747ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.001057Z","caller":"traceutil/trace.go:171","msg":"trace[1652303090] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"150.713339ms","start":"2026-06-26T02:11:16.850321Z","end":"2026-06-26T02:11:17.001034Z","steps":["trace[1652303090] 'process raft request' (duration: 150.350664ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.001148Z","caller":"traceutil/trace.go:171","msg":"trace[2118163562] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"150.020071ms","start":"2026-06-26T02:11:16.851111Z","end":"2026-06-26T02:11:17.001131Z","steps":["trace[2118163562] 'process raft request' (duration: 149.604474ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.001298Z","caller":"traceutil/trace.go:171","msg":"trace[849131606] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"150.142227ms","start":"2026-06-26T02:11:16.851144Z","end":"2026-06-26T02:11:17.001286Z","steps":["trace[849131606] 'process raft request' (duration: 149.599273ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.001713Z","caller":"traceutil/trace.go:171","msg":"trace[1472974469] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"149.632246ms","start":"2026-06-26T02:11:16.852041Z","end":"2026-06-26T02:11:17.001673Z","steps":["trace[1472974469] 'process raft request' (duration: 149.207558ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.001843Z","caller":"traceutil/trace.go:171","msg":"trace[418268128] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"122.502107ms","start":"2026-06-26T02:11:16.879327Z","end":"2026-06-26T02:11:17.001829Z","steps":["trace[418268128] 'process raft request' (duration: 122.472466ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.001872Z","caller":"traceutil/trace.go:171","msg":"trace[127232797] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"147.627962ms","start":"2026-06-26T02:11:16.854222Z","end":"2026-06-26T02:11:17.00185Z","steps":["trace[127232797] 'process raft request' (duration: 147.463195ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.001937Z","caller":"traceutil/trace.go:171","msg":"trace[1963776615] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"145.984973ms","start":"2026-06-26T02:11:16.855944Z","end":"2026-06-26T02:11:17.001929Z","steps":["trace[1963776615] 'process raft request' (duration: 145.820326ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.011318Z","caller":"traceutil/trace.go:171","msg":"trace[72718225] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"101.799923ms","start":"2026-06-26T02:11:16.909499Z","end":"2026-06-26T02:11:17.011299Z","steps":["trace[72718225] 'process raft request' (duration: 101.467609ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.011378Z","caller":"traceutil/trace.go:171","msg":"trace[2146217578] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"125.043889ms","start":"2026-06-26T02:11:16.886308Z","end":"2026-06-26T02:11:17.011352Z","steps":["trace[2146217578] 'process raft request' (duration: 124.536138ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:17.244983Z","caller":"traceutil/trace.go:171","msg":"trace[1326351628] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"105.273879ms","start":"2026-06-26T02:11:17.139681Z","end":"2026-06-26T02:11:17.244955Z","steps":["trace[1326351628] 'process raft request' (duration: 98.146046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:18.440293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.151155ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:11:18.44047Z","caller":"traceutil/trace.go:171","msg":"trace[1275248478] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"349.725793ms","start":"2026-06-26T02:11:18.090709Z","end":"2026-06-26T02:11:18.440435Z","steps":["trace[1275248478] 'process raft request' (duration: 132.231975ms)","trace[1275248478] 'compare' (duration: 216.776479ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:18.440566Z","caller":"traceutil/trace.go:171","msg":"trace[915481443] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"244.005546ms","start":"2026-06-26T02:11:18.196543Z","end":"2026-06-26T02:11:18.440549Z","steps":["trace[915481443] 'process raft request' (duration: 243.912542ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:18.440704Z","caller":"traceutil/trace.go:171","msg":"trace[1187239047] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"305.543657ms","start":"2026-06-26T02:11:18.135104Z","end":"2026-06-26T02:11:18.440647Z","steps":["trace[1187239047] 'read index received' (duration: 87.803659ms)","trace[1187239047] 'applied index is now lower than readState.Index' (duration: 217.736978ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:18.440715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:18.090632Z","time spent":"349.961352ms","remote":"127.0.0.1:44784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:11:18.440926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.207092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:18.440973Z","caller":"traceutil/trace.go:171","msg":"trace[1215730494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"117.282575ms","start":"2026-06-26T02:11:18.323678Z","end":"2026-06-26T02:11:18.440961Z","steps":["trace[1215730494] 'agreement among raft nodes before linearized reading' (duration: 117.196761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:18.441047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.922672ms","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-06-26T02:11:18.44113Z","caller":"traceutil/trace.go:171","msg":"trace[496307476] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"306.121511ms","start":"2026-06-26T02:11:18.134994Z","end":"2026-06-26T02:11:18.441115Z","steps":["trace[496307476] 'agreement among raft nodes before linearized reading' (duration: 305.932222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:18.441205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:18.134977Z","time spent":"306.215875ms","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T02:11:23.772191Z","caller":"traceutil/trace.go:171","msg":"trace[1031733228] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"138.975109ms","start":"2026-06-26T02:11:23.633182Z","end":"2026-06-26T02:11:23.772158Z","steps":["trace[1031733228] 'read index received' (duration: 55.979876ms)","trace[1031733228] 'applied index is now lower than readState.Index' (duration: 82.993833ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:23.772434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.238511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:11:23.772474Z","caller":"traceutil/trace.go:171","msg":"trace[1363044951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"139.337194ms","start":"2026-06-26T02:11:23.633129Z","end":"2026-06-26T02:11:23.772466Z","steps":["trace[1363044951] 'agreement among raft nodes before linearized reading' (duration: 139.150017ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:23.772232Z","caller":"traceutil/trace.go:171","msg":"trace[125543180] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"241.452681ms","start":"2026-06-26T02:11:23.530751Z","end":"2026-06-26T02:11:23.772204Z","steps":["trace[125543180] 'process raft request' (duration: 158.463327ms)","trace[125543180] 'compare' (duration: 82.746043ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:24.301765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.294136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sfktl\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-26T02:11:24.3019Z","caller":"traceutil/trace.go:171","msg":"trace[172288372] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sfktl; range_end:; response_count:1; response_revision:636; }","duration":"344.464152ms","start":"2026-06-26T02:11:23.957411Z","end":"2026-06-26T02:11:24.301875Z","steps":["trace[172288372] 'range keys from in-memory index tree' (duration: 344.114118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:24.301951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:23.957396Z","time spent":"344.542055ms","remote":"127.0.0.1:44910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-sfktl\" "} {"level":"info","ts":"2026-06-26T02:11:24.53532Z","caller":"traceutil/trace.go:171","msg":"trace[1875304433] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"300.341407ms","start":"2026-06-26T02:11:24.234954Z","end":"2026-06-26T02:11:24.535296Z","steps":["trace[1875304433] 'process raft request' (duration: 299.758245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:24.535469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:24.234929Z","time spent":"300.461362ms","remote":"127.0.0.1:44816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:11:24.55766Z","caller":"traceutil/trace.go:171","msg":"trace[466421050] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:657; }","duration":"234.094936ms","start":"2026-06-26T02:11:24.323547Z","end":"2026-06-26T02:11:24.557642Z","steps":["trace[466421050] 'read index received' (duration: 211.110364ms)","trace[466421050] 'applied index is now lower than readState.Index' (duration: 22.983772ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:24.558249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.694159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:24.558307Z","caller":"traceutil/trace.go:171","msg":"trace[2133346027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"234.783832ms","start":"2026-06-26T02:11:24.323514Z","end":"2026-06-26T02:11:24.558298Z","steps":["trace[2133346027] 'agreement among raft nodes before linearized reading' (duration: 234.693029ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:24.558448Z","caller":"traceutil/trace.go:171","msg":"trace[1894909084] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"238.188091ms","start":"2026-06-26T02:11:24.320226Z","end":"2026-06-26T02:11:24.558414Z","steps":["trace[1894909084] 'process raft request' (duration: 237.267386ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:26.30782Z","caller":"traceutil/trace.go:171","msg":"trace[1707396948] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"125.578014ms","start":"2026-06-26T02:11:26.182221Z","end":"2026-06-26T02:11:26.307799Z","steps":["trace[1707396948] 'process raft request' (duration: 115.541502ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:26.31335Z","caller":"traceutil/trace.go:171","msg":"trace[889897108] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"124.179053ms","start":"2026-06-26T02:11:26.189148Z","end":"2026-06-26T02:11:26.313327Z","steps":["trace[889897108] 'process raft request' (duration: 124.059308ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:39.238635Z","caller":"traceutil/trace.go:171","msg":"trace[1443486715] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"175.180618ms","start":"2026-06-26T02:11:39.063419Z","end":"2026-06-26T02:11:39.2386Z","steps":["trace[1443486715] 'read index received' (duration: 174.895399ms)","trace[1443486715] 'applied index is now lower than readState.Index' (duration: 283.719µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:39.238844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.408236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-tncv2\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-26T02:11:39.238895Z","caller":"traceutil/trace.go:171","msg":"trace[2023718521] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-tncv2; range_end:; response_count:1; response_revision:794; }","duration":"175.51059ms","start":"2026-06-26T02:11:39.063364Z","end":"2026-06-26T02:11:39.238874Z","steps":["trace[2023718521] 'agreement among raft nodes before linearized reading' (duration: 175.352414ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:39.238933Z","caller":"traceutil/trace.go:171","msg":"trace[1114358177] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"416.266168ms","start":"2026-06-26T02:11:38.822638Z","end":"2026-06-26T02:11:39.238904Z","steps":["trace[1114358177] 'process raft request' (duration: 415.786042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:39.239076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:38.822606Z","time spent":"416.396412ms","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:11:45.351978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575138839,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:11:45.853039Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575138839,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:11:45.868458Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.153669951s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:11:45.931698Z","caller":"traceutil/trace.go:171","msg":"trace[1670367505] linearizableReadLoop","detail":"{readStateIndex:888; appliedIndex:887; }","duration":"1.080454639s","start":"2026-06-26T02:11:44.851208Z","end":"2026-06-26T02:11:45.931663Z","steps":["trace[1670367505] 'read index received' (duration: 1.017430567s)","trace[1670367505] 'applied index is now lower than readState.Index' (duration: 63.023052ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:45.931802Z","caller":"traceutil/trace.go:171","msg":"trace[878572971] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"1.270316597s","start":"2026-06-26T02:11:44.661461Z","end":"2026-06-26T02:11:45.931778Z","steps":["trace[878572971] 'process raft request' (duration: 1.207257415s)","trace[878572971] 'compare' (duration: 62.826535ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:45.93187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080651485s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/eg\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:45.931909Z","caller":"traceutil/trace.go:171","msg":"trace[947392249] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/eg; range_end:; response_count:0; response_revision:860; }","duration":"1.080757188s","start":"2026-06-26T02:11:44.851141Z","end":"2026-06-26T02:11:45.931898Z","steps":["trace[947392249] 'agreement among raft nodes before linearized reading' (duration: 1.080678066s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:45.931943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:44.851114Z","time spent":"1.0808205s","remote":"127.0.0.1:59792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/eg\" "} {"level":"warn","ts":"2026-06-26T02:11:45.931956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:44.661428Z","time spent":"1.270433211s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:11:45.932095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.340211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:11:45.932138Z","caller":"traceutil/trace.go:171","msg":"trace[2120024882] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:860; }","duration":"872.427514ms","start":"2026-06-26T02:11:45.059697Z","end":"2026-06-26T02:11:45.932124Z","steps":["trace[2120024882] 'agreement among raft nodes before linearized reading' (duration: 872.351201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:45.932169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:45.059676Z","time spent":"872.484055ms","remote":"127.0.0.1:45256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:11:45.932248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.796158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:45.932289Z","caller":"traceutil/trace.go:171","msg":"trace[1551056447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:860; }","duration":"607.86175ms","start":"2026-06-26T02:11:45.324415Z","end":"2026-06-26T02:11:45.932277Z","steps":["trace[1551056447] 'agreement among raft nodes before linearized reading' (duration: 607.804359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:45.932318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:45.324393Z","time spent":"607.918201ms","remote":"127.0.0.1:44754","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-06-26T02:11:45.932398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.51371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-26T02:11:45.932466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.024451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:45.932506Z","caller":"traceutil/trace.go:171","msg":"trace[1458983611] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:860; }","duration":"640.097043ms","start":"2026-06-26T02:11:45.292399Z","end":"2026-06-26T02:11:45.932496Z","steps":["trace[1458983611] 'agreement among raft nodes before linearized reading' (duration: 640.0011ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:45.932506Z","caller":"traceutil/trace.go:171","msg":"trace[765259684] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:860; }","duration":"666.654404ms","start":"2026-06-26T02:11:45.265837Z","end":"2026-06-26T02:11:45.932491Z","steps":["trace[765259684] 'agreement among raft nodes before linearized reading' (duration: 666.458558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:45.932533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:45.292377Z","time spent":"640.148035ms","remote":"127.0.0.1:45030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:11:45.932548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:45.265817Z","time spent":"666.720406ms","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T02:11:46.114428Z","caller":"traceutil/trace.go:171","msg":"trace[1794952223] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"176.582564ms","start":"2026-06-26T02:11:45.937817Z","end":"2026-06-26T02:11:46.1144Z","steps":["trace[1794952223] 'process raft request' (duration: 176.495761ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:46.114609Z","caller":"traceutil/trace.go:171","msg":"trace[2058575491] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"177.951006ms","start":"2026-06-26T02:11:45.936625Z","end":"2026-06-26T02:11:46.114576Z","steps":["trace[2058575491] 'process raft request' (duration: 126.84179ms)","trace[2058575491] 'compare' (duration: 50.667873ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:47.9225Z","caller":"traceutil/trace.go:171","msg":"trace[2066175696] transaction","detail":"{read_only:false; number_of_response:1; response_revision:869; }","duration":"242.614161ms","start":"2026-06-26T02:11:47.67984Z","end":"2026-06-26T02:11:47.922454Z","steps":["trace[2066175696] 'process raft request' (duration: 172.825518ms)","trace[2066175696] 'compare' (duration: 69.68486ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:47.95516Z","caller":"traceutil/trace.go:171","msg":"trace[863315196] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"193.954243ms","start":"2026-06-26T02:11:47.761187Z","end":"2026-06-26T02:11:47.955141Z","steps":["trace[863315196] 'process raft request' (duration: 193.783258ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:47.955535Z","caller":"traceutil/trace.go:171","msg":"trace[1533506127] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"192.427628ms","start":"2026-06-26T02:11:47.763083Z","end":"2026-06-26T02:11:47.955511Z","steps":["trace[1533506127] 'process raft request' (duration: 192.265314ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:47.955552Z","caller":"traceutil/trace.go:171","msg":"trace[1861822504] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"194.176739ms","start":"2026-06-26T02:11:47.761363Z","end":"2026-06-26T02:11:47.95554Z","steps":["trace[1861822504] 'process raft request' (duration: 193.723536ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:48.120362Z","caller":"traceutil/trace.go:171","msg":"trace[466542861] linearizableReadLoop","detail":"{readStateIndex:902; appliedIndex:899; }","duration":"184.013946ms","start":"2026-06-26T02:11:47.936325Z","end":"2026-06-26T02:11:48.120339Z","steps":["trace[466542861] 'read index received' (duration: 18.822977ms)","trace[466542861] 'applied index is now lower than readState.Index' (duration: 165.189909ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:48.120451Z","caller":"traceutil/trace.go:171","msg":"trace[390692714] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"191.331312ms","start":"2026-06-26T02:11:47.92908Z","end":"2026-06-26T02:11:48.120411Z","steps":["trace[390692714] 'process raft request' (duration: 170.279125ms)","trace[390692714] 'compare' (duration: 20.872532ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:48.120861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.49262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-26T02:11:48.121125Z","caller":"traceutil/trace.go:171","msg":"trace[1291055775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:873; }","duration":"184.671435ms","start":"2026-06-26T02:11:47.936268Z","end":"2026-06-26T02:11:48.12094Z","steps":["trace[1291055775] 'agreement among raft nodes before linearized reading' (duration: 184.172041ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:48.168378Z","caller":"traceutil/trace.go:171","msg":"trace[1749763565] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"209.474894ms","start":"2026-06-26T02:11:47.958878Z","end":"2026-06-26T02:11:48.168353Z","steps":["trace[1749763565] 'process raft request' (duration: 209.34506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:48.168435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.455363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T02:11:48.16848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.900724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-26T02:11:48.16856Z","caller":"traceutil/trace.go:171","msg":"trace[620232175] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:874; }","duration":"213.973416ms","start":"2026-06-26T02:11:47.954538Z","end":"2026-06-26T02:11:48.168512Z","steps":["trace[620232175] 'agreement among raft nodes before linearized reading' (duration: 213.804771ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:48.168748Z","caller":"traceutil/trace.go:171","msg":"trace[1871801183] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:874; }","duration":"150.544846ms","start":"2026-06-26T02:11:48.017946Z","end":"2026-06-26T02:11:48.168491Z","steps":["trace[1871801183] 'agreement among raft nodes before linearized reading' (duration: 150.420162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:48.168821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.763625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:11:48.168921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.487245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-7st4r\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-06-26T02:11:48.168925Z","caller":"traceutil/trace.go:171","msg":"trace[1728002008] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:874; }","duration":"159.931719ms","start":"2026-06-26T02:11:48.008971Z","end":"2026-06-26T02:11:48.168903Z","steps":["trace[1728002008] 'agreement among raft nodes before linearized reading' (duration: 159.765595ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:48.169005Z","caller":"traceutil/trace.go:171","msg":"trace[837479036] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-7st4r; range_end:; response_count:1; response_revision:874; }","duration":"207.635979ms","start":"2026-06-26T02:11:47.961356Z","end":"2026-06-26T02:11:48.168992Z","steps":["trace[837479036] 'agreement among raft nodes before linearized reading' (duration: 207.391782ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:48.296511Z","caller":"traceutil/trace.go:171","msg":"trace[1125078779] linearizableReadLoop","detail":"{readStateIndex:908; appliedIndex:904; }","duration":"109.136573ms","start":"2026-06-26T02:11:48.187349Z","end":"2026-06-26T02:11:48.296485Z","steps":["trace[1125078779] 'read index received' (duration: 97.333058ms)","trace[1125078779] 'applied index is now lower than readState.Index' (duration: 11.800485ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:48.29663Z","caller":"traceutil/trace.go:171","msg":"trace[78936202] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"123.419541ms","start":"2026-06-26T02:11:48.173199Z","end":"2026-06-26T02:11:48.296618Z","steps":["trace[78936202] 'process raft request' (duration: 111.492142ms)","trace[78936202] 'compare' (duration: 11.453065ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:48.297191Z","caller":"traceutil/trace.go:171","msg":"trace[1295988581] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"123.821823ms","start":"2026-06-26T02:11:48.173355Z","end":"2026-06-26T02:11:48.297177Z","steps":["trace[1295988581] 'process raft request' (duration: 122.965258ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:48.297347Z","caller":"traceutil/trace.go:171","msg":"trace[67856596] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"123.102542ms","start":"2026-06-26T02:11:48.174236Z","end":"2026-06-26T02:11:48.297339Z","steps":["trace[67856596] 'process raft request' (duration: 122.145604ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:48.297969Z","caller":"traceutil/trace.go:171","msg":"trace[589217892] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"121.375871ms","start":"2026-06-26T02:11:48.176561Z","end":"2026-06-26T02:11:48.297936Z","steps":["trace[589217892] 'process raft request' (duration: 119.866747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:48.298177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.695978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-06-26T02:11:48.29822Z","caller":"traceutil/trace.go:171","msg":"trace[319799452] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:879; }","duration":"124.77526ms","start":"2026-06-26T02:11:48.173433Z","end":"2026-06-26T02:11:48.298208Z","steps":["trace[319799452] 'agreement among raft nodes before linearized reading' (duration: 124.686307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:48.319342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.240601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-7st4r\" ","response":"range_response_count:1 size:4777"} {"level":"info","ts":"2026-06-26T02:11:48.319413Z","caller":"traceutil/trace.go:171","msg":"trace[1123400208] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-7st4r; range_end:; response_count:1; response_revision:880; }","duration":"130.348994ms","start":"2026-06-26T02:11:48.18905Z","end":"2026-06-26T02:11:48.319399Z","steps":["trace[1123400208] 'agreement among raft nodes before linearized reading' (duration: 130.233991ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:48.45846Z","caller":"traceutil/trace.go:171","msg":"trace[1901326982] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"129.086157ms","start":"2026-06-26T02:11:48.329341Z","end":"2026-06-26T02:11:48.458427Z","steps":["trace[1901326982] 'process raft request' (duration: 83.624956ms)","trace[1901326982] 'compare' (duration: 45.311486ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:48.898719Z","caller":"traceutil/trace.go:171","msg":"trace[1431139170] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"103.059005ms","start":"2026-06-26T02:11:48.795642Z","end":"2026-06-26T02:11:48.898701Z","steps":["trace[1431139170] 'process raft request' (duration: 102.959133ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:49.138559Z","caller":"traceutil/trace.go:171","msg":"trace[2043382426] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"103.282801ms","start":"2026-06-26T02:11:49.035253Z","end":"2026-06-26T02:11:49.138535Z","steps":["trace[2043382426] 'process raft request' (duration: 103.169838ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:49.317708Z","caller":"traceutil/trace.go:171","msg":"trace[2048001046] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"132.720274ms","start":"2026-06-26T02:11:49.184959Z","end":"2026-06-26T02:11:49.31768Z","steps":["trace[2048001046] 'process raft request' (duration: 81.498251ms)","trace[2048001046] 'compare' (duration: 51.079499ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:49.556852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.234548ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-26T02:11:50.300074Z","caller":"traceutil/trace.go:171","msg":"trace[1687826198] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"105.63682ms","start":"2026-06-26T02:11:50.194418Z","end":"2026-06-26T02:11:50.300055Z","steps":["trace[1687826198] 'process raft request' (duration: 105.522197ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:50.477812Z","caller":"traceutil/trace.go:171","msg":"trace[589929368] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:916; }","duration":"153.627065ms","start":"2026-06-26T02:11:50.32416Z","end":"2026-06-26T02:11:50.477787Z","steps":["trace[589929368] 'read index received' (duration: 40.032578ms)","trace[589929368] 'applied index is now lower than readState.Index' (duration: 113.593257ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:50.477861Z","caller":"traceutil/trace.go:171","msg":"trace[1680211340] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"172.819176ms","start":"2026-06-26T02:11:50.305018Z","end":"2026-06-26T02:11:50.477837Z","steps":["trace[1680211340] 'process raft request' (duration: 92.378359ms)","trace[1680211340] 'compare' (duration: 80.20602ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:50.477899Z","caller":"traceutil/trace.go:171","msg":"trace[1745272092] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"151.090442ms","start":"2026-06-26T02:11:50.326793Z","end":"2026-06-26T02:11:50.477883Z","steps":["trace[1745272092] 'process raft request' (duration: 150.934777ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:50.477968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.79722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:50.478067Z","caller":"traceutil/trace.go:171","msg":"trace[217871238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:889; }","duration":"153.941305ms","start":"2026-06-26T02:11:50.324113Z","end":"2026-06-26T02:11:50.478055Z","steps":["trace[217871238] 'agreement among raft nodes before linearized reading' (duration: 153.8116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:50.552559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.283268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-26T02:11:50.552615Z","caller":"traceutil/trace.go:171","msg":"trace[563562008] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:890; }","duration":"212.518724ms","start":"2026-06-26T02:11:50.340084Z","end":"2026-06-26T02:11:50.552602Z","steps":["trace[563562008] 'agreement among raft nodes before linearized reading' (duration: 212.172355ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:50.671233Z","caller":"traceutil/trace.go:171","msg":"trace[932873936] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:920; }","duration":"109.099538ms","start":"2026-06-26T02:11:50.562111Z","end":"2026-06-26T02:11:50.67121Z","steps":["trace[932873936] 'read index received' (duration: 108.945053ms)","trace[932873936] 'applied index is now lower than readState.Index' (duration: 153.574µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:50.67137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.244603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:50.671356Z","caller":"traceutil/trace.go:171","msg":"trace[368248855] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"115.459672ms","start":"2026-06-26T02:11:50.555865Z","end":"2026-06-26T02:11:50.671324Z","steps":["trace[368248855] 'process raft request' (duration: 115.187213ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:50.671405Z","caller":"traceutil/trace.go:171","msg":"trace[347629013] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:891; }","duration":"109.337446ms","start":"2026-06-26T02:11:50.562055Z","end":"2026-06-26T02:11:50.671393Z","steps":["trace[347629013] 'agreement among raft nodes before linearized reading' (duration: 109.261214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:50.936472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.674698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:50.936555Z","caller":"traceutil/trace.go:171","msg":"trace[727899963] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:892; }","duration":"167.805932ms","start":"2026-06-26T02:11:50.76873Z","end":"2026-06-26T02:11:50.936536Z","steps":["trace[727899963] 'range keys from in-memory index tree' (duration: 167.596707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:57.42351Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:11:57.9246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:11:58.425167Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:11:58.926109Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:11:59.426952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:11:59.673633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999993338s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-26T02:11:59.673711Z","caller":"traceutil/trace.go:171","msg":"trace[843122045] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000128171s","start":"2026-06-26T02:11:57.673564Z","end":"2026-06-26T02:11:59.673692Z","steps":["trace[843122045] 'agreement among raft nodes before linearized reading' (duration: 2.000025509s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:59.67376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:57.673543Z","time spent":"2.000207594s","remote":"127.0.0.1:44754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/26 02:11:59 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:11:59.92852Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:00.323912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999832956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-26T02:12:00.32402Z","caller":"traceutil/trace.go:171","msg":"trace[1704978820] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000007851s","start":"2026-06-26T02:11:58.323994Z","end":"2026-06-26T02:12:00.324002Z","steps":["trace[1704978820] 'agreement among raft nodes before linearized reading' (duration: 1.999876667s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:00.324068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:58.323972Z","time spent":"2.000086703s","remote":"127.0.0.1:44744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:12:00.429665Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:00.930656Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:01.431045Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:01.693846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:56.69485Z","time spent":"4.998990463s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-06-26T02:12:01.931821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:02.33253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999874738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-26T02:12:02.332635Z","caller":"traceutil/trace.go:171","msg":"trace[994356434] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999996781s","start":"2026-06-26T02:12:00.332619Z","end":"2026-06-26T02:12:02.332616Z","steps":["trace[994356434] 'agreement among raft nodes before linearized reading' (duration: 1.999869087s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:02.332682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:00.332567Z","time spent":"2.000105423s","remote":"127.0.0.1:44754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/26 02:12:02 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:02.432796Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:02.933851Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:03.331097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999727507s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-26T02:12:03.331408Z","caller":"traceutil/trace.go:171","msg":"trace[600972598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"5.000005904s","start":"2026-06-26T02:11:58.331297Z","end":"2026-06-26T02:12:03.331303Z","steps":["trace[600972598] 'agreement among raft nodes before linearized reading' (duration: 4.999736767s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:03.331562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:58.33128Z","time spent":"5.00026482s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/06/26 02:12:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:03.39649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999174272s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:03.39659Z","caller":"traceutil/trace.go:171","msg":"trace[900022125] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999330146s","start":"2026-06-26T02:11:58.397239Z","end":"2026-06-26T02:12:03.39657Z","steps":["trace[900022125] 'agreement among raft nodes before linearized reading' (duration: 4.999202013s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:03.396641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:58.397219Z","time spent":"4.999411288s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/06/26 02:12:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:03.434681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:03.503407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:58.504666Z","time spent":"4.99873384s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/06/26 02:12:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:03.923501Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-06-26T02:12:03.92368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.001051279s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-06-26T02:12:03.923723Z","caller":"traceutil/trace.go:171","msg":"trace[1108746059] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; }","duration":"7.001153461s","start":"2026-06-26T02:11:56.922553Z","end":"2026-06-26T02:12:03.923706Z","steps":["trace[1108746059] 'agreement among raft nodes before linearized reading' (duration: 7.0010828s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:03.923798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:56.922534Z","time spent":"7.001230933s","remote":"127.0.0.1:44872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":0,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:04.333129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000233541s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:04.333215Z","caller":"traceutil/trace.go:171","msg":"trace[22565600] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000359095s","start":"2026-06-26T02:12:02.332836Z","end":"2026-06-26T02:12:04.333195Z","steps":["trace[22565600] 'agreement among raft nodes before linearized reading' (duration: 2.000256202s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:04.333287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:02.332817Z","time spent":"2.000460377s","remote":"127.0.0.1:44744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/26 02:12:04 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:04.382659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:57.381612Z","time spent":"7.001041122s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-06-26T02:12:04.424728Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:04.926821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:05.429043Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:05.930128Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:06.341546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000365365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:06.341622Z","caller":"traceutil/trace.go:171","msg":"trace[1145372044] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000493189s","start":"2026-06-26T02:12:04.341113Z","end":"2026-06-26T02:12:06.341606Z","steps":["trace[1145372044] 'agreement among raft nodes before linearized reading' (duration: 2.000399146s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:06.341665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:04.34109Z","time spent":"2.00056553s","remote":"127.0.0.1:44754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/26 02:12:06 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:06.358225Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"1b2e9f01b189fe10","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-06-26T02:12:06.431037Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:06.678104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:59.676994Z","time spent":"7.001098386s","remote":"127.0.0.1:44796","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-06-26T02:12:06.690189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.993708376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:06.690299Z","caller":"traceutil/trace.go:171","msg":"trace[1291576652] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.993823519s","start":"2026-06-26T02:12:03.696459Z","end":"2026-06-26T02:12:06.690282Z","steps":["trace[1291576652] 'agreement among raft nodes before linearized reading' (duration: 2.993706956s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:06.690369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:03.696396Z","time spent":"2.993961223s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/06/26 02:12:06 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:06.932152Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:07.023376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.001548476s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:07.0235Z","caller":"traceutil/trace.go:171","msg":"trace[357820627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.001698979s","start":"2026-06-26T02:11:57.021777Z","end":"2026-06-26T02:12:07.023476Z","steps":["trace[357820627] 'agreement among raft nodes before linearized reading' (duration: 10.001567956s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:07.023571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:57.021765Z","time spent":"10.001789241s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} 2026/06/26 02:12:07 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:07.432527Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:07.932921Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:08.331867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998258571s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:08.331976Z","caller":"traceutil/trace.go:171","msg":"trace[408829819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.998449796s","start":"2026-06-26T02:12:05.333507Z","end":"2026-06-26T02:12:08.331957Z","steps":["trace[408829819] 'agreement among raft nodes before linearized reading' (duration: 2.998296932s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:08.332035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:05.33349Z","time spent":"2.998524507s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/06/26 02:12:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:08.342391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000413198s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:08.342475Z","caller":"traceutil/trace.go:171","msg":"trace[1692971228] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000533282s","start":"2026-06-26T02:12:06.341921Z","end":"2026-06-26T02:12:08.342454Z","steps":["trace[1692971228] 'agreement among raft nodes before linearized reading' (duration: 2.000435219s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:08.342531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:06.341908Z","time spent":"2.000611013s","remote":"127.0.0.1:44744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/26 02:12:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:08.397045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.996892393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:08.397137Z","caller":"traceutil/trace.go:171","msg":"trace[1839194844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.997050347s","start":"2026-06-26T02:12:05.400063Z","end":"2026-06-26T02:12:08.397114Z","steps":["trace[1839194844] 'agreement among raft nodes before linearized reading' (duration: 2.996937644s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:08.397199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:05.400034Z","time spent":"2.997154559s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/06/26 02:12:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:08.433033Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:08.503179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998324478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:08.503255Z","caller":"traceutil/trace.go:171","msg":"trace[1695375024] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; }","duration":"4.998416641s","start":"2026-06-26T02:12:03.504823Z","end":"2026-06-26T02:12:08.50324Z","steps":["trace[1695375024] 'agreement among raft nodes before linearized reading' (duration: 4.998321938s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:08.503291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:03.504762Z","time spent":"4.998521843s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} 2026/06/26 02:12:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:08.509811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999321401s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:12:08.509877Z","caller":"traceutil/trace.go:171","msg":"trace[688788932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"9.999446064s","start":"2026-06-26T02:11:58.510415Z","end":"2026-06-26T02:12:08.509861Z","steps":["trace[688788932] 'agreement among raft nodes before linearized reading' (duration: 9.999364852s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:08.509915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:58.510388Z","time spent":"9.999519706s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} 2026/06/26 02:12:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:12:08.933638Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:09.434829Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958677717575139070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:12:09.526051Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"12.831093215s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-26T02:12:09.566753Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"53.012µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"info","ts":"2026-06-26T02:12:09.56683Z","caller":"traceutil/trace.go:171","msg":"trace[796301433] transaction","detail":"{read_only:false; number_of_response:1; response_revision:980; }","duration":"5.179076429s","start":"2026-06-26T02:12:04.387713Z","end":"2026-06-26T02:12:09.566789Z","steps":["trace[796301433] 'process raft request' (duration: 5.178817232s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:12:09.567093Z","caller":"traceutil/trace.go:171","msg":"trace[629810580] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"5.850865745s","start":"2026-06-26T02:12:03.715717Z","end":"2026-06-26T02:12:09.566583Z","steps":["trace[629810580] 'process raft request' (duration: 5.85070435s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.567159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:04.387688Z","time spent":"5.179281214s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":45,"response count":0,"response size":570,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:12:09.567323Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"1b2e9f01b189fe10","error":"lease not found"} {"level":"info","ts":"2026-06-26T02:12:09.56743Z","caller":"traceutil/trace.go:171","msg":"trace[1222245217] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"2.884369332s","start":"2026-06-26T02:12:06.683037Z","end":"2026-06-26T02:12:09.567407Z","steps":["trace[1222245217] 'process raft request' (duration: 2.883817339s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.567537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:06.683004Z","time spent":"2.884466183s","remote":"127.0.0.1:44796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:12:09.567607Z","caller":"traceutil/trace.go:171","msg":"trace[546951731] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"1.167906827s","start":"2026-06-26T02:12:08.399589Z","end":"2026-06-26T02:12:09.567495Z","steps":["trace[546951731] 'process raft request' (duration: 1.167465696s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:12:09.567594Z","caller":"traceutil/trace.go:171","msg":"trace[62349042] transaction","detail":"{read_only:false; number_of_response:1; response_revision:981; }","duration":"2.874602s","start":"2026-06-26T02:12:06.692952Z","end":"2026-06-26T02:12:09.567554Z","steps":["trace[62349042] 'process raft request' (duration: 2.873971575s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.56772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:08.399565Z","time spent":"1.168097761s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:12:09.567724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:06.692935Z","time spent":"2.874733734s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":62,"response count":0,"response size":525,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:12:09.567302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:03.715693Z","time spent":"5.85147648s","remote":"127.0.0.1:44992","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-06-26T02:12:09.567834Z","caller":"traceutil/trace.go:171","msg":"trace[1911907260] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"1.062102709s","start":"2026-06-26T02:12:08.505723Z","end":"2026-06-26T02:12:09.567826Z","steps":["trace[1911907260] 'process raft request' (duration: 1.061383162s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.567885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:08.5057Z","time spent":"1.06216005s","remote":"127.0.0.1:44796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":904,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:12:09.567915Z","caller":"traceutil/trace.go:171","msg":"trace[1911916625] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"1.055838578s","start":"2026-06-26T02:12:08.512057Z","end":"2026-06-26T02:12:09.567895Z","steps":["trace[1911916625] 'process raft request' (duration: 1.055097661s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.568028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:08.512038Z","time spent":"1.05594019s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":411,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:12:09.568012Z","caller":"traceutil/trace.go:171","msg":"trace[155227493] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"2.541984349s","start":"2026-06-26T02:12:07.025947Z","end":"2026-06-26T02:12:09.567932Z","steps":["trace[155227493] 'process raft request' (duration: 2.541043797s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.568324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:07.025918Z","time spent":"2.542323727s","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":413,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:12:09.571635Z","caller":"traceutil/trace.go:171","msg":"trace[1172541477] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1007; }","duration":"5.648013816s","start":"2026-06-26T02:12:03.923608Z","end":"2026-06-26T02:12:09.571622Z","steps":["trace[1172541477] 'read index received' (duration: 5.602904996s)","trace[1172541477] 'applied index is now lower than readState.Index' (duration: 45.10783ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:12:09.571932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.56092427s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:12:09.572067Z","caller":"traceutil/trace.go:171","msg":"trace[1860376369] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:986; }","duration":"6.561115764s","start":"2026-06-26T02:12:03.01094Z","end":"2026-06-26T02:12:09.572056Z","steps":["trace[1860376369] 'agreement among raft nodes before linearized reading' (duration: 6.560825048s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.572168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:03.010915Z","time spent":"6.561240957s","remote":"127.0.0.1:44796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":124,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.574163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.285107234s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:12:09.574278Z","caller":"traceutil/trace.go:171","msg":"trace[102125174] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:986; }","duration":"11.285261157s","start":"2026-06-26T02:11:58.288997Z","end":"2026-06-26T02:12:09.574258Z","steps":["trace[102125174] 'agreement among raft nodes before linearized reading' (duration: 11.285085523s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.574335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:58.28898Z","time spent":"11.28533891s","remote":"127.0.0.1:44816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" "} {"level":"warn","ts":"2026-06-26T02:12:09.574324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.992269069s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:12:09.574443Z","caller":"traceutil/trace.go:171","msg":"trace[905000163] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:986; }","duration":"10.992473965s","start":"2026-06-26T02:11:58.581938Z","end":"2026-06-26T02:12:09.574412Z","steps":["trace[905000163] 'agreement among raft nodes before linearized reading' (duration: 10.991380489s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.574501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:58.581914Z","time spent":"10.992575417s","remote":"127.0.0.1:45166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.574506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.503224623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:12:09.574574Z","caller":"traceutil/trace.go:171","msg":"trace[945331866] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:986; }","duration":"7.503335296s","start":"2026-06-26T02:12:02.071229Z","end":"2026-06-26T02:12:09.574565Z","steps":["trace[945331866] 'agreement among raft nodes before linearized reading' (duration: 7.503210753s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.574605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:02.071209Z","time spent":"7.503389517s","remote":"127.0.0.1:45228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.574706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.73839528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:12:09.574765Z","caller":"traceutil/trace.go:171","msg":"trace[2136144404] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:986; }","duration":"9.738495982s","start":"2026-06-26T02:11:59.836252Z","end":"2026-06-26T02:12:09.574748Z","steps":["trace[2136144404] 'agreement among raft nodes before linearized reading' (duration: 9.73841706s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.574825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:59.836216Z","time spent":"9.738593114s","remote":"127.0.0.1:45208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.574872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.650233137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:12:09.574909Z","caller":"traceutil/trace.go:171","msg":"trace[876119809] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:986; }","duration":"12.650286658s","start":"2026-06-26T02:11:56.924615Z","end":"2026-06-26T02:12:09.574902Z","steps":["trace[876119809] 'agreement among raft nodes before linearized reading' (duration: 12.650228256s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.574975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:56.924609Z","time spent":"12.650357029s","remote":"127.0.0.1:44898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.576449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.350944407s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.112\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:12:09.576506Z","caller":"traceutil/trace.go:171","msg":"trace[1303505053] range","detail":"{range_begin:/registry/masterleases/199.19.213.112; range_end:; response_count:0; response_revision:987; }","duration":"5.351055979s","start":"2026-06-26T02:12:04.225434Z","end":"2026-06-26T02:12:09.57649Z","steps":["trace[1303505053] 'agreement among raft nodes before linearized reading' (duration: 5.350954737s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.576548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:04.225411Z","time spent":"5.35112785s","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.112\" "} {"level":"warn","ts":"2026-06-26T02:12:09.576545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.972343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:12:09.576623Z","caller":"traceutil/trace.go:171","msg":"trace[1952123848] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:987; }","duration":"178.092006ms","start":"2026-06-26T02:12:09.398505Z","end":"2026-06-26T02:12:09.576597Z","steps":["trace[1952123848] 'agreement among raft nodes before linearized reading' (duration: 177.961833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.576692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.017723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T02:12:09.576755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.226200564s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:12:09.576795Z","caller":"traceutil/trace.go:171","msg":"trace[597009678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:987; }","duration":"1.226258405s","start":"2026-06-26T02:12:08.350526Z","end":"2026-06-26T02:12:09.576785Z","steps":["trace[597009678] 'agreement among raft nodes before linearized reading' (duration: 1.226202214s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.576826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:08.350517Z","time spent":"1.226303986s","remote":"127.0.0.1:44744","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-06-26T02:12:09.576839Z","caller":"traceutil/trace.go:171","msg":"trace[702303490] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:987; }","duration":"764.209728ms","start":"2026-06-26T02:12:08.812562Z","end":"2026-06-26T02:12:09.576772Z","steps":["trace[702303490] 'agreement among raft nodes before linearized reading' (duration: 763.88237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.576938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:08.812542Z","time spent":"764.379351ms","remote":"127.0.0.1:45004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.577048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.367825132s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:12:09.577077Z","caller":"traceutil/trace.go:171","msg":"trace[590742490] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:987; }","duration":"3.367890584s","start":"2026-06-26T02:12:06.209179Z","end":"2026-06-26T02:12:09.577069Z","steps":["trace[590742490] 'agreement among raft nodes before linearized reading' (duration: 3.367841963s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.577101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:06.209158Z","time spent":"3.367936674s","remote":"127.0.0.1:45084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.577115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.857245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:12:09.577157Z","caller":"traceutil/trace.go:171","msg":"trace[2092741100] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:987; }","duration":"671.924947ms","start":"2026-06-26T02:12:08.905223Z","end":"2026-06-26T02:12:09.577147Z","steps":["trace[2092741100] 'agreement among raft nodes before linearized reading' (duration: 671.865835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.576947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.232449415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7111"} {"level":"info","ts":"2026-06-26T02:12:09.577333Z","caller":"traceutil/trace.go:171","msg":"trace[870172763] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:987; }","duration":"1.232882535s","start":"2026-06-26T02:12:08.344441Z","end":"2026-06-26T02:12:09.577323Z","steps":["trace[870172763] 'agreement among raft nodes before linearized reading' (duration: 1.232402803s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.577361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:08.344418Z","time spent":"1.232935027s","remote":"127.0.0.1:44910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7134,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-06-26T02:12:09.577425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.640484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:12:09.57749Z","caller":"traceutil/trace.go:171","msg":"trace[1648644042] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:987; }","duration":"341.744616ms","start":"2026-06-26T02:12:09.235728Z","end":"2026-06-26T02:12:09.577473Z","steps":["trace[1648644042] 'agreement among raft nodes before linearized reading' (duration: 341.633594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.577532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:09.235708Z","time spent":"341.813758ms","remote":"127.0.0.1:44910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":14,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.57682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.902505721s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:12:09.57764Z","caller":"traceutil/trace.go:171","msg":"trace[1817381952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:987; }","duration":"1.903354351s","start":"2026-06-26T02:12:07.674269Z","end":"2026-06-26T02:12:09.577623Z","steps":["trace[1817381952] 'agreement among raft nodes before linearized reading' (duration: 1.902503381s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:09.577191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:08.905209Z","time spent":"671.973847ms","remote":"127.0.0.1:45050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:12:09.577711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:07.674248Z","time spent":"1.903447424s","remote":"127.0.0.1:44754","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-06-26T02:13:30.822433Z","caller":"traceutil/trace.go:171","msg":"trace[904751851] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"146.895796ms","start":"2026-06-26T02:13:30.675374Z","end":"2026-06-26T02:13:30.82227Z","steps":["trace[904751851] 'process raft request' (duration: 146.676863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:31.098494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.304646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:13:31.098851Z","caller":"traceutil/trace.go:171","msg":"trace[799581567] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"271.196925ms","start":"2026-06-26T02:13:30.827629Z","end":"2026-06-26T02:13:31.098826Z","steps":["trace[799581567] 'process raft request' (duration: 149.487353ms)","trace[799581567] 'compare' (duration: 120.744669ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:13:31.132822Z","caller":"traceutil/trace.go:171","msg":"trace[8470051] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"304.885732ms","start":"2026-06-26T02:13:30.827899Z","end":"2026-06-26T02:13:31.132785Z","steps":["trace[8470051] 'process raft request' (duration: 304.581987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:31.133022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:30.82789Z","time spent":"305.027353ms","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:13:31.133201Z","caller":"traceutil/trace.go:171","msg":"trace[1657468389] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"193.055513ms","start":"2026-06-26T02:13:30.94011Z","end":"2026-06-26T02:13:31.133165Z","steps":["trace[1657468389] 'process raft request' (duration: 192.991122ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.133392Z","caller":"traceutil/trace.go:171","msg":"trace[755903720] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"297.679678ms","start":"2026-06-26T02:13:30.835683Z","end":"2026-06-26T02:13:31.133362Z","steps":["trace[755903720] 'process raft request' (duration: 297.030429ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.133512Z","caller":"traceutil/trace.go:171","msg":"trace[316326366] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"278.485435ms","start":"2026-06-26T02:13:30.854999Z","end":"2026-06-26T02:13:31.133485Z","steps":["trace[316326366] 'process raft request' (duration: 278.010049ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.144112Z","caller":"traceutil/trace.go:171","msg":"trace[1173095722] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"108.693037ms","start":"2026-06-26T02:13:31.035403Z","end":"2026-06-26T02:13:31.144096Z","steps":["trace[1173095722] 'process raft request' (duration: 108.494124ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.301424Z","caller":"traceutil/trace.go:171","msg":"trace[1299836606] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"161.826428ms","start":"2026-06-26T02:13:31.13957Z","end":"2026-06-26T02:13:31.301397Z","steps":["trace[1299836606] 'process raft request' (duration: 161.477723ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.301865Z","caller":"traceutil/trace.go:171","msg":"trace[1509869283] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"161.95229ms","start":"2026-06-26T02:13:31.139904Z","end":"2026-06-26T02:13:31.301856Z","steps":["trace[1509869283] 'process raft request' (duration: 161.432102ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.302198Z","caller":"traceutil/trace.go:171","msg":"trace[1062278930] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"161.930299ms","start":"2026-06-26T02:13:31.140257Z","end":"2026-06-26T02:13:31.302187Z","steps":["trace[1062278930] 'process raft request' (duration: 161.826608ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.302353Z","caller":"traceutil/trace.go:171","msg":"trace[613309297] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"162.221654ms","start":"2026-06-26T02:13:31.140121Z","end":"2026-06-26T02:13:31.302342Z","steps":["trace[613309297] 'process raft request' (duration: 161.686625ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.345811Z","caller":"traceutil/trace.go:171","msg":"trace[1818962007] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"188.86508ms","start":"2026-06-26T02:13:31.156921Z","end":"2026-06-26T02:13:31.345786Z","steps":["trace[1818962007] 'process raft request' (duration: 188.696598ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.345763Z","caller":"traceutil/trace.go:171","msg":"trace[1157105750] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2042; }","duration":"174.241864ms","start":"2026-06-26T02:13:31.171499Z","end":"2026-06-26T02:13:31.34574Z","steps":["trace[1157105750] 'read index received' (duration: 129.535002ms)","trace[1157105750] 'applied index is now lower than readState.Index' (duration: 44.705722ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:13:31.346135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.501807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-26T02:13:31.346154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.640229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-26T02:13:31.346177Z","caller":"traceutil/trace.go:171","msg":"trace[248192408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1968; }","duration":"174.582509ms","start":"2026-06-26T02:13:31.171586Z","end":"2026-06-26T02:13:31.346168Z","steps":["trace[248192408] 'agreement among raft nodes before linearized reading' (duration: 174.425527ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.346199Z","caller":"traceutil/trace.go:171","msg":"trace[576642695] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1968; }","duration":"174.73539ms","start":"2026-06-26T02:13:31.171448Z","end":"2026-06-26T02:13:31.346183Z","steps":["trace[576642695] 'agreement among raft nodes before linearized reading' (duration: 174.484566ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.549924Z","caller":"traceutil/trace.go:171","msg":"trace[925955338] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"199.669563ms","start":"2026-06-26T02:13:31.350193Z","end":"2026-06-26T02:13:31.549863Z","steps":["trace[925955338] 'process raft request' (duration: 199.46237ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:31.55181Z","caller":"traceutil/trace.go:171","msg":"trace[2094273361] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"200.04562ms","start":"2026-06-26T02:13:31.351744Z","end":"2026-06-26T02:13:31.55179Z","steps":["trace[2094273361] 'process raft request' (duration: 199.872127ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:14:05.397623Z","caller":"traceutil/trace.go:171","msg":"trace[1585892253] linearizableReadLoop","detail":"{readStateIndex:2288; appliedIndex:2287; }","duration":"121.867266ms","start":"2026-06-26T02:14:05.275729Z","end":"2026-06-26T02:14:05.397596Z","steps":["trace[1585892253] 'read index received' (duration: 121.641873ms)","trace[1585892253] 'applied index is now lower than readState.Index' (duration: 221.943µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:14:05.397693Z","caller":"traceutil/trace.go:171","msg":"trace[300168309] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"127.179413ms","start":"2026-06-26T02:14:05.270485Z","end":"2026-06-26T02:14:05.397664Z","steps":["trace[300168309] 'process raft request' (duration: 126.94715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:14:05.398095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.342612ms","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-06-26T02:14:05.398248Z","caller":"traceutil/trace.go:171","msg":"trace[981410595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2200; }","duration":"122.521933ms","start":"2026-06-26T02:14:05.275692Z","end":"2026-06-26T02:14:05.398214Z","steps":["trace[981410595] 'agreement among raft nodes before linearized reading' (duration: 122.084908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:14:06.161352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.476196ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:14:06.161482Z","caller":"traceutil/trace.go:171","msg":"trace[767729751] linearizableReadLoop","detail":"{readStateIndex:2293; appliedIndex:2292; }","duration":"387.354603ms","start":"2026-06-26T02:14:05.774108Z","end":"2026-06-26T02:14:06.161463Z","steps":["trace[767729751] 'read index received' (duration: 195.078397ms)","trace[767729751] 'applied index is now lower than readState.Index' (duration: 192.274586ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:14:06.161548Z","caller":"traceutil/trace.go:171","msg":"trace[1438819145] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"419.259616ms","start":"2026-06-26T02:14:05.742251Z","end":"2026-06-26T02:14:06.16151Z","steps":["trace[1438819145] 'process raft request' (duration: 227.063141ms)","trace[1438819145] 'compare' (duration: 191.138742ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:14:06.161698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.584967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-26T02:14:06.161734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:14:05.742195Z","time spent":"419.445787ms","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:14:06.161754Z","caller":"traceutil/trace.go:171","msg":"trace[300025835] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2205; }","duration":"387.660077ms","start":"2026-06-26T02:14:05.774073Z","end":"2026-06-26T02:14:06.161733Z","steps":["trace[300025835] 'agreement among raft nodes before linearized reading' (duration: 387.507456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:14:06.161791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:14:05.77405Z","time spent":"387.732358ms","remote":"127.0.0.1:50076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-26T02:14:06.161783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.319987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-26T02:14:06.161855Z","caller":"traceutil/trace.go:171","msg":"trace[1569188916] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2205; }","duration":"103.437ms","start":"2026-06-26T02:14:06.058398Z","end":"2026-06-26T02:14:06.161835Z","steps":["trace[1569188916] 'agreement among raft nodes before linearized reading' (duration: 103.189746ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:14:06.417641Z","caller":"traceutil/trace.go:171","msg":"trace[714326261] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"168.080762ms","start":"2026-06-26T02:14:06.249523Z","end":"2026-06-26T02:14:06.417604Z","steps":["trace[714326261] 'process raft request' (duration: 154.072705ms)","trace[714326261] 'compare' (duration: 13.741453ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:47.960513Z","caller":"traceutil/trace.go:171","msg":"trace[1872451534] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"116.460277ms","start":"2026-06-26T02:15:47.844025Z","end":"2026-06-26T02:15:47.960485Z","steps":["trace[1872451534] 'process raft request' (duration: 97.539646ms)","trace[1872451534] 'compare' (duration: 18.790706ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:26.842528Z","caller":"traceutil/trace.go:171","msg":"trace[1758458026] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"100.865661ms","start":"2026-06-26T02:19:26.741648Z","end":"2026-06-26T02:19:26.842514Z","steps":["trace[1758458026] 'process raft request' (duration: 43.878086ms)","trace[1758458026] 'compare' (duration: 56.800442ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:35.945147Z","caller":"traceutil/trace.go:171","msg":"trace[1786188014] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"140.196018ms","start":"2026-06-26T02:19:35.804924Z","end":"2026-06-26T02:19:35.94512Z","steps":["trace[1786188014] 'process raft request' (duration: 139.997005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:36.180419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.970661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T02:19:36.18051Z","caller":"traceutil/trace.go:171","msg":"trace[1561659274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4821; }","duration":"160.079173ms","start":"2026-06-26T02:19:36.020411Z","end":"2026-06-26T02:19:36.180491Z","steps":["trace[1561659274] 'range keys from in-memory index tree' (duration: 159.708857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:36.180674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.391997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-06-26T02:19:36.181299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.869026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-65f08250-b6e1-410e-9512-1b79fcada2e7\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-26T02:19:36.181375Z","caller":"traceutil/trace.go:171","msg":"trace[1050868972] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-65f08250-b6e1-410e-9512-1b79fcada2e7; range_end:; response_count:1; response_revision:4821; }","duration":"161.007128ms","start":"2026-06-26T02:19:36.020347Z","end":"2026-06-26T02:19:36.181354Z","steps":["trace[1050868972] 'range keys from in-memory index tree' (duration: 159.642196ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:36.181691Z","caller":"traceutil/trace.go:171","msg":"trace[315684975] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4821; }","duration":"146.501338ms","start":"2026-06-26T02:19:36.034247Z","end":"2026-06-26T02:19:36.180748Z","steps":["trace[315684975] 'range keys from in-memory index tree' (duration: 146.030141ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:36.571556Z","caller":"traceutil/trace.go:171","msg":"trace[650553267] linearizableReadLoop","detail":"{readStateIndex:5015; appliedIndex:5013; }","duration":"105.571572ms","start":"2026-06-26T02:19:36.465962Z","end":"2026-06-26T02:19:36.571533Z","steps":["trace[650553267] 'read index received' (duration: 2.267097ms)","trace[650553267] 'applied index is now lower than readState.Index' (duration: 103.301795ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:19:36.571725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.748775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-26T02:19:36.57171Z","caller":"traceutil/trace.go:171","msg":"trace[42727584] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"133.004636ms","start":"2026-06-26T02:19:36.438666Z","end":"2026-06-26T02:19:36.571671Z","steps":["trace[42727584] 'process raft request' (duration: 123.151723ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:36.571789Z","caller":"traceutil/trace.go:171","msg":"trace[27019811] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4825; }","duration":"105.859507ms","start":"2026-06-26T02:19:36.465917Z","end":"2026-06-26T02:19:36.571777Z","steps":["trace[27019811] 'agreement among raft nodes before linearized reading' (duration: 105.690785ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:37.688482Z","caller":"traceutil/trace.go:171","msg":"trace[203480957] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"125.665742ms","start":"2026-06-26T02:19:37.562789Z","end":"2026-06-26T02:19:37.688455Z","steps":["trace[203480957] 'process raft request' (duration: 84.985142ms)","trace[203480957] 'compare' (duration: 40.457867ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:20:40.763708Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2824} {"level":"info","ts":"2026-06-26T02:20:40.850538Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2824,"took":"85.180681ms","hash":2739421150,"current-db-size-bytes":53735424,"current-db-size":"54 MB","current-db-size-in-use-bytes":28790784,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-26T02:20:40.850604Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2739421150,"revision":2824,"compact-revision":-1} {"level":"warn","ts":"2026-06-26T02:23:15.712709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.302231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:23:15.712862Z","caller":"traceutil/trace.go:171","msg":"trace[1448299071] transaction","detail":"{read_only:false; response_revision:6540; number_of_response:1; }","duration":"145.66108ms","start":"2026-06-26T02:23:15.567179Z","end":"2026-06-26T02:23:15.71284Z","steps":["trace[1448299071] 'process raft request' (duration: 42.116417ms)","trace[1448299071] 'compare' (duration: 101.022218ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:23:15.994257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.122302ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:23:15.994367Z","caller":"traceutil/trace.go:171","msg":"trace[403902205] transaction","detail":"{read_only:false; response_revision:6541; number_of_response:1; }","duration":"194.515803ms","start":"2026-06-26T02:23:15.799833Z","end":"2026-06-26T02:23:15.994349Z","steps":["trace[403902205] 'process raft request' (duration: 85.186239ms)","trace[403902205] 'compare' (duration: 108.949499ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:25:40.771541Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5444} {"level":"info","ts":"2026-06-26T02:25:40.873493Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5444,"took":"100.416168ms","hash":1322374722,"current-db-size-bytes":53735424,"current-db-size":"54 MB","current-db-size-in-use-bytes":18833408,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-06-26T02:25:40.873551Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1322374722,"revision":5444,"compact-revision":2824}