{"level":"warn","ts":"2026-06-26T02:19:07.301646Z","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:19:07.301926Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.3: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.3:2380","--initial-cluster=instance=https://199.19.213.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.3: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:19:07.302076Z","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:19:07.302123Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-06-26T02:19:07.30217Z","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:19:07.303278Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"]} {"level":"info","ts":"2026-06-26T02:19:07.303473Z","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.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.3: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:19:07.31512Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"11.29892ms"} {"level":"info","ts":"2026-06-26T02:19:07.321267Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cf904ec39d3e333","cluster-id":"7b1ae51097bedd0e"} {"level":"info","ts":"2026-06-26T02:19:07.321438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T02:19:07.321492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 0"} {"level":"info","ts":"2026-06-26T02:19:07.32154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cf904ec39d3e333 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T02:19:07.321592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 1"} {"level":"info","ts":"2026-06-26T02:19:07.321673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"warn","ts":"2026-06-26T02:19:07.328328Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T02:19:07.329926Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T02:19:07.33153Z","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:19:07.334278Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cf904ec39d3e333","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T02:19:07.334511Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cf904ec39d3e333","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T02:19:07.334769Z","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:19:07.33489Z","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:19:07.334902Z","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:19:07.335503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"info","ts":"2026-06-26T02:19:07.336179Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","added-peer-id":"3cf904ec39d3e333","added-peer-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-06-26T02:19:07.340224Z","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:19:07.340551Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cf904ec39d3e333","initial-advertise-peer-urls":["https://199.19.213.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T02:19:07.340583Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T02:19:07.340877Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-06-26T02:19:07.340924Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-06-26T02:19:07.822685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T02:19:07.822759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T02:19:07.822786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgPreVoteResp from 3cf904ec39d3e333 at term 1"} {"level":"info","ts":"2026-06-26T02:19:07.822802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became candidate at term 2"} {"level":"info","ts":"2026-06-26T02:19:07.822808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgVoteResp from 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-06-26T02:19:07.822817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became leader at term 2"} {"level":"info","ts":"2026-06-26T02:19:07.822825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cf904ec39d3e333 elected leader 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-06-26T02:19:07.826531Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:19:07.827775Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cf904ec39d3e333","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.3:2379]}","request-path":"/0/members/3cf904ec39d3e333/attributes","cluster-id":"7b1ae51097bedd0e","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T02:19:07.827971Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:19:07.828264Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:19:07.828377Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:19:07.828431Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:19:07.828451Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:19:07.829915Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.3:2379"} {"level":"info","ts":"2026-06-26T02:19:07.832075Z","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:19:07.856267Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T02:19:07.856455Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-06-26T02:19:17.482943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.066033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4367"} {"level":"info","ts":"2026-06-26T02:19:17.48309Z","caller":"traceutil/trace.go:171","msg":"trace[1217707857] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:387; }","duration":"134.228238ms","start":"2026-06-26T02:19:17.348838Z","end":"2026-06-26T02:19:17.483066Z","steps":["trace[1217707857] 'range keys from in-memory index tree' (duration: 133.974002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:20.108818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.670336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5316"} {"level":"info","ts":"2026-06-26T02:19:20.109072Z","caller":"traceutil/trace.go:171","msg":"trace[1623236387] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:402; }","duration":"215.88451ms","start":"2026-06-26T02:19:19.893063Z","end":"2026-06-26T02:19:20.108948Z","steps":["trace[1623236387] 'range keys from in-memory index tree' (duration: 215.487973ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:23.793696Z","caller":"traceutil/trace.go:171","msg":"trace[1203590108] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"146.428206ms","start":"2026-06-26T02:19:23.647239Z","end":"2026-06-26T02:19:23.793667Z","steps":["trace[1203590108] 'process raft request' (duration: 59.749635ms)","trace[1203590108] 'compare' (duration: 86.552099ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:23.798318Z","caller":"traceutil/trace.go:171","msg":"trace[217435257] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"150.539527ms","start":"2026-06-26T02:19:23.647757Z","end":"2026-06-26T02:19:23.798297Z","steps":["trace[217435257] 'process raft request' (duration: 150.447395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:24.025689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.083301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4318"} {"level":"info","ts":"2026-06-26T02:19:24.025817Z","caller":"traceutil/trace.go:171","msg":"trace[329315605] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:417; }","duration":"122.261705ms","start":"2026-06-26T02:19:23.903524Z","end":"2026-06-26T02:19:24.025786Z","steps":["trace[329315605] 'range keys from in-memory index tree' (duration: 121.956848ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:25.915617Z","caller":"traceutil/trace.go:171","msg":"trace[312262874] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"109.074967ms","start":"2026-06-26T02:19:25.806512Z","end":"2026-06-26T02:19:25.915587Z","steps":["trace[312262874] 'process raft request' (duration: 88.406174ms)","trace[312262874] 'compare' (duration: 20.540551ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:31.87325Z","caller":"traceutil/trace.go:171","msg":"trace[179593605] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"144.378747ms","start":"2026-06-26T02:19:31.728844Z","end":"2026-06-26T02:19:31.873223Z","steps":["trace[179593605] 'process raft request' (duration: 144.105712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:32.442898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174089439,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:19:32.859507Z","caller":"traceutil/trace.go:171","msg":"trace[1106435220] linearizableReadLoop","detail":"{readStateIndex:450; appliedIndex:449; }","duration":"917.215338ms","start":"2026-06-26T02:19:31.942199Z","end":"2026-06-26T02:19:32.859415Z","steps":["trace[1106435220] 'read index received' (duration: 914.167427ms)","trace[1106435220] 'applied index is now lower than readState.Index' (duration: 3.046671ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:32.859543Z","caller":"traceutil/trace.go:171","msg":"trace[1748809896] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"982.206725ms","start":"2026-06-26T02:19:31.877261Z","end":"2026-06-26T02:19:32.859468Z","steps":["trace[1748809896] 'process raft request' (duration: 979.088383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:32.859678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.174059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:19:32.85973Z","caller":"traceutil/trace.go:171","msg":"trace[2144843009] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:435; }","duration":"733.431833ms","start":"2026-06-26T02:19:32.126281Z","end":"2026-06-26T02:19:32.859713Z","steps":["trace[2144843009] 'agreement among raft nodes before linearized reading' (duration: 733.334251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:32.859713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.476412ms","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:32.859815Z","caller":"traceutil/trace.go:171","msg":"trace[534988306] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:435; }","duration":"917.651916ms","start":"2026-06-26T02:19:31.942138Z","end":"2026-06-26T02:19:32.85979Z","steps":["trace[534988306] 'agreement among raft nodes before linearized reading' (duration: 917.434632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:32.8598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:32.126254Z","time spent":"733.527926ms","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:19:32.85988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:31.942111Z","time spent":"917.758928ms","remote":"127.0.0.1:33592","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":"warn","ts":"2026-06-26T02:19:32.859966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.811528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T02:19:32.860045Z","caller":"traceutil/trace.go:171","msg":"trace[535669709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:435; }","duration":"118.94887ms","start":"2026-06-26T02:19:32.741077Z","end":"2026-06-26T02:19:32.860026Z","steps":["trace[535669709] 'agreement among raft nodes before linearized reading' (duration: 118.767317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:32.860328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:31.877228Z","time spent":"982.415749ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:19:35.042775Z","caller":"traceutil/trace.go:171","msg":"trace[1069013274] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"123.480388ms","start":"2026-06-26T02:19:34.919249Z","end":"2026-06-26T02:19:35.04273Z","steps":["trace[1069013274] 'process raft request' (duration: 81.088882ms)","trace[1069013274] 'compare' (duration: 42.07522ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:42.883505Z","caller":"traceutil/trace.go:171","msg":"trace[292633538] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"935.22023ms","start":"2026-06-26T02:19:41.948257Z","end":"2026-06-26T02:19:42.883477Z","steps":["trace[292633538] 'process raft request' (duration: 935.048377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:42.883707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:41.948215Z","time spent":"935.381133ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:19:50.605459Z","caller":"traceutil/trace.go:171","msg":"trace[2104084494] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"942.331518ms","start":"2026-06-26T02:19:49.6631Z","end":"2026-06-26T02:19:50.605431Z","steps":["trace[2104084494] 'process raft request' (duration: 942.161985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.605628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.663075Z","time spent":"942.47371ms","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.791288Z","caller":"traceutil/trace.go:171","msg":"trace[791455002] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.127984896s","start":"2026-06-26T02:19:49.663202Z","end":"2026-06-26T02:19:50.791187Z","steps":["trace[791455002] 'process raft request' (duration: 1.127608608s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.791566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.663163Z","time spent":"1.128286272s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.791944Z","caller":"traceutil/trace.go:171","msg":"trace[146861247] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:558; }","duration":"663.098228ms","start":"2026-06-26T02:19:50.128783Z","end":"2026-06-26T02:19:50.791881Z","steps":["trace[146861247] 'read index received' (duration: 476.606124ms)","trace[146861247] 'applied index is now lower than readState.Index' (duration: 186.490874ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:50.791969Z","caller":"traceutil/trace.go:171","msg":"trace[62025358] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.054382529s","start":"2026-06-26T02:19:49.737546Z","end":"2026-06-26T02:19:50.791928Z","steps":["trace[62025358] 'process raft request' (duration: 1.054075564s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.792172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.737503Z","time spent":"1.054573142s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.792197Z","caller":"traceutil/trace.go:171","msg":"trace[1094352427] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.085154615s","start":"2026-06-26T02:19:49.70703Z","end":"2026-06-26T02:19:50.792185Z","steps":["trace[1094352427] 'process raft request' (duration: 1.084452672s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.792316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.707019Z","time spent":"1.085221806s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.792345Z","caller":"traceutil/trace.go:171","msg":"trace[278212575] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"925.801178ms","start":"2026-06-26T02:19:49.866532Z","end":"2026-06-26T02:19:50.792333Z","steps":["trace[278212575] 'process raft request' (duration: 925.188676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.792391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.86648Z","time spent":"925.8892ms","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.792469Z","caller":"traceutil/trace.go:171","msg":"trace[993632754] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.07195041s","start":"2026-06-26T02:19:49.720509Z","end":"2026-06-26T02:19:50.792459Z","steps":["trace[993632754] 'process raft request' (duration: 1.071047523s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.792522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.7205Z","time spent":"1.071999661s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.792561Z","caller":"traceutil/trace.go:171","msg":"trace[2009251713] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.105498799s","start":"2026-06-26T02:19:49.686394Z","end":"2026-06-26T02:19:50.791893Z","steps":["trace[2009251713] 'process raft request' (duration: 1.10503095s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:50.792709Z","caller":"traceutil/trace.go:171","msg":"trace[1866057299] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"543.436269ms","start":"2026-06-26T02:19:50.249259Z","end":"2026-06-26T02:19:50.792696Z","steps":["trace[1866057299] 'process raft request' (duration: 542.535501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.792795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:50.24923Z","time spent":"543.510311ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:19:50.792827Z","caller":"traceutil/trace.go:171","msg":"trace[230954600] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.109656511s","start":"2026-06-26T02:19:49.683132Z","end":"2026-06-26T02:19:50.792789Z","steps":["trace[230954600] 'process raft request' (duration: 1.108143351s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:50.792853Z","caller":"traceutil/trace.go:171","msg":"trace[1717803215] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.113812651s","start":"2026-06-26T02:19:49.678956Z","end":"2026-06-26T02:19:50.792768Z","steps":["trace[1717803215] 'process raft request' (duration: 1.11220147s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.793579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.678921Z","time spent":"1.114610466s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:19:50.792914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.683126Z","time spent":"1.109747592s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.792969Z","caller":"traceutil/trace.go:171","msg":"trace[1892420987] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.106618961s","start":"2026-06-26T02:19:49.686338Z","end":"2026-06-26T02:19:50.792957Z","steps":["trace[1892420987] 'process raft request' (duration: 1.10501505s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.792981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.686388Z","time spent":"1.106349586s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.79302Z","caller":"traceutil/trace.go:171","msg":"trace[2005823163] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.127509586s","start":"2026-06-26T02:19:49.665498Z","end":"2026-06-26T02:19:50.793008Z","steps":["trace[2005823163] 'process raft request' (duration: 1.125536988s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.794092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.665493Z","time spent":"1.128567436s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.793083Z","caller":"traceutil/trace.go:171","msg":"trace[1140197171] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"1.118197206s","start":"2026-06-26T02:19:49.674874Z","end":"2026-06-26T02:19:50.793072Z","steps":["trace[1140197171] 'process raft request' (duration: 1.116208388s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.794211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.674866Z","time spent":"1.119308118s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:19:50.793042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.23483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:19:50.79434Z","caller":"traceutil/trace.go:171","msg":"trace[951312721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"665.618826ms","start":"2026-06-26T02:19:50.128693Z","end":"2026-06-26T02:19:50.794311Z","steps":["trace[951312721] 'agreement among raft nodes before linearized reading' (duration: 664.168818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:50.79439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:50.128661Z","time spent":"665.712608ms","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:19:50.793919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:49.686333Z","time spent":"1.107470728s","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:19:50.800998Z","caller":"traceutil/trace.go:171","msg":"trace[904804725] transaction","detail":"{read_only:false; number_of_response:1; response_revision:554; }","duration":"186.011234ms","start":"2026-06-26T02:19:50.614956Z","end":"2026-06-26T02:19:50.800968Z","steps":["trace[904804725] 'process raft request' (duration: 185.967553ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:50.801167Z","caller":"traceutil/trace.go:171","msg":"trace[1461874739] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"187.093536ms","start":"2026-06-26T02:19:50.614066Z","end":"2026-06-26T02:19:50.80116Z","steps":["trace[1461874739] 'process raft request' (duration: 186.721749ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:50.801194Z","caller":"traceutil/trace.go:171","msg":"trace[1693881368] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"186.977643ms","start":"2026-06-26T02:19:50.614194Z","end":"2026-06-26T02:19:50.801172Z","steps":["trace[1693881368] 'process raft request' (duration: 186.694418ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:57.224747Z","caller":"traceutil/trace.go:171","msg":"trace[1452858225] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"258.04954ms","start":"2026-06-26T02:19:56.966665Z","end":"2026-06-26T02:19:57.224715Z","steps":["trace[1452858225] 'process raft request' (duration: 257.756304ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:57.613976Z","caller":"traceutil/trace.go:171","msg":"trace[1389162884] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:671; }","duration":"609.628622ms","start":"2026-06-26T02:19:57.004285Z","end":"2026-06-26T02:19:57.613913Z","steps":["trace[1389162884] 'read index received' (duration: 220.188707ms)","trace[1389162884] 'applied index is now lower than readState.Index' (duration: 389.438535ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:57.61404Z","caller":"traceutil/trace.go:171","msg":"trace[1137925405] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"610.815976ms","start":"2026-06-26T02:19:57.003175Z","end":"2026-06-26T02:19:57.613991Z","steps":["trace[1137925405] 'process raft request' (duration: 609.768105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:57.614257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.003144Z","time spent":"610.991809ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:19:57.614254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.668237ms","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:19:57.614281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.167915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:19:57.614269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.55015ms","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:19:57.614268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.963859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbbrd\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-06-26T02:19:57.614343Z","caller":"traceutil/trace.go:171","msg":"trace[869846406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"493.270737ms","start":"2026-06-26T02:19:57.121054Z","end":"2026-06-26T02:19:57.614325Z","steps":["trace[869846406] 'agreement among raft nodes before linearized reading' (duration: 493.158015ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:57.614364Z","caller":"traceutil/trace.go:171","msg":"trace[338768660] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"465.650672ms","start":"2026-06-26T02:19:57.148688Z","end":"2026-06-26T02:19:57.614338Z","steps":["trace[338768660] 'agreement among raft nodes before linearized reading' (duration: 465.490179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:57.614383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.121043Z","time spent":"493.332058ms","remote":"127.0.0.1:33368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:19:57.614322Z","caller":"traceutil/trace.go:171","msg":"trace[200813127] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"570.789549ms","start":"2026-06-26T02:19:57.043519Z","end":"2026-06-26T02:19:57.614309Z","steps":["trace[200813127] 'agreement among raft nodes before linearized reading' (duration: 570.639717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:57.614404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.282113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-26T02:19:57.614412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.148651Z","time spent":"465.751534ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-26T02:19:57.614445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.043498Z","time spent":"570.935713ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T02:19:57.614435Z","caller":"traceutil/trace.go:171","msg":"trace[2039925013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"548.356705ms","start":"2026-06-26T02:19:57.06607Z","end":"2026-06-26T02:19:57.614426Z","steps":["trace[2039925013] 'agreement among raft nodes before linearized reading' (duration: 548.273013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:57.614497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.066056Z","time spent":"548.431716ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:19:57.614378Z","caller":"traceutil/trace.go:171","msg":"trace[586766265] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbbrd; range_end:; response_count:1; response_revision:648; }","duration":"610.117071ms","start":"2026-06-26T02:19:57.004232Z","end":"2026-06-26T02:19:57.61435Z","steps":["trace[586766265] 'agreement among raft nodes before linearized reading' (duration: 609.840266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:57.614612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.004206Z","time spent":"610.382347ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16979,"request content":"key:\"/registry/pods/kube-system/cilium-kbbrd\" "} {"level":"warn","ts":"2026-06-26T02:19:58.625669Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174089831,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:19:58.817331Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.149251767s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:19:58.8181Z","caller":"traceutil/trace.go:171","msg":"trace[453324548] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"1.197322268s","start":"2026-06-26T02:19:57.620752Z","end":"2026-06-26T02:19:58.818074Z","steps":["trace[453324548] 'process raft request' (duration: 1.197202336s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:58.818259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.620721Z","time spent":"1.197436821s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:19:58.818276Z","caller":"traceutil/trace.go:171","msg":"trace[327961971] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"1.190823493s","start":"2026-06-26T02:19:57.627421Z","end":"2026-06-26T02:19:58.818244Z","steps":["trace[327961971] 'process raft request' (duration: 1.190583849s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:58.818482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.627406Z","time spent":"1.190986076s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:19:58.818091Z","caller":"traceutil/trace.go:171","msg":"trace[1168621417] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.197300538s","start":"2026-06-26T02:19:57.620733Z","end":"2026-06-26T02:19:58.818033Z","steps":["trace[1168621417] 'process raft request' (duration: 1.197034692s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:58.818961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.620705Z","time spent":"1.198213955s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:19:58.896808Z","caller":"traceutil/trace.go:171","msg":"trace[469657676] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"1.224911603s","start":"2026-06-26T02:19:57.671868Z","end":"2026-06-26T02:19:58.89678Z","steps":["trace[469657676] 'process raft request' (duration: 1.224714669s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:58.896948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:57.671836Z","time spent":"1.225036146s","remote":"127.0.0.1:33868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:19:58.897287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.570709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:19:58.897909Z","caller":"traceutil/trace.go:171","msg":"trace[836963093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"773.240973ms","start":"2026-06-26T02:19:58.124646Z","end":"2026-06-26T02:19:58.897887Z","steps":["trace[836963093] 'agreement among raft nodes before linearized reading' (duration: 772.305334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:58.897976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:58.124603Z","time spent":"773.358695ms","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:19:58.896763Z","caller":"traceutil/trace.go:171","msg":"trace[1769342648] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:674; }","duration":"772.026479ms","start":"2026-06-26T02:19:58.124711Z","end":"2026-06-26T02:19:58.896737Z","steps":["trace[1769342648] 'read index received' (duration: 693.049518ms)","trace[1769342648] 'applied index is now lower than readState.Index' (duration: 78.975731ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:00.174749Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174089840,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:20:00.375047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145480584s","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:20:00.375168Z","caller":"traceutil/trace.go:171","msg":"trace[1037832664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:653; }","duration":"1.145627957s","start":"2026-06-26T02:19:59.229489Z","end":"2026-06-26T02:20:00.375117Z","steps":["trace[1037832664] 'range keys from in-memory index tree' (duration: 1.145283801s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:00.375226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:59.229465Z","time spent":"1.145747509s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:20:00.675564Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174089840,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:20:01.176709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174089840,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:20:01.363143Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.060591694s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:20:01.364425Z","caller":"traceutil/trace.go:171","msg":"trace[1036514060] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"2.064101842s","start":"2026-06-26T02:19:59.300294Z","end":"2026-06-26T02:20:01.364395Z","steps":["trace[1036514060] 'process raft request' (duration: 2.063330408s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:01.364585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:59.300255Z","time spent":"2.064247935s","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:01.379081Z","caller":"traceutil/trace.go:171","msg":"trace[1533336283] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"999.149189ms","start":"2026-06-26T02:20:00.379892Z","end":"2026-06-26T02:20:01.379041Z","steps":["trace[1533336283] 'process raft request' (duration: 997.314683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:01.379233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:00.379867Z","time spent":"999.281781ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:01.379498Z","caller":"traceutil/trace.go:171","msg":"trace[100911259] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"408.207549ms","start":"2026-06-26T02:20:00.971279Z","end":"2026-06-26T02:20:01.379487Z","steps":["trace[100911259] 'process raft request' (duration: 406.566287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:01.379554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:00.97126Z","time spent":"408.262999ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:01.381037Z","caller":"traceutil/trace.go:171","msg":"trace[1278905884] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:678; }","duration":"1.707246148s","start":"2026-06-26T02:19:59.673738Z","end":"2026-06-26T02:20:01.380984Z","steps":["trace[1278905884] 'read index received' (duration: 1.689724469s)","trace[1278905884] 'applied index is now lower than readState.Index' (duration: 17.519188ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:01.420837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.268783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-26T02:20:01.421045Z","caller":"traceutil/trace.go:171","msg":"trace[924698842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:656; }","duration":"596.539578ms","start":"2026-06-26T02:20:00.824484Z","end":"2026-06-26T02:20:01.421023Z","steps":["trace[924698842] 'agreement among raft nodes before linearized reading' (duration: 557.43442ms)","trace[924698842] 'range keys from in-memory index tree' (duration: 38.624168ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:01.42113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:00.824461Z","time spent":"596.64353ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:20:01.421147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.29960703s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:20:01.421226Z","caller":"traceutil/trace.go:171","msg":"trace[72582591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"1.299748652s","start":"2026-06-26T02:20:00.121454Z","end":"2026-06-26T02:20:01.421203Z","steps":["trace[72582591] 'agreement among raft nodes before linearized reading' (duration: 1.260061913s)","trace[72582591] 'range keys from in-memory index tree' (duration: 39.466835ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:01.421262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:00.121427Z","time spent":"1.299829504s","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:20:01.421491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.21522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-26T02:20:01.421536Z","caller":"traceutil/trace.go:171","msg":"trace[1225423803] range","detail":"{range_begin:/registry/masterleases/199.19.213.3; range_end:; response_count:1; response_revision:656; }","duration":"390.301022ms","start":"2026-06-26T02:20:01.031225Z","end":"2026-06-26T02:20:01.421527Z","steps":["trace[1225423803] 'agreement among raft nodes before linearized reading' (duration: 350.509532ms)","trace[1225423803] 'range keys from in-memory index tree' (duration: 39.573647ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:01.42156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.747846095s","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:20:01.421586Z","caller":"traceutil/trace.go:171","msg":"trace[687137914] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:656; }","duration":"1.747912026s","start":"2026-06-26T02:19:59.673666Z","end":"2026-06-26T02:20:01.421578Z","steps":["trace[687137914] 'agreement among raft nodes before linearized reading' (duration: 1.707759198s)","trace[687137914] 'range keys from in-memory index tree' (duration: 39.993354ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:01.421794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:19:59.67364Z","time spent":"1.74814973s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T02:20:01.421569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:01.031207Z","time spent":"390.356634ms","remote":"127.0.0.1:33378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":153,"request content":"key:\"/registry/masterleases/199.19.213.3\" "} {"level":"warn","ts":"2026-06-26T02:20:01.421975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.419334ms","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:20:01.422062Z","caller":"traceutil/trace.go:171","msg":"trace[391977219] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"597.542287ms","start":"2026-06-26T02:20:00.824512Z","end":"2026-06-26T02:20:01.422054Z","steps":["trace[391977219] 'agreement among raft nodes before linearized reading' (duration: 557.375419ms)","trace[391977219] 'range keys from in-memory index tree' (duration: 40.030775ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:01.422121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:00.824491Z","time spent":"597.624069ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T02:20:03.464592Z","caller":"traceutil/trace.go:171","msg":"trace[760159119] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"143.088212ms","start":"2026-06-26T02:20:03.32147Z","end":"2026-06-26T02:20:03.464558Z","steps":["trace[760159119] 'process raft request' (duration: 142.888539ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:20:14.686961Z","caller":"traceutil/trace.go:171","msg":"trace[956641941] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"320.724314ms","start":"2026-06-26T02:20:14.3662Z","end":"2026-06-26T02:20:14.686924Z","steps":["trace[956641941] 'process raft request' (duration: 320.50444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:14.687177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:14.366168Z","time spent":"320.900827ms","remote":"127.0.0.1:33498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4903,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:20:18.528525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.797303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:20:18.52866Z","caller":"traceutil/trace.go:171","msg":"trace[377844878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:821; }","duration":"404.996307ms","start":"2026-06-26T02:20:18.123635Z","end":"2026-06-26T02:20:18.528631Z","steps":["trace[377844878] 'range keys from in-memory index tree' (duration: 404.713621ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.52872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.123612Z","time spent":"405.094148ms","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:20:18.529215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.976107ms","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:20:18.529291Z","caller":"traceutil/trace.go:171","msg":"trace[1654681036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:821; }","duration":"979.065461ms","start":"2026-06-26T02:20:17.550204Z","end":"2026-06-26T02:20:18.52927Z","steps":["trace[1654681036] 'range keys from in-memory index tree' (duration: 978.788295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.529342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:17.550196Z","time spent":"979.133932ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:20:18.528568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.067608ms","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":"warn","ts":"2026-06-26T02:20:18.529515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.292196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:20:18.529536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.343296ms","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:20:18.52953Z","caller":"traceutil/trace.go:171","msg":"trace[322285079] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:821; }","duration":"582.086859ms","start":"2026-06-26T02:20:17.9474Z","end":"2026-06-26T02:20:18.529487Z","steps":["trace[322285079] 'count revisions from in-memory index tree' (duration: 580.933146ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:20:18.529629Z","caller":"traceutil/trace.go:171","msg":"trace[2115480263] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:821; }","duration":"432.460349ms","start":"2026-06-26T02:20:18.097137Z","end":"2026-06-26T02:20:18.529598Z","steps":["trace[2115480263] 'count revisions from in-memory index tree' (duration: 432.169453ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:20:18.529637Z","caller":"traceutil/trace.go:171","msg":"trace[901190725] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:821; }","duration":"978.501679ms","start":"2026-06-26T02:20:17.551112Z","end":"2026-06-26T02:20:18.529614Z","steps":["trace[901190725] 'range keys from in-memory index tree' (duration: 978.064971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.529687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:17.551084Z","time spent":"978.59335ms","remote":"127.0.0.1:33592","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":"warn","ts":"2026-06-26T02:20:18.529681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:17.94737Z","time spent":"582.261701ms","remote":"127.0.0.1:33878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":94,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:20:18.529686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.097111Z","time spent":"432.562741ms","remote":"127.0.0.1:33482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:20:18.529585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.577082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T02:20:18.530916Z","caller":"traceutil/trace.go:171","msg":"trace[1334444599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:821; }","duration":"977.925408ms","start":"2026-06-26T02:20:17.552968Z","end":"2026-06-26T02:20:18.530893Z","steps":["trace[1334444599] 'range keys from in-memory index tree' (duration: 976.379348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.530995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:17.552957Z","time spent":"978.0216ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:20:18.530809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.986887ms","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:20:18.531103Z","caller":"traceutil/trace.go:171","msg":"trace[164604928] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:821; }","duration":"982.477886ms","start":"2026-06-26T02:20:17.54859Z","end":"2026-06-26T02:20:18.531068Z","steps":["trace[164604928] 'range keys from in-memory index tree' (duration: 981.782492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.53124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:17.548562Z","time spent":"982.598048ms","remote":"127.0.0.1:33592","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":"warn","ts":"2026-06-26T02:20:18.835811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174090245,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:20:18.871902Z","caller":"traceutil/trace.go:171","msg":"trace[1919487651] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"730.715037ms","start":"2026-06-26T02:20:18.141107Z","end":"2026-06-26T02:20:18.871822Z","steps":["trace[1919487651] 'process raft request' (duration: 730.464203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.872292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.141065Z","time spent":"731.042265ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:18.880496Z","caller":"traceutil/trace.go:171","msg":"trace[2085146901] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"345.866562ms","start":"2026-06-26T02:20:18.534451Z","end":"2026-06-26T02:20:18.880317Z","steps":["trace[2085146901] 'process raft request' (duration: 345.490615ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:20:18.880678Z","caller":"traceutil/trace.go:171","msg":"trace[1627578355] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"344.214859ms","start":"2026-06-26T02:20:18.536389Z","end":"2026-06-26T02:20:18.880604Z","steps":["trace[1627578355] 'process raft request' (duration: 344.012025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.880798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.534433Z","time spent":"346.164588ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:20:18.880972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.536375Z","time spent":"344.428154ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:18.880961Z","caller":"traceutil/trace.go:171","msg":"trace[36441847] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"344.24326ms","start":"2026-06-26T02:20:18.536678Z","end":"2026-06-26T02:20:18.880921Z","steps":["trace[36441847] 'process raft request' (duration: 343.842053ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:20:18.881226Z","caller":"traceutil/trace.go:171","msg":"trace[692562356] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"344.468195ms","start":"2026-06-26T02:20:18.536744Z","end":"2026-06-26T02:20:18.881212Z","steps":["trace[692562356] 'process raft request' (duration: 344.060817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.881302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.536736Z","time spent":"344.530336ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:18.881204Z","caller":"traceutil/trace.go:171","msg":"trace[1972076728] linearizableReadLoop","detail":"{readStateIndex:857; appliedIndex:853; }","duration":"545.818766ms","start":"2026-06-26T02:20:18.335355Z","end":"2026-06-26T02:20:18.881173Z","steps":["trace[1972076728] 'read index received' (duration: 536.478145ms)","trace[1972076728] 'applied index is now lower than readState.Index' (duration: 9.338941ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:18.881335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.978909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T02:20:18.881316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.536668Z","time spent":"344.513905ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:18.8814Z","caller":"traceutil/trace.go:171","msg":"trace[620852056] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:826; }","duration":"546.081991ms","start":"2026-06-26T02:20:18.335302Z","end":"2026-06-26T02:20:18.881384Z","steps":["trace[620852056] 'agreement among raft nodes before linearized reading' (duration: 545.952008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.881572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.109225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:20:18.881588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.335258Z","time spent":"546.281935ms","remote":"127.0.0.1:33750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-06-26T02:20:18.881649Z","caller":"traceutil/trace.go:171","msg":"trace[1908270082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:826; }","duration":"348.201116ms","start":"2026-06-26T02:20:18.533408Z","end":"2026-06-26T02:20:18.88161Z","steps":["trace[1908270082] 'agreement among raft nodes before linearized reading' (duration: 348.077214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:18.881694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:18.533388Z","time spent":"348.296787ms","remote":"127.0.0.1:33368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:20:53.455246Z","caller":"traceutil/trace.go:171","msg":"trace[1927871035] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"104.384772ms","start":"2026-06-26T02:20:53.350825Z","end":"2026-06-26T02:20:53.45521Z","steps":["trace[1927871035] 'process raft request' (duration: 45.725496ms)","trace[1927871035] 'compare' (duration: 58.527174ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:20:55.121773Z","caller":"traceutil/trace.go:171","msg":"trace[2059162204] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"228.549599ms","start":"2026-06-26T02:20:54.893195Z","end":"2026-06-26T02:20:55.121744Z","steps":["trace[2059162204] 'process raft request' (duration: 228.280254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:56.35975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.526114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:20:56.359953Z","caller":"traceutil/trace.go:171","msg":"trace[33486123] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"1.231595927s","start":"2026-06-26T02:20:55.128343Z","end":"2026-06-26T02:20:56.359938Z","steps":["trace[33486123] 'process raft request' (duration: 1.231534076s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:56.360019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:55.128337Z","time spent":"1.231649838s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:56.360238Z","caller":"traceutil/trace.go:171","msg":"trace[698009620] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"1.232359411s","start":"2026-06-26T02:20:55.127726Z","end":"2026-06-26T02:20:56.360085Z","steps":["trace[698009620] 'process raft request' (duration: 642.267687ms)","trace[698009620] 'compare' (duration: 589.044104ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:20:56.360523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:55.127708Z","time spent":"1.232604836s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:56.361023Z","caller":"traceutil/trace.go:171","msg":"trace[1954086962] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"1.232033605s","start":"2026-06-26T02:20:55.127983Z","end":"2026-06-26T02:20:56.360016Z","steps":["trace[1954086962] 'process raft request' (duration: 1.231846142s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:56.361161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:55.127963Z","time spent":"1.233119076s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:56.362876Z","caller":"traceutil/trace.go:171","msg":"trace[466242395] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"1.234442932s","start":"2026-06-26T02:20:55.128387Z","end":"2026-06-26T02:20:56.36283Z","steps":["trace[466242395] 'process raft request' (duration: 1.231514475s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:20:56.362932Z","caller":"traceutil/trace.go:171","msg":"trace[1872251779] linearizableReadLoop","detail":"{readStateIndex:1082; appliedIndex:1078; }","duration":"1.082840733s","start":"2026-06-26T02:20:55.280064Z","end":"2026-06-26T02:20:56.362905Z","steps":["trace[1872251779] 'read index received' (duration: 489.941864ms)","trace[1872251779] 'applied index is now lower than readState.Index' (duration: 592.897539ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:20:56.363051Z","caller":"traceutil/trace.go:171","msg":"trace[875158238] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"901.407428ms","start":"2026-06-26T02:20:55.461635Z","end":"2026-06-26T02:20:56.363042Z","steps":["trace[875158238] 'process raft request' (duration: 901.083712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:56.363068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:55.128384Z","time spent":"1.234586734s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:20:56.363178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:55.461603Z","time spent":"901.47758ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:20:56.363258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.587536ms","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:20:56.363315Z","caller":"traceutil/trace.go:171","msg":"trace[117780659] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1045; }","duration":"476.717218ms","start":"2026-06-26T02:20:55.886589Z","end":"2026-06-26T02:20:56.363306Z","steps":["trace[117780659] 'agreement among raft nodes before linearized reading' (duration: 476.613996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:56.363352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:55.886529Z","time spent":"476.80621ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":11,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:20:56.363428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.083364215s","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:20:56.363486Z","caller":"traceutil/trace.go:171","msg":"trace[660444557] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1045; }","duration":"1.083463636s","start":"2026-06-26T02:20:55.280007Z","end":"2026-06-26T02:20:56.36347Z","steps":["trace[660444557] 'agreement among raft nodes before linearized reading' (duration: 1.083298582s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:56.363528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:55.279983Z","time spent":"1.083536818s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T02:21:21.268843Z","caller":"traceutil/trace.go:171","msg":"trace[938175941] linearizableReadLoop","detail":"{readStateIndex:1168; appliedIndex:1167; }","duration":"144.596032ms","start":"2026-06-26T02:21:21.124219Z","end":"2026-06-26T02:21:21.268815Z","steps":["trace[938175941] 'read index received' (duration: 144.410848ms)","trace[938175941] 'applied index is now lower than readState.Index' (duration: 183.343µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:21:21.269014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.777257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:21.269053Z","caller":"traceutil/trace.go:171","msg":"trace[526263060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1124; }","duration":"144.893569ms","start":"2026-06-26T02:21:21.124147Z","end":"2026-06-26T02:21:21.269041Z","steps":["trace[526263060] 'agreement among raft nodes before linearized reading' (duration: 144.791997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:21.770986Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174090923,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:21:22.271371Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174090923,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:21:22.399448Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.074488552s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:21:22.399779Z","caller":"traceutil/trace.go:171","msg":"trace[482703835] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"1.129533939s","start":"2026-06-26T02:21:21.270225Z","end":"2026-06-26T02:21:22.399759Z","steps":["trace[482703835] 'process raft request' (duration: 1.129393566s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:22.399844Z","caller":"traceutil/trace.go:171","msg":"trace[1223986374] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1169; }","duration":"1.129466227s","start":"2026-06-26T02:21:21.27035Z","end":"2026-06-26T02:21:22.399816Z","steps":["trace[1223986374] 'read index received' (duration: 1.129395845s)","trace[1223986374] 'applied index is now lower than readState.Index' (duration: 68.032µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:21:22.400502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:21.270192Z","time spent":"1.129647021s","remote":"127.0.0.1:33378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:21:22.400921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.120169ms","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:21:22.400967Z","caller":"traceutil/trace.go:171","msg":"trace[2039646183] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1125; }","duration":"988.21177ms","start":"2026-06-26T02:21:21.412746Z","end":"2026-06-26T02:21:22.400958Z","steps":["trace[2039646183] 'agreement among raft nodes before linearized reading' (duration: 987.295832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:22.400985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:21.412724Z","time spent":"988.256141ms","remote":"127.0.0.1:33664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:21:22.401021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130628439s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:22.401186Z","caller":"traceutil/trace.go:171","msg":"trace[784952745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1125; }","duration":"1.130854724s","start":"2026-06-26T02:21:21.270302Z","end":"2026-06-26T02:21:22.401157Z","steps":["trace[784952745] 'agreement among raft nodes before linearized reading' (duration: 1.129668031s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:22.401244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:21.270285Z","time spent":"1.130950766s","remote":"127.0.0.1:33368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:21:22.63904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.455287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:22.639174Z","caller":"traceutil/trace.go:171","msg":"trace[1930380923] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1125; }","duration":"181.608289ms","start":"2026-06-26T02:21:22.457513Z","end":"2026-06-26T02:21:22.639121Z","steps":["trace[1930380923] 'count revisions from in-memory index tree' (duration: 181.364195ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:22.63925Z","caller":"traceutil/trace.go:171","msg":"trace[462955609] linearizableReadLoop","detail":"{readStateIndex:1170; appliedIndex:1169; }","duration":"166.013997ms","start":"2026-06-26T02:21:22.473211Z","end":"2026-06-26T02:21:22.639225Z","steps":["trace[462955609] 'read index received' (duration: 144.191465ms)","trace[462955609] 'applied index is now lower than readState.Index' (duration: 21.820762ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:21:22.639534Z","caller":"traceutil/trace.go:171","msg":"trace[1037013229] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"174.650963ms","start":"2026-06-26T02:21:22.464867Z","end":"2026-06-26T02:21:22.639518Z","steps":["trace[1037013229] 'process raft request' (duration: 152.537066ms)","trace[1037013229] 'compare' (duration: 21.350693ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:21:22.639769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.355457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T02:21:22.63981Z","caller":"traceutil/trace.go:171","msg":"trace[724659896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1126; }","duration":"146.430998ms","start":"2026-06-26T02:21:22.493364Z","end":"2026-06-26T02:21:22.639795Z","steps":["trace[724659896] 'agreement among raft nodes before linearized reading' (duration: 146.254663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:22.639904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.202052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:21:22.640001Z","caller":"traceutil/trace.go:171","msg":"trace[955436628] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1126; }","duration":"133.392856ms","start":"2026-06-26T02:21:22.506584Z","end":"2026-06-26T02:21:22.639977Z","steps":["trace[955436628] 'agreement among raft nodes before linearized reading' (duration: 133.0663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:22.640036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.731368ms","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:21:22.640082Z","caller":"traceutil/trace.go:171","msg":"trace[1376316180] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1126; }","duration":"140.8156ms","start":"2026-06-26T02:21:22.499254Z","end":"2026-06-26T02:21:22.64007Z","steps":["trace[1376316180] 'agreement among raft nodes before linearized reading' (duration: 140.604376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:22.640149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.879214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-26T02:21:22.640313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.779443ms","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:21:22.640356Z","caller":"traceutil/trace.go:171","msg":"trace[1584232678] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1126; }","duration":"167.131358ms","start":"2026-06-26T02:21:22.473177Z","end":"2026-06-26T02:21:22.640308Z","steps":["trace[1584232678] 'agreement among raft nodes before linearized reading' (duration: 166.505626ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:22.640402Z","caller":"traceutil/trace.go:171","msg":"trace[1551585657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1126; }","duration":"133.889665ms","start":"2026-06-26T02:21:22.506494Z","end":"2026-06-26T02:21:22.640383Z","steps":["trace[1551585657] 'agreement among raft nodes before linearized reading' (duration: 133.66003ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:22.860305Z","caller":"traceutil/trace.go:171","msg":"trace[638119083] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"215.006756ms","start":"2026-06-26T02:21:22.645276Z","end":"2026-06-26T02:21:22.860283Z","steps":["trace[638119083] 'process raft request' (duration: 214.944875ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:22.860402Z","caller":"traceutil/trace.go:171","msg":"trace[1417790833] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"215.078287ms","start":"2026-06-26T02:21:22.645256Z","end":"2026-06-26T02:21:22.860334Z","steps":["trace[1417790833] 'process raft request' (duration: 214.820112ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:22.861549Z","caller":"traceutil/trace.go:171","msg":"trace[1869005168] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"215.826512ms","start":"2026-06-26T02:21:22.645703Z","end":"2026-06-26T02:21:22.861529Z","steps":["trace[1869005168] 'process raft request' (duration: 215.573407ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:22.86167Z","caller":"traceutil/trace.go:171","msg":"trace[1453841246] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"189.555703ms","start":"2026-06-26T02:21:22.672073Z","end":"2026-06-26T02:21:22.861629Z","steps":["trace[1453841246] 'process raft request' (duration: 189.362449ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:22.861546Z","caller":"traceutil/trace.go:171","msg":"trace[1471088970] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"216.197879ms","start":"2026-06-26T02:21:22.645316Z","end":"2026-06-26T02:21:22.861514Z","steps":["trace[1471088970] 'process raft request' (duration: 214.938024ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:25.214093Z","caller":"traceutil/trace.go:171","msg":"trace[557619979] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"333.728397ms","start":"2026-06-26T02:21:24.880333Z","end":"2026-06-26T02:21:25.214062Z","steps":["trace[557619979] 'process raft request' (duration: 332.934622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:25.214253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:24.880312Z","time spent":"333.857549ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:21:25.214419Z","caller":"traceutil/trace.go:171","msg":"trace[869403791] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"332.267589ms","start":"2026-06-26T02:21:24.882106Z","end":"2026-06-26T02:21:25.214374Z","steps":["trace[869403791] 'process raft request' (duration: 331.900912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:25.214675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:24.882093Z","time spent":"332.433913ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:21:25.215274Z","caller":"traceutil/trace.go:171","msg":"trace[885594649] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1179; }","duration":"160.258495ms","start":"2026-06-26T02:21:25.054987Z","end":"2026-06-26T02:21:25.215245Z","steps":["trace[885594649] 'read index received' (duration: 157.636664ms)","trace[885594649] 'applied index is now lower than readState.Index' (duration: 2.620451ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:21:25.215433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.423358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:21:25.21547Z","caller":"traceutil/trace.go:171","msg":"trace[1524420527] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1138; }","duration":"160.52105ms","start":"2026-06-26T02:21:25.054936Z","end":"2026-06-26T02:21:25.215458Z","steps":["trace[1524420527] 'agreement among raft nodes before linearized reading' (duration: 160.412248ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:25.215475Z","caller":"traceutil/trace.go:171","msg":"trace[893759840] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"333.295138ms","start":"2026-06-26T02:21:24.882134Z","end":"2026-06-26T02:21:25.215429Z","steps":["trace[893759840] 'process raft request' (duration: 332.918931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:25.215665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:24.882092Z","time spent":"333.473832ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:21:26.364233Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174090956,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:21:26.674738Z","caller":"traceutil/trace.go:171","msg":"trace[2110844984] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"811.23365ms","start":"2026-06-26T02:21:25.863469Z","end":"2026-06-26T02:21:26.674703Z","steps":["trace[2110844984] 'read index received' (duration: 810.910554ms)","trace[2110844984] 'applied index is now lower than readState.Index' (duration: 321.356µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:21:26.674796Z","caller":"traceutil/trace.go:171","msg":"trace[320633498] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"964.606572ms","start":"2026-06-26T02:21:25.710165Z","end":"2026-06-26T02:21:26.674772Z","steps":["trace[320633498] 'process raft request' (duration: 964.253765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:26.67492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:25.710128Z","time spent":"964.720976ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:21:26.674912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.426205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:26.675044Z","caller":"traceutil/trace.go:171","msg":"trace[325155081] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1139; }","duration":"811.640759ms","start":"2026-06-26T02:21:25.863391Z","end":"2026-06-26T02:21:26.675032Z","steps":["trace[325155081] 'agreement among raft nodes before linearized reading' (duration: 811.453295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:26.675069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:25.863364Z","time spent":"811.69728ms","remote":"127.0.0.1:33628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:21:28.121895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000356084s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:21:28.122016Z","caller":"traceutil/trace.go:171","msg":"trace[1504241017] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000579999s","start":"2026-06-26T02:21:26.121409Z","end":"2026-06-26T02:21:28.121989Z","steps":["trace[1504241017] 'agreement among raft nodes before linearized reading' (duration: 2.000423726s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.122077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.121345Z","time spent":"2.000720221s","remote":"127.0.0.1:33354","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:21:28 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:21:28.130365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.32408731s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-26T02:21:28.130727Z","caller":"traceutil/trace.go:171","msg":"trace[1120321640] linearizableReadLoop","detail":"{readStateIndex:1185; appliedIndex:1183; }","duration":"1.455884182s","start":"2026-06-26T02:21:26.674818Z","end":"2026-06-26T02:21:28.130702Z","steps":["trace[1120321640] 'read index received' (duration: 130.810894ms)","trace[1120321640] 'applied index is now lower than readState.Index' (duration: 1.325071778s)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:21:28.131096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.892917693s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:28.131212Z","caller":"traceutil/trace.go:171","msg":"trace[1373307325] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"1.46338246s","start":"2026-06-26T02:21:26.667712Z","end":"2026-06-26T02:21:28.131095Z","steps":["trace[1373307325] 'process raft request' (duration: 1.462783267s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:28.131455Z","caller":"traceutil/trace.go:171","msg":"trace[683791296] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1140; }","duration":"1.893162746s","start":"2026-06-26T02:21:26.23807Z","end":"2026-06-26T02:21:28.131233Z","steps":["trace[683791296] 'agreement among raft nodes before linearized reading' (duration: 1.89286725s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.131486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.374363474s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T02:21:28.131539Z","caller":"traceutil/trace.go:171","msg":"trace[1128771245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1140; }","duration":"1.374478596s","start":"2026-06-26T02:21:26.757048Z","end":"2026-06-26T02:21:28.131527Z","steps":["trace[1128771245] 'agreement among raft nodes before linearized reading' (duration: 1.374056748s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.131527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.238048Z","time spent":"1.893460752s","remote":"127.0.0.1:37310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:21:28.131583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.757018Z","time spent":"1.374556268s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:21:28.13161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.667676Z","time spent":"1.463830417s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:21:28.131744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.577225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-26T02:21:28.131772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.953074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:21:28.131837Z","caller":"traceutil/trace.go:171","msg":"trace[252688131] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1140; }","duration":"911.027405ms","start":"2026-06-26T02:21:27.220795Z","end":"2026-06-26T02:21:28.131823Z","steps":["trace[252688131] 'agreement among raft nodes before linearized reading' (duration: 910.685929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.131886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:27.220763Z","time spent":"911.114516ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T02:21:28.131837Z","caller":"traceutil/trace.go:171","msg":"trace[786281947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1140; }","duration":"911.768139ms","start":"2026-06-26T02:21:27.220049Z","end":"2026-06-26T02:21:28.131817Z","steps":["trace[786281947] 'agreement among raft nodes before linearized reading' (duration: 911.501414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.131966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:27.220008Z","time spent":"911.943432ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:21:28.132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.207958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-26T02:21:28.131968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221090653s","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:21:28.132144Z","caller":"traceutil/trace.go:171","msg":"trace[366400266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1140; }","duration":"1.221351368s","start":"2026-06-26T02:21:26.910762Z","end":"2026-06-26T02:21:28.132114Z","steps":["trace[366400266] 'agreement among raft nodes before linearized reading' (duration: 1.220881399s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.132858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.910669Z","time spent":"1.222172034s","remote":"127.0.0.1:33592","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:21:28.132069Z","caller":"traceutil/trace.go:171","msg":"trace[352338231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1140; }","duration":"911.255039ms","start":"2026-06-26T02:21:27.220782Z","end":"2026-06-26T02:21:28.132037Z","steps":["trace[352338231] 'agreement among raft nodes before linearized reading' (duration: 911.048615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.133303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:27.220748Z","time spent":"912.538445ms","remote":"127.0.0.1:33592","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:21:28.367626Z","caller":"traceutil/trace.go:171","msg":"trace[760675853] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"230.364714ms","start":"2026-06-26T02:21:28.136401Z","end":"2026-06-26T02:21:28.366766Z","steps":["trace[760675853] 'process raft request' (duration: 184.338952ms)","trace[760675853] 'compare' (duration: 45.800228ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:21:28.463606Z","caller":"traceutil/trace.go:171","msg":"trace[1887799699] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"326.255932ms","start":"2026-06-26T02:21:28.137314Z","end":"2026-06-26T02:21:28.46357Z","steps":["trace[1887799699] 'process raft request' (duration: 326.046478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.463844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:28.137288Z","time spent":"326.423876ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:21:28.46397Z","caller":"traceutil/trace.go:171","msg":"trace[1015452831] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"326.496677ms","start":"2026-06-26T02:21:28.137446Z","end":"2026-06-26T02:21:28.463942Z","steps":["trace[1015452831] 'process raft request' (duration: 326.060119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.464223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:28.137436Z","time spent":"326.594709ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:21:28.464472Z","caller":"traceutil/trace.go:171","msg":"trace[1651222599] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"326.236332ms","start":"2026-06-26T02:21:28.138222Z","end":"2026-06-26T02:21:28.464459Z","steps":["trace[1651222599] 'process raft request' (duration: 325.621869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.464539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:28.1382Z","time spent":"326.303193ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:21:28.46474Z","caller":"traceutil/trace.go:171","msg":"trace[573904167] linearizableReadLoop","detail":"{readStateIndex:1191; appliedIndex:1185; }","duration":"325.739453ms","start":"2026-06-26T02:21:28.138986Z","end":"2026-06-26T02:21:28.464725Z","steps":["trace[573904167] 'read index received' (duration: 181.774253ms)","trace[573904167] 'applied index is now lower than readState.Index' (duration: 143.96389ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:21:28.464884Z","caller":"traceutil/trace.go:171","msg":"trace[955835118] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"326.14225ms","start":"2026-06-26T02:21:28.138732Z","end":"2026-06-26T02:21:28.464874Z","steps":["trace[955835118] 'process raft request' (duration: 325.664971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.464961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:28.138721Z","time spent":"326.197241ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:21:28.465104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.12376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:28.465145Z","caller":"traceutil/trace.go:171","msg":"trace[2129607405] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1145; }","duration":"326.16354ms","start":"2026-06-26T02:21:28.138972Z","end":"2026-06-26T02:21:28.465136Z","steps":["trace[2129607405] 'agreement among raft nodes before linearized reading' (duration: 326.100919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:28.465174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:28.138947Z","time spent":"326.221302ms","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:21:28.463473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:28.13697Z","time spent":"326.494407ms","remote":"127.0.0.1:33402","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-26T02:21:28.465336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.108583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:28.465533Z","caller":"traceutil/trace.go:171","msg":"trace[1745907889] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1145; }","duration":"112.337416ms","start":"2026-06-26T02:21:28.353126Z","end":"2026-06-26T02:21:28.465464Z","steps":["trace[1745907889] 'agreement among raft nodes before linearized reading' (duration: 112.027181ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:42.290937Z","caller":"traceutil/trace.go:171","msg":"trace[1698580040] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"111.553163ms","start":"2026-06-26T02:21:42.179354Z","end":"2026-06-26T02:21:42.290907Z","steps":["trace[1698580040] 'process raft request' (duration: 111.359939ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:42.997892Z","caller":"traceutil/trace.go:171","msg":"trace[780756114] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"354.969229ms","start":"2026-06-26T02:21:42.642897Z","end":"2026-06-26T02:21:42.997866Z","steps":["trace[780756114] 'process raft request' (duration: 354.910317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:42.998051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:42.642866Z","time spent":"355.099911ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:21:42.998409Z","caller":"traceutil/trace.go:171","msg":"trace[780131019] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"356.180601ms","start":"2026-06-26T02:21:42.642217Z","end":"2026-06-26T02:21:42.998397Z","steps":["trace[780131019] 'process raft request' (duration: 354.55467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:42.998479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:42.64221Z","time spent":"356.233922ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:21:44.982252Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174091198,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:21:45.482821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174091198,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:21:45.901739Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.603905862s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:21:45.902335Z","caller":"traceutil/trace.go:171","msg":"trace[1986064178] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"1.604607705s","start":"2026-06-26T02:21:44.297697Z","end":"2026-06-26T02:21:45.902305Z","steps":["trace[1986064178] 'process raft request' (duration: 1.60432423s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:45.902287Z","caller":"traceutil/trace.go:171","msg":"trace[562900180] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1294; }","duration":"1.420705711s","start":"2026-06-26T02:21:44.481548Z","end":"2026-06-26T02:21:45.902254Z","steps":["trace[562900180] 'read index received' (duration: 1.420340675s)","trace[562900180] 'applied index is now lower than readState.Index' (duration: 363.316µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:21:45.902484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:44.297666Z","time spent":"1.604725107s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:21:45.90261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.263769099s","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:21:45.902702Z","caller":"traceutil/trace.go:171","msg":"trace[481058893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1245; }","duration":"1.263888391s","start":"2026-06-26T02:21:44.638796Z","end":"2026-06-26T02:21:45.902684Z","steps":["trace[481058893] 'agreement among raft nodes before linearized reading' (duration: 1.263653587s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:45.902746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:44.638734Z","time spent":"1.264002773s","remote":"127.0.0.1:33592","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":"warn","ts":"2026-06-26T02:21:45.902799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.45761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:21:45.902891Z","caller":"traceutil/trace.go:171","msg":"trace[2031103831] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1245; }","duration":"899.583693ms","start":"2026-06-26T02:21:45.003284Z","end":"2026-06-26T02:21:45.902868Z","steps":["trace[2031103831] 'agreement among raft nodes before linearized reading' (duration: 899.299706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:45.902944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:45.003274Z","time spent":"899.659554ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:21:45.902957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233112736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-26T02:21:45.902949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.351822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:45.902987Z","caller":"traceutil/trace.go:171","msg":"trace[553722504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1245; }","duration":"1.233168228s","start":"2026-06-26T02:21:44.669809Z","end":"2026-06-26T02:21:45.902978Z","steps":["trace[553722504] 'agreement among raft nodes before linearized reading' (duration: 1.233069646s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:45.902988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.363177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T02:21:45.90305Z","caller":"traceutil/trace.go:171","msg":"trace[574821338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1245; }","duration":"781.490605ms","start":"2026-06-26T02:21:45.12153Z","end":"2026-06-26T02:21:45.90302Z","steps":["trace[574821338] 'agreement among raft nodes before linearized reading' (duration: 781.329842ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:45.903086Z","caller":"traceutil/trace.go:171","msg":"trace[43480273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1245; }","duration":"900.535371ms","start":"2026-06-26T02:21:45.002529Z","end":"2026-06-26T02:21:45.903064Z","steps":["trace[43480273] 'agreement among raft nodes before linearized reading' (duration: 900.179484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:45.903112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:45.121519Z","time spent":"781.584107ms","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:21:45.903146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:45.002508Z","time spent":"900.628714ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:21:45.903031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:44.669797Z","time spent":"1.233228219s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:21:45.903698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.421205831s","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:21:45.903759Z","caller":"traceutil/trace.go:171","msg":"trace[238369676] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1245; }","duration":"1.422242021s","start":"2026-06-26T02:21:44.481501Z","end":"2026-06-26T02:21:45.903743Z","steps":["trace[238369676] 'agreement among raft nodes before linearized reading' (duration: 1.420952856s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:45.903799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:44.48148Z","time spent":"1.422306683s","remote":"127.0.0.1:33592","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:21:58.210443Z","caller":"traceutil/trace.go:171","msg":"trace[743466668] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"248.010193ms","start":"2026-06-26T02:21:57.962402Z","end":"2026-06-26T02:21:58.210412Z","steps":["trace[743466668] 'read index received' (duration: 247.715027ms)","trace[743466668] 'applied index is now lower than readState.Index' (duration: 294.416µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:21:58.210557Z","caller":"traceutil/trace.go:171","msg":"trace[1729027701] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"268.143753ms","start":"2026-06-26T02:21:57.942342Z","end":"2026-06-26T02:21:58.210486Z","steps":["trace[1729027701] 'process raft request' (duration: 267.866998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:58.210738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.322569ms","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:21:58.210769Z","caller":"traceutil/trace.go:171","msg":"trace[1120840204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1285; }","duration":"219.442311ms","start":"2026-06-26T02:21:57.991316Z","end":"2026-06-26T02:21:58.210759Z","steps":["trace[1120840204] 'agreement among raft nodes before linearized reading' (duration: 219.246688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:58.210832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.395351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-26T02:21:58.21089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.665649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-26T02:21:58.210894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.530007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-26T02:21:58.2109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.836664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:21:58.210974Z","caller":"traceutil/trace.go:171","msg":"trace[682631808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1285; }","duration":"214.778111ms","start":"2026-06-26T02:21:57.996176Z","end":"2026-06-26T02:21:58.210954Z","steps":["trace[682631808] 'agreement among raft nodes before linearized reading' (duration: 214.545487ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:58.210986Z","caller":"traceutil/trace.go:171","msg":"trace[2002898513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1285; }","duration":"214.678129ms","start":"2026-06-26T02:21:57.996289Z","end":"2026-06-26T02:21:58.210967Z","steps":["trace[2002898513] 'agreement among raft nodes before linearized reading' (duration: 214.437125ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:58.211013Z","caller":"traceutil/trace.go:171","msg":"trace[329776033] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1285; }","duration":"211.994617ms","start":"2026-06-26T02:21:57.998998Z","end":"2026-06-26T02:21:58.210992Z","steps":["trace[329776033] 'agreement among raft nodes before linearized reading' (duration: 211.65206ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:58.210928Z","caller":"traceutil/trace.go:171","msg":"trace[582433566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1285; }","duration":"248.576264ms","start":"2026-06-26T02:21:57.962329Z","end":"2026-06-26T02:21:58.210906Z","steps":["trace[582433566] 'agreement among raft nodes before linearized reading' (duration: 248.198817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:02.730379Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603900174091355,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:22:03.175846Z","caller":"traceutil/trace.go:171","msg":"trace[335130715] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1371; }","duration":"946.208069ms","start":"2026-06-26T02:22:02.229612Z","end":"2026-06-26T02:22:03.17582Z","steps":["trace[335130715] 'read index received' (duration: 945.987765ms)","trace[335130715] 'applied index is now lower than readState.Index' (duration: 219.564µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:22:03.176166Z","caller":"traceutil/trace.go:171","msg":"trace[1664566903] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"950.670295ms","start":"2026-06-26T02:22:02.225484Z","end":"2026-06-26T02:22:03.176155Z","steps":["trace[1664566903] 'process raft request' (duration: 950.194486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:03.176333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:02.225456Z","time spent":"950.734696ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:22:03.176536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.922233ms","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:22:03.176569Z","caller":"traceutil/trace.go:171","msg":"trace[378675055] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1318; }","duration":"946.978834ms","start":"2026-06-26T02:22:02.229583Z","end":"2026-06-26T02:22:03.176562Z","steps":["trace[378675055] 'agreement among raft nodes before linearized reading' (duration: 946.861041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:03.176591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:02.229572Z","time spent":"947.013865ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-26T02:22:03.176829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.524566ms","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":"warn","ts":"2026-06-26T02:22:03.176879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.749582ms","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:22:03.176904Z","caller":"traceutil/trace.go:171","msg":"trace[1695007913] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1318; }","duration":"941.782524ms","start":"2026-06-26T02:22:02.235113Z","end":"2026-06-26T02:22:03.176896Z","steps":["trace[1695007913] 'agreement among raft nodes before linearized reading' (duration: 941.701322ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:03.176901Z","caller":"traceutil/trace.go:171","msg":"trace[1409665949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1318; }","duration":"944.619108ms","start":"2026-06-26T02:22:02.232265Z","end":"2026-06-26T02:22:03.176884Z","steps":["trace[1409665949] 'agreement among raft nodes before linearized reading' (duration: 944.419594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:03.17692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:02.235109Z","time spent":"941.807454ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T02:22:03.176939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:02.23226Z","time spent":"944.67227ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:22:03.177131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.236172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-26T02:22:03.17715Z","caller":"traceutil/trace.go:171","msg":"trace[483994230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1318; }","duration":"942.268272ms","start":"2026-06-26T02:22:02.234875Z","end":"2026-06-26T02:22:03.177143Z","steps":["trace[483994230] 'agreement among raft nodes before linearized reading' (duration: 942.201451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:03.177168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:02.234871Z","time spent":"942.293223ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:22:03.177262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.68666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-26T02:22:03.177287Z","caller":"traceutil/trace.go:171","msg":"trace[11046574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1318; }","duration":"943.72116ms","start":"2026-06-26T02:22:02.233559Z","end":"2026-06-26T02:22:03.17728Z","steps":["trace[11046574] 'agreement among raft nodes before linearized reading' (duration: 943.651469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:03.177311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:02.233555Z","time spent":"943.75194ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:22:03.60576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.121812ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:22:03.605834Z","caller":"traceutil/trace.go:171","msg":"trace[1683407091] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1318; }","duration":"120.220104ms","start":"2026-06-26T02:22:03.485593Z","end":"2026-06-26T02:22:03.605814Z","steps":["trace[1683407091] 'range keys from in-memory index tree' (duration: 120.099781ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:03.60626Z","caller":"traceutil/trace.go:171","msg":"trace[849718039] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"421.779652ms","start":"2026-06-26T02:22:03.184459Z","end":"2026-06-26T02:22:03.606239Z","steps":["trace[849718039] 'process raft request' (duration: 421.746782ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:03.606319Z","caller":"traceutil/trace.go:171","msg":"trace[698177916] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"423.102508ms","start":"2026-06-26T02:22:03.183172Z","end":"2026-06-26T02:22:03.606275Z","steps":["trace[698177916] 'process raft request' (duration: 422.916264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:03.606386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:03.18445Z","time spent":"421.863584ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:22:03.606465Z","caller":"traceutil/trace.go:171","msg":"trace[676262175] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"423.153499ms","start":"2026-06-26T02:22:03.1833Z","end":"2026-06-26T02:22:03.606453Z","steps":["trace[676262175] 'process raft request' (duration: 422.869214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:03.60652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:03.183148Z","time spent":"423.25216ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:22:03.606557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:03.183292Z","time spent":"423.20477ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:22:03.606561Z","caller":"traceutil/trace.go:171","msg":"trace[2137589486] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"424.028056ms","start":"2026-06-26T02:22:03.182486Z","end":"2026-06-26T02:22:03.606514Z","steps":["trace[2137589486] 'process raft request' (duration: 337.497713ms)","trace[2137589486] 'compare' (duration: 85.856669ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:22:03.606777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:03.182467Z","time spent":"424.199498ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:22:03.606909Z","caller":"traceutil/trace.go:171","msg":"trace[1223673657] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"423.22113ms","start":"2026-06-26T02:22:03.183211Z","end":"2026-06-26T02:22:03.606432Z","steps":["trace[1223673657] 'process raft request' (duration: 422.920904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:03.607036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:03.183187Z","time spent":"423.791351ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:22:04.302342Z","caller":"traceutil/trace.go:171","msg":"trace[1945959706] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1377; }","duration":"180.048541ms","start":"2026-06-26T02:22:04.122263Z","end":"2026-06-26T02:22:04.302311Z","steps":["trace[1945959706] 'read index received' (duration: 179.790936ms)","trace[1945959706] 'applied index is now lower than readState.Index' (duration: 256.365µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:22:04.302476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.195713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:22:04.30251Z","caller":"traceutil/trace.go:171","msg":"trace[1330993081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1324; }","duration":"180.292485ms","start":"2026-06-26T02:22:04.122207Z","end":"2026-06-26T02:22:04.302499Z","steps":["trace[1330993081] 'agreement among raft nodes before linearized reading' (duration: 180.212564ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:04.302658Z","caller":"traceutil/trace.go:171","msg":"trace[1514658827] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"297.780556ms","start":"2026-06-26T02:22:04.004827Z","end":"2026-06-26T02:22:04.302607Z","steps":["trace[1514658827] 'process raft request' (duration: 297.245306ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:05.311215Z","caller":"traceutil/trace.go:171","msg":"trace[859315836] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"127.602356ms","start":"2026-06-26T02:22:05.183576Z","end":"2026-06-26T02:22:05.311178Z","steps":["trace[859315836] 'process raft request' (duration: 127.416452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:06.225748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.01611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:22:06.225873Z","caller":"traceutil/trace.go:171","msg":"trace[1068626389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1326; }","duration":"104.232486ms","start":"2026-06-26T02:22:06.121612Z","end":"2026-06-26T02:22:06.225845Z","steps":["trace[1068626389] 'range keys from in-memory index tree' (duration: 103.896418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:06.226413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.440796ms","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:22:06.226496Z","caller":"traceutil/trace.go:171","msg":"trace[2964512] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1326; }","duration":"615.588868ms","start":"2026-06-26T02:22:05.610885Z","end":"2026-06-26T02:22:06.226474Z","steps":["trace[2964512] 'range keys from in-memory index tree' (duration: 615.203471ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:06.22654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:05.610855Z","time spent":"615.67589ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T02:22:06.226602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.300353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-26T02:22:06.226673Z","caller":"traceutil/trace.go:171","msg":"trace[1664585049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1326; }","duration":"614.431136ms","start":"2026-06-26T02:22:05.612229Z","end":"2026-06-26T02:22:06.22666Z","steps":["trace[1664585049] 'range keys from in-memory index tree' (duration: 614.12228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:06.226662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.357415ms","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":"warn","ts":"2026-06-26T02:22:06.226706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:05.612196Z","time spent":"614.502777ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-26T02:22:06.226725Z","caller":"traceutil/trace.go:171","msg":"trace[677917014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1326; }","duration":"614.456277ms","start":"2026-06-26T02:22:05.612254Z","end":"2026-06-26T02:22:06.22671Z","steps":["trace[677917014] 'range keys from in-memory index tree' (duration: 614.11693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:06.226759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:05.612204Z","time spent":"614.548128ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:22:06.226778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.754302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-26T02:22:06.22686Z","caller":"traceutil/trace.go:171","msg":"trace[961395797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1326; }","duration":"614.852144ms","start":"2026-06-26T02:22:05.611987Z","end":"2026-06-26T02:22:06.22684Z","steps":["trace[961395797] 'range keys from in-memory index tree' (duration: 614.470747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:06.226907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:05.611904Z","time spent":"614.992666ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:22:06.227597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.048568ms","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:22:06.227658Z","caller":"traceutil/trace.go:171","msg":"trace[1063071365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1326; }","duration":"615.504307ms","start":"2026-06-26T02:22:05.612139Z","end":"2026-06-26T02:22:06.227643Z","steps":["trace[1063071365] 'range keys from in-memory index tree' (duration: 614.349275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:06.228087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:05.612132Z","time spent":"615.937105ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T02:22:06.44291Z","caller":"traceutil/trace.go:171","msg":"trace[774296317] linearizableReadLoop","detail":"{readStateIndex:1381; appliedIndex:1380; }","duration":"215.466145ms","start":"2026-06-26T02:22:06.227378Z","end":"2026-06-26T02:22:06.442844Z","steps":["trace[774296317] 'read index received' (duration: 133.167214ms)","trace[774296317] 'applied index is now lower than readState.Index' (duration: 82.296671ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:22:06.443077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.676288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:22:06.443129Z","caller":"traceutil/trace.go:171","msg":"trace[104790395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1326; }","duration":"215.76598ms","start":"2026-06-26T02:22:06.227349Z","end":"2026-06-26T02:22:06.443115Z","steps":["trace[104790395] 'agreement among raft nodes before linearized reading' (duration: 215.645788ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:06.528275Z","caller":"traceutil/trace.go:171","msg":"trace[379345549] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"295.89554ms","start":"2026-06-26T02:22:06.232343Z","end":"2026-06-26T02:22:06.528239Z","steps":["trace[379345549] 'process raft request' (duration: 295.613024ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:06.528567Z","caller":"traceutil/trace.go:171","msg":"trace[645920469] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"296.149514ms","start":"2026-06-26T02:22:06.232366Z","end":"2026-06-26T02:22:06.528516Z","steps":["trace[645920469] 'process raft request' (duration: 295.799957ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:06.528749Z","caller":"traceutil/trace.go:171","msg":"trace[223410598] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"296.149304ms","start":"2026-06-26T02:22:06.232563Z","end":"2026-06-26T02:22:06.528712Z","steps":["trace[223410598] 'process raft request' (duration: 296.035272ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:06.52878Z","caller":"traceutil/trace.go:171","msg":"trace[1825209858] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"296.283967ms","start":"2026-06-26T02:22:06.232458Z","end":"2026-06-26T02:22:06.528742Z","steps":["trace[1825209858] 'process raft request' (duration: 295.993371ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:06.528889Z","caller":"traceutil/trace.go:171","msg":"trace[1159565918] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"295.137515ms","start":"2026-06-26T02:22:06.233707Z","end":"2026-06-26T02:22:06.528845Z","steps":["trace[1159565918] 'process raft request' (duration: 294.944531ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:06.985872Z","caller":"traceutil/trace.go:171","msg":"trace[1378802744] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"145.663045ms","start":"2026-06-26T02:22:06.840168Z","end":"2026-06-26T02:22:06.985831Z","steps":["trace[1378802744] 'process raft request' (duration: 89.709514ms)","trace[1378802744] 'compare' (duration: 55.774438ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:22:06.994743Z","caller":"traceutil/trace.go:171","msg":"trace[1435634868] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"154.489416ms","start":"2026-06-26T02:22:06.840234Z","end":"2026-06-26T02:22:06.994723Z","steps":["trace[1435634868] 'process raft request' (duration: 154.18251ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:06.994716Z","caller":"traceutil/trace.go:171","msg":"trace[446235723] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"137.212372ms","start":"2026-06-26T02:22:06.857471Z","end":"2026-06-26T02:22:06.994684Z","steps":["trace[446235723] 'process raft request' (duration: 137.11094ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:07.481808Z","caller":"traceutil/trace.go:171","msg":"trace[1788974992] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"164.037211ms","start":"2026-06-26T02:22:07.317526Z","end":"2026-06-26T02:22:07.481564Z","steps":["trace[1788974992] 'process raft request' (duration: 163.854277ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:08.036327Z","caller":"traceutil/trace.go:171","msg":"trace[74734552] linearizableReadLoop","detail":"{readStateIndex:1394; appliedIndex:1393; }","duration":"502.37492ms","start":"2026-06-26T02:22:07.533925Z","end":"2026-06-26T02:22:08.0363Z","steps":["trace[74734552] 'read index received' (duration: 432.161892ms)","trace[74734552] 'applied index is now lower than readState.Index' (duration: 70.211498ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:22:08.036694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.590957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:22:08.036691Z","caller":"traceutil/trace.go:171","msg":"trace[251923741] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"581.258685ms","start":"2026-06-26T02:22:07.45541Z","end":"2026-06-26T02:22:08.036669Z","steps":["trace[251923741] 'process raft request' (duration: 510.770832ms)","trace[251923741] 'compare' (duration: 69.789248ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:22:08.036737Z","caller":"traceutil/trace.go:171","msg":"trace[1812951402] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1339; }","duration":"348.69235ms","start":"2026-06-26T02:22:07.688036Z","end":"2026-06-26T02:22:08.036728Z","steps":["trace[1812951402] 'agreement among raft nodes before linearized reading' (duration: 348.581428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:08.036763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:07.688016Z","time spent":"348.74048ms","remote":"127.0.0.1:33434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:22:08.036748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.826069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:22:08.03681Z","caller":"traceutil/trace.go:171","msg":"trace[1543799067] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1339; }","duration":"502.896ms","start":"2026-06-26T02:22:07.533898Z","end":"2026-06-26T02:22:08.036794Z","steps":["trace[1543799067] 'agreement among raft nodes before linearized reading' (duration: 502.787148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:08.036835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:07.455384Z","time spent":"581.362667ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:22:08.036869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:07.533842Z","time spent":"503.011022ms","remote":"127.0.0.1:37284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:22:18.802394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.849137251s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-26T02:22:18.802533Z","caller":"traceutil/trace.go:171","msg":"trace[870778567] linearizableReadLoop","detail":"{readStateIndex:1458; appliedIndex:1457; }","duration":"2.212277339s","start":"2026-06-26T02:22:16.590235Z","end":"2026-06-26T02:22:18.802512Z","steps":["trace[870778567] 'read index received' (duration: 362.922164ms)","trace[870778567] 'applied index is now lower than readState.Index' (duration: 1.849353055s)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:22:18.803106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.212857241s","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:22:18.803169Z","caller":"traceutil/trace.go:171","msg":"trace[1545398106] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1401; }","duration":"2.212995763s","start":"2026-06-26T02:22:16.590157Z","end":"2026-06-26T02:22:18.803153Z","steps":["trace[1545398106] 'agreement among raft nodes before linearized reading' (duration: 2.212782759s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.803213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:16.590136Z","time spent":"2.213065575s","remote":"127.0.0.1:33592","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":"warn","ts":"2026-06-26T02:22:18.810411Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.570540646s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:22:18.810989Z","caller":"traceutil/trace.go:171","msg":"trace[1326742187] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"1.571233889s","start":"2026-06-26T02:22:17.239728Z","end":"2026-06-26T02:22:18.810962Z","steps":["trace[1326742187] 'process raft request' (duration: 1.571047135s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.811264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:17.239705Z","time spent":"1.571403282s","remote":"127.0.0.1:33498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:22:18.815094Z","caller":"traceutil/trace.go:171","msg":"trace[2130554845] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"1.29656973s","start":"2026-06-26T02:22:17.518504Z","end":"2026-06-26T02:22:18.815074Z","steps":["trace[2130554845] 'process raft request' (duration: 1.29601191s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.815221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:17.518463Z","time spent":"1.296679172s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:22:18.815347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.368291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-26T02:22:18.815408Z","caller":"traceutil/trace.go:171","msg":"trace[1819015689] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1405; }","duration":"976.464263ms","start":"2026-06-26T02:22:17.838925Z","end":"2026-06-26T02:22:18.815389Z","steps":["trace[1819015689] 'agreement among raft nodes before linearized reading' (duration: 976.257139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.815442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:17.838903Z","time spent":"976.532604ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-26T02:22:18.815463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.217129203s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-26T02:22:18.815627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.215298227s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T02:22:18.815735Z","caller":"traceutil/trace.go:171","msg":"trace[1279874317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1405; }","duration":"2.215441731s","start":"2026-06-26T02:22:16.600243Z","end":"2026-06-26T02:22:18.815685Z","steps":["trace[1279874317] 'agreement among raft nodes before linearized reading' (duration: 2.215064734s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.815796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:16.600235Z","time spent":"2.215537212s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:22:18.815875Z","caller":"traceutil/trace.go:171","msg":"trace[662147891] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"624.957911ms","start":"2026-06-26T02:22:18.190901Z","end":"2026-06-26T02:22:18.815859Z","steps":["trace[662147891] 'process raft request' (duration: 623.988832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.815485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.696009161s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:22:18.815961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:18.190867Z","time spent":"625.039592ms","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:22:18.815983Z","caller":"traceutil/trace.go:171","msg":"trace[816948534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1405; }","duration":"1.696524742s","start":"2026-06-26T02:22:17.119447Z","end":"2026-06-26T02:22:18.815972Z","steps":["trace[816948534] 'agreement among raft nodes before linearized reading' (duration: 1.6959329s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.816035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:17.119372Z","time spent":"1.696655104s","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:22:18.815358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.927317351s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-26T02:22:18.816075Z","caller":"traceutil/trace.go:171","msg":"trace[1318942796] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1405; }","duration":"1.928076397s","start":"2026-06-26T02:22:16.887985Z","end":"2026-06-26T02:22:18.816062Z","steps":["trace[1318942796] 'agreement among raft nodes before linearized reading' (duration: 1.92724917s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.816107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:16.88797Z","time spent":"1.928128317s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-26T02:22:18.816302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.809311ms","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":"warn","ts":"2026-06-26T02:22:18.816329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.672463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-26T02:22:18.816342Z","caller":"traceutil/trace.go:171","msg":"trace[1595450904] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1405; }","duration":"617.906663ms","start":"2026-06-26T02:22:18.198427Z","end":"2026-06-26T02:22:18.816333Z","steps":["trace[1595450904] 'agreement among raft nodes before linearized reading' (duration: 617.829811ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:18.816356Z","caller":"traceutil/trace.go:171","msg":"trace[429312192] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1405; }","duration":"863.728695ms","start":"2026-06-26T02:22:17.95262Z","end":"2026-06-26T02:22:18.816348Z","steps":["trace[429312192] 'agreement among raft nodes before linearized reading' (duration: 863.551982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.816366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:18.19841Z","time spent":"617.950553ms","remote":"127.0.0.1:33624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:22:18.816379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:17.952609Z","time spent":"863.764205ms","remote":"127.0.0.1:33878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":160,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:22:18.815494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.807051197s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-06-26T02:22:18.816512Z","caller":"traceutil/trace.go:171","msg":"trace[1412189780] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1405; }","duration":"1.808125548s","start":"2026-06-26T02:22:17.008377Z","end":"2026-06-26T02:22:18.816503Z","steps":["trace[1412189780] 'agreement among raft nodes before linearized reading' (duration: 1.807062747s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.816542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:17.008355Z","time spent":"1.808178888s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-26T02:22:18.816734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.877933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:22:18.816795Z","caller":"traceutil/trace.go:171","msg":"trace[2039402566] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1405; }","duration":"244.017946ms","start":"2026-06-26T02:22:18.572761Z","end":"2026-06-26T02:22:18.816779Z","steps":["trace[2039402566] 'agreement among raft nodes before linearized reading' (duration: 242.789752ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:22:18.815598Z","caller":"traceutil/trace.go:171","msg":"trace[1307077231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1405; }","duration":"2.217251526s","start":"2026-06-26T02:22:16.598272Z","end":"2026-06-26T02:22:18.815524Z","steps":["trace[1307077231] 'agreement among raft nodes before linearized reading' (duration: 2.216980661s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.817724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:16.598259Z","time spent":"2.219453988s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:22:18.817907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.219620321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:22:18.817943Z","caller":"traceutil/trace.go:171","msg":"trace[1851889674] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1405; }","duration":"2.219688462s","start":"2026-06-26T02:22:16.598245Z","end":"2026-06-26T02:22:18.817934Z","steps":["trace[1851889674] 'agreement among raft nodes before linearized reading' (duration: 2.217273155s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.817967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:16.598235Z","time spent":"2.219725913s","remote":"127.0.0.1:33592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:22:18.818317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.221991417s","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:22:18.818348Z","caller":"traceutil/trace.go:171","msg":"trace[109142884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1405; }","duration":"2.222044098s","start":"2026-06-26T02:22:16.596295Z","end":"2026-06-26T02:22:18.818339Z","steps":["trace[109142884] 'agreement among raft nodes before linearized reading' (duration: 2.220411047s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:22:18.818399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:22:16.596281Z","time spent":"2.2221127s","remote":"127.0.0.1:33592","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\" "}