{"level":"warn","ts":"2026-07-16T06:52:36.597055Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T06:52:36.597191Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.216: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.216:2380","--initial-cluster=instance=https://199.19.213.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.216: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-07-16T06:52:36.597291Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T06:52:36.597312Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.216:2380"]} {"level":"info","ts":"2026-07-16T06:52:36.597334Z","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-07-16T06:52:36.598321Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"]} {"level":"info","ts":"2026-07-16T06:52:36.598423Z","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.216:2380"],"listen-peer-urls":["https://199.19.213.216:2380"],"advertise-client-urls":["https://199.19.213.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.216: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-07-16T06:52:36.610966Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.269239ms"} {"level":"info","ts":"2026-07-16T06:52:36.624984Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"58fa9386873601ed","cluster-id":"b3ae27d84cfabdf7"} {"level":"info","ts":"2026-07-16T06:52:36.625072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=()"} {"level":"info","ts":"2026-07-16T06:52:36.625093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became follower at term 0"} {"level":"info","ts":"2026-07-16T06:52:36.625109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 58fa9386873601ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-16T06:52:36.62512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became follower at term 1"} {"level":"info","ts":"2026-07-16T06:52:36.625166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=(6411599225518686701)"} {"level":"warn","ts":"2026-07-16T06:52:36.633195Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-16T06:52:36.63471Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-16T06:52:36.635994Z","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-07-16T06:52:36.638813Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"58fa9386873601ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-16T06:52:36.638953Z","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-07-16T06:52:36.639027Z","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-07-16T06:52:36.639041Z","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-07-16T06:52:36.639794Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"58fa9386873601ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-16T06:52:36.641372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=(6411599225518686701)"} {"level":"info","ts":"2026-07-16T06:52:36.641525Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b3ae27d84cfabdf7","local-member-id":"58fa9386873601ed","added-peer-id":"58fa9386873601ed","added-peer-peer-urls":["https://199.19.213.216:2380"]} {"level":"info","ts":"2026-07-16T06:52:36.644588Z","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-07-16T06:52:36.644802Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"58fa9386873601ed","initial-advertise-peer-urls":["https://199.19.213.216:2380"],"listen-peer-urls":["https://199.19.213.216:2380"],"advertise-client-urls":["https://199.19.213.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-16T06:52:36.644834Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-16T06:52:36.644979Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.216:2380"} {"level":"info","ts":"2026-07-16T06:52:36.644993Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.216:2380"} {"level":"info","ts":"2026-07-16T06:52:36.826185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed is starting a new election at term 1"} {"level":"info","ts":"2026-07-16T06:52:36.826247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became pre-candidate at term 1"} {"level":"info","ts":"2026-07-16T06:52:36.826295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed received MsgPreVoteResp from 58fa9386873601ed at term 1"} {"level":"info","ts":"2026-07-16T06:52:36.826315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became candidate at term 2"} {"level":"info","ts":"2026-07-16T06:52:36.826383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed received MsgVoteResp from 58fa9386873601ed at term 2"} {"level":"info","ts":"2026-07-16T06:52:36.826402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became leader at term 2"} {"level":"info","ts":"2026-07-16T06:52:36.826455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 58fa9386873601ed elected leader 58fa9386873601ed at term 2"} {"level":"info","ts":"2026-07-16T06:52:36.827519Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:52:36.828406Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"58fa9386873601ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.216:2379]}","request-path":"/0/members/58fa9386873601ed/attributes","cluster-id":"b3ae27d84cfabdf7","publish-timeout":"7s"} {"level":"info","ts":"2026-07-16T06:52:36.828419Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T06:52:36.828594Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T06:52:36.828792Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-16T06:52:36.8289Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-16T06:52:36.829026Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b3ae27d84cfabdf7","local-member-id":"58fa9386873601ed","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:52:36.829219Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:52:36.829297Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:52:36.832065Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.216:2379"} {"level":"info","ts":"2026-07-16T06:52:36.832777Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-16T06:53:00.211201Z","caller":"traceutil/trace.go:171","msg":"trace[2118277349] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"116.12182ms","start":"2026-07-16T06:53:00.095042Z","end":"2026-07-16T06:53:00.211164Z","steps":["trace[2118277349] 'process raft request' (duration: 115.835963ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:20.144773Z","caller":"traceutil/trace.go:171","msg":"trace[1055795882] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"253.189585ms","start":"2026-07-16T06:53:19.891552Z","end":"2026-07-16T06:53:20.144742Z","steps":["trace[1055795882] 'process raft request' (duration: 252.880998ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:53:20.615198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.309913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:53:20.615333Z","caller":"traceutil/trace.go:171","msg":"trace[1337320744] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"313.839263ms","start":"2026-07-16T06:53:20.30148Z","end":"2026-07-16T06:53:20.61532Z","steps":["trace[1337320744] 'read index received' (duration: 58.021µs)","trace[1337320744] 'applied index is now lower than readState.Index' (duration: 313.778942ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:53:20.61538Z","caller":"traceutil/trace.go:171","msg":"trace[555283556] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"454.950491ms","start":"2026-07-16T06:53:20.160422Z","end":"2026-07-16T06:53:20.615372Z","steps":["trace[555283556] 'process raft request' (duration: 45.054144ms)","trace[555283556] 'compare' (duration: 409.19951ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:53:20.615416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:53:20.16041Z","time spent":"454.985701ms","remote":"127.0.0.1:60148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T06:53:20.615586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.107648ms","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-07-16T06:53:20.615636Z","caller":"traceutil/trace.go:171","msg":"trace[597667453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"314.376476ms","start":"2026-07-16T06:53:20.301252Z","end":"2026-07-16T06:53:20.615629Z","steps":["trace[597667453] 'agreement among raft nodes before linearized reading' (duration: 314.259583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:53:20.615657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:53:20.301233Z","time spent":"314.418947ms","remote":"127.0.0.1:60214","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-07-16T06:53:20.752533Z","caller":"traceutil/trace.go:171","msg":"trace[83574361] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"137.158548ms","start":"2026-07-16T06:53:20.615349Z","end":"2026-07-16T06:53:20.752507Z","steps":["trace[83574361] 'read index received' (duration: 134.242012ms)","trace[83574361] 'applied index is now lower than readState.Index' (duration: 2.915266ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:53:20.752574Z","caller":"traceutil/trace.go:171","msg":"trace[126564864] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"220.135574ms","start":"2026-07-16T06:53:20.532403Z","end":"2026-07-16T06:53:20.752538Z","steps":["trace[126564864] 'process raft request' (duration: 217.374441ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:53:20.752688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.601646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.216\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-16T06:53:20.752691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.896938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-16T06:53:20.752729Z","caller":"traceutil/trace.go:171","msg":"trace[445869912] range","detail":"{range_begin:/registry/masterleases/199.19.213.216; range_end:; response_count:1; response_revision:593; }","duration":"408.73044ms","start":"2026-07-16T06:53:20.343988Z","end":"2026-07-16T06:53:20.752718Z","steps":["trace[445869912] 'agreement among raft nodes before linearized reading' (duration: 408.607127ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:53:20.752868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:53:20.343966Z","time spent":"408.889424ms","remote":"127.0.0.1:60022","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.216\" "} {"level":"info","ts":"2026-07-16T06:53:20.752741Z","caller":"traceutil/trace.go:171","msg":"trace[1277766015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:593; }","duration":"193.97219ms","start":"2026-07-16T06:53:20.558755Z","end":"2026-07-16T06:53:20.752727Z","steps":["trace[1277766015] 'agreement among raft nodes before linearized reading' (duration: 193.803156ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:53:20.753872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.56886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-16T06:53:20.75479Z","caller":"traceutil/trace.go:171","msg":"trace[782073331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"281.721794ms","start":"2026-07-16T06:53:20.47222Z","end":"2026-07-16T06:53:20.753942Z","steps":["trace[782073331] 'agreement among raft nodes before linearized reading' (duration: 281.023238ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:20.75998Z","caller":"traceutil/trace.go:171","msg":"trace[1526765330] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"140.045823ms","start":"2026-07-16T06:53:20.61992Z","end":"2026-07-16T06:53:20.759966Z","steps":["trace[1526765330] 'process raft request' (duration: 139.956021ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:53:34.946233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.916073ms","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-07-16T06:53:34.946239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.709365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-16T06:53:34.946313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.00062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-16T06:53:34.946315Z","caller":"traceutil/trace.go:171","msg":"trace[1121206453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:753; }","duration":"123.043146ms","start":"2026-07-16T06:53:34.823254Z","end":"2026-07-16T06:53:34.946297Z","steps":["trace[1121206453] 'range keys from in-memory index tree' (duration: 122.677338ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:34.946413Z","caller":"traceutil/trace.go:171","msg":"trace[522131011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:753; }","duration":"121.161093ms","start":"2026-07-16T06:53:34.825225Z","end":"2026-07-16T06:53:34.946386Z","steps":["trace[522131011] 'range keys from in-memory index tree' (duration: 120.786405ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:34.946329Z","caller":"traceutil/trace.go:171","msg":"trace[1724772479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:753; }","duration":"121.851719ms","start":"2026-07-16T06:53:34.824457Z","end":"2026-07-16T06:53:34.946309Z","steps":["trace[1724772479] 'range keys from in-memory index tree' (duration: 121.48226ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:35.091388Z","caller":"traceutil/trace.go:171","msg":"trace[1309306367] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"140.892802ms","start":"2026-07-16T06:53:34.950473Z","end":"2026-07-16T06:53:35.091366Z","steps":["trace[1309306367] 'process raft request' (duration: 140.746528ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:35.141683Z","caller":"traceutil/trace.go:171","msg":"trace[2037971896] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"191.112583ms","start":"2026-07-16T06:53:34.950548Z","end":"2026-07-16T06:53:35.141661Z","steps":["trace[2037971896] 'process raft request' (duration: 190.940079ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:35.141876Z","caller":"traceutil/trace.go:171","msg":"trace[551905920] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"190.9717ms","start":"2026-07-16T06:53:34.950865Z","end":"2026-07-16T06:53:35.141837Z","steps":["trace[551905920] 'process raft request' (duration: 190.760665ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:54:09.505029Z","caller":"traceutil/trace.go:171","msg":"trace[1809620103] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"199.618091ms","start":"2026-07-16T06:54:09.305374Z","end":"2026-07-16T06:54:09.504992Z","steps":["trace[1809620103] 'process raft request' (duration: 197.879892ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:54:09.507378Z","caller":"traceutil/trace.go:171","msg":"trace[1368177813] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"200.743025ms","start":"2026-07-16T06:54:09.306616Z","end":"2026-07-16T06:54:09.507359Z","steps":["trace[1368177813] 'process raft request' (duration: 200.601592ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:54:09.507475Z","caller":"traceutil/trace.go:171","msg":"trace[1645755853] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"172.856968ms","start":"2026-07-16T06:54:09.334599Z","end":"2026-07-16T06:54:09.507456Z","steps":["trace[1645755853] 'process raft request' (duration: 172.713974ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:54:31.165502Z","caller":"traceutil/trace.go:171","msg":"trace[176076501] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"140.384699ms","start":"2026-07-16T06:54:31.025095Z","end":"2026-07-16T06:54:31.16548Z","steps":["trace[176076501] 'process raft request' (duration: 140.239296ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:54:32.092923Z","caller":"traceutil/trace.go:171","msg":"trace[87292433] linearizableReadLoop","detail":"{readStateIndex:1078; appliedIndex:1077; }","duration":"499.090281ms","start":"2026-07-16T06:54:31.593765Z","end":"2026-07-16T06:54:32.092855Z","steps":["trace[87292433] 'read index received' (duration: 498.741193ms)","trace[87292433] 'applied index is now lower than readState.Index' (duration: 347.778µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:54:32.09295Z","caller":"traceutil/trace.go:171","msg":"trace[1374973987] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"512.116689ms","start":"2026-07-16T06:54:31.580803Z","end":"2026-07-16T06:54:32.09292Z","steps":["trace[1374973987] 'process raft request' (duration: 511.827663ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:54:32.093127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.349516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-16T06:54:32.093136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:54:31.580779Z","time spent":"512.287684ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:54:32.093161Z","caller":"traceutil/trace.go:171","msg":"trace[514232661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1038; }","duration":"499.429118ms","start":"2026-07-16T06:54:31.593725Z","end":"2026-07-16T06:54:32.093154Z","steps":["trace[514232661] 'agreement among raft nodes before linearized reading' (duration: 499.283125ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:54:32.093186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:54:31.593708Z","time spent":"499.473049ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-16T06:54:32.0932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.697857ms","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-07-16T06:54:32.093245Z","caller":"traceutil/trace.go:171","msg":"trace[553967139] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1038; }","duration":"486.773538ms","start":"2026-07-16T06:54:31.606457Z","end":"2026-07-16T06:54:32.093231Z","steps":["trace[553967139] 'agreement among raft nodes before linearized reading' (duration: 486.621625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:54:32.093244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.289506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-16T06:54:32.093287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:54:31.606425Z","time spent":"486.85228ms","remote":"127.0.0.1:60214","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-07-16T06:54:32.093301Z","caller":"traceutil/trace.go:171","msg":"trace[1930147905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1038; }","duration":"462.390138ms","start":"2026-07-16T06:54:31.630898Z","end":"2026-07-16T06:54:32.093288Z","steps":["trace[1930147905] 'agreement among raft nodes before linearized reading' (duration: 462.248245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:54:32.093331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:54:31.630872Z","time spent":"462.45396ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-16T06:54:32.274922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.229941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:54:32.275223Z","caller":"traceutil/trace.go:171","msg":"trace[432090162] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"177.820088ms","start":"2026-07-16T06:54:32.097221Z","end":"2026-07-16T06:54:32.275041Z","steps":["trace[432090162] 'process raft request' (duration: 67.354071ms)","trace[432090162] 'compare' (duration: 110.069128ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:54:32.48323Z","caller":"traceutil/trace.go:171","msg":"trace[344898168] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"385.947595ms","start":"2026-07-16T06:54:32.097259Z","end":"2026-07-16T06:54:32.483207Z","steps":["trace[344898168] 'process raft request' (duration: 298.434668ms)","trace[344898168] 'compare' (duration: 87.367924ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:54:32.483368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:54:32.097238Z","time spent":"386.058348ms","remote":"127.0.0.1:60214","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-07-16T06:54:32.483438Z","caller":"traceutil/trace.go:171","msg":"trace[44286255] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1079; }","duration":"196.876699ms","start":"2026-07-16T06:54:32.286537Z","end":"2026-07-16T06:54:32.483413Z","steps":["trace[44286255] 'read index received' (duration: 109.142467ms)","trace[44286255] 'applied index is now lower than readState.Index' (duration: 87.730742ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:54:32.483679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.133384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-16T06:54:32.48372Z","caller":"traceutil/trace.go:171","msg":"trace[1196904551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1041; }","duration":"197.236316ms","start":"2026-07-16T06:54:32.286474Z","end":"2026-07-16T06:54:32.48371Z","steps":["trace[1196904551] 'agreement among raft nodes before linearized reading' (duration: 197.028492ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:54:32.483813Z","caller":"traceutil/trace.go:171","msg":"trace[704608472] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"386.482708ms","start":"2026-07-16T06:54:32.097288Z","end":"2026-07-16T06:54:32.483771Z","steps":["trace[704608472] 'process raft request' (duration: 385.883305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:54:32.483987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:54:32.097261Z","time spent":"386.6353ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:54:49.81911Z","caller":"traceutil/trace.go:171","msg":"trace[171908918] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"201.772328ms","start":"2026-07-16T06:54:49.617322Z","end":"2026-07-16T06:54:49.819094Z","steps":["trace[171908918] 'process raft request' (duration: 201.654395ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:06.547411Z","caller":"traceutil/trace.go:171","msg":"trace[93326698] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"136.855487ms","start":"2026-07-16T06:55:06.410504Z","end":"2026-07-16T06:55:06.54736Z","steps":["trace[93326698] 'process raft request' (duration: 136.570981ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:06.814516Z","caller":"traceutil/trace.go:171","msg":"trace[234783528] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1272; }","duration":"171.976297ms","start":"2026-07-16T06:55:06.642509Z","end":"2026-07-16T06:55:06.814486Z","steps":["trace[234783528] 'read index received' (duration: 166.8706ms)","trace[234783528] 'applied index is now lower than readState.Index' (duration: 5.104327ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:55:06.814823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.290194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-16T06:55:06.814866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.729723ms","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-07-16T06:55:06.814883Z","caller":"traceutil/trace.go:171","msg":"trace[1582407181] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1224; }","duration":"172.374836ms","start":"2026-07-16T06:55:06.64249Z","end":"2026-07-16T06:55:06.814864Z","steps":["trace[1582407181] 'agreement among raft nodes before linearized reading' (duration: 172.186092ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:06.814922Z","caller":"traceutil/trace.go:171","msg":"trace[835870549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1224; }","duration":"114.939098ms","start":"2026-07-16T06:55:06.699966Z","end":"2026-07-16T06:55:06.814905Z","steps":["trace[835870549] 'agreement among raft nodes before linearized reading' (duration: 114.721773ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:06.815096Z","caller":"traceutil/trace.go:171","msg":"trace[1928030686] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"183.9589ms","start":"2026-07-16T06:55:06.631116Z","end":"2026-07-16T06:55:06.815075Z","steps":["trace[1928030686] 'process raft request' (duration: 178.359462ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:07.387976Z","caller":"traceutil/trace.go:171","msg":"trace[1906605792] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"169.408359ms","start":"2026-07-16T06:55:07.218533Z","end":"2026-07-16T06:55:07.387942Z","steps":["trace[1906605792] 'process raft request' (duration: 169.162263ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:55:09.039938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.401995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-16T06:55:09.039938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.358502ms","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-07-16T06:55:09.040022Z","caller":"traceutil/trace.go:171","msg":"trace[1120027648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1236; }","duration":"193.536268ms","start":"2026-07-16T06:55:08.846465Z","end":"2026-07-16T06:55:09.040001Z","steps":["trace[1120027648] 'range keys from in-memory index tree' (duration: 193.229062ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:09.040029Z","caller":"traceutil/trace.go:171","msg":"trace[719358632] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1236; }","duration":"221.525516ms","start":"2026-07-16T06:55:08.818487Z","end":"2026-07-16T06:55:09.040013Z","steps":["trace[719358632] 'range keys from in-memory index tree' (duration: 221.117377ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:55:09.040115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.973896ms","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-07-16T06:55:09.040199Z","caller":"traceutil/trace.go:171","msg":"trace[784747589] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1236; }","duration":"211.089868ms","start":"2026-07-16T06:55:08.829092Z","end":"2026-07-16T06:55:09.040181Z","steps":["trace[784747589] 'range keys from in-memory index tree' (duration: 210.766411ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:55:09.040194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.28908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-16T06:55:09.040274Z","caller":"traceutil/trace.go:171","msg":"trace[1572006541] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1236; }","duration":"278.417812ms","start":"2026-07-16T06:55:08.761835Z","end":"2026-07-16T06:55:09.040253Z","steps":["trace[1572006541] 'count revisions from in-memory index tree' (duration: 278.163336ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:09.212656Z","caller":"traceutil/trace.go:171","msg":"trace[372895958] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"168.402196ms","start":"2026-07-16T06:55:09.044224Z","end":"2026-07-16T06:55:09.212626Z","steps":["trace[372895958] 'process raft request' (duration: 156.141537ms)","trace[372895958] 'compare' (duration: 12.034984ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:55:09.213178Z","caller":"traceutil/trace.go:171","msg":"trace[196323647] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"168.56021ms","start":"2026-07-16T06:55:09.044606Z","end":"2026-07-16T06:55:09.213166Z","steps":["trace[196323647] 'process raft request' (duration: 167.960886ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:20.146104Z","caller":"traceutil/trace.go:171","msg":"trace[747448970] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"138.32936ms","start":"2026-07-16T06:55:20.007748Z","end":"2026-07-16T06:55:20.146077Z","steps":["trace[747448970] 'process raft request' (duration: 138.183367ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:53.200129Z","caller":"traceutil/trace.go:171","msg":"trace[14443911] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"106.609099ms","start":"2026-07-16T06:55:53.093448Z","end":"2026-07-16T06:55:53.200057Z","steps":["trace[14443911] 'process raft request' (duration: 106.372764ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:56:55.518105Z","caller":"traceutil/trace.go:171","msg":"trace[1653492704] transaction","detail":"{read_only:false; response_revision:1753; number_of_response:1; }","duration":"112.551434ms","start":"2026-07-16T06:56:55.40552Z","end":"2026-07-16T06:56:55.518072Z","steps":["trace[1653492704] 'process raft request' (duration: 32.474311ms)","trace[1653492704] 'compare' (duration: 79.862639ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:00.356332Z","caller":"traceutil/trace.go:171","msg":"trace[481647764] linearizableReadLoop","detail":"{readStateIndex:1846; appliedIndex:1845; }","duration":"187.373259ms","start":"2026-07-16T06:57:00.168929Z","end":"2026-07-16T06:57:00.356303Z","steps":["trace[481647764] 'read index received' (duration: 101.589797ms)","trace[481647764] 'applied index is now lower than readState.Index' (duration: 85.782332ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:57:00.356473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.530852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:57:00.356506Z","caller":"traceutil/trace.go:171","msg":"trace[1829185513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1775; }","duration":"187.620064ms","start":"2026-07-16T06:57:00.168874Z","end":"2026-07-16T06:57:00.356494Z","steps":["trace[1829185513] 'agreement among raft nodes before linearized reading' (duration: 187.530082ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:00.356674Z","caller":"traceutil/trace.go:171","msg":"trace[1187297910] transaction","detail":"{read_only:false; response_revision:1775; number_of_response:1; }","duration":"389.692005ms","start":"2026-07-16T06:56:59.966963Z","end":"2026-07-16T06:57:00.356656Z","steps":["trace[1187297910] 'process raft request' (duration: 303.607926ms)","trace[1187297910] 'compare' (duration: 85.610358ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:57:00.356779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:56:59.96695Z","time spent":"389.765316ms","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:57:01.980093Z","caller":"traceutil/trace.go:171","msg":"trace[378816802] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"100.746198ms","start":"2026-07-16T06:57:01.879319Z","end":"2026-07-16T06:57:01.980065Z","steps":["trace[378816802] 'process raft request' (duration: 100.576845ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:01.997124Z","caller":"traceutil/trace.go:171","msg":"trace[1824460605] transaction","detail":"{read_only:false; response_revision:1782; number_of_response:1; }","duration":"116.812961ms","start":"2026-07-16T06:57:01.880267Z","end":"2026-07-16T06:57:01.99708Z","steps":["trace[1824460605] 'process raft request' (duration: 116.606976ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:04.152156Z","caller":"traceutil/trace.go:171","msg":"trace[832028424] transaction","detail":"{read_only:false; response_revision:1792; number_of_response:1; }","duration":"122.017098ms","start":"2026-07-16T06:57:04.030098Z","end":"2026-07-16T06:57:04.152115Z","steps":["trace[832028424] 'process raft request' (duration: 101.20151ms)","trace[832028424] 'compare' (duration: 20.673945ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:05.429679Z","caller":"traceutil/trace.go:171","msg":"trace[748280899] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"219.707978ms","start":"2026-07-16T06:57:05.209946Z","end":"2026-07-16T06:57:05.429654Z","steps":["trace[748280899] 'process raft request' (duration: 219.546995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:05.618171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.207008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:57:05.61848Z","caller":"traceutil/trace.go:171","msg":"trace[1417597793] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"149.928366ms","start":"2026-07-16T06:57:05.46851Z","end":"2026-07-16T06:57:05.618438Z","steps":["trace[1417597793] 'process raft request' (duration: 43.310169ms)","trace[1417597793] 'compare' (duration: 106.052854ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:05.714395Z","caller":"traceutil/trace.go:171","msg":"trace[620420304] linearizableReadLoop","detail":"{readStateIndex:1871; appliedIndex:1869; }","duration":"170.835425ms","start":"2026-07-16T06:57:05.543523Z","end":"2026-07-16T06:57:05.714358Z","steps":["trace[620420304] 'read index received' (duration: 52.26408ms)","trace[620420304] 'applied index is now lower than readState.Index' (duration: 118.569505ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:57:05.714659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.121141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-16T06:57:05.71471Z","caller":"traceutil/trace.go:171","msg":"trace[661998712] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1798; }","duration":"171.232233ms","start":"2026-07-16T06:57:05.54346Z","end":"2026-07-16T06:57:05.714692Z","steps":["trace[661998712] 'agreement among raft nodes before linearized reading' (duration: 171.016108ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:06.139168Z","caller":"traceutil/trace.go:171","msg":"trace[1091523170] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"118.768108ms","start":"2026-07-16T06:57:06.020372Z","end":"2026-07-16T06:57:06.13914Z","steps":["trace[1091523170] 'process raft request' (duration: 118.588824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:07.154695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.295197ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:57:07.154833Z","caller":"traceutil/trace.go:171","msg":"trace[1630160178] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"148.153487ms","start":"2026-07-16T06:57:07.006652Z","end":"2026-07-16T06:57:07.154805Z","steps":["trace[1630160178] 'process raft request' (duration: 42.654125ms)","trace[1630160178] 'compare' (duration: 105.160914ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:07.536905Z","caller":"traceutil/trace.go:171","msg":"trace[116951827] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"102.008203ms","start":"2026-07-16T06:57:07.434861Z","end":"2026-07-16T06:57:07.536869Z","steps":["trace[116951827] 'process raft request' (duration: 65.069237ms)","trace[116951827] 'compare' (duration: 36.789963ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:07.759993Z","caller":"traceutil/trace.go:171","msg":"trace[2102294491] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"133.730094ms","start":"2026-07-16T06:57:07.626231Z","end":"2026-07-16T06:57:07.759962Z","steps":["trace[2102294491] 'process raft request' (duration: 133.5567ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:08.657724Z","caller":"traceutil/trace.go:171","msg":"trace[1121941806] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"131.218796ms","start":"2026-07-16T06:57:08.526466Z","end":"2026-07-16T06:57:08.657685Z","steps":["trace[1121941806] 'process raft request' (duration: 108.709462ms)","trace[1121941806] 'compare' (duration: 22.224108ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:10.41712Z","caller":"traceutil/trace.go:171","msg":"trace[131857796] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"117.306795ms","start":"2026-07-16T06:57:10.299793Z","end":"2026-07-16T06:57:10.4171Z","steps":["trace[131857796] 'process raft request' (duration: 107.70962ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:13.140291Z","caller":"traceutil/trace.go:171","msg":"trace[259994800] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"100.327956ms","start":"2026-07-16T06:57:13.039931Z","end":"2026-07-16T06:57:13.140259Z","steps":["trace[259994800] 'process raft request' (duration: 30.573515ms)","trace[259994800] 'compare' (duration: 69.499445ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:13.705476Z","caller":"traceutil/trace.go:171","msg":"trace[122284255] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"109.251246ms","start":"2026-07-16T06:57:13.596183Z","end":"2026-07-16T06:57:13.705434Z","steps":["trace[122284255] 'process raft request' (duration: 30.250087ms)","trace[122284255] 'compare' (duration: 78.889766ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:57:14.76069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.135657ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:57:14.760812Z","caller":"traceutil/trace.go:171","msg":"trace[1380766562] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"297.394438ms","start":"2026-07-16T06:57:14.46339Z","end":"2026-07-16T06:57:14.760784Z","steps":["trace[1380766562] 'process raft request' (duration: 157.076467ms)","trace[1380766562] 'compare' (duration: 139.706947ms)"],"step_count":2}