{"level":"warn","ts":"2026-07-23T03:15:08.135922Z","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-23T03:15:08.136005Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-23T03:15:08.136084Z","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-23T03:15:08.136097Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-07-23T03:15:08.13612Z","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-23T03:15:08.136937Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-07-23T03:15:08.137009Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-23T03:15:08.148376Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"11.161646ms"} {"level":"info","ts":"2026-07-23T03:15:08.168133Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-07-23T03:15:08.16824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-07-23T03:15:08.168273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-07-23T03:15:08.168297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-23T03:15:08.168318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-07-23T03:15:08.168369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-07-23T03:15:08.182532Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-23T03:15:08.189392Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-23T03:15:08.195048Z","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-23T03:15:08.201926Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-23T03:15:08.20216Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-23T03:15:08.2022Z","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-23T03:15:08.202286Z","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-23T03:15:08.202309Z","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-23T03:15:08.204783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-07-23T03:15:08.205178Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-07-23T03:15:08.208384Z","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-23T03:15:08.208569Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-07-23T03:15:08.208597Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-07-23T03:15:08.208922Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-23T03:15:08.208961Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-23T03:15:08.268921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-07-23T03:15:08.268989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-07-23T03:15:08.269015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-07-23T03:15:08.269036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-07-23T03:15:08.269047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-07-23T03:15:08.269068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-07-23T03:15:08.269082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-07-23T03:15:08.277727Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T03:15:08.280033Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T03:15:08.280085Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T03:15:08.280099Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T03:15:08.280111Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T03:15:08.28016Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T03:15:08.280159Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-07-23T03:15:08.280708Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-23T03:15:08.280783Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-23T03:15:08.281779Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-23T03:15:08.283461Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-07-23T03:15:11.610092Z","caller":"traceutil/trace.go:171","msg":"trace[363413093] transaction","detail":"{read_only:false; response_revision:125; number_of_response:1; }","duration":"151.868943ms","start":"2026-07-23T03:15:11.458192Z","end":"2026-07-23T03:15:11.610061Z","steps":["trace[363413093] 'process raft request' (duration: 105.256555ms)","trace[363413093] 'compare' (duration: 46.437184ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T03:15:22.699561Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870931719195511,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T03:15:23.200678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870931719195511,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T03:15:23.306424Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.108528571s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T03:15:23.306827Z","caller":"traceutil/trace.go:171","msg":"trace[770190634] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"1.108060569s","start":"2026-07-23T03:15:22.198746Z","end":"2026-07-23T03:15:23.306806Z","steps":["trace[770190634] 'read index received' (duration: 1.107871574s)","trace[770190634] 'applied index is now lower than readState.Index' (duration: 188.145µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T03:15:23.306908Z","caller":"traceutil/trace.go:171","msg":"trace[2114147493] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"1.109227018s","start":"2026-07-23T03:15:22.19767Z","end":"2026-07-23T03:15:23.306897Z","steps":["trace[2114147493] 'process raft request' (duration: 1.109003002s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:23.307041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.566595ms","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-07-23T03:15:23.307163Z","caller":"traceutil/trace.go:171","msg":"trace[1862430826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:403; }","duration":"574.73899ms","start":"2026-07-23T03:15:22.732405Z","end":"2026-07-23T03:15:23.307144Z","steps":["trace[1862430826] 'agreement among raft nodes before linearized reading' (duration: 574.534605ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:23.307207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:22.732385Z","time spent":"574.809372ms","remote":"127.0.0.1:52076","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-23T03:15:23.307195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.108437408s","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-07-23T03:15:23.307274Z","caller":"traceutil/trace.go:171","msg":"trace[1955613504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:403; }","duration":"1.10855419s","start":"2026-07-23T03:15:22.198699Z","end":"2026-07-23T03:15:23.307254Z","steps":["trace[1955613504] 'agreement among raft nodes before linearized reading' (duration: 1.108433017s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:23.307316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:22.198681Z","time spent":"1.108624902s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-23T03:15:23.307442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:22.197621Z","time spent":"1.10933052s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T03:15:23.307459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.819003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-23T03:15:23.307492Z","caller":"traceutil/trace.go:171","msg":"trace[1921263312] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:403; }","duration":"554.870894ms","start":"2026-07-23T03:15:22.752612Z","end":"2026-07-23T03:15:23.307483Z","steps":["trace[1921263312] 'agreement among raft nodes before linearized reading' (duration: 554.820812ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:23.307517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:22.7526Z","time spent":"554.911784ms","remote":"127.0.0.1:51858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"info","ts":"2026-07-23T03:15:29.499266Z","caller":"traceutil/trace.go:171","msg":"trace[1581541978] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:438; }","duration":"101.451155ms","start":"2026-07-23T03:15:29.397798Z","end":"2026-07-23T03:15:29.499249Z","steps":["trace[1581541978] 'read index received' (duration: 101.325282ms)","trace[1581541978] 'applied index is now lower than readState.Index' (duration: 125.203µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T03:15:29.499301Z","caller":"traceutil/trace.go:171","msg":"trace[1165568454] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"102.414809ms","start":"2026-07-23T03:15:29.396863Z","end":"2026-07-23T03:15:29.499278Z","steps":["trace[1165568454] 'process raft request' (duration: 102.281755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:29.499679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.295046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T03:15:29.499858Z","caller":"traceutil/trace.go:171","msg":"trace[914235033] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:423; }","duration":"100.599183ms","start":"2026-07-23T03:15:29.399235Z","end":"2026-07-23T03:15:29.499834Z","steps":["trace[914235033] 'agreement among raft nodes before linearized reading' (duration: 100.236924ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:29.499515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.120572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T03:15:29.500036Z","caller":"traceutil/trace.go:171","msg":"trace[18015602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:423; }","duration":"100.621974ms","start":"2026-07-23T03:15:29.399364Z","end":"2026-07-23T03:15:29.499986Z","steps":["trace[18015602] 'agreement among raft nodes before linearized reading' (duration: 100.110592ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:29.499589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.567278ms","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-07-23T03:15:29.500264Z","caller":"traceutil/trace.go:171","msg":"trace[1686159195] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:423; }","duration":"102.342307ms","start":"2026-07-23T03:15:29.397756Z","end":"2026-07-23T03:15:29.500098Z","steps":["trace[1686159195] 'agreement among raft nodes before linearized reading' (duration: 101.583878ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:35.545297Z","caller":"traceutil/trace.go:171","msg":"trace[1292707031] linearizableReadLoop","detail":"{readStateIndex:454; appliedIndex:453; }","duration":"270.434325ms","start":"2026-07-23T03:15:35.274841Z","end":"2026-07-23T03:15:35.545275Z","steps":["trace[1292707031] 'read index received' (duration: 269.851281ms)","trace[1292707031] 'applied index is now lower than readState.Index' (duration: 582.034µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T03:15:35.545453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.576389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T03:15:35.545483Z","caller":"traceutil/trace.go:171","msg":"trace[98097267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:437; }","duration":"270.692532ms","start":"2026-07-23T03:15:35.274782Z","end":"2026-07-23T03:15:35.545475Z","steps":["trace[98097267] 'agreement among raft nodes before linearized reading' (duration: 270.60939ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:35.54544Z","caller":"traceutil/trace.go:171","msg":"trace[1779734195] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"849.502345ms","start":"2026-07-23T03:15:34.695867Z","end":"2026-07-23T03:15:35.545369Z","steps":["trace[1779734195] 'process raft request' (duration: 848.91267ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:35.545699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:34.695844Z","time spent":"849.690109ms","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T03:15:35.696652Z","caller":"traceutil/trace.go:171","msg":"trace[829627949] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"138.339117ms","start":"2026-07-23T03:15:35.558282Z","end":"2026-07-23T03:15:35.696621Z","steps":["trace[829627949] 'process raft request' (duration: 137.144076ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:35.696813Z","caller":"traceutil/trace.go:171","msg":"trace[546392711] linearizableReadLoop","detail":"{readStateIndex:456; appliedIndex:454; }","duration":"133.249098ms","start":"2026-07-23T03:15:35.563536Z","end":"2026-07-23T03:15:35.696785Z","steps":["trace[546392711] 'read index received' (duration: 131.845461ms)","trace[546392711] 'applied index is now lower than readState.Index' (duration: 1.402457ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T03:15:35.697038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.816741ms","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-07-23T03:15:35.697076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.667201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T03:15:35.697095Z","caller":"traceutil/trace.go:171","msg":"trace[1211877366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:439; }","duration":"131.909343ms","start":"2026-07-23T03:15:35.56517Z","end":"2026-07-23T03:15:35.69708Z","steps":["trace[1211877366] 'agreement among raft nodes before linearized reading' (duration: 131.760009ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:35.697077Z","caller":"traceutil/trace.go:171","msg":"trace[108117048] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"137.620509ms","start":"2026-07-23T03:15:35.559283Z","end":"2026-07-23T03:15:35.696903Z","steps":["trace[108117048] 'process raft request' (duration: 137.302851ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:35.697131Z","caller":"traceutil/trace.go:171","msg":"trace[610785669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:439; }","duration":"128.767724ms","start":"2026-07-23T03:15:35.568349Z","end":"2026-07-23T03:15:35.697117Z","steps":["trace[610785669] 'agreement among raft nodes before linearized reading' (duration: 128.61648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:35.697533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.985416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T03:15:35.697614Z","caller":"traceutil/trace.go:171","msg":"trace[217063540] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:439; }","duration":"134.058848ms","start":"2026-07-23T03:15:35.563509Z","end":"2026-07-23T03:15:35.697568Z","steps":["trace[217063540] 'agreement among raft nodes before linearized reading' (duration: 133.403202ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:40.069771Z","caller":"traceutil/trace.go:171","msg":"trace[2005783515] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"352.232069ms","start":"2026-07-23T03:15:39.717513Z","end":"2026-07-23T03:15:40.069745Z","steps":["trace[2005783515] 'process raft request' (duration: 351.972602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:40.069997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:39.717496Z","time spent":"352.403954ms","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T03:15:40.076011Z","caller":"traceutil/trace.go:171","msg":"trace[361285081] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:494; }","duration":"346.11341ms","start":"2026-07-23T03:15:39.729884Z","end":"2026-07-23T03:15:40.075998Z","steps":["trace[361285081] 'read index received' (duration: 339.684774ms)","trace[361285081] 'applied index is now lower than readState.Index' (duration: 6.427976ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T03:15:40.076076Z","caller":"traceutil/trace.go:171","msg":"trace[1032212774] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"355.002871ms","start":"2026-07-23T03:15:39.721063Z","end":"2026-07-23T03:15:40.076066Z","steps":["trace[1032212774] 'process raft request' (duration: 354.876048ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:40.07612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:39.72104Z","time spent":"355.050723ms","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T03:15:40.076208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.318016ms","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-07-23T03:15:40.076254Z","caller":"traceutil/trace.go:171","msg":"trace[349256963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:477; }","duration":"346.379728ms","start":"2026-07-23T03:15:39.729864Z","end":"2026-07-23T03:15:40.076244Z","steps":["trace[349256963] 'agreement among raft nodes before linearized reading' (duration: 346.250214ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:40.076277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:39.729857Z","time spent":"346.414668ms","remote":"127.0.0.1:52076","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-23T03:15:40.07625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.241197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T03:15:40.076335Z","caller":"traceutil/trace.go:171","msg":"trace[960169310] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:477; }","duration":"336.350939ms","start":"2026-07-23T03:15:39.739962Z","end":"2026-07-23T03:15:40.076313Z","steps":["trace[960169310] 'agreement among raft nodes before linearized reading' (duration: 336.135884ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:40.076392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:39.739955Z","time spent":"336.428111ms","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-23T03:15:40.997883Z","caller":"traceutil/trace.go:171","msg":"trace[2103262780] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"237.244516ms","start":"2026-07-23T03:15:40.760611Z","end":"2026-07-23T03:15:40.997855Z","steps":["trace[2103262780] 'process raft request' (duration: 237.057371ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:49.274063Z","caller":"traceutil/trace.go:171","msg":"trace[1355562706] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"131.908311ms","start":"2026-07-23T03:15:49.14213Z","end":"2026-07-23T03:15:49.274038Z","steps":["trace[1355562706] 'process raft request' (duration: 131.694786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:51.789534Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870931719195795,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T03:15:52.158872Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.199421866s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T03:15:52.159572Z","caller":"traceutil/trace.go:171","msg":"trace[953460952] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.200200408s","start":"2026-07-23T03:15:50.959347Z","end":"2026-07-23T03:15:52.159547Z","steps":["trace[953460952] 'process raft request' (duration: 1.19990897s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.15971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.959328Z","time spent":"1.200316732s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.173055Z","caller":"traceutil/trace.go:171","msg":"trace[856785355] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.210851035s","start":"2026-07-23T03:15:50.962184Z","end":"2026-07-23T03:15:52.173035Z","steps":["trace[856785355] 'process raft request' (duration: 1.21066488s)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:52.173267Z","caller":"traceutil/trace.go:171","msg":"trace[832488597] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.19873597s","start":"2026-07-23T03:15:50.974519Z","end":"2026-07-23T03:15:52.173255Z","steps":["trace[832488597] 'process raft request' (duration: 1.198554385s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.173351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.97451Z","time spent":"1.198791572s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T03:15:52.17327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.962164Z","time spent":"1.2110467s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.173457Z","caller":"traceutil/trace.go:171","msg":"trace[768068079] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"1.194363795s","start":"2026-07-23T03:15:50.979084Z","end":"2026-07-23T03:15:52.173447Z","steps":["trace[768068079] 'process raft request' (duration: 1.194044075s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.173506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.979075Z","time spent":"1.194411856s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.173082Z","caller":"traceutil/trace.go:171","msg":"trace[485009031] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.203049385s","start":"2026-07-23T03:15:50.970014Z","end":"2026-07-23T03:15:52.173063Z","steps":["trace[485009031] 'process raft request' (duration: 1.202940052s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.173711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.969994Z","time spent":"1.203667543s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.173118Z","caller":"traceutil/trace.go:171","msg":"trace[1742897024] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.200422415s","start":"2026-07-23T03:15:50.972673Z","end":"2026-07-23T03:15:52.173096Z","steps":["trace[1742897024] 'process raft request' (duration: 1.200322883s)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:52.173717Z","caller":"traceutil/trace.go:171","msg":"trace[1683558294] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.194573159s","start":"2026-07-23T03:15:50.97913Z","end":"2026-07-23T03:15:52.173704Z","steps":["trace[1683558294] 'process raft request' (duration: 1.194155128s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.173916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.972645Z","time spent":"1.201191497s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.173152Z","caller":"traceutil/trace.go:171","msg":"trace[217672431] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.200153898s","start":"2026-07-23T03:15:50.972986Z","end":"2026-07-23T03:15:52.17314Z","steps":["trace[217672431] 'process raft request' (duration: 1.200051346s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.173998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.979126Z","time spent":"1.194820937s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T03:15:52.174044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.972976Z","time spent":"1.201052533s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.174085Z","caller":"traceutil/trace.go:171","msg":"trace[978930920] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.179897536s","start":"2026-07-23T03:15:50.99417Z","end":"2026-07-23T03:15:52.174068Z","steps":["trace[978930920] 'process raft request' (duration: 1.179223548s)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:15:52.17415Z","caller":"traceutil/trace.go:171","msg":"trace[1284831521] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.161810022s","start":"2026-07-23T03:15:51.012314Z","end":"2026-07-23T03:15:52.174124Z","steps":["trace[1284831521] 'process raft request' (duration: 1.161581506s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.17421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:50.99416Z","time spent":"1.179990868s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T03:15:52.174237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:51.012294Z","time spent":"1.161905465s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.174264Z","caller":"traceutil/trace.go:171","msg":"trace[1613351690] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.14162529s","start":"2026-07-23T03:15:51.032628Z","end":"2026-07-23T03:15:52.174254Z","steps":["trace[1613351690] 'process raft request' (duration: 1.141406084s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.174306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:51.032607Z","time spent":"1.141681711s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.174481Z","caller":"traceutil/trace.go:171","msg":"trace[585561951] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.043058183s","start":"2026-07-23T03:15:51.131416Z","end":"2026-07-23T03:15:52.174474Z","steps":["trace[585561951] 'process raft request' (duration: 1.042719444s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.17453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:51.131371Z","time spent":"1.043130825s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T03:15:52.174587Z","caller":"traceutil/trace.go:171","msg":"trace[2146800690] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:557; }","duration":"885.742518ms","start":"2026-07-23T03:15:51.288822Z","end":"2026-07-23T03:15:52.174564Z","steps":["trace[2146800690] 'read index received' (duration: 870.338543ms)","trace[2146800690] 'applied index is now lower than readState.Index' (duration: 15.402935ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T03:15:52.174635Z","caller":"traceutil/trace.go:171","msg":"trace[23876051] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.037849823s","start":"2026-07-23T03:15:51.13677Z","end":"2026-07-23T03:15:52.17462Z","steps":["trace[23876051] 'process raft request' (duration: 1.037646087s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.174708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.902403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T03:15:52.174711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:51.136746Z","time spent":"1.037933694s","remote":"127.0.0.1:51872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:15:52.174752Z","caller":"traceutil/trace.go:171","msg":"trace[882608785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:549; }","duration":"885.950414ms","start":"2026-07-23T03:15:51.288791Z","end":"2026-07-23T03:15:52.174741Z","steps":["trace[882608785] 'agreement among raft nodes before linearized reading' (duration: 885.864882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:52.174789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:51.288732Z","time spent":"886.050007ms","remote":"127.0.0.1:51840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-23T03:15:59.767112Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.107633891s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T03:15:59.767574Z","caller":"traceutil/trace.go:171","msg":"trace[1116450027] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.108170176s","start":"2026-07-23T03:15:58.659374Z","end":"2026-07-23T03:15:59.767544Z","steps":["trace[1116450027] 'process raft request' (duration: 1.107967471s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:15:59.767713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:58.659356Z","time spent":"1.108280779s","remote":"127.0.0.1:52020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T03:16:00.776355Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870931719195992,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T03:16:01.276853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870931719195992,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T03:16:01.470851Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.701649578s","expected-duration":"1s"} {"level":"info","ts":"2026-07-23T03:16:01.471673Z","caller":"traceutil/trace.go:171","msg":"trace[1391591082] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"1.19616173s","start":"2026-07-23T03:16:00.27549Z","end":"2026-07-23T03:16:01.471652Z","steps":["trace[1391591082] 'read index received' (duration: 1.195496511s)","trace[1391591082] 'applied index is now lower than readState.Index' (duration: 664.399µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T03:16:01.471794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.196283364s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T03:16:01.471831Z","caller":"traceutil/trace.go:171","msg":"trace[566422017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"1.196348905s","start":"2026-07-23T03:16:00.275472Z","end":"2026-07-23T03:16:01.471821Z","steps":["trace[566422017] 'agreement among raft nodes before linearized reading' (duration: 1.196263763s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:01.471867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:00.275421Z","time spent":"1.196438117s","remote":"127.0.0.1:51840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-23T03:16:01.47183Z","caller":"traceutil/trace.go:171","msg":"trace[1328838191] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"2.672016373s","start":"2026-07-23T03:15:58.799723Z","end":"2026-07-23T03:16:01.471739Z","steps":["trace[1328838191] 'process raft request' (duration: 2.671468248s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:01.472076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.167518322s","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-07-23T03:16:01.472129Z","caller":"traceutil/trace.go:171","msg":"trace[1075249948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:651; }","duration":"1.167575333s","start":"2026-07-23T03:16:00.304535Z","end":"2026-07-23T03:16:01.47211Z","steps":["trace[1075249948] 'agreement among raft nodes before linearized reading' (duration: 1.167486621s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:01.47217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:00.304526Z","time spent":"1.167636456s","remote":"127.0.0.1:52076","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-23T03:16:01.472288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:15:58.799679Z","time spent":"2.672420894s","remote":"127.0.0.1:51912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T03:16:01.472295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.169685772s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-23T03:16:01.472317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.169610819s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T03:16:01.472346Z","caller":"traceutil/trace.go:171","msg":"trace[677552823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:651; }","duration":"1.169754784s","start":"2026-07-23T03:16:00.30258Z","end":"2026-07-23T03:16:01.472335Z","steps":["trace[677552823] 'agreement among raft nodes before linearized reading' (duration: 1.16960527s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:01.472386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:00.302571Z","time spent":"1.169807395s","remote":"127.0.0.1:52076","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-07-23T03:16:01.471986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170591386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-23T03:16:01.472416Z","caller":"traceutil/trace.go:171","msg":"trace[1064326395] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:651; }","duration":"1.169689272s","start":"2026-07-23T03:16:00.302652Z","end":"2026-07-23T03:16:01.472341Z","steps":["trace[1064326395] 'agreement among raft nodes before linearized reading' (duration: 1.169505837s)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:16:01.472481Z","caller":"traceutil/trace.go:171","msg":"trace[342347603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:651; }","duration":"1.171129351s","start":"2026-07-23T03:16:00.301343Z","end":"2026-07-23T03:16:01.472472Z","steps":["trace[342347603] 'agreement among raft nodes before linearized reading' (duration: 1.170454073s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:01.472512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:00.301328Z","time spent":"1.171177443s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T03:16:01.472485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:00.30263Z","time spent":"1.169847316s","remote":"127.0.0.1:52076","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-07-23T03:16:03.481205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999920503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-23T03:16:03.481281Z","caller":"traceutil/trace.go:171","msg":"trace[1023586112] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000037346s","start":"2026-07-23T03:16:01.481229Z","end":"2026-07-23T03:16:03.481266Z","steps":["trace[1023586112] 'agreement among raft nodes before linearized reading' (duration: 1.999942444s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:03.481324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:01.481217Z","time spent":"2.000098808s","remote":"127.0.0.1:51840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-23T03:16:03.705601Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.155297179s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-23T03:16:04.487766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.377651ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T03:16:04.48791Z","caller":"traceutil/trace.go:171","msg":"trace[1795996511] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:651; }","duration":"193.545436ms","start":"2026-07-23T03:16:04.294343Z","end":"2026-07-23T03:16:04.487888Z","steps":["trace[1795996511] 'range keys from in-memory index tree' (duration: 193.357751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:04.488834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.938329259s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T03:16:04.489032Z","caller":"traceutil/trace.go:171","msg":"trace[1921532195] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"3.011196408s","start":"2026-07-23T03:16:01.477819Z","end":"2026-07-23T03:16:04.489016Z","steps":["trace[1921532195] 'process raft request' (duration: 3.011110315s)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:16:04.489033Z","caller":"traceutil/trace.go:171","msg":"trace[2032610022] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"3.01234612s","start":"2026-07-23T03:16:01.476669Z","end":"2026-07-23T03:16:04.489015Z","steps":["trace[2032610022] 'process raft request' (duration: 73.61764ms)","trace[2032610022] 'compare' (duration: 2.937726801s)"],"step_count":2} {"level":"warn","ts":"2026-07-23T03:16:04.489096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:01.477788Z","time spent":"3.01127744s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T03:16:04.489143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:01.476649Z","time spent":"3.012423622s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T03:16:04.489156Z","caller":"traceutil/trace.go:171","msg":"trace[1573634347] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"3.00982231s","start":"2026-07-23T03:16:01.479323Z","end":"2026-07-23T03:16:04.489145Z","steps":["trace[1573634347] 'process raft request' (duration: 3.009663116s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:04.489207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:01.479312Z","time spent":"3.009868422s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T03:16:04.489201Z","caller":"traceutil/trace.go:171","msg":"trace[185251447] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:681; }","duration":"3.007923658s","start":"2026-07-23T03:16:01.481259Z","end":"2026-07-23T03:16:04.489182Z","steps":["trace[185251447] 'read index received' (duration: 69.040925ms)","trace[185251447] 'applied index is now lower than readState.Index' (duration: 2.938881893s)"],"step_count":2} {"level":"info","ts":"2026-07-23T03:16:04.489213Z","caller":"traceutil/trace.go:171","msg":"trace[1345632360] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"3.008303748s","start":"2026-07-23T03:16:01.480863Z","end":"2026-07-23T03:16:04.489167Z","steps":["trace[1345632360] 'process raft request' (duration: 3.008203725s)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:16:04.489287Z","caller":"traceutil/trace.go:171","msg":"trace[85196882] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"2.962222798s","start":"2026-07-23T03:16:01.527053Z","end":"2026-07-23T03:16:04.489276Z","steps":["trace[85196882] 'process raft request' (duration: 2.962066144s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:04.489334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:01.527012Z","time spent":"2.96230157s","remote":"127.0.0.1:52058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T03:16:04.489315Z","caller":"traceutil/trace.go:171","msg":"trace[1955105072] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"2.084752501s","start":"2026-07-23T03:16:02.404527Z","end":"2026-07-23T03:16:04.489279Z","steps":["trace[1955105072] 'process raft request' (duration: 2.084629088s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:04.489353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:01.480845Z","time spent":"3.008429432s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T03:16:04.489409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.7349198s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-23T03:16:04.489431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:02.404497Z","time spent":"2.084872125s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T03:16:04.489442Z","caller":"traceutil/trace.go:171","msg":"trace[1649773435] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:657; }","duration":"1.734991742s","start":"2026-07-23T03:16:02.75444Z","end":"2026-07-23T03:16:04.489432Z","steps":["trace[1649773435] 'agreement among raft nodes before linearized reading' (duration: 1.734853128s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:04.489477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:02.754394Z","time spent":"1.735074945s","remote":"127.0.0.1:51858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-07-23T03:16:04.489501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00707746s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T03:16:04.489523Z","caller":"traceutil/trace.go:171","msg":"trace[1495482526] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"1.007136492s","start":"2026-07-23T03:16:03.48238Z","end":"2026-07-23T03:16:04.489516Z","steps":["trace[1495482526] 'agreement among raft nodes before linearized reading' (duration: 1.007101171s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:04.489541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:03.48236Z","time spent":"1.007177103s","remote":"127.0.0.1:51850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-23T03:16:04.789106Z","caller":"traceutil/trace.go:171","msg":"trace[1213910853] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"124.891269ms","start":"2026-07-23T03:16:04.664186Z","end":"2026-07-23T03:16:04.789078Z","steps":["trace[1213910853] 'process raft request' (duration: 57.289201ms)","trace[1213910853] 'compare' (duration: 67.456684ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T03:16:04.830423Z","caller":"traceutil/trace.go:171","msg":"trace[486127056] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"152.6407ms","start":"2026-07-23T03:16:04.677758Z","end":"2026-07-23T03:16:04.830399Z","steps":["trace[486127056] 'process raft request' (duration: 152.512846ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:16:05.83525Z","caller":"traceutil/trace.go:171","msg":"trace[787831711] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"156.484906ms","start":"2026-07-23T03:16:05.678733Z","end":"2026-07-23T03:16:05.835218Z","steps":["trace[787831711] 'process raft request' (duration: 156.24085ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:16:07.547792Z","caller":"traceutil/trace.go:171","msg":"trace[1341799672] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"272.433338ms","start":"2026-07-23T03:16:07.275336Z","end":"2026-07-23T03:16:07.54777Z","steps":["trace[1341799672] 'read index received' (duration: 272.269604ms)","trace[1341799672] 'applied index is now lower than readState.Index' (duration: 162.884µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T03:16:07.547864Z","caller":"traceutil/trace.go:171","msg":"trace[1633097808] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"752.204392ms","start":"2026-07-23T03:16:06.795622Z","end":"2026-07-23T03:16:07.547826Z","steps":["trace[1633097808] 'process raft request' (duration: 752.033567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:07.547943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.585863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T03:16:07.547984Z","caller":"traceutil/trace.go:171","msg":"trace[58442385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"272.678156ms","start":"2026-07-23T03:16:07.275296Z","end":"2026-07-23T03:16:07.547974Z","steps":["trace[58442385] 'agreement among raft nodes before linearized reading' (duration: 272.570883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:07.54821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:06.795594Z","time spent":"752.343956ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T03:16:23.28222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.922603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-23T03:16:23.282217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.154188ms","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-07-23T03:16:23.28229Z","caller":"traceutil/trace.go:171","msg":"trace[363528996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:821; }","duration":"694.034266ms","start":"2026-07-23T03:16:22.588243Z","end":"2026-07-23T03:16:23.282278Z","steps":["trace[363528996] 'range keys from in-memory index tree' (duration: 693.777338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:23.282321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:22.588232Z","time spent":"694.083177ms","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-23T03:16:23.282317Z","caller":"traceutil/trace.go:171","msg":"trace[549064998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:821; }","duration":"695.308463ms","start":"2026-07-23T03:16:22.586985Z","end":"2026-07-23T03:16:23.282293Z","steps":["trace[549064998] 'range keys from in-memory index tree' (duration: 694.833089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:23.282384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:22.586964Z","time spent":"695.407916ms","remote":"127.0.0.1:52076","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-23T03:16:23.282678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.936994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-23T03:16:23.282701Z","caller":"traceutil/trace.go:171","msg":"trace[1510631872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:821; }","duration":"693.974515ms","start":"2026-07-23T03:16:22.588721Z","end":"2026-07-23T03:16:23.282695Z","steps":["trace[1510631872] 'range keys from in-memory index tree' (duration: 693.869171ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:23.282715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:22.588712Z","time spent":"693.999146ms","remote":"127.0.0.1:52076","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-07-23T03:16:23.282708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.222515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-23T03:16:23.282824Z","caller":"traceutil/trace.go:171","msg":"trace[319335682] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:821; }","duration":"527.522135ms","start":"2026-07-23T03:16:22.755277Z","end":"2026-07-23T03:16:23.282799Z","steps":["trace[319335682] 'range keys from in-memory index tree' (duration: 527.03784ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:23.282841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.567161068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-23T03:16:23.282911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:22.755258Z","time spent":"527.633648ms","remote":"127.0.0.1:51858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-07-23T03:16:23.283011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528282612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-23T03:16:23.283041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.840531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T03:16:23.283074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.527125548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-p5m5q\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-23T03:16:23.283073Z","caller":"traceutil/trace.go:171","msg":"trace[984985347] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:821; }","duration":"439.904513ms","start":"2026-07-23T03:16:22.843159Z","end":"2026-07-23T03:16:23.283063Z","steps":["trace[984985347] 'count revisions from in-memory index tree' (duration: 439.750449ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:16:23.282916Z","caller":"traceutil/trace.go:171","msg":"trace[1260756228] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:821; }","duration":"1.567289283s","start":"2026-07-23T03:16:21.715609Z","end":"2026-07-23T03:16:23.282898Z","steps":["trace[1260756228] 'range keys from in-memory index tree' (duration: 1.566983574s)"],"step_count":1} {"level":"info","ts":"2026-07-23T03:16:23.283099Z","caller":"traceutil/trace.go:171","msg":"trace[1519965189] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-p5m5q; range_end:; response_count:1; response_revision:821; }","duration":"1.527166289s","start":"2026-07-23T03:16:21.755924Z","end":"2026-07-23T03:16:23.283091Z","steps":["trace[1519965189] 'range keys from in-memory index tree' (duration: 1.527060646s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:23.283116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:21.755917Z","time spent":"1.52719586s","remote":"127.0.0.1:52020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-p5m5q\" "} {"level":"warn","ts":"2026-07-23T03:16:23.283131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:21.715582Z","time spent":"1.567523329s","remote":"127.0.0.1:52076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-23T03:16:23.283072Z","caller":"traceutil/trace.go:171","msg":"trace[2029114857] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:821; }","duration":"1.528377324s","start":"2026-07-23T03:16:21.754683Z","end":"2026-07-23T03:16:23.28306Z","steps":["trace[2029114857] 'count revisions from in-memory index tree' (duration: 1.528214929s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:23.283209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:21.754662Z","time spent":"1.528537149s","remote":"127.0.0.1:52012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-07-23T03:16:23.283249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.129774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-23T03:16:23.283268Z","caller":"traceutil/trace.go:171","msg":"trace[185587880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:821; }","duration":"699.181095ms","start":"2026-07-23T03:16:22.584082Z","end":"2026-07-23T03:16:23.283263Z","steps":["trace[185587880] 'range keys from in-memory index tree' (duration: 699.00309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:23.283281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:22.584062Z","time spent":"699.216456ms","remote":"127.0.0.1:52076","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-07-23T03:16:23.283112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:22.843138Z","time spent":"439.959225ms","remote":"127.0.0.1:52042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-07-23T03:16:23.283394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08509162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T03:16:23.283893Z","caller":"traceutil/trace.go:171","msg":"trace[1688142601] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:821; }","duration":"1.085952235s","start":"2026-07-23T03:16:22.197921Z","end":"2026-07-23T03:16:23.283873Z","steps":["trace[1688142601] 'count revisions from in-memory index tree' (duration: 1.084997407s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T03:16:23.28428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T03:16:22.197896Z","time spent":"1.086362497s","remote":"127.0.0.1:52288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}