{"level":"warn","ts":"2026-08-11T08:16:54.932038Z","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-11T08:16:54.93221Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.40:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.40:2380","--initial-cluster=instance=https://199.19.213.40:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.40:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.40: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-11T08:16:54.932335Z","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-11T08:16:54.932357Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.40:2380"]} {"level":"info","ts":"2026-08-11T08:16:54.932384Z","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-11T08:16:54.933113Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.40:2379"]} {"level":"info","ts":"2026-08-11T08:16:54.933221Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.40:2380"],"listen-peer-urls":["https://199.19.213.40:2380"],"advertise-client-urls":["https://199.19.213.40:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.40:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.40: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-11T08:16:54.937825Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.379087ms"} {"level":"info","ts":"2026-08-11T08:16:54.945159Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1082227b3dfb8db7","cluster-id":"1c36bbf7868e18b9"} {"level":"info","ts":"2026-08-11T08:16:54.945252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T08:16:54.945278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 became follower at term 0"} {"level":"info","ts":"2026-08-11T08:16:54.945295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1082227b3dfb8db7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T08:16:54.945308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 became follower at term 1"} {"level":"info","ts":"2026-08-11T08:16:54.945343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 switched to configuration voters=(1189551164295450039)"} {"level":"warn","ts":"2026-08-11T08:16:54.957894Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T08:16:54.959223Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T08:16:54.959993Z","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-11T08:16:54.962103Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1082227b3dfb8db7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T08:16:54.962305Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1082227b3dfb8db7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T08:16:54.9626Z","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-11T08:16:54.962744Z","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-11T08:16:54.962761Z","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-11T08:16:54.966956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 switched to configuration voters=(1189551164295450039)"} {"level":"info","ts":"2026-08-11T08:16:54.96805Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1c36bbf7868e18b9","local-member-id":"1082227b3dfb8db7","added-peer-id":"1082227b3dfb8db7","added-peer-peer-urls":["https://199.19.213.40:2380"]} {"level":"info","ts":"2026-08-11T08:16:54.971107Z","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-11T08:16:54.971313Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.40:2380"} {"level":"info","ts":"2026-08-11T08:16:54.971384Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.40:2380"} {"level":"info","ts":"2026-08-11T08:16:54.97151Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1082227b3dfb8db7","initial-advertise-peer-urls":["https://199.19.213.40:2380"],"listen-peer-urls":["https://199.19.213.40:2380"],"advertise-client-urls":["https://199.19.213.40:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.40:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T08:16:54.971575Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T08:16:55.346055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T08:16:55.346122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T08:16:55.346144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 received MsgPreVoteResp from 1082227b3dfb8db7 at term 1"} {"level":"info","ts":"2026-08-11T08:16:55.346163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 became candidate at term 2"} {"level":"info","ts":"2026-08-11T08:16:55.346174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 received MsgVoteResp from 1082227b3dfb8db7 at term 2"} {"level":"info","ts":"2026-08-11T08:16:55.346191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1082227b3dfb8db7 became leader at term 2"} {"level":"info","ts":"2026-08-11T08:16:55.346209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1082227b3dfb8db7 elected leader 1082227b3dfb8db7 at term 2"} {"level":"info","ts":"2026-08-11T08:16:55.346956Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:16:55.347626Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1082227b3dfb8db7","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.40:2379]}","request-path":"/0/members/1082227b3dfb8db7/attributes","cluster-id":"1c36bbf7868e18b9","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T08:16:55.348434Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1c36bbf7868e18b9","local-member-id":"1082227b3dfb8db7","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:16:55.348567Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:16:55.34867Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:16:55.348733Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:16:55.348757Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:16:55.348927Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T08:16:55.348945Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T08:16:55.351248Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T08:16:55.351247Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.40:2379"} {"level":"info","ts":"2026-08-11T08:16:57.405964Z","caller":"traceutil/trace.go:171","msg":"trace[655408289] linearizableReadLoop","detail":"{readStateIndex:8; appliedIndex:7; }","duration":"239.255606ms","start":"2026-08-11T08:16:57.166672Z","end":"2026-08-11T08:16:57.405927Z","steps":["trace[655408289] 'read index received' (duration: 166.252258ms)","trace[655408289] 'applied index is now lower than readState.Index' (duration: 73.001768ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:57.406133Z","caller":"traceutil/trace.go:171","msg":"trace[1159104110] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"239.520044ms","start":"2026-08-11T08:16:57.166599Z","end":"2026-08-11T08:16:57.406119Z","steps":["trace[1159104110] 'process raft request' (duration: 166.275588ms)","trace[1159104110] 'compare' (duration: 72.864385ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:16:57.406393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.687178ms","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-11T08:16:57.406464Z","caller":"traceutil/trace.go:171","msg":"trace[1441511240] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:5; }","duration":"239.810381ms","start":"2026-08-11T08:16:57.166637Z","end":"2026-08-11T08:16:57.406447Z","steps":["trace[1441511240] 'agreement among raft nodes before linearized reading' (duration: 239.643447ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.907345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.173455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-11T08:16:57.907703Z","caller":"traceutil/trace.go:171","msg":"trace[586873747] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:8; }","duration":"501.601939ms","start":"2026-08-11T08:16:57.406078Z","end":"2026-08-11T08:16:57.90768Z","steps":["trace[586873747] 'read index received' (duration: 213.286093ms)","trace[586873747] 'applied index is now lower than readState.Index' (duration: 288.314586ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:57.907884Z","caller":"traceutil/trace.go:171","msg":"trace[228474784] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"739.327114ms","start":"2026-08-11T08:16:57.168393Z","end":"2026-08-11T08:16:57.90772Z","steps":["trace[228474784] 'process raft request' (duration: 739.133398ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:57.909138Z","caller":"traceutil/trace.go:171","msg":"trace[990023637] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"739.491628ms","start":"2026-08-11T08:16:57.168171Z","end":"2026-08-11T08:16:57.907663Z","steps":["trace[990023637] 'process raft request' (duration: 451.173973ms)","trace[990023637] 'compare' (duration: 286.365873ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:57.908469Z","caller":"traceutil/trace.go:171","msg":"trace[293298542] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"701.266927ms","start":"2026-08-11T08:16:57.207155Z","end":"2026-08-11T08:16:57.908422Z","steps":["trace[293298542] 'process raft request' (duration: 700.475436ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:57.91014Z","caller":"traceutil/trace.go:171","msg":"trace[450531008] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"741.576033ms","start":"2026-08-11T08:16:57.168452Z","end":"2026-08-11T08:16:57.910028Z","steps":["trace[450531008] 'process raft request' (duration: 739.138578ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:57.910213Z","caller":"traceutil/trace.go:171","msg":"trace[485013691] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"741.686876ms","start":"2026-08-11T08:16:57.168453Z","end":"2026-08-11T08:16:57.91014Z","steps":["trace[485013691] 'process raft request' (duration: 739.103327ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.910443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.168434Z","time spent":"741.864922ms","remote":"127.0.0.1:59900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:16:57.910349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.168418Z","time spent":"741.870561ms","remote":"127.0.0.1:59900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:16:57.914323Z","caller":"traceutil/trace.go:171","msg":"trace[1285416646] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"746.035362ms","start":"2026-08-11T08:16:57.16827Z","end":"2026-08-11T08:16:57.914305Z","steps":["trace[1285416646] 'process raft request' (duration: 739.20948ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.914337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.887429ms","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-11T08:16:57.91439Z","caller":"traceutil/trace.go:171","msg":"trace[1599600147] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"745.982231ms","start":"2026-08-11T08:16:57.168393Z","end":"2026-08-11T08:16:57.914375Z","steps":["trace[1599600147] 'agreement among raft nodes before linearized reading' (duration: 739.355574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.909249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.168152Z","time spent":"741.044119ms","remote":"127.0.0.1:59900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:16:57.91443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.168241Z","time spent":"746.131205ms","remote":"127.0.0.1:59900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:16:57.914471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.887145ms","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-11T08:16:57.909333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.20713Z","time spent":"702.11704ms","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:16:57.914429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.168383Z","time spent":"746.039213ms","remote":"127.0.0.1:59440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-11T08:16:57.914495Z","caller":"traceutil/trace.go:171","msg":"trace[472040507] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"740.924906ms","start":"2026-08-11T08:16:57.173564Z","end":"2026-08-11T08:16:57.914489Z","steps":["trace[472040507] 'agreement among raft nodes before linearized reading' (duration: 740.890515ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.914544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.369138ms","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-11T08:16:57.914571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.173547Z","time spent":"741.014768ms","remote":"127.0.0.1:59440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-11T08:16:57.91452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.151408ms","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-11T08:16:57.914652Z","caller":"traceutil/trace.go:171","msg":"trace[453663254] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"697.316592ms","start":"2026-08-11T08:16:57.217316Z","end":"2026-08-11T08:16:57.914633Z","steps":["trace[453663254] 'agreement among raft nodes before linearized reading' (duration: 697.093596ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.91489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.217304Z","time spent":"697.578639ms","remote":"127.0.0.1:59440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-11T08:16:57.914598Z","caller":"traceutil/trace.go:171","msg":"trace[1963638322] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"741.41149ms","start":"2026-08-11T08:16:57.173163Z","end":"2026-08-11T08:16:57.914575Z","steps":["trace[1963638322] 'agreement among raft nodes before linearized reading' (duration: 741.347748ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.914994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.173134Z","time spent":"741.83797ms","remote":"127.0.0.1:59440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-11T08:16:57.908296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.16838Z","time spent":"739.769155ms","remote":"127.0.0.1:59900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:16:57.918471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.826446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-11T08:16:57.918525Z","caller":"traceutil/trace.go:171","msg":"trace[792990757] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"715.922529ms","start":"2026-08-11T08:16:57.202586Z","end":"2026-08-11T08:16:57.918509Z","steps":["trace[792990757] 'agreement among raft nodes before linearized reading' (duration: 709.165698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.918545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.202564Z","time spent":"715.976351ms","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-08-11T08:16:57.952442Z","caller":"traceutil/trace.go:171","msg":"trace[252274544] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"542.301964ms","start":"2026-08-11T08:16:57.410107Z","end":"2026-08-11T08:16:57.952409Z","steps":["trace[252274544] 'process raft request' (duration: 542.231333ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:57.952709Z","caller":"traceutil/trace.go:171","msg":"trace[1547256672] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"543.702152ms","start":"2026-08-11T08:16:57.408991Z","end":"2026-08-11T08:16:57.952693Z","steps":["trace[1547256672] 'process raft request' (duration: 543.306481ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.952881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.408978Z","time spent":"543.817505ms","remote":"127.0.0.1:59440","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:16:57.952473Z","caller":"traceutil/trace.go:171","msg":"trace[1690255778] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"543.743613ms","start":"2026-08-11T08:16:57.408673Z","end":"2026-08-11T08:16:57.952416Z","steps":["trace[1690255778] 'process raft request' (duration: 543.486246ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:57.952938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.410095Z","time spent":"542.624383ms","remote":"127.0.0.1:59802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:16:57.953096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:57.408641Z","time spent":"544.349479ms","remote":"127.0.0.1:59440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:17:37.202281Z","caller":"traceutil/trace.go:171","msg":"trace[1404309782] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"269.184004ms","start":"2026-08-11T08:17:36.93307Z","end":"2026-08-11T08:17:37.202254Z","steps":["trace[1404309782] 'process raft request' (duration: 268.226819ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:17:37.207801Z","caller":"traceutil/trace.go:171","msg":"trace[69861469] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"268.041404ms","start":"2026-08-11T08:17:36.939737Z","end":"2026-08-11T08:17:37.207779Z","steps":["trace[69861469] 'process raft request' (duration: 267.813078ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:17:37.208102Z","caller":"traceutil/trace.go:171","msg":"trace[666558255] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"218.104641ms","start":"2026-08-11T08:17:36.989985Z","end":"2026-08-11T08:17:37.20809Z","steps":["trace[666558255] 'read index received' (duration: 211.273599ms)","trace[666558255] 'applied index is now lower than readState.Index' (duration: 6.830472ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:17:37.208114Z","caller":"traceutil/trace.go:171","msg":"trace[1084133518] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"151.36559ms","start":"2026-08-11T08:17:37.056739Z","end":"2026-08-11T08:17:37.208105Z","steps":["trace[1084133518] 'process raft request' (duration: 151.038771ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:17:37.208255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.628859ms","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-11T08:17:37.208253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.252276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:17:37.208283Z","caller":"traceutil/trace.go:171","msg":"trace[880377750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"108.67009ms","start":"2026-08-11T08:17:37.099605Z","end":"2026-08-11T08:17:37.208275Z","steps":["trace[880377750] 'agreement among raft nodes before linearized reading' (duration: 108.604599ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:17:37.208313Z","caller":"traceutil/trace.go:171","msg":"trace[76673177] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:627; }","duration":"218.359598ms","start":"2026-08-11T08:17:36.989937Z","end":"2026-08-11T08:17:37.208296Z","steps":["trace[76673177] 'agreement among raft nodes before linearized reading' (duration: 218.220044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:17:37.208366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.879933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:17:37.208414Z","caller":"traceutil/trace.go:171","msg":"trace[1962336415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"121.956265ms","start":"2026-08-11T08:17:37.086444Z","end":"2026-08-11T08:17:37.2084Z","steps":["trace[1962336415] 'agreement among raft nodes before linearized reading' (duration: 121.886873ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:17:37.210587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.177203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-2zgvn\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-08-11T08:17:37.210651Z","caller":"traceutil/trace.go:171","msg":"trace[625403666] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-2zgvn; range_end:; response_count:1; response_revision:627; }","duration":"212.295376ms","start":"2026-08-11T08:17:36.998343Z","end":"2026-08-11T08:17:37.210638Z","steps":["trace[625403666] 'agreement among raft nodes before linearized reading' (duration: 209.81777ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:17:42.351863Z","caller":"traceutil/trace.go:171","msg":"trace[356698161] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"103.601065ms","start":"2026-08-11T08:17:42.248239Z","end":"2026-08-11T08:17:42.35184Z","steps":["trace[356698161] 'process raft request' (duration: 103.459371ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:17:43.666148Z","caller":"traceutil/trace.go:171","msg":"trace[369587698] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"119.217809ms","start":"2026-08-11T08:17:43.546904Z","end":"2026-08-11T08:17:43.666122Z","steps":["trace[369587698] 'read index received' (duration: 119.043525ms)","trace[369587698] 'applied index is now lower than readState.Index' (duration: 173.424µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:17:43.666313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.402595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T08:17:43.666342Z","caller":"traceutil/trace.go:171","msg":"trace[1699170884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:700; }","duration":"119.474907ms","start":"2026-08-11T08:17:43.546858Z","end":"2026-08-11T08:17:43.666333Z","steps":["trace[1699170884] 'agreement among raft nodes before linearized reading' (duration: 119.365694ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:17:43.666413Z","caller":"traceutil/trace.go:171","msg":"trace[663171537] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"152.68338ms","start":"2026-08-11T08:17:43.513714Z","end":"2026-08-11T08:17:43.666397Z","steps":["trace[663171537] 'process raft request' (duration: 152.235528ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:17:44.563658Z","caller":"traceutil/trace.go:171","msg":"trace[1995008123] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"202.308609ms","start":"2026-08-11T08:17:44.361324Z","end":"2026-08-11T08:17:44.563633Z","steps":["trace[1995008123] 'process raft request' (duration: 202.133004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:18:00.841852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.004069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-11T08:18:00.841914Z","caller":"traceutil/trace.go:171","msg":"trace[750991663] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"188.108632ms","start":"2026-08-11T08:18:00.653795Z","end":"2026-08-11T08:18:00.841903Z","steps":["trace[750991663] 'range keys from in-memory index tree' (duration: 187.826725ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:18:17.979402Z","caller":"traceutil/trace.go:171","msg":"trace[200793362] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"152.804463ms","start":"2026-08-11T08:18:17.82657Z","end":"2026-08-11T08:18:17.979374Z","steps":["trace[200793362] 'process raft request' (duration: 152.591537ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:18:17.979667Z","caller":"traceutil/trace.go:171","msg":"trace[494729776] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:997; }","duration":"137.841665ms","start":"2026-08-11T08:18:17.841806Z","end":"2026-08-11T08:18:17.979648Z","steps":["trace[494729776] 'read index received' (duration: 137.834625ms)","trace[494729776] 'applied index is now lower than readState.Index' (duration: 5.66µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:18:17.979872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.055461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T08:18:17.979907Z","caller":"traceutil/trace.go:171","msg":"trace[1526381543] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"138.121193ms","start":"2026-08-11T08:18:17.841774Z","end":"2026-08-11T08:18:17.979896Z","steps":["trace[1526381543] 'agreement among raft nodes before linearized reading' (duration: 137.981929ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:18:18.236116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.108047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:18:18.236203Z","caller":"traceutil/trace.go:171","msg":"trace[924779274] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"252.441513ms","start":"2026-08-11T08:18:17.983747Z","end":"2026-08-11T08:18:18.236189Z","steps":["trace[924779274] 'process raft request' (duration: 139.092349ms)","trace[924779274] 'compare' (duration: 113.004994ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:18:18.240737Z","caller":"traceutil/trace.go:171","msg":"trace[1348597564] linearizableReadLoop","detail":"{readStateIndex:1000; appliedIndex:997; }","duration":"154.398595ms","start":"2026-08-11T08:18:18.086327Z","end":"2026-08-11T08:18:18.240726Z","steps":["trace[1348597564] 'read index received' (duration: 36.528361ms)","trace[1348597564] 'applied index is now lower than readState.Index' (duration: 117.869514ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:18:18.240797Z","caller":"traceutil/trace.go:171","msg":"trace[1406220896] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"256.980162ms","start":"2026-08-11T08:18:17.983796Z","end":"2026-08-11T08:18:18.240776Z","steps":["trace[1406220896] 'process raft request' (duration: 256.846589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:18:18.240821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.492438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:18:18.240859Z","caller":"traceutil/trace.go:171","msg":"trace[1349493529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"154.558249ms","start":"2026-08-11T08:18:18.086289Z","end":"2026-08-11T08:18:18.240847Z","steps":["trace[1349493529] 'agreement among raft nodes before linearized reading' (duration: 154.484907ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:18:18.241009Z","caller":"traceutil/trace.go:171","msg":"trace[1903024019] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"232.372858ms","start":"2026-08-11T08:18:18.008626Z","end":"2026-08-11T08:18:18.240999Z","steps":["trace[1903024019] 'process raft request' (duration: 232.07193ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:18:48.311232Z","caller":"traceutil/trace.go:171","msg":"trace[1831534208] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"162.226396ms","start":"2026-08-11T08:18:48.148974Z","end":"2026-08-11T08:18:48.3112Z","steps":["trace[1831534208] 'process raft request' (duration: 162.065722ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:20.760854Z","caller":"traceutil/trace.go:171","msg":"trace[189518019] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"280.039988ms","start":"2026-08-11T08:19:20.48079Z","end":"2026-08-11T08:19:20.76083Z","steps":["trace[189518019] 'process raft request' (duration: 184.917815ms)","trace[189518019] 'compare' (duration: 94.939778ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:19:20.760868Z","caller":"traceutil/trace.go:171","msg":"trace[1714826732] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"280.058388ms","start":"2026-08-11T08:19:20.480791Z","end":"2026-08-11T08:19:20.76085Z","steps":["trace[1714826732] 'process raft request' (duration: 279.978366ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:20.809094Z","caller":"traceutil/trace.go:171","msg":"trace[393115935] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1288; }","duration":"309.927737ms","start":"2026-08-11T08:19:20.499148Z","end":"2026-08-11T08:19:20.809076Z","steps":["trace[393115935] 'read index received' (duration: 166.57276ms)","trace[393115935] 'applied index is now lower than readState.Index' (duration: 143.354237ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:19:20.809189Z","caller":"traceutil/trace.go:171","msg":"trace[42118577] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"328.371525ms","start":"2026-08-11T08:19:20.48081Z","end":"2026-08-11T08:19:20.809182Z","steps":["trace[42118577] 'process raft request' (duration: 328.135379ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:19:20.80927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:19:20.480785Z","time spent":"328.422826ms","remote":"127.0.0.1:59640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1507,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:19:20.809498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.66188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-11T08:19:20.809484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.356028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T08:19:20.809552Z","caller":"traceutil/trace.go:171","msg":"trace[562527834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1246; }","duration":"310.480082ms","start":"2026-08-11T08:19:20.499055Z","end":"2026-08-11T08:19:20.809536Z","steps":["trace[562527834] 'agreement among raft nodes before linearized reading' (duration: 310.294428ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:19:20.809587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.247258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T08:19:20.809518Z","caller":"traceutil/trace.go:171","msg":"trace[1652320065] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1246; }","duration":"203.716012ms","start":"2026-08-11T08:19:20.605797Z","end":"2026-08-11T08:19:20.809513Z","steps":["trace[1652320065] 'agreement among raft nodes before linearized reading' (duration: 203.63618ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:20.809604Z","caller":"traceutil/trace.go:171","msg":"trace[1486387395] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1246; }","duration":"198.277868ms","start":"2026-08-11T08:19:20.611322Z","end":"2026-08-11T08:19:20.8096Z","steps":["trace[1486387395] 'agreement among raft nodes before linearized reading' (duration: 198.235467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:19:20.809584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:19:20.499035Z","time spent":"310.541774ms","remote":"127.0.0.1:59626","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-11T08:19:20.809722Z","caller":"traceutil/trace.go:171","msg":"trace[1279433850] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"243.809921ms","start":"2026-08-11T08:19:20.565887Z","end":"2026-08-11T08:19:20.809697Z","steps":["trace[1279433850] 'process raft request' (duration: 243.152073ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:20.920049Z","caller":"traceutil/trace.go:171","msg":"trace[1947097259] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"106.979866ms","start":"2026-08-11T08:19:20.812958Z","end":"2026-08-11T08:19:20.919938Z","steps":["trace[1947097259] 'process raft request' (duration: 93.398237ms)","trace[1947097259] 'compare' (duration: 13.397714ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:19:21.013914Z","caller":"traceutil/trace.go:171","msg":"trace[179112907] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"200.738973ms","start":"2026-08-11T08:19:20.813145Z","end":"2026-08-11T08:19:21.013884Z","steps":["trace[179112907] 'process raft request' (duration: 200.505197ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:21.014172Z","caller":"traceutil/trace.go:171","msg":"trace[657777650] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"150.910756ms","start":"2026-08-11T08:19:20.863232Z","end":"2026-08-11T08:19:21.014142Z","steps":["trace[657777650] 'process raft request' (duration: 150.803034ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:21.014232Z","caller":"traceutil/trace.go:171","msg":"trace[1681349020] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"200.316052ms","start":"2026-08-11T08:19:20.813883Z","end":"2026-08-11T08:19:21.014199Z","steps":["trace[1681349020] 'process raft request' (duration: 199.949782ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:21.518558Z","caller":"traceutil/trace.go:171","msg":"trace[1173462645] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"149.88355ms","start":"2026-08-11T08:19:21.368651Z","end":"2026-08-11T08:19:21.518535Z","steps":["trace[1173462645] 'process raft request' (duration: 149.770067ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:21.566108Z","caller":"traceutil/trace.go:171","msg":"trace[535445318] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1298; }","duration":"160.994793ms","start":"2026-08-11T08:19:21.405083Z","end":"2026-08-11T08:19:21.566078Z","steps":["trace[535445318] 'read index received' (duration: 113.415696ms)","trace[535445318] 'applied index is now lower than readState.Index' (duration: 47.577887ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:19:21.566177Z","caller":"traceutil/trace.go:171","msg":"trace[1238700937] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"171.965712ms","start":"2026-08-11T08:19:21.394176Z","end":"2026-08-11T08:19:21.566142Z","steps":["trace[1238700937] 'process raft request' (duration: 171.753957ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:19:21.566291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.178347ms","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-11T08:19:21.566323Z","caller":"traceutil/trace.go:171","msg":"trace[64292816] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1254; }","duration":"161.26297ms","start":"2026-08-11T08:19:21.405053Z","end":"2026-08-11T08:19:21.566315Z","steps":["trace[64292816] 'agreement among raft nodes before linearized reading' (duration: 161.134147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:19:21.946978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.961497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:19:21.947195Z","caller":"traceutil/trace.go:171","msg":"trace[1438753620] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1300; }","duration":"190.42058ms","start":"2026-08-11T08:19:21.756758Z","end":"2026-08-11T08:19:21.947179Z","steps":["trace[1438753620] 'read index received' (duration: 50.211346ms)","trace[1438753620] 'applied index is now lower than readState.Index' (duration: 140.208024ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:19:21.947363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.606776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T08:19:21.947352Z","caller":"traceutil/trace.go:171","msg":"trace[495510134] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"376.588278ms","start":"2026-08-11T08:19:21.570736Z","end":"2026-08-11T08:19:21.947324Z","steps":["trace[495510134] 'process raft request' (duration: 236.22216ms)","trace[495510134] 'compare' (duration: 139.857375ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:19:21.947396Z","caller":"traceutil/trace.go:171","msg":"trace[570135607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1256; }","duration":"190.643187ms","start":"2026-08-11T08:19:21.756744Z","end":"2026-08-11T08:19:21.947387Z","steps":["trace[570135607] 'agreement among raft nodes before linearized reading' (duration: 190.485172ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:19:21.94745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:19:21.570699Z","time spent":"376.702641ms","remote":"127.0.0.1:59404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:19:21.947574Z","caller":"traceutil/trace.go:171","msg":"trace[393202953] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"374.38004ms","start":"2026-08-11T08:19:21.573182Z","end":"2026-08-11T08:19:21.947562Z","steps":["trace[393202953] 'process raft request' (duration: 373.893797ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:19:21.94763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:19:21.573147Z","time spent":"374.456332ms","remote":"127.0.0.1:59626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:19:22.121208Z","caller":"traceutil/trace.go:171","msg":"trace[739256468] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"169.461166ms","start":"2026-08-11T08:19:21.951714Z","end":"2026-08-11T08:19:22.121175Z","steps":["trace[739256468] 'process raft request' (duration: 140.531481ms)","trace[739256468] 'compare' (duration: 28.810341ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:19:22.14426Z","caller":"traceutil/trace.go:171","msg":"trace[592626521] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"191.026465ms","start":"2026-08-11T08:19:21.953215Z","end":"2026-08-11T08:19:22.144241Z","steps":["trace[592626521] 'process raft request' (duration: 190.901882ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:19:22.144609Z","caller":"traceutil/trace.go:171","msg":"trace[1266766232] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"189.784243ms","start":"2026-08-11T08:19:21.954817Z","end":"2026-08-11T08:19:22.144602Z","steps":["trace[1266766232] 'process raft request' (duration: 189.395402ms)"],"step_count":1}