{"level":"warn","ts":"2026-05-06T01:13:46.242551Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T01:13:46.242658Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.175: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.175:2380","--initial-cluster=instance=https://199.19.213.175:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.175:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.175: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-05-06T01:13:46.242735Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T01:13:46.242752Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.175:2380"]} {"level":"info","ts":"2026-05-06T01:13:46.242775Z","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-05-06T01:13:46.243578Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"]} {"level":"info","ts":"2026-05-06T01:13:46.243904Z","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.175:2380"],"listen-peer-urls":["https://199.19.213.175:2380"],"advertise-client-urls":["https://199.19.213.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.175: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-05-06T01:13:46.250207Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.055025ms"} {"level":"info","ts":"2026-05-06T01:13:46.267127Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"223c7693b78843e1","cluster-id":"b697af90308fdc01"} {"level":"info","ts":"2026-05-06T01:13:46.267248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T01:13:46.267285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became follower at term 0"} {"level":"info","ts":"2026-05-06T01:13:46.26731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 223c7693b78843e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T01:13:46.267332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became follower at term 1"} {"level":"info","ts":"2026-05-06T01:13:46.26738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=(2466977072703620065)"} {"level":"warn","ts":"2026-05-06T01:13:46.282437Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T01:13:46.284327Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T01:13:46.285868Z","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-05-06T01:13:46.289942Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"223c7693b78843e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T01:13:46.290106Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"223c7693b78843e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T01:13:46.292187Z","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-05-06T01:13:46.292306Z","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-05-06T01:13:46.29245Z","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-05-06T01:13:46.293647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=(2466977072703620065)"} {"level":"info","ts":"2026-05-06T01:13:46.293984Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b697af90308fdc01","local-member-id":"223c7693b78843e1","added-peer-id":"223c7693b78843e1","added-peer-peer-urls":["https://199.19.213.175:2380"]} {"level":"info","ts":"2026-05-06T01:13:46.297225Z","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-05-06T01:13:46.297331Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.175:2380"} {"level":"info","ts":"2026-05-06T01:13:46.297389Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.175:2380"} {"level":"info","ts":"2026-05-06T01:13:46.297571Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"223c7693b78843e1","initial-advertise-peer-urls":["https://199.19.213.175:2380"],"listen-peer-urls":["https://199.19.213.175:2380"],"advertise-client-urls":["https://199.19.213.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T01:13:46.297659Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T01:13:46.368392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T01:13:46.368464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T01:13:46.368501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 received MsgPreVoteResp from 223c7693b78843e1 at term 1"} {"level":"info","ts":"2026-05-06T01:13:46.368521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became candidate at term 2"} {"level":"info","ts":"2026-05-06T01:13:46.368532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 received MsgVoteResp from 223c7693b78843e1 at term 2"} {"level":"info","ts":"2026-05-06T01:13:46.368548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became leader at term 2"} {"level":"info","ts":"2026-05-06T01:13:46.368562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 223c7693b78843e1 elected leader 223c7693b78843e1 at term 2"} {"level":"info","ts":"2026-05-06T01:13:46.370905Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:13:46.372774Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"223c7693b78843e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.175:2379]}","request-path":"/0/members/223c7693b78843e1/attributes","cluster-id":"b697af90308fdc01","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T01:13:46.37327Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b697af90308fdc01","local-member-id":"223c7693b78843e1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:13:46.37334Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T01:13:46.373381Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:13:46.373409Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:13:46.373416Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T01:13:46.373465Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T01:13:46.373479Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T01:13:46.375526Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T01:13:46.376544Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.175:2379"} {"level":"info","ts":"2026-05-06T01:13:50.065423Z","caller":"traceutil/trace.go:171","msg":"trace[1213055213] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"144.159096ms","start":"2026-05-06T01:13:49.921235Z","end":"2026-05-06T01:13:50.065395Z","steps":["trace[1213055213] 'process raft request' (duration: 132.292518ms)","trace[1213055213] 'compare' (duration: 11.554654ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:13:50.065822Z","caller":"traceutil/trace.go:171","msg":"trace[960234468] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"102.663972ms","start":"2026-05-06T01:13:49.963148Z","end":"2026-05-06T01:13:50.065812Z","steps":["trace[960234468] 'process raft request' (duration: 102.18633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:51.094566Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011083574,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T01:13:51.249204Z","caller":"traceutil/trace.go:171","msg":"trace[614273522] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"709.638074ms","start":"2026-05-06T01:13:50.539538Z","end":"2026-05-06T01:13:51.249176Z","steps":["trace[614273522] 'process raft request' (duration: 709.465136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:51.249538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.014048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"info","ts":"2026-05-06T01:13:51.249606Z","caller":"traceutil/trace.go:171","msg":"trace[491239374] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:253; }","duration":"656.123163ms","start":"2026-05-06T01:13:50.593471Z","end":"2026-05-06T01:13:51.249594Z","steps":["trace[491239374] 'agreement among raft nodes before linearized reading' (duration: 655.970406ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:51.24939Z","caller":"traceutil/trace.go:171","msg":"trace[399644705] linearizableReadLoop","detail":"{readStateIndex:260; appliedIndex:260; }","duration":"655.84396ms","start":"2026-05-06T01:13:50.593512Z","end":"2026-05-06T01:13:51.249356Z","steps":["trace[399644705] 'read index received' (duration: 655.83642ms)","trace[399644705] 'applied index is now lower than readState.Index' (duration: 5.43µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:13:51.249643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:50.593459Z","time spent":"656.176175ms","remote":"127.0.0.1:56922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-06T01:13:51.250493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:50.539527Z","time spent":"709.967528ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T01:13:51.511346Z","caller":"traceutil/trace.go:171","msg":"trace[40765232] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"253.747604ms","start":"2026-05-06T01:13:51.257561Z","end":"2026-05-06T01:13:51.511309Z","steps":["trace[40765232] 'process raft request' (duration: 226.894903ms)","trace[40765232] 'compare' (duration: 26.640461ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:13:51.512844Z","caller":"traceutil/trace.go:171","msg":"trace[508590787] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"255.001352ms","start":"2026-05-06T01:13:51.257789Z","end":"2026-05-06T01:13:51.51279Z","steps":["trace[508590787] 'process raft request' (duration: 254.795152ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:51.512885Z","caller":"traceutil/trace.go:171","msg":"trace[1001525877] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"254.980171ms","start":"2026-05-06T01:13:51.257881Z","end":"2026-05-06T01:13:51.512861Z","steps":["trace[1001525877] 'process raft request' (duration: 254.801423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:51.513191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.219598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:13:51.513348Z","caller":"traceutil/trace.go:171","msg":"trace[1738404280] linearizableReadLoop","detail":"{readStateIndex:263; appliedIndex:260; }","duration":"248.82131ms","start":"2026-05-06T01:13:51.263938Z","end":"2026-05-06T01:13:51.512759Z","steps":["trace[1738404280] 'read index received' (duration: 220.532354ms)","trace[1738404280] 'applied index is now lower than readState.Index' (duration: 28.288086ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:13:51.513436Z","caller":"traceutil/trace.go:171","msg":"trace[1849142102] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:0; response_revision:256; }","duration":"249.339394ms","start":"2026-05-06T01:13:51.263924Z","end":"2026-05-06T01:13:51.513263Z","steps":["trace[1849142102] 'agreement among raft nodes before linearized reading' (duration: 249.150145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:51.513572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.784356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:13:51.514358Z","caller":"traceutil/trace.go:171","msg":"trace[1356476298] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:256; }","duration":"223.624615ms","start":"2026-05-06T01:13:51.290701Z","end":"2026-05-06T01:13:51.514325Z","steps":["trace[1356476298] 'agreement among raft nodes before linearized reading' (duration: 222.749615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:56.869638Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011083819,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-06T01:13:57.374985Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011083819,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-06T01:13:57.694462Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.364891977s","expected-duration":"1s"} {"level":"info","ts":"2026-05-06T01:13:57.695045Z","caller":"traceutil/trace.go:171","msg":"trace[268846686] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"1.326030334s","start":"2026-05-06T01:13:56.36899Z","end":"2026-05-06T01:13:57.695021Z","steps":["trace[268846686] 'read index received' (duration: 1.325837876s)","trace[268846686] 'applied index is now lower than readState.Index' (duration: 191.518µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:13:57.695187Z","caller":"traceutil/trace.go:171","msg":"trace[1401507707] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"1.365727524s","start":"2026-05-06T01:13:56.329423Z","end":"2026-05-06T01:13:57.695151Z","steps":["trace[1401507707] 'process raft request' (duration: 1.365467133s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:57.695337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326263845s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-05-06T01:13:57.695369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.329388Z","time spent":"1.365897812s","remote":"127.0.0.1:56850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T01:13:57.695411Z","caller":"traceutil/trace.go:171","msg":"trace[392538542] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:350; }","duration":"1.326461744s","start":"2026-05-06T01:13:56.368933Z","end":"2026-05-06T01:13:57.695395Z","steps":["trace[392538542] 'agreement among raft nodes before linearized reading' (duration: 1.326243155s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:57.695519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.368911Z","time spent":"1.32659417s","remote":"127.0.0.1:56944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-05-06T01:13:57.695594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.127183921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-06T01:13:57.695615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.239937001s","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-05-06T01:13:57.695534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276591742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-06T01:13:57.69571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077506817s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-06T01:13:57.695728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177005642s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-06T01:13:57.695769Z","caller":"traceutil/trace.go:171","msg":"trace[66007375] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:350; }","duration":"1.177076495s","start":"2026-05-06T01:13:56.518684Z","end":"2026-05-06T01:13:57.69576Z","steps":["trace[66007375] 'agreement among raft nodes before linearized reading' (duration: 1.177016802s)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:57.695766Z","caller":"traceutil/trace.go:171","msg":"trace[1567797468] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:350; }","duration":"1.077597332s","start":"2026-05-06T01:13:56.618158Z","end":"2026-05-06T01:13:57.695756Z","steps":["trace[1567797468] 'agreement among raft nodes before linearized reading' (duration: 1.077520388s)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:57.695765Z","caller":"traceutil/trace.go:171","msg":"trace[441851687] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:350; }","duration":"1.276864614s","start":"2026-05-06T01:13:56.418864Z","end":"2026-05-06T01:13:57.695728Z","steps":["trace[441851687] 'agreement among raft nodes before linearized reading' (duration: 1.27657578s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:57.69574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02800869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-05-06T01:13:57.695821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.618138Z","time spent":"1.077671375s","remote":"127.0.0.1:56944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-05-06T01:13:57.695816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.518669Z","time spent":"1.177139438s","remote":"127.0.0.1:56944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-05-06T01:13:57.695846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.418844Z","time spent":"1.276984009s","remote":"127.0.0.1:56944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-05-06T01:13:57.69566Z","caller":"traceutil/trace.go:171","msg":"trace[413800721] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:350; }","duration":"1.127264695s","start":"2026-05-06T01:13:56.568358Z","end":"2026-05-06T01:13:57.695623Z","steps":["trace[413800721] 'agreement among raft nodes before linearized reading' (duration: 1.12715725s)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:57.695865Z","caller":"traceutil/trace.go:171","msg":"trace[1391832929] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:350; }","duration":"1.028187619s","start":"2026-05-06T01:13:56.667655Z","end":"2026-05-06T01:13:57.695843Z","steps":["trace[1391832929] 'agreement among raft nodes before linearized reading' (duration: 1.027950958s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:57.695918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.667635Z","time spent":"1.028268762s","remote":"127.0.0.1:56944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-05-06T01:13:57.695944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.792244ms","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-05-06T01:13:57.696079Z","caller":"traceutil/trace.go:171","msg":"trace[1858988557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:350; }","duration":"162.944951ms","start":"2026-05-06T01:13:57.533099Z","end":"2026-05-06T01:13:57.696043Z","steps":["trace[1858988557] 'agreement among raft nodes before linearized reading' (duration: 162.587465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:57.695903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.568335Z","time spent":"1.127554038s","remote":"127.0.0.1:56944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-05-06T01:13:57.695657Z","caller":"traceutil/trace.go:171","msg":"trace[1912570027] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:350; }","duration":"1.239994204s","start":"2026-05-06T01:13:56.455648Z","end":"2026-05-06T01:13:57.695642Z","steps":["trace[1912570027] 'agreement among raft nodes before linearized reading' (duration: 1.23992215s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:57.697352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.455635Z","time spent":"1.241695301s","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T01:13:57.719089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.249842992s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-06T01:13:57.719194Z","caller":"traceutil/trace.go:171","msg":"trace[220661356] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:350; }","duration":"1.249988649s","start":"2026-05-06T01:13:56.469179Z","end":"2026-05-06T01:13:57.719168Z","steps":["trace[220661356] 'agreement among raft nodes before linearized reading' (duration: 1.226866285s)","trace[220661356] 'range keys from in-memory index tree' (duration: 16.545044ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:13:57.719257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:56.469159Z","time spent":"1.250082723s","remote":"127.0.0.1:56944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"info","ts":"2026-05-06T01:13:57.993112Z","caller":"traceutil/trace.go:171","msg":"trace[545684853] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"130.458879ms","start":"2026-05-06T01:13:57.862609Z","end":"2026-05-06T01:13:57.993068Z","steps":["trace[545684853] 'process raft request' (duration: 80.476739ms)","trace[545684853] 'compare' (duration: 49.674876ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:13:57.9932Z","caller":"traceutil/trace.go:171","msg":"trace[1154615847] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"128.403715ms","start":"2026-05-06T01:13:57.864749Z","end":"2026-05-06T01:13:57.993152Z","steps":["trace[1154615847] 'process raft request' (duration: 128.296601ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:58.047464Z","caller":"traceutil/trace.go:171","msg":"trace[149517086] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"157.447172ms","start":"2026-05-06T01:13:57.889996Z","end":"2026-05-06T01:13:58.047443Z","steps":["trace[149517086] 'process raft request' (duration: 157.386539ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:58.047506Z","caller":"traceutil/trace.go:171","msg":"trace[643881419] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"160.403006ms","start":"2026-05-06T01:13:57.887067Z","end":"2026-05-06T01:13:58.04747Z","steps":["trace[643881419] 'process raft request' (duration: 160.206426ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:58.18383Z","caller":"traceutil/trace.go:171","msg":"trace[1414840339] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:399; }","duration":"139.975427ms","start":"2026-05-06T01:13:58.043815Z","end":"2026-05-06T01:13:58.183791Z","steps":["trace[1414840339] 'read index received' (duration: 3.50804ms)","trace[1414840339] 'applied index is now lower than readState.Index' (duration: 136.465967ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:13:58.18408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.232207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-06T01:13:58.18413Z","caller":"traceutil/trace.go:171","msg":"trace[1613575850] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:387; }","duration":"140.356153ms","start":"2026-05-06T01:13:58.043758Z","end":"2026-05-06T01:13:58.184115Z","steps":["trace[1613575850] 'agreement among raft nodes before linearized reading' (duration: 140.212257ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:58.184198Z","caller":"traceutil/trace.go:171","msg":"trace[201282968] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"183.077142ms","start":"2026-05-06T01:13:58.001079Z","end":"2026-05-06T01:13:58.184157Z","steps":["trace[201282968] 'process raft request' (duration: 124.223487ms)","trace[201282968] 'compare' (duration: 58.271109ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:02.977468Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011083920,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T01:14:02.998536Z","caller":"traceutil/trace.go:171","msg":"trace[552810306] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"693.37792ms","start":"2026-05-06T01:14:02.305126Z","end":"2026-05-06T01:14:02.998504Z","steps":["trace[552810306] 'process raft request' (duration: 693.208392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:02.998986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:02.305092Z","time spent":"693.530736ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:14:03.021712Z","caller":"traceutil/trace.go:171","msg":"trace[360305343] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:427; }","duration":"545.050409ms","start":"2026-05-06T01:14:02.476637Z","end":"2026-05-06T01:14:03.021688Z","steps":["trace[360305343] 'read index received' (duration: 521.690912ms)","trace[360305343] 'applied index is now lower than readState.Index' (duration: 23.357957ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:03.021829Z","caller":"traceutil/trace.go:171","msg":"trace[2114182711] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"389.175217ms","start":"2026-05-06T01:14:02.632629Z","end":"2026-05-06T01:14:03.021805Z","steps":["trace[2114182711] 'process raft request' (duration: 388.921615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:03.02185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.200747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:03.021895Z","caller":"traceutil/trace.go:171","msg":"trace[732664036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:412; }","duration":"545.310311ms","start":"2026-05-06T01:14:02.47657Z","end":"2026-05-06T01:14:03.02188Z","steps":["trace[732664036] 'agreement among raft nodes before linearized reading' (duration: 545.226167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:03.021929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:02.476539Z","time spent":"545.382595ms","remote":"127.0.0.1:56772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T01:14:03.022023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:02.63261Z","time spent":"389.302893ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:14:05.158377Z","caller":"traceutil/trace.go:171","msg":"trace[217593243] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"150.964208ms","start":"2026-05-06T01:14:05.007391Z","end":"2026-05-06T01:14:05.158356Z","steps":["trace[217593243] 'process raft request' (duration: 150.818681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:05.375445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.158099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-05-06T01:14:05.375573Z","caller":"traceutil/trace.go:171","msg":"trace[988518465] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:418; }","duration":"129.341428ms","start":"2026-05-06T01:14:05.246204Z","end":"2026-05-06T01:14:05.375546Z","steps":["trace[988518465] 'range keys from in-memory index tree' (duration: 128.992772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:05.535332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.437163ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-06T01:14:05.585894Z","caller":"traceutil/trace.go:171","msg":"trace[544020231] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:436; }","duration":"109.193436ms","start":"2026-05-06T01:14:05.476679Z","end":"2026-05-06T01:14:05.585872Z","steps":["trace[544020231] 'read index received' (duration: 108.920144ms)","trace[544020231] 'applied index is now lower than readState.Index' (duration: 269.652µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:05.586012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.318492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:05.586046Z","caller":"traceutil/trace.go:171","msg":"trace[1142283214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"109.390655ms","start":"2026-05-06T01:14:05.476642Z","end":"2026-05-06T01:14:05.586033Z","steps":["trace[1142283214] 'agreement among raft nodes before linearized reading' (duration: 109.318362ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:05.586018Z","caller":"traceutil/trace.go:171","msg":"trace[1776851033] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"200.626359ms","start":"2026-05-06T01:14:05.385339Z","end":"2026-05-06T01:14:05.585965Z","steps":["trace[1776851033] 'process raft request' (duration: 200.325685ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:05.763551Z","caller":"traceutil/trace.go:171","msg":"trace[1469644244] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"167.731225ms","start":"2026-05-06T01:14:05.595784Z","end":"2026-05-06T01:14:05.763515Z","steps":["trace[1469644244] 'process raft request' (duration: 110.709455ms)","trace[1469644244] 'compare' (duration: 56.858023ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:08.224999Z","caller":"traceutil/trace.go:171","msg":"trace[1751477043] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"114.883672ms","start":"2026-05-06T01:14:08.110092Z","end":"2026-05-06T01:14:08.224976Z","steps":["trace[1751477043] 'process raft request' (duration: 102.396961ms)","trace[1751477043] 'compare' (duration: 12.399687ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:08.399018Z","caller":"traceutil/trace.go:171","msg":"trace[87247355] linearizableReadLoop","detail":"{readStateIndex:474; appliedIndex:473; }","duration":"112.291243ms","start":"2026-05-06T01:14:08.286705Z","end":"2026-05-06T01:14:08.398996Z","steps":["trace[87247355] 'read index received' (duration: 54.60379ms)","trace[87247355] 'applied index is now lower than readState.Index' (duration: 57.686613ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:08.399124Z","caller":"traceutil/trace.go:171","msg":"trace[1894471747] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"121.316078ms","start":"2026-05-06T01:14:08.277768Z","end":"2026-05-06T01:14:08.399084Z","steps":["trace[1894471747] 'process raft request' (duration: 63.599914ms)","trace[1894471747] 'compare' (duration: 57.535746ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:08.399158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.441821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3855"} {"level":"info","ts":"2026-05-06T01:14:08.399225Z","caller":"traceutil/trace.go:171","msg":"trace[1816076195] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:454; }","duration":"112.536065ms","start":"2026-05-06T01:14:08.286674Z","end":"2026-05-06T01:14:08.39921Z","steps":["trace[1816076195] 'agreement among raft nodes before linearized reading' (duration: 112.403269ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:13.385004Z","caller":"traceutil/trace.go:171","msg":"trace[1592366944] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"185.140034ms","start":"2026-05-06T01:14:13.199843Z","end":"2026-05-06T01:14:13.384983Z","steps":["trace[1592366944] 'process raft request' (duration: 185.023309ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:13.911968Z","caller":"traceutil/trace.go:171","msg":"trace[1378630602] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"436.098127ms","start":"2026-05-06T01:14:13.475849Z","end":"2026-05-06T01:14:13.911947Z","steps":["trace[1378630602] 'read index received' (duration: 354.351316ms)","trace[1378630602] 'applied index is now lower than readState.Index' (duration: 81.745811ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:13.912205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.346179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:13.912218Z","caller":"traceutil/trace.go:171","msg":"trace[2107646596] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"502.725605ms","start":"2026-05-06T01:14:13.409459Z","end":"2026-05-06T01:14:13.912185Z","steps":["trace[2107646596] 'process raft request' (duration: 420.816636ms)","trace[2107646596] 'compare' (duration: 81.378934ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:13.912287Z","caller":"traceutil/trace.go:171","msg":"trace[967598080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:470; }","duration":"436.468105ms","start":"2026-05-06T01:14:13.475796Z","end":"2026-05-06T01:14:13.912264Z","steps":["trace[967598080] 'agreement among raft nodes before linearized reading' (duration: 436.346329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:13.912327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:13.475773Z","time spent":"436.545518ms","remote":"127.0.0.1:56772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T01:14:13.912369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:13.409436Z","time spent":"502.849551ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:14:22.675431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277540044s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:14:22.675503Z","caller":"traceutil/trace.go:171","msg":"trace[1077103292] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"1.350717057s","start":"2026-05-06T01:14:21.324775Z","end":"2026-05-06T01:14:22.675492Z","steps":["trace[1077103292] 'read index received' (duration: 72.947772ms)","trace[1077103292] 'applied index is now lower than readState.Index' (duration: 1.277768615s)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:22.675552Z","caller":"traceutil/trace.go:171","msg":"trace[752529151] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"1.365859285s","start":"2026-05-06T01:14:21.309687Z","end":"2026-05-06T01:14:22.675546Z","steps":["trace[752529151] 'process raft request' (duration: 88.15768ms)","trace[752529151] 'compare' (duration: 1.277409124s)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:22.675577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:21.309674Z","time spent":"1.365891805s","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T01:14:22.67581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.351029687s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:150495"} {"level":"info","ts":"2026-05-06T01:14:22.675842Z","caller":"traceutil/trace.go:171","msg":"trace[433019418] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:572; }","duration":"1.351094608s","start":"2026-05-06T01:14:21.324741Z","end":"2026-05-06T01:14:22.675836Z","steps":["trace[433019418] 'agreement among raft nodes before linearized reading' (duration: 1.350928697s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:22.675858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:21.324729Z","time spent":"1.351124728s","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":150518,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-05-06T01:14:22.675868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.260788733s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-06T01:14:22.675935Z","caller":"traceutil/trace.go:171","msg":"trace[130036660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"1.260895473s","start":"2026-05-06T01:14:21.415023Z","end":"2026-05-06T01:14:22.675919Z","steps":["trace[130036660] 'agreement among raft nodes before linearized reading' (duration: 1.260774642s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:22.676066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.865346ms","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-05-06T01:14:22.676089Z","caller":"traceutil/trace.go:171","msg":"trace[2146955161] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:572; }","duration":"719.925096ms","start":"2026-05-06T01:14:21.956158Z","end":"2026-05-06T01:14:22.676084Z","steps":["trace[2146955161] 'agreement among raft nodes before linearized reading' (duration: 719.885826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:22.676102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:21.956138Z","time spent":"719.961536ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-06T01:14:22.676131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.342229ms","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-05-06T01:14:22.676171Z","caller":"traceutil/trace.go:171","msg":"trace[1563098548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"721.413549ms","start":"2026-05-06T01:14:21.954746Z","end":"2026-05-06T01:14:22.67616Z","steps":["trace[1563098548] 'agreement among raft nodes before linearized reading' (duration: 721.342099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:22.676185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.672417ms","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-05-06T01:14:22.676201Z","caller":"traceutil/trace.go:171","msg":"trace[1742480971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:572; }","duration":"199.711797ms","start":"2026-05-06T01:14:22.476485Z","end":"2026-05-06T01:14:22.676197Z","steps":["trace[1742480971] 'agreement among raft nodes before linearized reading' (duration: 199.682746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:22.676197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:21.954726Z","time spent":"721.46517ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T01:14:22.676187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.197801725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:22.676285Z","caller":"traceutil/trace.go:171","msg":"trace[1339103383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"1.197930976s","start":"2026-05-06T01:14:21.478327Z","end":"2026-05-06T01:14:22.676258Z","steps":["trace[1339103383] 'agreement among raft nodes before linearized reading' (duration: 1.197780445s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:22.67648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:21.415003Z","time spent":"1.260959113s","remote":"127.0.0.1:57006","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-05-06T01:14:22.676353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:21.47831Z","time spent":"1.198031016s","remote":"127.0.0.1:56772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-06T01:14:26.066068Z","caller":"traceutil/trace.go:171","msg":"trace[1323652014] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"132.047484ms","start":"2026-05-06T01:14:25.933986Z","end":"2026-05-06T01:14:26.066033Z","steps":["trace[1323652014] 'process raft request' (duration: 131.531431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:26.066202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.951266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:26.066268Z","caller":"traceutil/trace.go:171","msg":"trace[1532724278] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:610; }","duration":"120.051676ms","start":"2026-05-06T01:14:25.9462Z","end":"2026-05-06T01:14:26.066252Z","steps":["trace[1532724278] 'agreement among raft nodes before linearized reading' (duration: 119.916586ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:26.065968Z","caller":"traceutil/trace.go:171","msg":"trace[1163704119] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"119.731345ms","start":"2026-05-06T01:14:25.946219Z","end":"2026-05-06T01:14:26.065951Z","steps":["trace[1163704119] 'read index received' (duration: 119.062141ms)","trace[1163704119] 'applied index is now lower than readState.Index' (duration: 668.564µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:26.067606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.455255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:26.067635Z","caller":"traceutil/trace.go:171","msg":"trace[275902781] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:610; }","duration":"109.529695ms","start":"2026-05-06T01:14:25.958099Z","end":"2026-05-06T01:14:26.067629Z","steps":["trace[275902781] 'agreement among raft nodes before linearized reading' (duration: 109.472335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:26.067741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.360844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:26.067775Z","caller":"traceutil/trace.go:171","msg":"trace[515812938] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:610; }","duration":"121.515455ms","start":"2026-05-06T01:14:25.946248Z","end":"2026-05-06T01:14:26.067763Z","steps":["trace[515812938] 'agreement among raft nodes before linearized reading' (duration: 121.329604ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:26.773498Z","caller":"traceutil/trace.go:171","msg":"trace[1435590749] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"134.248136ms","start":"2026-05-06T01:14:26.638856Z","end":"2026-05-06T01:14:26.773104Z","steps":["trace[1435590749] 'process raft request' (duration: 133.609332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:29.976719Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011084377,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-06T01:14:30.477511Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011084377,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-06T01:14:30.612032Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.382751381s","expected-duration":"1s"} {"level":"info","ts":"2026-05-06T01:14:30.613126Z","caller":"traceutil/trace.go:171","msg":"trace[925823600] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"1.137099709s","start":"2026-05-06T01:14:29.475999Z","end":"2026-05-06T01:14:30.613099Z","steps":["trace[925823600] 'read index received' (duration: 1.136176812s)","trace[925823600] 'applied index is now lower than readState.Index' (duration: 921.847µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:30.613267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13725296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:30.613309Z","caller":"traceutil/trace.go:171","msg":"trace[1978876466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"1.137349651s","start":"2026-05-06T01:14:29.475947Z","end":"2026-05-06T01:14:30.613297Z","steps":["trace[1978876466] 'agreement among raft nodes before linearized reading' (duration: 1.137266401s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:30.613349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:29.475928Z","time spent":"1.137411652s","remote":"127.0.0.1:56764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-06T01:14:30.613267Z","caller":"traceutil/trace.go:171","msg":"trace[1371148305] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.38544186s","start":"2026-05-06T01:14:29.227794Z","end":"2026-05-06T01:14:30.613236Z","steps":["trace[1371148305] 'process raft request' (duration: 1.384692395s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:30.613567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:29.22776Z","time spent":"1.385710133s","remote":"127.0.0.1:56844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:14:30.613595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.050419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bxk76\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-06T01:14:30.613744Z","caller":"traceutil/trace.go:171","msg":"trace[1135616978] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bxk76; range_end:; response_count:1; response_revision:634; }","duration":"971.242061ms","start":"2026-05-06T01:14:29.642451Z","end":"2026-05-06T01:14:30.613693Z","steps":["trace[1135616978] 'agreement among raft nodes before linearized reading' (duration: 970.835267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:30.613751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.873097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.175\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-06T01:14:30.613793Z","caller":"traceutil/trace.go:171","msg":"trace[411470183] range","detail":"{range_begin:/registry/masterleases/199.19.213.175; range_end:; response_count:1; response_revision:634; }","duration":"818.950868ms","start":"2026-05-06T01:14:29.794832Z","end":"2026-05-06T01:14:30.613783Z","steps":["trace[411470183] 'agreement among raft nodes before linearized reading' (duration: 818.876457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:30.613824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:29.642426Z","time spent":"971.362382ms","remote":"127.0.0.1:56932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-bxk76\" "} {"level":"warn","ts":"2026-05-06T01:14:30.613829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:29.794813Z","time spent":"819.009598ms","remote":"127.0.0.1:56788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.175\" "} {"level":"warn","ts":"2026-05-06T01:14:31.179553Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011084385,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T01:14:31.471698Z","caller":"traceutil/trace.go:171","msg":"trace[34857972] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"836.426804ms","start":"2026-05-06T01:14:30.635254Z","end":"2026-05-06T01:14:31.471681Z","steps":["trace[34857972] 'process raft request' (duration: 836.159692ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:31.471826Z","caller":"traceutil/trace.go:171","msg":"trace[38439998] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"806.86173ms","start":"2026-05-06T01:14:30.664947Z","end":"2026-05-06T01:14:31.471809Z","steps":["trace[38439998] 'process raft request' (duration: 806.582928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:31.472606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:30.664919Z","time spent":"807.635986ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T01:14:31.472581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:30.635232Z","time spent":"837.24755ms","remote":"127.0.0.1:56932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:14:31.486436Z","caller":"traceutil/trace.go:171","msg":"trace[1249818660] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"807.911135ms","start":"2026-05-06T01:14:30.678504Z","end":"2026-05-06T01:14:31.486415Z","steps":["trace[1249818660] 'process raft request' (duration: 807.729554ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:31.486434Z","caller":"traceutil/trace.go:171","msg":"trace[1470013236] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:663; }","duration":"807.756874ms","start":"2026-05-06T01:14:30.67864Z","end":"2026-05-06T01:14:31.486397Z","steps":["trace[1470013236] 'read index received' (duration: 792.797593ms)","trace[1470013236] 'applied index is now lower than readState.Index' (duration: 14.957841ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:31.486557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:30.678488Z","time spent":"808.003236ms","remote":"127.0.0.1:56788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:14:31.486611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.948605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:31.486652Z","caller":"traceutil/trace.go:171","msg":"trace[281895247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"808.021496ms","start":"2026-05-06T01:14:30.67862Z","end":"2026-05-06T01:14:31.486642Z","steps":["trace[281895247] 'agreement among raft nodes before linearized reading' (duration: 807.868145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:31.486734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:30.678614Z","time spent":"808.112856ms","remote":"127.0.0.1:56764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T01:14:31.486802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.646229ms","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-05-06T01:14:31.486856Z","caller":"traceutil/trace.go:171","msg":"trace[945592340] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"652.767049ms","start":"2026-05-06T01:14:30.834075Z","end":"2026-05-06T01:14:31.486842Z","steps":["trace[945592340] 'agreement among raft nodes before linearized reading' (duration: 652.527887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:31.486902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:30.834016Z","time spent":"652.877101ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T01:14:31.486928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.907725ms","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-05-06T01:14:31.486958Z","caller":"traceutil/trace.go:171","msg":"trace[1549527924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"650.953135ms","start":"2026-05-06T01:14:30.835997Z","end":"2026-05-06T01:14:31.48695Z","steps":["trace[1549527924] 'agreement among raft nodes before linearized reading' (duration: 650.820494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:31.486981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:30.835988Z","time spent":"650.988346ms","remote":"127.0.0.1:57006","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-05-06T01:14:31.487211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.692961ms","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-05-06T01:14:31.487255Z","caller":"traceutil/trace.go:171","msg":"trace[1014140855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"651.748951ms","start":"2026-05-06T01:14:30.835494Z","end":"2026-05-06T01:14:31.487243Z","steps":["trace[1014140855] 'agreement among raft nodes before linearized reading' (duration: 651.644241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:31.487286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:30.835487Z","time spent":"651.792462ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-06T01:14:31.487323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.957103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-06T01:14:31.487444Z","caller":"traceutil/trace.go:171","msg":"trace[1685100336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"652.102394ms","start":"2026-05-06T01:14:30.835304Z","end":"2026-05-06T01:14:31.487406Z","steps":["trace[1685100336] 'agreement among raft nodes before linearized reading' (duration: 651.900322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:31.487513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:30.835293Z","time spent":"652.208736ms","remote":"127.0.0.1:57006","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-05-06T01:14:31.625058Z","caller":"traceutil/trace.go:171","msg":"trace[658259802] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"132.617765ms","start":"2026-05-06T01:14:31.49239Z","end":"2026-05-06T01:14:31.625008Z","steps":["trace[658259802] 'process raft request' (duration: 132.348713ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:31.625154Z","caller":"traceutil/trace.go:171","msg":"trace[1289011905] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:667; }","duration":"131.473355ms","start":"2026-05-06T01:14:31.493664Z","end":"2026-05-06T01:14:31.625138Z","steps":["trace[1289011905] 'read index received' (duration: 20.580107ms)","trace[1289011905] 'applied index is now lower than readState.Index' (duration: 110.892238ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:31.625259Z","caller":"traceutil/trace.go:171","msg":"trace[249904306] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"132.655415ms","start":"2026-05-06T01:14:31.492582Z","end":"2026-05-06T01:14:31.625237Z","steps":["trace[249904306] 'process raft request' (duration: 132.368863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:31.625405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.724917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-06T01:14:31.625453Z","caller":"traceutil/trace.go:171","msg":"trace[486024642] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:641; }","duration":"131.824558ms","start":"2026-05-06T01:14:31.493617Z","end":"2026-05-06T01:14:31.625441Z","steps":["trace[486024642] 'agreement among raft nodes before linearized reading' (duration: 131.712437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:31.625459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.962407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:31.625498Z","caller":"traceutil/trace.go:171","msg":"trace[638243098] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:641; }","duration":"128.028357ms","start":"2026-05-06T01:14:31.497459Z","end":"2026-05-06T01:14:31.625487Z","steps":["trace[638243098] 'agreement among raft nodes before linearized reading' (duration: 127.951206ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:31.625049Z","caller":"traceutil/trace.go:171","msg":"trace[1038399987] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"132.471784ms","start":"2026-05-06T01:14:31.492517Z","end":"2026-05-06T01:14:31.624989Z","steps":["trace[1038399987] 'process raft request' (duration: 132.387564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:32.977205Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011084397,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-06T01:14:33.35164Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.723723716s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-06T01:14:34.006436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.527841ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:14:34.006555Z","caller":"traceutil/trace.go:171","msg":"trace[1490170281] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"1.530266244s","start":"2026-05-06T01:14:32.476264Z","end":"2026-05-06T01:14:34.00653Z","steps":["trace[1490170281] 'read index received' (duration: 875.4721ms)","trace[1490170281] 'applied index is now lower than readState.Index' (duration: 654.792474ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:34.006736Z","caller":"traceutil/trace.go:171","msg":"trace[783759152] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"2.378939414s","start":"2026-05-06T01:14:31.627782Z","end":"2026-05-06T01:14:34.006722Z","steps":["trace[783759152] 'process raft request' (duration: 1.724042529s)","trace[783759152] 'compare' (duration: 654.288669ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:34.006796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:31.627723Z","time spent":"2.379042835s","remote":"127.0.0.1:56932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T01:14:34.007036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.530775088s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:34.007068Z","caller":"traceutil/trace.go:171","msg":"trace[1905907828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"1.53083625s","start":"2026-05-06T01:14:32.476221Z","end":"2026-05-06T01:14:34.007057Z","steps":["trace[1905907828] 'agreement among raft nodes before linearized reading' (duration: 1.530744609s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:34.007097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:32.4762Z","time spent":"1.53089063s","remote":"127.0.0.1:56772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-06T01:14:34.007376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.099443ms","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-05-06T01:14:34.007437Z","caller":"traceutil/trace.go:171","msg":"trace[2000107012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"489.172663ms","start":"2026-05-06T01:14:33.518252Z","end":"2026-05-06T01:14:34.007425Z","steps":["trace[2000107012] 'agreement among raft nodes before linearized reading' (duration: 488.940201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:34.007458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.331252ms","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-05-06T01:14:34.007467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:33.518198Z","time spent":"489.262235ms","remote":"127.0.0.1:57006","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":"info","ts":"2026-05-06T01:14:34.007487Z","caller":"traceutil/trace.go:171","msg":"trace[700382819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"377.389343ms","start":"2026-05-06T01:14:33.630083Z","end":"2026-05-06T01:14:34.007472Z","steps":["trace[700382819] 'agreement among raft nodes before linearized reading' (duration: 377.327732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:34.007477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.535705ms","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-05-06T01:14:34.007509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:33.630073Z","time spent":"377.430814ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-06T01:14:34.007397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.351983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-06T01:14:34.007519Z","caller":"traceutil/trace.go:171","msg":"trace[1435619079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"377.613495ms","start":"2026-05-06T01:14:33.629895Z","end":"2026-05-06T01:14:34.007508Z","steps":["trace[1435619079] 'agreement among raft nodes before linearized reading' (duration: 377.470264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:34.007554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:33.629873Z","time spent":"377.673705ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-06T01:14:34.007572Z","caller":"traceutil/trace.go:171","msg":"trace[1188671163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"377.557974ms","start":"2026-05-06T01:14:33.629981Z","end":"2026-05-06T01:14:34.007539Z","steps":["trace[1188671163] 'agreement among raft nodes before linearized reading' (duration: 377.370102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:34.007664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:33.629954Z","time spent":"377.681566ms","remote":"127.0.0.1:57006","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-05-06T01:14:36.193246Z","caller":"traceutil/trace.go:171","msg":"trace[265476336] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"223.556392ms","start":"2026-05-06T01:14:35.969663Z","end":"2026-05-06T01:14:36.193219Z","steps":["trace[265476336] 'process raft request' (duration: 223.42125ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:37.554874Z","caller":"traceutil/trace.go:171","msg":"trace[351954405] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"186.655195ms","start":"2026-05-06T01:14:37.368194Z","end":"2026-05-06T01:14:37.55485Z","steps":["trace[351954405] 'process raft request' (duration: 186.511464ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:37.909636Z","caller":"traceutil/trace.go:171","msg":"trace[1866354958] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"228.176475ms","start":"2026-05-06T01:14:37.681436Z","end":"2026-05-06T01:14:37.909612Z","steps":["trace[1866354958] 'process raft request' (duration: 193.262049ms)","trace[1866354958] 'compare' (duration: 34.800524ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:37.986289Z","caller":"traceutil/trace.go:171","msg":"trace[70614917] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:732; }","duration":"214.573474ms","start":"2026-05-06T01:14:37.771681Z","end":"2026-05-06T01:14:37.986255Z","steps":["trace[70614917] 'read index received' (duration: 103.02772ms)","trace[70614917] 'applied index is now lower than readState.Index' (duration: 111.544614ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:37.986325Z","caller":"traceutil/trace.go:171","msg":"trace[83818373] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"248.409068ms","start":"2026-05-06T01:14:37.737891Z","end":"2026-05-06T01:14:37.9863Z","steps":["trace[83818373] 'process raft request' (duration: 248.203696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:37.986535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.837876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-05-06T01:14:37.986576Z","caller":"traceutil/trace.go:171","msg":"trace[1553819473] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:704; }","duration":"214.915909ms","start":"2026-05-06T01:14:37.771649Z","end":"2026-05-06T01:14:37.986565Z","steps":["trace[1553819473] 'agreement among raft nodes before linearized reading' (duration: 214.740616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.245606Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364371011084724,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T01:14:54.61984Z","caller":"traceutil/trace.go:171","msg":"trace[1599135355] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:842; }","duration":"874.868011ms","start":"2026-05-06T01:14:53.74495Z","end":"2026-05-06T01:14:54.619818Z","steps":["trace[1599135355] 'read index received' (duration: 874.741079ms)","trace[1599135355] 'applied index is now lower than readState.Index' (duration: 126.002µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:54.619964Z","caller":"traceutil/trace.go:171","msg":"trace[2111492887] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"957.234002ms","start":"2026-05-06T01:14:53.662709Z","end":"2026-05-06T01:14:54.619943Z","steps":["trace[2111492887] 'process raft request' (duration: 956.971117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.620105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:53.662689Z","time spent":"957.332624ms","remote":"127.0.0.1:56922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:14:54.620162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.199377ms","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-05-06T01:14:54.620213Z","caller":"traceutil/trace.go:171","msg":"trace[1626994032] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:808; }","duration":"875.290559ms","start":"2026-05-06T01:14:53.744908Z","end":"2026-05-06T01:14:54.620198Z","steps":["trace[1626994032] 'agreement among raft nodes before linearized reading' (duration: 875.024404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.620268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:53.744888Z","time spent":"875.36407ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-06T01:14:54.697826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.128881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7s95j\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-06T01:14:54.697946Z","caller":"traceutil/trace.go:171","msg":"trace[494536881] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7s95j; range_end:; response_count:1; response_revision:809; }","duration":"943.265693ms","start":"2026-05-06T01:14:53.754657Z","end":"2026-05-06T01:14:54.697923Z","steps":["trace[494536881] 'agreement among raft nodes before linearized reading' (duration: 943.011938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.697971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.517786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-06T01:14:54.698047Z","caller":"traceutil/trace.go:171","msg":"trace[683968921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"397.633728ms","start":"2026-05-06T01:14:54.300398Z","end":"2026-05-06T01:14:54.698032Z","steps":["trace[683968921] 'agreement among raft nodes before linearized reading' (duration: 397.482485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.6981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:54.300377Z","time spent":"397.70948ms","remote":"127.0.0.1:57006","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-05-06T01:14:54.698162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.987455ms","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-05-06T01:14:54.698221Z","caller":"traceutil/trace.go:171","msg":"trace[37580776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"398.091166ms","start":"2026-05-06T01:14:54.300116Z","end":"2026-05-06T01:14:54.698208Z","steps":["trace[37580776] 'agreement among raft nodes before linearized reading' (duration: 397.910783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.698269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:54.300092Z","time spent":"398.165198ms","remote":"127.0.0.1:57006","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":"info","ts":"2026-05-06T01:14:54.698294Z","caller":"traceutil/trace.go:171","msg":"trace[1844652227] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"259.683211ms","start":"2026-05-06T01:14:54.438588Z","end":"2026-05-06T01:14:54.698271Z","steps":["trace[1844652227] 'process raft request' (duration: 258.933718ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.697999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:53.754649Z","time spent":"943.335364ms","remote":"127.0.0.1:56932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7s95j\" "} {"level":"warn","ts":"2026-05-06T01:14:54.698506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.956044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-06T01:14:54.698587Z","caller":"traceutil/trace.go:171","msg":"trace[162926320] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:809; }","duration":"298.065925ms","start":"2026-05-06T01:14:54.400508Z","end":"2026-05-06T01:14:54.698574Z","steps":["trace[162926320] 'agreement among raft nodes before linearized reading' (duration: 297.956743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.698612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.959231ms","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-05-06T01:14:54.698667Z","caller":"traceutil/trace.go:171","msg":"trace[622778255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:809; }","duration":"400.045152ms","start":"2026-05-06T01:14:54.298609Z","end":"2026-05-06T01:14:54.698654Z","steps":["trace[622778255] 'agreement among raft nodes before linearized reading' (duration: 399.868639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.69871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:54.298593Z","time spent":"400.105782ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T01:14:54.69922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.514483ms","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-05-06T01:14:54.69931Z","caller":"traceutil/trace.go:171","msg":"trace[174336806] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"399.254307ms","start":"2026-05-06T01:14:54.300039Z","end":"2026-05-06T01:14:54.699293Z","steps":["trace[174336806] 'agreement among raft nodes before linearized reading' (duration: 398.421892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:54.699357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:54.300023Z","time spent":"399.318448ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-06T01:14:54.82636Z","caller":"traceutil/trace.go:171","msg":"trace[812492251] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"201.279694ms","start":"2026-05-06T01:14:54.625057Z","end":"2026-05-06T01:14:54.826337Z","steps":["trace[812492251] 'process raft request' (duration: 198.773379ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:54.8328Z","caller":"traceutil/trace.go:171","msg":"trace[701602394] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"128.836873ms","start":"2026-05-06T01:14:54.703943Z","end":"2026-05-06T01:14:54.83278Z","steps":["trace[701602394] 'process raft request' (duration: 128.71251ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:54.833065Z","caller":"traceutil/trace.go:171","msg":"trace[472728442] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"128.996885ms","start":"2026-05-06T01:14:54.704055Z","end":"2026-05-06T01:14:54.833052Z","steps":["trace[472728442] 'process raft request' (duration: 128.69263ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:54.833545Z","caller":"traceutil/trace.go:171","msg":"trace[770788623] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"129.372072ms","start":"2026-05-06T01:14:54.704158Z","end":"2026-05-06T01:14:54.83353Z","steps":["trace[770788623] 'process raft request' (duration: 128.70232ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:54.834141Z","caller":"traceutil/trace.go:171","msg":"trace[657982427] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"129.166889ms","start":"2026-05-06T01:14:54.70495Z","end":"2026-05-06T01:14:54.834117Z","steps":["trace[657982427] 'process raft request' (duration: 128.386264ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:54.834419Z","caller":"traceutil/trace.go:171","msg":"trace[1374196348] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"127.570139ms","start":"2026-05-06T01:14:54.706837Z","end":"2026-05-06T01:14:54.834407Z","steps":["trace[1374196348] 'process raft request' (duration: 127.191533ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:05.0451Z","caller":"traceutil/trace.go:171","msg":"trace[471104812] linearizableReadLoop","detail":"{readStateIndex:944; appliedIndex:943; }","duration":"171.654843ms","start":"2026-05-06T01:15:04.873427Z","end":"2026-05-06T01:15:05.045081Z","steps":["trace[471104812] 'read index received' (duration: 171.49562ms)","trace[471104812] 'applied index is now lower than readState.Index' (duration: 158.333µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:15:05.045205Z","caller":"traceutil/trace.go:171","msg":"trace[122554592] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"237.540565ms","start":"2026-05-06T01:15:04.807655Z","end":"2026-05-06T01:15:05.045195Z","steps":["trace[122554592] 'process raft request' (duration: 237.256399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:05.045392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.96087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-06T01:15:05.045432Z","caller":"traceutil/trace.go:171","msg":"trace[857027204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:907; }","duration":"172.048622ms","start":"2026-05-06T01:15:04.873374Z","end":"2026-05-06T01:15:05.045422Z","steps":["trace[857027204] 'agreement among raft nodes before linearized reading' (duration: 171.927899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:05.078852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.905079ms","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-05-06T01:15:05.078923Z","caller":"traceutil/trace.go:171","msg":"trace[110279681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:908; }","duration":"199.993591ms","start":"2026-05-06T01:15:04.878913Z","end":"2026-05-06T01:15:05.078907Z","steps":["trace[110279681] 'agreement among raft nodes before linearized reading' (duration: 199.824417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:05.078991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.397414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:15:05.079058Z","caller":"traceutil/trace.go:171","msg":"trace[613053241] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:908; }","duration":"133.515916ms","start":"2026-05-06T01:15:04.945527Z","end":"2026-05-06T01:15:05.079043Z","steps":["trace[613053241] 'agreement among raft nodes before linearized reading' (duration: 133.380843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:05.078991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.216875ms","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-05-06T01:15:05.079224Z","caller":"traceutil/trace.go:171","msg":"trace[697944170] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:908; }","duration":"200.43782ms","start":"2026-05-06T01:15:04.878755Z","end":"2026-05-06T01:15:05.079193Z","steps":["trace[697944170] 'agreement among raft nodes before linearized reading' (duration: 200.124953ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:05.07883Z","caller":"traceutil/trace.go:171","msg":"trace[1806287878] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"193.536111ms","start":"2026-05-06T01:15:04.885259Z","end":"2026-05-06T01:15:05.078795Z","steps":["trace[1806287878] 'process raft request' (duration: 193.351197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:05.079322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.593865ms","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-05-06T01:15:05.079512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.945517ms","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-05-06T01:15:05.079566Z","caller":"traceutil/trace.go:171","msg":"trace[1470659797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:908; }","duration":"198.028148ms","start":"2026-05-06T01:15:04.881522Z","end":"2026-05-06T01:15:05.07955Z","steps":["trace[1470659797] 'agreement among raft nodes before linearized reading' (duration: 197.208671ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:05.079632Z","caller":"traceutil/trace.go:171","msg":"trace[1052246731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:908; }","duration":"201.862541ms","start":"2026-05-06T01:15:04.877664Z","end":"2026-05-06T01:15:05.079526Z","steps":["trace[1052246731] 'agreement among raft nodes before linearized reading' (duration: 201.269148ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:10.496Z","caller":"traceutil/trace.go:171","msg":"trace[1658950227] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"136.610349ms","start":"2026-05-06T01:15:10.35936Z","end":"2026-05-06T01:15:10.49597Z","steps":["trace[1658950227] 'process raft request' (duration: 136.387964ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:32.181874Z","caller":"traceutil/trace.go:171","msg":"trace[1294411809] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"174.785347ms","start":"2026-05-06T01:15:32.007061Z","end":"2026-05-06T01:15:32.181846Z","steps":["trace[1294411809] 'process raft request' (duration: 174.623162ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:48.447981Z","caller":"traceutil/trace.go:171","msg":"trace[2045865252] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"194.268215ms","start":"2026-05-06T01:15:48.253691Z","end":"2026-05-06T01:15:48.447959Z","steps":["trace[2045865252] 'process raft request' (duration: 194.149501ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:07.683828Z","caller":"traceutil/trace.go:171","msg":"trace[1077287936] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"117.851598ms","start":"2026-05-06T01:16:07.565962Z","end":"2026-05-06T01:16:07.683814Z","steps":["trace[1077287936] 'process raft request' (duration: 117.738404ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:07.800181Z","caller":"traceutil/trace.go:171","msg":"trace[2124971178] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"112.270599ms","start":"2026-05-06T01:16:07.687887Z","end":"2026-05-06T01:16:07.800158Z","steps":["trace[2124971178] 'process raft request' (duration: 112.193026ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:07.800416Z","caller":"traceutil/trace.go:171","msg":"trace[971498857] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"111.977769ms","start":"2026-05-06T01:16:07.688422Z","end":"2026-05-06T01:16:07.8004Z","steps":["trace[971498857] 'process raft request' (duration: 111.70145ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:07.800643Z","caller":"traceutil/trace.go:171","msg":"trace[2133329484] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"112.89373ms","start":"2026-05-06T01:16:07.687738Z","end":"2026-05-06T01:16:07.800632Z","steps":["trace[2133329484] 'process raft request' (duration: 111.900767ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:11.851741Z","caller":"traceutil/trace.go:171","msg":"trace[1170579008] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"101.77425ms","start":"2026-05-06T01:16:11.749946Z","end":"2026-05-06T01:16:11.85172Z","steps":["trace[1170579008] 'process raft request' (duration: 101.644735ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:21.979463Z","caller":"traceutil/trace.go:171","msg":"trace[1141138636] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"183.191726ms","start":"2026-05-06T01:16:21.796238Z","end":"2026-05-06T01:16:21.97943Z","steps":["trace[1141138636] 'process raft request' (duration: 183.0109ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:22.010463Z","caller":"traceutil/trace.go:171","msg":"trace[1260035624] linearizableReadLoop","detail":"{readStateIndex:1285; appliedIndex:1283; }","duration":"114.016673ms","start":"2026-05-06T01:16:21.896407Z","end":"2026-05-06T01:16:22.010424Z","steps":["trace[1260035624] 'read index received' (duration: 82.908707ms)","trace[1260035624] 'applied index is now lower than readState.Index' (duration: 31.106436ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:16:22.010577Z","caller":"traceutil/trace.go:171","msg":"trace[489168964] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"136.079849ms","start":"2026-05-06T01:16:21.874445Z","end":"2026-05-06T01:16:22.010525Z","steps":["trace[489168964] 'process raft request' (duration: 124.443969ms)","trace[489168964] 'compare' (duration: 11.37991ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:16:22.010871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.438467ms","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-05-06T01:16:22.010979Z","caller":"traceutil/trace.go:171","msg":"trace[1510914102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1230; }","duration":"114.566952ms","start":"2026-05-06T01:16:21.896373Z","end":"2026-05-06T01:16:22.01094Z","steps":["trace[1510914102] 'agreement among raft nodes before linearized reading' (duration: 114.23454ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:22.124793Z","caller":"traceutil/trace.go:171","msg":"trace[1459355734] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"109.205542ms","start":"2026-05-06T01:16:22.015553Z","end":"2026-05-06T01:16:22.124759Z","steps":["trace[1459355734] 'process raft request' (duration: 97.667175ms)","trace[1459355734] 'compare' (duration: 11.31448ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:16:22.124922Z","caller":"traceutil/trace.go:171","msg":"trace[1076853862] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"107.506092ms","start":"2026-05-06T01:16:22.017392Z","end":"2026-05-06T01:16:22.124899Z","steps":["trace[1076853862] 'process raft request' (duration: 107.311465ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:22.124895Z","caller":"traceutil/trace.go:171","msg":"trace[200203145] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"108.797287ms","start":"2026-05-06T01:16:22.016039Z","end":"2026-05-06T01:16:22.124836Z","steps":["trace[200203145] 'process raft request' (duration: 108.619601ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:24.135574Z","caller":"traceutil/trace.go:171","msg":"trace[2135291626] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"145.073023ms","start":"2026-05-06T01:16:23.990475Z","end":"2026-05-06T01:16:24.135548Z","steps":["trace[2135291626] 'read index received' (duration: 144.868866ms)","trace[2135291626] 'applied index is now lower than readState.Index' (duration: 202.887µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:16:24.135649Z","caller":"traceutil/trace.go:171","msg":"trace[1766692166] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"149.55389ms","start":"2026-05-06T01:16:23.986063Z","end":"2026-05-06T01:16:24.135617Z","steps":["trace[1766692166] 'process raft request' (duration: 149.339133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:24.135736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.224858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:16:24.13582Z","caller":"traceutil/trace.go:171","msg":"trace[1024544176] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1236; }","duration":"145.369884ms","start":"2026-05-06T01:16:23.99043Z","end":"2026-05-06T01:16:24.1358Z","steps":["trace[1024544176] 'agreement among raft nodes before linearized reading' (duration: 145.202138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:24.37963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.989567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:16:24.379734Z","caller":"traceutil/trace.go:171","msg":"trace[980142270] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"239.822132ms","start":"2026-05-06T01:16:24.139893Z","end":"2026-05-06T01:16:24.379715Z","steps":["trace[980142270] 'process raft request' (duration: 124.668389ms)","trace[980142270] 'compare' (duration: 114.880513ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:16:24.397671Z","caller":"traceutil/trace.go:171","msg":"trace[138272716] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"256.576237ms","start":"2026-05-06T01:16:24.141082Z","end":"2026-05-06T01:16:24.397658Z","steps":["trace[138272716] 'process raft request' (duration: 256.509605ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:24.397684Z","caller":"traceutil/trace.go:171","msg":"trace[862537384] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"257.056474ms","start":"2026-05-06T01:16:24.140591Z","end":"2026-05-06T01:16:24.397648Z","steps":["trace[862537384] 'process raft request' (duration: 256.973531ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:24.397782Z","caller":"traceutil/trace.go:171","msg":"trace[337788996] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"257.724547ms","start":"2026-05-06T01:16:24.140006Z","end":"2026-05-06T01:16:24.39773Z","steps":["trace[337788996] 'process raft request' (duration: 257.434877ms)"],"step_count":1}