{"level":"warn","ts":"2026-08-07T04:35:09.998105Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-07T04:35:09.998215Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-08-07T04:35:09.998285Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-07T04:35:09.998296Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-08-07T04:35:09.998317Z","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-08-07T04:35:09.999221Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-08-07T04:35:09.999319Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-08-07T04:35:10.001838Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.206428ms"} {"level":"info","ts":"2026-08-07T04:35:10.009606Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-08-07T04:35:10.009659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-08-07T04:35:10.009675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-08-07T04:35:10.009683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-07T04:35:10.00969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-08-07T04:35:10.009718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-08-07T04:35:10.016203Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-07T04:35:10.017554Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-07T04:35:10.018641Z","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-08-07T04:35:10.02139Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-07T04:35:10.021763Z","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-08-07T04:35:10.021856Z","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-08-07T04:35:10.021867Z","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-08-07T04:35:10.021821Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-07T04:35:10.025787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-08-07T04:35:10.025961Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-08-07T04:35:10.029481Z","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-08-07T04:35:10.029543Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-08-07T04:35:10.029596Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-08-07T04:35:10.029822Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-07T04:35:10.02986Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-07T04:35:10.5153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-08-07T04:35:10.515343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-07T04:35:10.515358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-08-07T04:35:10.515368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-08-07T04:35:10.515374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-08-07T04:35:10.515382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-08-07T04:35:10.515389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-08-07T04:35:10.51686Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T04:35:10.518804Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T04:35:10.518897Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T04:35:10.518928Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T04:35:10.518965Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-08-07T04:35:10.519215Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-07T04:35:10.519404Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-07T04:35:10.519672Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-07T04:35:10.519707Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-07T04:35:10.522419Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-08-07T04:35:10.522838Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-07T04:35:12.050458Z","caller":"traceutil/trace.go:171","msg":"trace[542931610] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"314.919076ms","start":"2026-08-07T04:35:11.735519Z","end":"2026-08-07T04:35:12.050438Z","steps":["trace[542931610] 'process raft request' (duration: 314.771593ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:12.050863Z","caller":"traceutil/trace.go:171","msg":"trace[1459220566] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:5; }","duration":"307.88128ms","start":"2026-08-07T04:35:11.742944Z","end":"2026-08-07T04:35:12.050825Z","steps":["trace[1459220566] 'read index received' (duration: 307.867119ms)","trace[1459220566] 'applied index is now lower than readState.Index' (duration: 12.121µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:35:12.050963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.735504Z","time spent":"315.025978ms","remote":"127.0.0.1:39824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:35:12.051219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.234517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-07T04:35:12.051358Z","caller":"traceutil/trace.go:171","msg":"trace[1107937199] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"308.405741ms","start":"2026-08-07T04:35:11.742923Z","end":"2026-08-07T04:35:12.051328Z","steps":["trace[1107937199] 'agreement among raft nodes before linearized reading' (duration: 308.117474ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.051423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.742913Z","time spent":"308.496082ms","remote":"127.0.0.1:39960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":27,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-08-07T04:35:12.55116Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656054546402916992,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-07T04:35:12.906412Z","caller":"traceutil/trace.go:171","msg":"trace[1777850691] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.090588375s","start":"2026-08-07T04:35:11.815781Z","end":"2026-08-07T04:35:12.906369Z","steps":["trace[1777850691] 'process raft request' (duration: 1.090329519s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:12.906552Z","caller":"traceutil/trace.go:171","msg":"trace[610915299] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.089834289s","start":"2026-08-07T04:35:11.81668Z","end":"2026-08-07T04:35:12.906514Z","steps":["trace[610915299] 'process raft request' (duration: 1.089606444s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.906589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.815756Z","time spent":"1.090742469s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:12.906693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.816652Z","time spent":"1.089966611s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:12.906759Z","caller":"traceutil/trace.go:171","msg":"trace[1427052717] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.073318283s","start":"2026-08-07T04:35:11.83342Z","end":"2026-08-07T04:35:12.906739Z","steps":["trace[1427052717] 'process raft request' (duration: 1.073066718s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:12.906754Z","caller":"traceutil/trace.go:171","msg":"trace[167644749] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"855.490968ms","start":"2026-08-07T04:35:12.05103Z","end":"2026-08-07T04:35:12.906521Z","steps":["trace[167644749] 'read index received' (duration: 855.017718ms)","trace[167644749] 'applied index is now lower than readState.Index' (duration: 472.45µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:35:12.906823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.833407Z","time spent":"1.073386174s","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:12.90691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110920195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-07T04:35:12.906901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088801645s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-07T04:35:12.906947Z","caller":"traceutil/trace.go:171","msg":"trace[459616840] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.110991657s","start":"2026-08-07T04:35:11.795943Z","end":"2026-08-07T04:35:12.906934Z","steps":["trace[459616840] 'agreement among raft nodes before linearized reading' (duration: 1.110907986s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:12.906963Z","caller":"traceutil/trace.go:171","msg":"trace[383099425] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"1.088905228s","start":"2026-08-07T04:35:11.818041Z","end":"2026-08-07T04:35:12.906947Z","steps":["trace[383099425] 'agreement among raft nodes before linearized reading' (duration: 1.088759184s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.906989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.795931Z","time spent":"1.111044378s","remote":"127.0.0.1:39880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-07T04:35:12.906969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.09354833s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-07T04:35:12.906998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.817997Z","time spent":"1.08899199s","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-08-07T04:35:12.907092Z","caller":"traceutil/trace.go:171","msg":"trace[1601515635] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:0; response_revision:10; }","duration":"1.093699414s","start":"2026-08-07T04:35:11.813369Z","end":"2026-08-07T04:35:12.907068Z","steps":["trace[1601515635] 'agreement among raft nodes before linearized reading' (duration: 1.093445389s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.907142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.813359Z","time spent":"1.093772736s","remote":"127.0.0.1:39782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.227\" "} {"level":"info","ts":"2026-08-07T04:35:12.907176Z","caller":"traceutil/trace.go:171","msg":"trace[58814686] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.089866229s","start":"2026-08-07T04:35:11.817298Z","end":"2026-08-07T04:35:12.907164Z","steps":["trace[58814686] 'process raft request' (duration: 1.089032901s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.907174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040338542s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-07T04:35:12.907269Z","caller":"traceutil/trace.go:171","msg":"trace[860409071] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.082037437s","start":"2026-08-07T04:35:11.825223Z","end":"2026-08-07T04:35:12.90726Z","steps":["trace[860409071] 'process raft request' (duration: 1.081220959s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.907289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.11426187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-07T04:35:12.90731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.825214Z","time spent":"1.082077478s","remote":"127.0.0.1:39960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:12.907313Z","caller":"traceutil/trace.go:171","msg":"trace[1846464265] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.089511752s","start":"2026-08-07T04:35:11.81779Z","end":"2026-08-07T04:35:12.907301Z","steps":["trace[1846464265] 'process raft request' (duration: 1.088601462s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:12.907321Z","caller":"traceutil/trace.go:171","msg":"trace[1414053246] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.114350613s","start":"2026-08-07T04:35:11.792961Z","end":"2026-08-07T04:35:12.907312Z","steps":["trace[1414053246] 'agreement among raft nodes before linearized reading' (duration: 1.114303872s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:12.907323Z","caller":"traceutil/trace.go:171","msg":"trace[14745875] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.040544068s","start":"2026-08-07T04:35:11.866742Z","end":"2026-08-07T04:35:12.907286Z","steps":["trace[14745875] 'agreement among raft nodes before linearized reading' (duration: 1.040177199s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.907353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.792941Z","time spent":"1.114406253s","remote":"127.0.0.1:39880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-07T04:35:12.907373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.817771Z","time spent":"1.089570913s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:12.907389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.866732Z","time spent":"1.04064624s","remote":"127.0.0.1:39880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-07T04:35:12.907427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093194854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-07T04:35:12.907233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.817275Z","time spent":"1.089930712s","remote":"127.0.0.1:40188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:12.907462Z","caller":"traceutil/trace.go:171","msg":"trace[1879912580] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.093246066s","start":"2026-08-07T04:35:11.814205Z","end":"2026-08-07T04:35:12.907451Z","steps":["trace[1879912580] 'agreement among raft nodes before linearized reading' (duration: 1.093195785s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.90749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.814191Z","time spent":"1.093293586s","remote":"127.0.0.1:39880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-07T04:35:12.907506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.11558916s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-07T04:35:12.907513Z","caller":"traceutil/trace.go:171","msg":"trace[557539794] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.089903971s","start":"2026-08-07T04:35:11.8176Z","end":"2026-08-07T04:35:12.907504Z","steps":["trace[557539794] 'process raft request' (duration: 1.088766325s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:12.907535Z","caller":"traceutil/trace.go:171","msg":"trace[773221429] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.115645591s","start":"2026-08-07T04:35:11.791881Z","end":"2026-08-07T04:35:12.907527Z","steps":["trace[773221429] 'agreement among raft nodes before linearized reading' (duration: 1.11560155s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.90756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.817587Z","time spent":"1.089950272s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:12.907561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.791864Z","time spent":"1.115690972s","remote":"127.0.0.1:39880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-07T04:35:12.907605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.032446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-07T04:35:12.907648Z","caller":"traceutil/trace.go:171","msg":"trace[211567738] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"193.142478ms","start":"2026-08-07T04:35:12.714492Z","end":"2026-08-07T04:35:12.907635Z","steps":["trace[211567738] 'agreement among raft nodes before linearized reading' (duration: 193.069896ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:12.907678Z","caller":"traceutil/trace.go:171","msg":"trace[1304150655] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.089391349s","start":"2026-08-07T04:35:11.818277Z","end":"2026-08-07T04:35:12.907668Z","steps":["trace[1304150655] 'process raft request' (duration: 1.088137211s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.907744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164771159s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-08-07T04:35:12.907746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.818232Z","time spent":"1.089467541s","remote":"127.0.0.1:40256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:12.907753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.159767328s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-07T04:35:12.90778Z","caller":"traceutil/trace.go:171","msg":"trace[196968785] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"1.16480788s","start":"2026-08-07T04:35:11.742959Z","end":"2026-08-07T04:35:12.907767Z","steps":["trace[196968785] 'agreement among raft nodes before linearized reading' (duration: 1.164738048s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.907793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.891044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-07T04:35:12.907809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.742957Z","time spent":"1.16484621s","remote":"127.0.0.1:39960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-08-07T04:35:12.907816Z","caller":"traceutil/trace.go:171","msg":"trace[1817683755] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"1.159841649s","start":"2026-08-07T04:35:11.74795Z","end":"2026-08-07T04:35:12.907792Z","steps":["trace[1817683755] 'agreement among raft nodes before linearized reading' (duration: 1.159748267s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.90782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.390471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-07T04:35:12.90782Z","caller":"traceutil/trace.go:171","msg":"trace[1994126768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"146.944465ms","start":"2026-08-07T04:35:12.760867Z","end":"2026-08-07T04:35:12.907812Z","steps":["trace[1994126768] 'agreement among raft nodes before linearized reading' (duration: 146.901845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:12.907848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:11.747943Z","time spent":"1.159899011s","remote":"127.0.0.1:39830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-08-07T04:35:12.907852Z","caller":"traceutil/trace.go:171","msg":"trace[1710152565] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"192.455383ms","start":"2026-08-07T04:35:12.715387Z","end":"2026-08-07T04:35:12.907842Z","steps":["trace[1710152565] 'agreement among raft nodes before linearized reading' (duration: 192.405182ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:31.208772Z","caller":"traceutil/trace.go:171","msg":"trace[1292896510] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"126.154754ms","start":"2026-08-07T04:35:31.08259Z","end":"2026-08-07T04:35:31.208745Z","steps":["trace[1292896510] 'process raft request' (duration: 125.990211ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:46.830773Z","caller":"traceutil/trace.go:171","msg":"trace[1262201694] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"288.628572ms","start":"2026-08-07T04:35:46.542118Z","end":"2026-08-07T04:35:46.830747Z","steps":["trace[1262201694] 'process raft request' (duration: 288.476489ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:46.997996Z","caller":"traceutil/trace.go:171","msg":"trace[1849180068] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"446.592332ms","start":"2026-08-07T04:35:46.551362Z","end":"2026-08-07T04:35:46.997955Z","steps":["trace[1849180068] 'process raft request' (duration: 446.339787ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:46.998158Z","caller":"traceutil/trace.go:171","msg":"trace[841419202] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"429.544883ms","start":"2026-08-07T04:35:46.568598Z","end":"2026-08-07T04:35:46.998142Z","steps":["trace[841419202] 'process raft request' (duration: 429.427031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:46.998249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.551348Z","time spent":"446.808807ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:46.998313Z","caller":"traceutil/trace.go:171","msg":"trace[1038984260] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"429.273568ms","start":"2026-08-07T04:35:46.56903Z","end":"2026-08-07T04:35:46.998304Z","steps":["trace[1038984260] 'process raft request' (duration: 429.034153ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:46.998087Z","caller":"traceutil/trace.go:171","msg":"trace[1892666622] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"446.637862ms","start":"2026-08-07T04:35:46.551421Z","end":"2026-08-07T04:35:46.998059Z","steps":["trace[1892666622] 'process raft request' (duration: 446.407907ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:46.998366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.569014Z","time spent":"429.328619ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:46.998411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.551418Z","time spent":"446.95809ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:46.998395Z","caller":"traceutil/trace.go:171","msg":"trace[1213971416] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"424.677716ms","start":"2026-08-07T04:35:46.573659Z","end":"2026-08-07T04:35:46.998337Z","steps":["trace[1213971416] 'process raft request' (duration: 424.446831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:46.99825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.568582Z","time spent":"429.614915ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:46.998522Z","caller":"traceutil/trace.go:171","msg":"trace[1237150117] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"424.623845ms","start":"2026-08-07T04:35:46.573883Z","end":"2026-08-07T04:35:46.998507Z","steps":["trace[1237150117] 'process raft request' (duration: 424.275698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:46.998563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.573635Z","time spent":"424.852101ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:46.998578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.573873Z","time spent":"424.678806ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:46.998264Z","caller":"traceutil/trace.go:171","msg":"trace[481975230] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"431.847675ms","start":"2026-08-07T04:35:46.566274Z","end":"2026-08-07T04:35:46.998121Z","steps":["trace[481975230] 'process raft request' (duration: 431.598179ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:46.99866Z","caller":"traceutil/trace.go:171","msg":"trace[1826972589] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:499; }","duration":"225.159377ms","start":"2026-08-07T04:35:46.773476Z","end":"2026-08-07T04:35:46.998635Z","steps":["trace[1826972589] 'read index received' (duration: 57.065314ms)","trace[1826972589] 'applied index is now lower than readState.Index' (duration: 168.093133ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:35:46.998707Z","caller":"traceutil/trace.go:171","msg":"trace[1869064586] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"384.521186ms","start":"2026-08-07T04:35:46.614175Z","end":"2026-08-07T04:35:46.998696Z","steps":["trace[1869064586] 'process raft request' (duration: 384.328552ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:46.998715Z","caller":"traceutil/trace.go:171","msg":"trace[1805004644] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"411.185758ms","start":"2026-08-07T04:35:46.587518Z","end":"2026-08-07T04:35:46.998704Z","steps":["trace[1805004644] 'process raft request' (duration: 410.922132ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:46.998728Z","caller":"traceutil/trace.go:171","msg":"trace[766134231] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"275.136714ms","start":"2026-08-07T04:35:46.723581Z","end":"2026-08-07T04:35:46.998717Z","steps":["trace[766134231] 'process raft request' (duration: 274.991001ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:46.998765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.614153Z","time spent":"384.590407ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:46.99877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.587497Z","time spent":"411.252368ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:46.998807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.30598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:35:46.998641Z","caller":"traceutil/trace.go:171","msg":"trace[679325134] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"424.621536ms","start":"2026-08-07T04:35:46.573948Z","end":"2026-08-07T04:35:46.998569Z","steps":["trace[679325134] 'process raft request' (duration: 424.37956ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:46.998845Z","caller":"traceutil/trace.go:171","msg":"trace[2886095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:498; }","duration":"225.431642ms","start":"2026-08-07T04:35:46.773404Z","end":"2026-08-07T04:35:46.998835Z","steps":["trace[2886095] 'agreement among raft nodes before linearized reading' (duration: 225.33217ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:46.998887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.573941Z","time spent":"424.903112ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:35:46.998928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:46.566203Z","time spent":"432.493398ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:47.00745Z","caller":"traceutil/trace.go:171","msg":"trace[1751210050] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"170.799333ms","start":"2026-08-07T04:35:46.836638Z","end":"2026-08-07T04:35:47.007437Z","steps":["trace[1751210050] 'process raft request' (duration: 170.615289ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:47.007467Z","caller":"traceutil/trace.go:171","msg":"trace[1475899966] transaction","detail":"{read_only:false; number_of_response:1; response_revision:500; }","duration":"168.968632ms","start":"2026-08-07T04:35:46.838482Z","end":"2026-08-07T04:35:47.00745Z","steps":["trace[1475899966] 'process raft request' (duration: 168.923841ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:47.014127Z","caller":"traceutil/trace.go:171","msg":"trace[427793108] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"169.31074ms","start":"2026-08-07T04:35:46.838286Z","end":"2026-08-07T04:35:47.007597Z","steps":["trace[427793108] 'process raft request' (duration: 169.060794ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:52.988929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.183044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:35:52.989102Z","caller":"traceutil/trace.go:171","msg":"trace[1240423479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"214.435149ms","start":"2026-08-07T04:35:52.774636Z","end":"2026-08-07T04:35:52.989072Z","steps":["trace[1240423479] 'range keys from in-memory index tree' (duration: 213.967489ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:53.020899Z","caller":"traceutil/trace.go:171","msg":"trace[185090975] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"158.089322ms","start":"2026-08-07T04:35:52.862768Z","end":"2026-08-07T04:35:53.020858Z","steps":["trace[185090975] 'process raft request' (duration: 157.060868ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:55.431565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.115152539s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:35:55.431867Z","caller":"traceutil/trace.go:171","msg":"trace[383200649] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.761010125s","start":"2026-08-07T04:35:53.670833Z","end":"2026-08-07T04:35:55.431843Z","steps":["trace[383200649] 'process raft request' (duration: 1.760912733s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:35:55.431864Z","caller":"traceutil/trace.go:171","msg":"trace[1497384318] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"2.337002053s","start":"2026-08-07T04:35:53.094793Z","end":"2026-08-07T04:35:55.431795Z","steps":["trace[1497384318] 'process raft request' (duration: 221.311852ms)","trace[1497384318] 'compare' (duration: 2.114103836s)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:35:55.431965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:53.670797Z","time spent":"1.761115027s","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:35:55.432074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:53.094755Z","time spent":"2.337209557s","remote":"127.0.0.1:40230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:55.431882Z","caller":"traceutil/trace.go:171","msg":"trace[1217002505] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"2.125465156s","start":"2026-08-07T04:35:53.306363Z","end":"2026-08-07T04:35:55.431828Z","steps":["trace[1217002505] 'read index received' (duration: 9.656443ms)","trace[1217002505] 'applied index is now lower than readState.Index' (duration: 2.115805503s)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:35:55.432353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.723365283s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-07T04:35:55.432355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.65511902s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:35:55.4324Z","caller":"traceutil/trace.go:171","msg":"trace[1041980511] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:594; }","duration":"1.723473445s","start":"2026-08-07T04:35:53.708912Z","end":"2026-08-07T04:35:55.432386Z","steps":["trace[1041980511] 'agreement among raft nodes before linearized reading' (duration: 1.723381213s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:55.432404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.12602315s","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-08-07T04:35:55.432443Z","caller":"traceutil/trace.go:171","msg":"trace[1947030668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"1.655284683s","start":"2026-08-07T04:35:53.777134Z","end":"2026-08-07T04:35:55.432419Z","steps":["trace[1947030668] 'agreement among raft nodes before linearized reading' (duration: 1.65513539s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:55.432462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:53.70887Z","time spent":"1.723581057s","remote":"127.0.0.1:39782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.227\" "} {"level":"warn","ts":"2026-08-07T04:35:55.432442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.754700396s","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-08-07T04:35:55.432496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:53.777099Z","time spent":"1.655389186s","remote":"127.0.0.1:39746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-07T04:35:55.432489Z","caller":"traceutil/trace.go:171","msg":"trace[529623860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"2.126167463s","start":"2026-08-07T04:35:53.306296Z","end":"2026-08-07T04:35:55.432464Z","steps":["trace[529623860] 'agreement among raft nodes before linearized reading' (duration: 2.125852266s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:55.432547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.053296369s","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-08-07T04:35:55.432555Z","caller":"traceutil/trace.go:171","msg":"trace[1570057594] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"1.754892261s","start":"2026-08-07T04:35:53.677635Z","end":"2026-08-07T04:35:55.432527Z","steps":["trace[1570057594] 'agreement among raft nodes before linearized reading' (duration: 1.754661126s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:55.43257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:53.30627Z","time spent":"2.126283285s","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-07T04:35:55.432596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093584123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-07T04:35:55.432601Z","caller":"traceutil/trace.go:171","msg":"trace[138403140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"2.053414842s","start":"2026-08-07T04:35:53.379168Z","end":"2026-08-07T04:35:55.432583Z","steps":["trace[138403140] 'agreement among raft nodes before linearized reading' (duration: 2.053083445s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:55.432611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:53.67761Z","time spent":"1.754989102s","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-07T04:35:55.432641Z","caller":"traceutil/trace.go:171","msg":"trace[885162568] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"1.093691875s","start":"2026-08-07T04:35:54.338937Z","end":"2026-08-07T04:35:55.432629Z","steps":["trace[885162568] 'agreement among raft nodes before linearized reading' (duration: 1.09346641s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:55.432655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:53.379149Z","time spent":"2.053496513s","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-07T04:35:55.43267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:54.338909Z","time spent":"1.093756467s","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-07T04:35:57.234849Z","caller":"traceutil/trace.go:171","msg":"trace[1295973070] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"376.211859ms","start":"2026-08-07T04:35:56.8586Z","end":"2026-08-07T04:35:57.234812Z","steps":["trace[1295973070] 'process raft request' (duration: 371.941574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:35:57.235111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:35:56.85857Z","time spent":"376.348582ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:35:57.236805Z","caller":"traceutil/trace.go:171","msg":"trace[1412655616] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"178.045364ms","start":"2026-08-07T04:35:57.058737Z","end":"2026-08-07T04:35:57.236783Z","steps":["trace[1412655616] 'process raft request' (duration: 177.922632ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:00.115366Z","caller":"traceutil/trace.go:171","msg":"trace[615712843] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"251.236085ms","start":"2026-08-07T04:35:59.864106Z","end":"2026-08-07T04:36:00.115342Z","steps":["trace[615712843] 'process raft request' (duration: 251.080392ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:10.629038Z","caller":"traceutil/trace.go:171","msg":"trace[1081392018] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"843.025582ms","start":"2026-08-07T04:36:09.785976Z","end":"2026-08-07T04:36:10.629002Z","steps":["trace[1081392018] 'process raft request' (duration: 842.818257ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:36:10.630116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:09.785949Z","time spent":"843.205885ms","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:36:25.531829Z","caller":"traceutil/trace.go:171","msg":"trace[2083836864] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"266.088939ms","start":"2026-08-07T04:36:25.265715Z","end":"2026-08-07T04:36:25.531804Z","steps":["trace[2083836864] 'process raft request' (duration: 265.923305ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:26.095509Z","caller":"traceutil/trace.go:171","msg":"trace[559330625] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:922; }","duration":"450.817323ms","start":"2026-08-07T04:36:25.644636Z","end":"2026-08-07T04:36:26.095453Z","steps":["trace[559330625] 'read index received' (duration: 377.333465ms)","trace[559330625] 'applied index is now lower than readState.Index' (duration: 73.481328ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:36:26.0957Z","caller":"traceutil/trace.go:171","msg":"trace[1196947497] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"451.649131ms","start":"2026-08-07T04:36:25.644021Z","end":"2026-08-07T04:36:26.09567Z","steps":["trace[1196947497] 'process raft request' (duration: 377.976919ms)","trace[1196947497] 'compare' (duration: 73.073369ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:36:26.09586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:25.64401Z","time spent":"451.729553ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:36:26.096159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.495199ms","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-08-07T04:36:26.096239Z","caller":"traceutil/trace.go:171","msg":"trace[168967805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:896; }","duration":"451.589251ms","start":"2026-08-07T04:36:25.644622Z","end":"2026-08-07T04:36:26.096212Z","steps":["trace[168967805] 'agreement among raft nodes before linearized reading' (duration: 451.380397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:36:26.096279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:25.644617Z","time spent":"451.657053ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-07T04:36:26.163644Z","caller":"traceutil/trace.go:171","msg":"trace[1401780340] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"265.306992ms","start":"2026-08-07T04:36:25.898319Z","end":"2026-08-07T04:36:26.163626Z","steps":["trace[1401780340] 'process raft request' (duration: 265.189429ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:26.294794Z","caller":"traceutil/trace.go:171","msg":"trace[923871698] linearizableReadLoop","detail":"{readStateIndex:925; appliedIndex:923; }","duration":"199.159239ms","start":"2026-08-07T04:36:26.095614Z","end":"2026-08-07T04:36:26.294773Z","steps":["trace[923871698] 'read index received' (duration: 67.939805ms)","trace[923871698] 'applied index is now lower than readState.Index' (duration: 131.218274ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:36:26.294896Z","caller":"traceutil/trace.go:171","msg":"trace[1811205273] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"194.197977ms","start":"2026-08-07T04:36:26.100643Z","end":"2026-08-07T04:36:26.294841Z","steps":["trace[1811205273] 'process raft request' (duration: 194.086283ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:36:26.294954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.573831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-07T04:36:26.294987Z","caller":"traceutil/trace.go:171","msg":"trace[1715665626] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:899; }","duration":"649.648883ms","start":"2026-08-07T04:36:25.645327Z","end":"2026-08-07T04:36:26.294976Z","steps":["trace[1715665626] 'agreement among raft nodes before linearized reading' (duration: 649.521101ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:26.294975Z","caller":"traceutil/trace.go:171","msg":"trace[1815742421] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"261.521297ms","start":"2026-08-07T04:36:26.033436Z","end":"2026-08-07T04:36:26.294957Z","steps":["trace[1815742421] 'process raft request' (duration: 255.044791ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:36:26.295032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:25.645308Z","time spent":"649.717255ms","remote":"127.0.0.1:40052","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-08-07T04:36:26.295315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.689715ms","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-08-07T04:36:26.295692Z","caller":"traceutil/trace.go:171","msg":"trace[2049922708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:899; }","duration":"650.155455ms","start":"2026-08-07T04:36:25.645511Z","end":"2026-08-07T04:36:26.295666Z","steps":["trace[2049922708] 'agreement among raft nodes before linearized reading' (duration: 649.323306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:36:26.295748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:25.645507Z","time spent":"650.231206ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-07T04:36:37.176891Z","caller":"traceutil/trace.go:171","msg":"trace[446856947] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"215.493424ms","start":"2026-08-07T04:36:36.961372Z","end":"2026-08-07T04:36:37.176865Z","steps":["trace[446856947] 'process raft request' (duration: 215.31763ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:37.512827Z","caller":"traceutil/trace.go:171","msg":"trace[1504785866] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"313.662126ms","start":"2026-08-07T04:36:37.199147Z","end":"2026-08-07T04:36:37.512809Z","steps":["trace[1504785866] 'process raft request' (duration: 286.671661ms)","trace[1504785866] 'compare' (duration: 26.75368ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:36:37.512923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:37.199124Z","time spent":"313.748558ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:36:38.371839Z","caller":"traceutil/trace.go:171","msg":"trace[511601683] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"196.15466ms","start":"2026-08-07T04:36:38.175665Z","end":"2026-08-07T04:36:38.37182Z","steps":["trace[511601683] 'process raft request' (duration: 196.007007ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:38.546161Z","caller":"traceutil/trace.go:171","msg":"trace[559365777] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:972; }","duration":"199.572857ms","start":"2026-08-07T04:36:38.346551Z","end":"2026-08-07T04:36:38.546124Z","steps":["trace[559365777] 'read index received' (duration: 25.263507ms)","trace[559365777] 'applied index is now lower than readState.Index' (duration: 174.30771ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:36:38.546472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.904313ms","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-08-07T04:36:38.546501Z","caller":"traceutil/trace.go:171","msg":"trace[748379496] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"211.118895ms","start":"2026-08-07T04:36:38.335352Z","end":"2026-08-07T04:36:38.546471Z","steps":["trace[748379496] 'process raft request' (duration: 197.878148ms)","trace[748379496] 'compare' (duration: 12.714956ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:36:38.546596Z","caller":"traceutil/trace.go:171","msg":"trace[1197236441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:943; }","duration":"200.068468ms","start":"2026-08-07T04:36:38.346478Z","end":"2026-08-07T04:36:38.546547Z","steps":["trace[1197236441] 'agreement among raft nodes before linearized reading' (duration: 199.833103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:36:38.546607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.01831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-07T04:36:38.546648Z","caller":"traceutil/trace.go:171","msg":"trace[117515253] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:943; }","duration":"189.076351ms","start":"2026-08-07T04:36:38.357559Z","end":"2026-08-07T04:36:38.546635Z","steps":["trace[117515253] 'agreement among raft nodes before linearized reading' (duration: 188.984319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:36:38.546513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.410509ms","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-08-07T04:36:38.546763Z","caller":"traceutil/trace.go:171","msg":"trace[164327562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:943; }","duration":"193.696565ms","start":"2026-08-07T04:36:38.353029Z","end":"2026-08-07T04:36:38.546725Z","steps":["trace[164327562] 'agreement among raft nodes before linearized reading' (duration: 193.298976ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:36:38.890219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.129578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:36:38.890561Z","caller":"traceutil/trace.go:171","msg":"trace[879866197] linearizableReadLoop","detail":"{readStateIndex:976; appliedIndex:973; }","duration":"115.599363ms","start":"2026-08-07T04:36:38.774939Z","end":"2026-08-07T04:36:38.890539Z","steps":["trace[879866197] 'read index received' (duration: 64.060316ms)","trace[879866197] 'applied index is now lower than readState.Index' (duration: 51.537757ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:36:38.890673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.740545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:36:38.890711Z","caller":"traceutil/trace.go:171","msg":"trace[228730822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:946; }","duration":"115.817977ms","start":"2026-08-07T04:36:38.774881Z","end":"2026-08-07T04:36:38.890699Z","steps":["trace[228730822] 'agreement among raft nodes before linearized reading' (duration: 115.725385ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:38.890691Z","caller":"traceutil/trace.go:171","msg":"trace[141527179] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"338.3434ms","start":"2026-08-07T04:36:38.552314Z","end":"2026-08-07T04:36:38.890658Z","steps":["trace[141527179] 'process raft request' (duration: 338.181577ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:38.890678Z","caller":"traceutil/trace.go:171","msg":"trace[1508451811] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"338.78237ms","start":"2026-08-07T04:36:38.551859Z","end":"2026-08-07T04:36:38.890642Z","steps":["trace[1508451811] 'process raft request' (duration: 338.505304ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:36:38.890827Z","caller":"traceutil/trace.go:171","msg":"trace[991048086] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"339.678329ms","start":"2026-08-07T04:36:38.551115Z","end":"2026-08-07T04:36:38.890794Z","steps":["trace[991048086] 'process raft request' (duration: 106.843216ms)","trace[991048086] 'compare' (duration: 231.853192ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:36:38.890886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:38.552303Z","time spent":"338.472673ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:36:38.890957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:38.551079Z","time spent":"339.820713ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:36:38.890891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:36:38.551832Z","time spent":"338.958473ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:37:00.813444Z","caller":"traceutil/trace.go:171","msg":"trace[754394803] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"295.725135ms","start":"2026-08-07T04:37:00.517687Z","end":"2026-08-07T04:37:00.813412Z","steps":["trace[754394803] 'process raft request' (duration: 295.559441ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:00.93937Z","caller":"traceutil/trace.go:171","msg":"trace[81332495] linearizableReadLoop","detail":"{readStateIndex:1054; appliedIndex:1052; }","duration":"228.857714ms","start":"2026-08-07T04:37:00.710453Z","end":"2026-08-07T04:37:00.939311Z","steps":["trace[81332495] 'read index received' (duration: 102.814806ms)","trace[81332495] 'applied index is now lower than readState.Index' (duration: 126.041708ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:00.939556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.075709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-07T04:37:00.939417Z","caller":"traceutil/trace.go:171","msg":"trace[1447480441] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"313.226426ms","start":"2026-08-07T04:37:00.626149Z","end":"2026-08-07T04:37:00.939376Z","steps":["trace[1447480441] 'process raft request' (duration: 249.955857ms)","trace[1447480441] 'compare' (duration: 63.008863ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:37:00.939641Z","caller":"traceutil/trace.go:171","msg":"trace[378993543] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1019; }","duration":"229.251003ms","start":"2026-08-07T04:37:00.710372Z","end":"2026-08-07T04:37:00.939623Z","steps":["trace[378993543] 'agreement among raft nodes before linearized reading' (duration: 229.071589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:00.939673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.452462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:37:00.93974Z","caller":"traceutil/trace.go:171","msg":"trace[669933141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1019; }","duration":"165.580774ms","start":"2026-08-07T04:37:00.774138Z","end":"2026-08-07T04:37:00.939719Z","steps":["trace[669933141] 'agreement among raft nodes before linearized reading' (duration: 165.437961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:00.939843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:00.626113Z","time spent":"313.530573ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:37:20.032607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.637145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:37:20.032764Z","caller":"traceutil/trace.go:171","msg":"trace[1510761393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1134; }","duration":"147.85011ms","start":"2026-08-07T04:37:19.884882Z","end":"2026-08-07T04:37:20.032732Z","steps":["trace[1510761393] 'range keys from in-memory index tree' (duration: 147.564073ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:20.032619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.919661ms","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-08-07T04:37:20.032956Z","caller":"traceutil/trace.go:171","msg":"trace[732460141] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1134; }","duration":"376.324919ms","start":"2026-08-07T04:37:19.65658Z","end":"2026-08-07T04:37:20.032905Z","steps":["trace[732460141] 'range keys from in-memory index tree' (duration: 375.684825ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:20.033068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:19.656561Z","time spent":"376.473793ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-07T04:37:20.032738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.293979ms","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-08-07T04:37:20.033305Z","caller":"traceutil/trace.go:171","msg":"trace[1854323689] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1134; }","duration":"507.865182ms","start":"2026-08-07T04:37:19.525429Z","end":"2026-08-07T04:37:20.033294Z","steps":["trace[1854323689] 'range keys from in-memory index tree' (duration: 507.284699ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:20.474515Z","caller":"traceutil/trace.go:171","msg":"trace[1933005432] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"359.947832ms","start":"2026-08-07T04:37:20.114538Z","end":"2026-08-07T04:37:20.474486Z","steps":["trace[1933005432] 'process raft request' (duration: 359.777918ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:20.474695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:20.114515Z","time spent":"360.083595ms","remote":"127.0.0.1:40052","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-08-07T04:37:36.87926Z","caller":"traceutil/trace.go:171","msg":"trace[1651573873] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"311.29682ms","start":"2026-08-07T04:37:36.567933Z","end":"2026-08-07T04:37:36.87923Z","steps":["trace[1651573873] 'process raft request' (duration: 311.119026ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:36.879461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:36.56791Z","time spent":"311.440672ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:37:37.565635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.842721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:37:37.565746Z","caller":"traceutil/trace.go:171","msg":"trace[126054655] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1207; }","duration":"620.992423ms","start":"2026-08-07T04:37:36.94473Z","end":"2026-08-07T04:37:37.565723Z","steps":["trace[126054655] 'count revisions from in-memory index tree' (duration: 620.766988ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:37.565799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:36.944717Z","time spent":"621.067665ms","remote":"127.0.0.1:46578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-07T04:37:37.566346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.253931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-07T04:37:37.566389Z","caller":"traceutil/trace.go:171","msg":"trace[1586643625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1207; }","duration":"467.379904ms","start":"2026-08-07T04:37:37.098999Z","end":"2026-08-07T04:37:37.566379Z","steps":["trace[1586643625] 'range keys from in-memory index tree' (duration: 467.068107ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:37.566419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:37.098973Z","time spent":"467.439466ms","remote":"127.0.0.1:40052","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-08-07T04:37:37.730932Z","caller":"traceutil/trace.go:171","msg":"trace[1598534905] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"593.159798ms","start":"2026-08-07T04:37:37.137749Z","end":"2026-08-07T04:37:37.730909Z","steps":["trace[1598534905] 'process raft request' (duration: 592.950174ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:37.731291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.361631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-07T04:37:37.731441Z","caller":"traceutil/trace.go:171","msg":"trace[2105263400] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1208; }","duration":"421.529704ms","start":"2026-08-07T04:37:37.309839Z","end":"2026-08-07T04:37:37.731369Z","steps":["trace[2105263400] 'agreement among raft nodes before linearized reading' (duration: 421.219137ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:37.731464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:37.13771Z","time spent":"593.606588ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:37:37.731544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:37.309815Z","time spent":"421.681017ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-07T04:37:37.732089Z","caller":"traceutil/trace.go:171","msg":"trace[917309621] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1251; }","duration":"420.967091ms","start":"2026-08-07T04:37:37.309895Z","end":"2026-08-07T04:37:37.730862Z","steps":["trace[917309621] 'read index received' (duration: 420.738556ms)","trace[917309621] 'applied index is now lower than readState.Index' (duration: 227.565µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:37.734381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.503724ms","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-08-07T04:37:37.734452Z","caller":"traceutil/trace.go:171","msg":"trace[375772633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1210; }","duration":"413.606856ms","start":"2026-08-07T04:37:37.320834Z","end":"2026-08-07T04:37:37.734441Z","steps":["trace[375772633] 'agreement among raft nodes before linearized reading' (duration: 413.342811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:37.734521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:37.320819Z","time spent":"413.693958ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-07T04:37:37.734768Z","caller":"traceutil/trace.go:171","msg":"trace[951340919] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"163.135513ms","start":"2026-08-07T04:37:37.571625Z","end":"2026-08-07T04:37:37.73476Z","steps":["trace[951340919] 'process raft request' (duration: 162.452407ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:37.734937Z","caller":"traceutil/trace.go:171","msg":"trace[144280719] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"103.540705ms","start":"2026-08-07T04:37:37.631389Z","end":"2026-08-07T04:37:37.734929Z","steps":["trace[144280719] 'process raft request' (duration: 102.759438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:37.735144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.848512ms","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-08-07T04:37:37.735224Z","caller":"traceutil/trace.go:171","msg":"trace[431126293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1210; }","duration":"413.949664ms","start":"2026-08-07T04:37:37.321266Z","end":"2026-08-07T04:37:37.735216Z","steps":["trace[431126293] 'agreement among raft nodes before linearized reading' (duration: 413.824961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:37.735301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:37.321257Z","time spent":"414.036735ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-07T04:37:38.955371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.775922ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:37:38.955532Z","caller":"traceutil/trace.go:171","msg":"trace[1561601989] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"597.373823ms","start":"2026-08-07T04:37:38.358131Z","end":"2026-08-07T04:37:38.955505Z","steps":["trace[1561601989] 'process raft request' (duration: 113.358645ms)","trace[1561601989] 'compare' (duration: 483.608649ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:37:38.955639Z","caller":"traceutil/trace.go:171","msg":"trace[1201655256] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"382.466167ms","start":"2026-08-07T04:37:38.573162Z","end":"2026-08-07T04:37:38.955629Z","steps":["trace[1201655256] 'process raft request' (duration: 382.360904ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:38.955721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:38.573137Z","time spent":"382.540839ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:37:38.955901Z","caller":"traceutil/trace.go:171","msg":"trace[145315882] linearizableReadLoop","detail":"{readStateIndex:1261; appliedIndex:1260; }","duration":"583.428229ms","start":"2026-08-07T04:37:38.372462Z","end":"2026-08-07T04:37:38.955891Z","steps":["trace[145315882] 'read index received' (duration: 98.938831ms)","trace[145315882] 'applied index is now lower than readState.Index' (duration: 484.488248ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:38.956085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.619053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:37:38.956114Z","caller":"traceutil/trace.go:171","msg":"trace[1975016110] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1218; }","duration":"583.691485ms","start":"2026-08-07T04:37:38.372414Z","end":"2026-08-07T04:37:38.956105Z","steps":["trace[1975016110] 'agreement among raft nodes before linearized reading' (duration: 583.639304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:38.956141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:38.372393Z","time spent":"583.741447ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-07T04:37:38.956184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:38.358103Z","time spent":"597.488505ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:37:39.360143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.50391ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-07T04:37:39.36076Z","caller":"traceutil/trace.go:171","msg":"trace[1467454263] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1262; }","duration":"404.8106ms","start":"2026-08-07T04:37:38.955921Z","end":"2026-08-07T04:37:39.360731Z","steps":["trace[1467454263] 'read index received' (duration: 641.344µs)","trace[1467454263] 'applied index is now lower than readState.Index' (duration: 404.166036ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:37:39.360908Z","caller":"traceutil/trace.go:171","msg":"trace[1656774741] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"399.960451ms","start":"2026-08-07T04:37:38.960938Z","end":"2026-08-07T04:37:39.360899Z","steps":["trace[1656774741] 'process raft request' (duration: 399.365057ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:39.360983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:38.960913Z","time spent":"400.013002ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:37:39.424609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.69362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-07T04:37:39.424744Z","caller":"traceutil/trace.go:171","msg":"trace[1006961617] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1219; }","duration":"499.891225ms","start":"2026-08-07T04:37:38.924833Z","end":"2026-08-07T04:37:39.424724Z","steps":["trace[1006961617] 'agreement among raft nodes before linearized reading' (duration: 436.00845ms)","trace[1006961617] 'count revisions from in-memory index tree' (duration: 63.69985ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:39.424793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:38.924815Z","time spent":"499.966866ms","remote":"127.0.0.1:39812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-08-07T04:37:39.425029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.14737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:37:39.42507Z","caller":"traceutil/trace.go:171","msg":"trace[114169577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"651.237183ms","start":"2026-08-07T04:37:38.773821Z","end":"2026-08-07T04:37:39.425059Z","steps":["trace[114169577] 'agreement among raft nodes before linearized reading' (duration: 587.000771ms)","trace[114169577] 'range keys from in-memory index tree' (duration: 64.182241ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:39.425106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:38.773792Z","time spent":"651.307854ms","remote":"127.0.0.1:39746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-07T04:37:39.425607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.632859ms","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-08-07T04:37:39.425658Z","caller":"traceutil/trace.go:171","msg":"trace[597329131] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1219; }","duration":"540.713821ms","start":"2026-08-07T04:37:38.884929Z","end":"2026-08-07T04:37:39.425643Z","steps":["trace[597329131] 'agreement among raft nodes before linearized reading' (duration: 475.923167ms)","trace[597329131] 'range keys from in-memory index tree' (duration: 64.395996ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:39.425695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:38.884913Z","time spent":"540.770952ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-07T04:37:39.926281Z","caller":"traceutil/trace.go:171","msg":"trace[1867719663] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"105.675133ms","start":"2026-08-07T04:37:39.820567Z","end":"2026-08-07T04:37:39.926242Z","steps":["trace[1867719663] 'read index received' (duration: 67.617048ms)","trace[1867719663] 'applied index is now lower than readState.Index' (duration: 38.056895ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:37:39.926363Z","caller":"traceutil/trace.go:171","msg":"trace[1031232085] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"144.773741ms","start":"2026-08-07T04:37:39.781558Z","end":"2026-08-07T04:37:39.926332Z","steps":["trace[1031232085] 'process raft request' (duration: 106.670635ms)","trace[1031232085] 'compare' (duration: 37.82527ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:39.926575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.98662ms","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-08-07T04:37:39.926635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.571741ms","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-08-07T04:37:39.926649Z","caller":"traceutil/trace.go:171","msg":"trace[524522550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1225; }","duration":"106.122333ms","start":"2026-08-07T04:37:39.820509Z","end":"2026-08-07T04:37:39.926631Z","steps":["trace[524522550] 'agreement among raft nodes before linearized reading' (duration: 105.921939ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:39.926683Z","caller":"traceutil/trace.go:171","msg":"trace[756088820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1225; }","duration":"105.692604ms","start":"2026-08-07T04:37:39.820977Z","end":"2026-08-07T04:37:39.92667Z","steps":["trace[756088820] 'agreement among raft nodes before linearized reading' (duration: 105.473939ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:46.149937Z","caller":"traceutil/trace.go:171","msg":"trace[2127575411] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1316; }","duration":"269.353758ms","start":"2026-08-07T04:37:45.88056Z","end":"2026-08-07T04:37:46.149914Z","steps":["trace[2127575411] 'read index received' (duration: 269.083432ms)","trace[2127575411] 'applied index is now lower than readState.Index' (duration: 269.176µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:46.15016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.583142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-07T04:37:46.15022Z","caller":"traceutil/trace.go:171","msg":"trace[717872042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1271; }","duration":"269.691845ms","start":"2026-08-07T04:37:45.880517Z","end":"2026-08-07T04:37:46.150209Z","steps":["trace[717872042] 'agreement among raft nodes before linearized reading' (duration: 269.485211ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:46.150238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.407448ms","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-08-07T04:37:46.150277Z","caller":"traceutil/trace.go:171","msg":"trace[341677087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1271; }","duration":"179.483169ms","start":"2026-08-07T04:37:45.970783Z","end":"2026-08-07T04:37:46.150266Z","steps":["trace[341677087] 'agreement among raft nodes before linearized reading' (duration: 179.346956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:46.150274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.055422ms","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-08-07T04:37:46.150343Z","caller":"traceutil/trace.go:171","msg":"trace[1965298645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1271; }","duration":"184.133354ms","start":"2026-08-07T04:37:45.966193Z","end":"2026-08-07T04:37:46.150326Z","steps":["trace[1965298645] 'agreement among raft nodes before linearized reading' (duration: 183.94722ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:46.14998Z","caller":"traceutil/trace.go:171","msg":"trace[1736588949] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"276.951458ms","start":"2026-08-07T04:37:45.872999Z","end":"2026-08-07T04:37:46.149951Z","steps":["trace[1736588949] 'process raft request' (duration: 276.748604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:46.150458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.944957ms","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-08-07T04:37:46.150511Z","caller":"traceutil/trace.go:171","msg":"trace[1049269003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1271; }","duration":"203.026878ms","start":"2026-08-07T04:37:45.947475Z","end":"2026-08-07T04:37:46.150502Z","steps":["trace[1049269003] 'agreement among raft nodes before linearized reading' (duration: 202.571638ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:46.561416Z","caller":"traceutil/trace.go:171","msg":"trace[1446499382] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"405.843753ms","start":"2026-08-07T04:37:46.155548Z","end":"2026-08-07T04:37:46.561391Z","steps":["trace[1446499382] 'process raft request' (duration: 341.445927ms)","trace[1446499382] 'compare' (duration: 64.206971ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:46.561541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:46.15534Z","time spent":"406.130768ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:37:46.568953Z","caller":"traceutil/trace.go:171","msg":"trace[1797142439] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"413.042884ms","start":"2026-08-07T04:37:46.155896Z","end":"2026-08-07T04:37:46.568939Z","steps":["trace[1797142439] 'process raft request' (duration: 412.936522ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:46.569034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:46.155889Z","time spent":"413.102576ms","remote":"127.0.0.1:40052","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-08-07T04:37:46.569237Z","caller":"traceutil/trace.go:171","msg":"trace[1310048405] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"412.957551ms","start":"2026-08-07T04:37:46.156252Z","end":"2026-08-07T04:37:46.56921Z","steps":["trace[1310048405] 'process raft request' (duration: 412.660665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:46.569415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:46.156247Z","time spent":"413.056583ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:37:46.56977Z","caller":"traceutil/trace.go:171","msg":"trace[431112373] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1317; }","duration":"308.949456ms","start":"2026-08-07T04:37:46.260806Z","end":"2026-08-07T04:37:46.569756Z","steps":["trace[431112373] 'read index received' (duration: 236.287225ms)","trace[431112373] 'applied index is now lower than readState.Index' (duration: 72.661361ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:46.569988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.180951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-jk6j5\" ","response":"range_response_count:1 size:12642"} {"level":"info","ts":"2026-08-07T04:37:46.570004Z","caller":"traceutil/trace.go:171","msg":"trace[1432760597] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"413.485754ms","start":"2026-08-07T04:37:46.1565Z","end":"2026-08-07T04:37:46.569986Z","steps":["trace[1432760597] 'process raft request' (duration: 412.632745ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:46.570028Z","caller":"traceutil/trace.go:171","msg":"trace[1091953351] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-jk6j5; range_end:; response_count:1; response_revision:1275; }","duration":"309.245963ms","start":"2026-08-07T04:37:46.26077Z","end":"2026-08-07T04:37:46.570016Z","steps":["trace[1091953351] 'agreement among raft nodes before linearized reading' (duration: 309.035149ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:37:46.570067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:46.260759Z","time spent":"309.297824ms","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":12665,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-jk6j5\" "} {"level":"warn","ts":"2026-08-07T04:37:46.570085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:37:46.156494Z","time spent":"413.551665ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:37:46.87808Z","caller":"traceutil/trace.go:171","msg":"trace[85667989] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1321; }","duration":"104.096357ms","start":"2026-08-07T04:37:46.773948Z","end":"2026-08-07T04:37:46.878044Z","steps":["trace[85667989] 'read index received' (duration: 103.663308ms)","trace[85667989] 'applied index is now lower than readState.Index' (duration: 431.529µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:37:46.878322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.305202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:37:46.87842Z","caller":"traceutil/trace.go:171","msg":"trace[791240885] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"295.406952ms","start":"2026-08-07T04:37:46.582966Z","end":"2026-08-07T04:37:46.878373Z","steps":["trace[791240885] 'process raft request' (duration: 294.8279ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:37:46.878496Z","caller":"traceutil/trace.go:171","msg":"trace[271198736] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"104.547087ms","start":"2026-08-07T04:37:46.773888Z","end":"2026-08-07T04:37:46.878435Z","steps":["trace[271198736] 'agreement among raft nodes before linearized reading' (duration: 104.293381ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:40:54.745616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.814576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:40:54.745755Z","caller":"traceutil/trace.go:171","msg":"trace[1084672547] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2161; }","duration":"184.025721ms","start":"2026-08-07T04:40:54.561702Z","end":"2026-08-07T04:40:54.745728Z","steps":["trace[1084672547] 'count revisions from in-memory index tree' (duration: 183.703913ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:40:54.74548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.220384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-07T04:40:54.745885Z","caller":"traceutil/trace.go:171","msg":"trace[301439754] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2161; }","duration":"200.662293ms","start":"2026-08-07T04:40:54.545204Z","end":"2026-08-07T04:40:54.745866Z","steps":["trace[301439754] 'range keys from in-memory index tree' (duration: 200.09759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:40:54.74548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.68698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-08-07T04:40:54.746033Z","caller":"traceutil/trace.go:171","msg":"trace[890677578] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2161; }","duration":"212.274133ms","start":"2026-08-07T04:40:54.53372Z","end":"2026-08-07T04:40:54.745994Z","steps":["trace[890677578] 'range keys from in-memory index tree' (duration: 211.517386ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:41:01.001107Z","caller":"traceutil/trace.go:171","msg":"trace[1939224648] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"157.6895ms","start":"2026-08-07T04:41:00.843393Z","end":"2026-08-07T04:41:01.001083Z","steps":["trace[1939224648] 'process raft request' (duration: 149.081468ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:41:01.064686Z","caller":"traceutil/trace.go:171","msg":"trace[1499254077] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"221.235934ms","start":"2026-08-07T04:41:00.843426Z","end":"2026-08-07T04:41:01.064662Z","steps":["trace[1499254077] 'process raft request' (duration: 221.062089ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:41:01.064889Z","caller":"traceutil/trace.go:171","msg":"trace[484897858] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"165.601407ms","start":"2026-08-07T04:41:00.89925Z","end":"2026-08-07T04:41:01.064851Z","steps":["trace[484897858] 'process raft request' (duration: 165.373772ms)"],"step_count":1}