{"level":"warn","ts":"2026-08-06T06:56:23.58325Z","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-06T06:56:23.583344Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.207: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.207:2380","--initial-cluster=instance=https://199.19.213.207:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.207:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.207: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-06T06:56:23.58344Z","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-06T06:56:23.583466Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.207:2380"]} {"level":"info","ts":"2026-08-06T06:56:23.583495Z","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-06T06:56:23.584325Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"]} {"level":"info","ts":"2026-08-06T06:56:23.584517Z","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.207:2380"],"listen-peer-urls":["https://199.19.213.207:2380"],"advertise-client-urls":["https://199.19.213.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.207: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-06T06:56:23.590427Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.327848ms"} {"level":"info","ts":"2026-08-06T06:56:23.599131Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"520ed656383c33a4","cluster-id":"21f34f1629612ac4"} {"level":"info","ts":"2026-08-06T06:56:23.599208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=()"} {"level":"info","ts":"2026-08-06T06:56:23.599226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became follower at term 0"} {"level":"info","ts":"2026-08-06T06:56:23.599239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 520ed656383c33a4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-06T06:56:23.599247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became follower at term 1"} {"level":"info","ts":"2026-08-06T06:56:23.599285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=(5912899026583040932)"} {"level":"warn","ts":"2026-08-06T06:56:23.606479Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-06T06:56:23.609433Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-06T06:56:23.611697Z","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-06T06:56:23.620566Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"520ed656383c33a4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-06T06:56:23.620681Z","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-06T06:56:23.620756Z","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-06T06:56:23.620769Z","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-06T06:56:23.620755Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"520ed656383c33a4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-06T06:56:23.623164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=(5912899026583040932)"} {"level":"info","ts":"2026-08-06T06:56:23.623356Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21f34f1629612ac4","local-member-id":"520ed656383c33a4","added-peer-id":"520ed656383c33a4","added-peer-peer-urls":["https://199.19.213.207:2380"]} {"level":"info","ts":"2026-08-06T06:56:23.632618Z","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-06T06:56:23.63277Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.207:2380"} {"level":"info","ts":"2026-08-06T06:56:23.632854Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.207:2380"} {"level":"info","ts":"2026-08-06T06:56:23.633044Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"520ed656383c33a4","initial-advertise-peer-urls":["https://199.19.213.207:2380"],"listen-peer-urls":["https://199.19.213.207:2380"],"advertise-client-urls":["https://199.19.213.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-06T06:56:23.633134Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-06T06:56:24.399968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 is starting a new election at term 1"} {"level":"info","ts":"2026-08-06T06:56:24.400006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-06T06:56:24.400038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 received MsgPreVoteResp from 520ed656383c33a4 at term 1"} {"level":"info","ts":"2026-08-06T06:56:24.40005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became candidate at term 2"} {"level":"info","ts":"2026-08-06T06:56:24.400055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 received MsgVoteResp from 520ed656383c33a4 at term 2"} {"level":"info","ts":"2026-08-06T06:56:24.400063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became leader at term 2"} {"level":"info","ts":"2026-08-06T06:56:24.400073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 520ed656383c33a4 elected leader 520ed656383c33a4 at term 2"} {"level":"info","ts":"2026-08-06T06:56:24.401114Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"520ed656383c33a4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.207:2379]}","request-path":"/0/members/520ed656383c33a4/attributes","cluster-id":"21f34f1629612ac4","publish-timeout":"7s"} {"level":"info","ts":"2026-08-06T06:56:24.401125Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T06:56:24.401117Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T06:56:24.401261Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T06:56:24.40151Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-06T06:56:24.401556Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-06T06:56:24.402096Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21f34f1629612ac4","local-member-id":"520ed656383c33a4","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T06:56:24.402151Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T06:56:24.402172Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T06:56:24.404203Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.207:2379"} {"level":"info","ts":"2026-08-06T06:56:24.405725Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-06T06:56:28.789483Z","caller":"traceutil/trace.go:171","msg":"trace[132068326] linearizableReadLoop","detail":"{readStateIndex:224; appliedIndex:223; }","duration":"461.654546ms","start":"2026-08-06T06:56:28.3278Z","end":"2026-08-06T06:56:28.789455Z","steps":["trace[132068326] 'read index received' (duration: 460.188086ms)","trace[132068326] 'applied index is now lower than readState.Index' (duration: 1.46546ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:56:28.789628Z","caller":"traceutil/trace.go:171","msg":"trace[1214409342] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"464.622167ms","start":"2026-08-06T06:56:28.324995Z","end":"2026-08-06T06:56:28.789617Z","steps":["trace[1214409342] 'process raft request' (duration: 463.046885ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:28.789885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.063615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:56:28.790012Z","caller":"traceutil/trace.go:171","msg":"trace[1051051479] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:218; }","duration":"462.234939ms","start":"2026-08-06T06:56:28.327755Z","end":"2026-08-06T06:56:28.78999Z","steps":["trace[1051051479] 'agreement among raft nodes before linearized reading' (duration: 461.961323ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:28.790064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:28.32774Z","time spent":"462.31469ms","remote":"127.0.0.1:39612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" "} {"level":"warn","ts":"2026-08-06T06:56:28.790064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:28.324969Z","time spent":"464.68826ms","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T06:56:30.50126Z","caller":"traceutil/trace.go:171","msg":"trace[1446739399] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"351.268035ms","start":"2026-08-06T06:56:30.149965Z","end":"2026-08-06T06:56:30.501233Z","steps":["trace[1446739399] 'process raft request' (duration: 351.148762ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:30.501389Z","caller":"traceutil/trace.go:171","msg":"trace[870541176] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:318; }","duration":"256.411543ms","start":"2026-08-06T06:56:30.244955Z","end":"2026-08-06T06:56:30.501367Z","steps":["trace[870541176] 'read index received' (duration: 256.402282ms)","trace[870541176] 'applied index is now lower than readState.Index' (duration: 7.03µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:56:30.501427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:30.14993Z","time spent":"351.432888ms","remote":"127.0.0.1:39612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":176,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T06:56:30.501524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.567515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:56:30.50156Z","caller":"traceutil/trace.go:171","msg":"trace[1971284771] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:309; }","duration":"256.643647ms","start":"2026-08-06T06:56:30.2449Z","end":"2026-08-06T06:56:30.501544Z","steps":["trace[1971284771] 'agreement among raft nodes before linearized reading' (duration: 256.563605ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:30.50615Z","caller":"traceutil/trace.go:171","msg":"trace[1564020887] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"214.581444ms","start":"2026-08-06T06:56:30.291557Z","end":"2026-08-06T06:56:30.506139Z","steps":["trace[1564020887] 'process raft request' (duration: 214.37775ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:30.506254Z","caller":"traceutil/trace.go:171","msg":"trace[2059998984] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"214.546994ms","start":"2026-08-06T06:56:30.291681Z","end":"2026-08-06T06:56:30.506228Z","steps":["trace[2059998984] 'process raft request' (duration: 214.376971ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:30.506412Z","caller":"traceutil/trace.go:171","msg":"trace[910870639] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"214.284859ms","start":"2026-08-06T06:56:30.29212Z","end":"2026-08-06T06:56:30.506405Z","steps":["trace[910870639] 'process raft request' (duration: 214.035994ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:30.506492Z","caller":"traceutil/trace.go:171","msg":"trace[2075105944] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"214.727277ms","start":"2026-08-06T06:56:30.291759Z","end":"2026-08-06T06:56:30.506486Z","steps":["trace[2075105944] 'process raft request' (duration: 214.355ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:30.506626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.29488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-08-06T06:56:30.506657Z","caller":"traceutil/trace.go:171","msg":"trace[217627540] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:309; }","duration":"217.353312ms","start":"2026-08-06T06:56:30.289294Z","end":"2026-08-06T06:56:30.506647Z","steps":["trace[217627540] 'agreement among raft nodes before linearized reading' (duration: 217.243339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:30.506704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.608735ms","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-06T06:56:30.506817Z","caller":"traceutil/trace.go:171","msg":"trace[1758434444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:309; }","duration":"253.790808ms","start":"2026-08-06T06:56:30.252981Z","end":"2026-08-06T06:56:30.506772Z","steps":["trace[1758434444] 'agreement among raft nodes before linearized reading' (duration: 253.539233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:37.048635Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721274932980363885,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T06:56:37.549905Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721274932980363885,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T06:56:37.691882Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.681465191s","expected-duration":"1s"} {"level":"info","ts":"2026-08-06T06:56:37.692503Z","caller":"traceutil/trace.go:171","msg":"trace[1033248589] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:408; }","duration":"1.144408106s","start":"2026-08-06T06:56:36.548072Z","end":"2026-08-06T06:56:37.692481Z","steps":["trace[1033248589] 'read index received' (duration: 1.144255212s)","trace[1033248589] 'applied index is now lower than readState.Index' (duration: 151.773µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:56:37.692716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144614299s","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-06T06:56:37.692753Z","caller":"traceutil/trace.go:171","msg":"trace[620045562] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:395; }","duration":"1.144702421s","start":"2026-08-06T06:56:36.548038Z","end":"2026-08-06T06:56:37.69274Z","steps":["trace[620045562] 'agreement among raft nodes before linearized reading' (duration: 1.144584839s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:37.692779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:36.548023Z","time spent":"1.144749212s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T06:56:37.692818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135030545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-06T06:56:37.692891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.945769ms","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-06T06:56:37.692916Z","caller":"traceutil/trace.go:171","msg":"trace[585722825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:395; }","duration":"383.004161ms","start":"2026-08-06T06:56:37.309905Z","end":"2026-08-06T06:56:37.692909Z","steps":["trace[585722825] 'agreement among raft nodes before linearized reading' (duration: 382.96169ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:37.692906Z","caller":"traceutil/trace.go:171","msg":"trace[75323969] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:395; }","duration":"1.135187658s","start":"2026-08-06T06:56:36.557692Z","end":"2026-08-06T06:56:37.69288Z","steps":["trace[75323969] 'agreement among raft nodes before linearized reading' (duration: 1.134975614s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:37.692941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:37.309886Z","time spent":"383.050801ms","remote":"127.0.0.1:39698","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-06T06:56:37.692969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:36.55767Z","time spent":"1.135288459s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-06T06:56:37.693082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.64263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-06T06:56:37.693161Z","caller":"traceutil/trace.go:171","msg":"trace[1920359976] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:395; }","duration":"293.786993ms","start":"2026-08-06T06:56:37.399354Z","end":"2026-08-06T06:56:37.693141Z","steps":["trace[1920359976] 'agreement among raft nodes before linearized reading' (duration: 293.404006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:37.693127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.73254ms","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-06T06:56:37.693309Z","caller":"traceutil/trace.go:171","msg":"trace[1512826852] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"1.682290827s","start":"2026-08-06T06:56:36.010294Z","end":"2026-08-06T06:56:37.692585Z","steps":["trace[1512826852] 'process raft request' (duration: 1.682001051s)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:37.693316Z","caller":"traceutil/trace.go:171","msg":"trace[536417139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:395; }","duration":"217.944565ms","start":"2026-08-06T06:56:37.47535Z","end":"2026-08-06T06:56:37.693295Z","steps":["trace[536417139] 'agreement among raft nodes before linearized reading' (duration: 217.489326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:37.693967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:36.010271Z","time spent":"1.683136644s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:56:39.691439Z","caller":"traceutil/trace.go:171","msg":"trace[1616555659] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"136.025584ms","start":"2026-08-06T06:56:39.555378Z","end":"2026-08-06T06:56:39.691404Z","steps":["trace[1616555659] 'process raft request' (duration: 135.860501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.766153Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.137336895s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-06T06:56:43.81169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.073621493s","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-06T06:56:43.811767Z","caller":"traceutil/trace.go:171","msg":"trace[38217124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:401; }","duration":"4.073749066s","start":"2026-08-06T06:56:39.737999Z","end":"2026-08-06T06:56:43.811748Z","steps":["trace[38217124] 'range keys from in-memory index tree' (duration: 4.073525592s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.811808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:39.737976Z","time spent":"4.073823407s","remote":"127.0.0.1:39698","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-06T06:56:43.812021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.073843978s","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-06T06:56:43.812058Z","caller":"traceutil/trace.go:171","msg":"trace[677187221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:401; }","duration":"4.073890248s","start":"2026-08-06T06:56:39.738159Z","end":"2026-08-06T06:56:43.812049Z","steps":["trace[677187221] 'range keys from in-memory index tree' (duration: 4.073755875s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.812084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:39.738152Z","time spent":"4.073925999s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-06T06:56:43.812207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.07398651s","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-06T06:56:43.812234Z","caller":"traceutil/trace.go:171","msg":"trace[1366055258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:401; }","duration":"4.07401909s","start":"2026-08-06T06:56:39.738205Z","end":"2026-08-06T06:56:43.812224Z","steps":["trace[1366055258] 'range keys from in-memory index tree' (duration: 4.073937709s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.812258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:39.738198Z","time spent":"4.074054331s","remote":"127.0.0.1:39698","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-06T06:56:43.812243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.277875297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:56:43.81233Z","caller":"traceutil/trace.go:171","msg":"trace[413033208] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:401; }","duration":"2.27802059s","start":"2026-08-06T06:56:41.534287Z","end":"2026-08-06T06:56:43.812307Z","steps":["trace[413033208] 'range keys from in-memory index tree' (duration: 2.277780676s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.812387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.074150093s","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-06T06:56:43.8124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:41.534259Z","time spent":"2.278130172s","remote":"127.0.0.1:39440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-06T06:56:43.812417Z","caller":"traceutil/trace.go:171","msg":"trace[2020633631] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:401; }","duration":"4.074214414s","start":"2026-08-06T06:56:39.738193Z","end":"2026-08-06T06:56:43.812407Z","steps":["trace[2020633631] 'range keys from in-memory index tree' (duration: 4.074066071s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.812445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:39.738171Z","time spent":"4.074267425s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T06:56:43.812808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.563943297s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:56:43.812891Z","caller":"traceutil/trace.go:171","msg":"trace[1786834117] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:401; }","duration":"1.56402846s","start":"2026-08-06T06:56:42.248852Z","end":"2026-08-06T06:56:43.81288Z","steps":["trace[1786834117] 'range keys from in-memory index tree' (duration: 1.563813095s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.812872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.06210066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-08-06T06:56:43.81294Z","caller":"traceutil/trace.go:171","msg":"trace[376250583] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:401; }","duration":"2.062215912s","start":"2026-08-06T06:56:41.750707Z","end":"2026-08-06T06:56:43.812923Z","steps":["trace[376250583] 'range keys from in-memory index tree' (duration: 2.061842656s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.812979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:41.750683Z","time spent":"2.062286714s","remote":"127.0.0.1:39596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4348,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-08-06T06:56:43.862951Z","caller":"traceutil/trace.go:171","msg":"trace[1475403568] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"323.845311ms","start":"2026-08-06T06:56:43.53908Z","end":"2026-08-06T06:56:43.862925Z","steps":["trace[1475403568] 'process raft request' (duration: 323.703118ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:43.86307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:43.539041Z","time spent":"323.972872ms","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T06:56:46.166571Z","caller":"traceutil/trace.go:171","msg":"trace[1049945736] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"262.919117ms","start":"2026-08-06T06:56:45.903636Z","end":"2026-08-06T06:56:46.166555Z","steps":["trace[1049945736] 'process raft request' (duration: 262.815144ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:46.248202Z","caller":"traceutil/trace.go:171","msg":"trace[1234304426] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"343.556276ms","start":"2026-08-06T06:56:45.904627Z","end":"2026-08-06T06:56:46.248183Z","steps":["trace[1234304426] 'process raft request' (duration: 343.467705ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:46.248364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:45.90462Z","time spent":"343.677439ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:56:46.248363Z","caller":"traceutil/trace.go:171","msg":"trace[1801916477] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"343.028628ms","start":"2026-08-06T06:56:45.905307Z","end":"2026-08-06T06:56:46.248336Z","steps":["trace[1801916477] 'process raft request' (duration: 342.836765ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:46.248489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:45.905295Z","time spent":"343.125589ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:56:46.248614Z","caller":"traceutil/trace.go:171","msg":"trace[116057402] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"344.048005ms","start":"2026-08-06T06:56:45.904557Z","end":"2026-08-06T06:56:46.248605Z","steps":["trace[116057402] 'process raft request' (duration: 343.434245ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:56:46.248717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:56:45.90454Z","time spent":"344.088626ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:56:50.320227Z","caller":"traceutil/trace.go:171","msg":"trace[1959608823] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"110.104141ms","start":"2026-08-06T06:56:50.210093Z","end":"2026-08-06T06:56:50.320197Z","steps":["trace[1959608823] 'process raft request' (duration: 109.717845ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:50.470762Z","caller":"traceutil/trace.go:171","msg":"trace[1044670576] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"146.293407ms","start":"2026-08-06T06:56:50.324448Z","end":"2026-08-06T06:56:50.470741Z","steps":["trace[1044670576] 'process raft request' (duration: 146.252946ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:56:50.470902Z","caller":"traceutil/trace.go:171","msg":"trace[324397531] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"146.51872ms","start":"2026-08-06T06:56:50.324373Z","end":"2026-08-06T06:56:50.470892Z","steps":["trace[324397531] 'process raft request' (duration: 108.926142ms)","trace[324397531] 'compare' (duration: 37.06331ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:06.651531Z","caller":"traceutil/trace.go:171","msg":"trace[213778370] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"138.783779ms","start":"2026-08-06T06:57:06.512726Z","end":"2026-08-06T06:57:06.65151Z","steps":["trace[213778370] 'process raft request' (duration: 74.856075ms)","trace[213778370] 'compare' (duration: 63.806272ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:12.662965Z","caller":"traceutil/trace.go:171","msg":"trace[949453555] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"127.058609ms","start":"2026-08-06T06:57:12.53589Z","end":"2026-08-06T06:57:12.662949Z","steps":["trace[949453555] 'process raft request' (duration: 126.946278ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:14.683632Z","caller":"traceutil/trace.go:171","msg":"trace[930783358] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"880.168489ms","start":"2026-08-06T06:57:13.803434Z","end":"2026-08-06T06:57:14.683603Z","steps":["trace[930783358] 'process raft request' (duration: 865.98278ms)","trace[930783358] 'compare' (duration: 13.897955ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:14.68383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:13.803414Z","time spent":"880.286231ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:57:14.694812Z","caller":"traceutil/trace.go:171","msg":"trace[403659206] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"867.742402ms","start":"2026-08-06T06:57:13.827049Z","end":"2026-08-06T06:57:14.694791Z","steps":["trace[403659206] 'process raft request' (duration: 867.534589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:14.695136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:13.827028Z","time spent":"867.844094ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:57:14.695254Z","caller":"traceutil/trace.go:171","msg":"trace[103487277] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:602; }","duration":"209.958448ms","start":"2026-08-06T06:57:14.485271Z","end":"2026-08-06T06:57:14.695229Z","steps":["trace[103487277] 'read index received' (duration: 184.037545ms)","trace[103487277] 'applied index is now lower than readState.Index' (duration: 25.919983ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:14.695309Z","caller":"traceutil/trace.go:171","msg":"trace[272703220] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"860.608651ms","start":"2026-08-06T06:57:13.834691Z","end":"2026-08-06T06:57:14.6953Z","steps":["trace[272703220] 'process raft request' (duration: 860.072464ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:14.695395Z","caller":"traceutil/trace.go:171","msg":"trace[1161009033] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"823.872632ms","start":"2026-08-06T06:57:13.871512Z","end":"2026-08-06T06:57:14.695385Z","steps":["trace[1161009033] 'process raft request' (duration: 823.554988ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:14.69552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:13.871491Z","time spent":"823.932973ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T06:57:14.69557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.295014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:14.69535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:13.83465Z","time spent":"860.682963ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T06:57:14.695647Z","caller":"traceutil/trace.go:171","msg":"trace[1191112685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"210.424046ms","start":"2026-08-06T06:57:14.485203Z","end":"2026-08-06T06:57:14.695627Z","steps":["trace[1191112685] 'agreement among raft nodes before linearized reading' (duration: 210.265553ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:20.073568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.507422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-06T06:57:20.073653Z","caller":"traceutil/trace.go:171","msg":"trace[1206811314] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"183.597832ms","start":"2026-08-06T06:57:19.890041Z","end":"2026-08-06T06:57:20.073639Z","steps":["trace[1206811314] 'process raft request' (duration: 49.808416ms)","trace[1206811314] 'compare' (duration: 133.398601ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:20.454795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.028899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T06:57:20.454887Z","caller":"traceutil/trace.go:171","msg":"trace[454272420] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"224.648654ms","start":"2026-08-06T06:57:20.230225Z","end":"2026-08-06T06:57:20.454873Z","steps":["trace[454272420] 'process raft request' (duration: 103.466303ms)","trace[454272420] 'compare' (duration: 120.823436ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:20.663321Z","caller":"traceutil/trace.go:171","msg":"trace[2079465185] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"165.959924ms","start":"2026-08-06T06:57:20.497319Z","end":"2026-08-06T06:57:20.663279Z","steps":["trace[2079465185] 'process raft request' (duration: 142.083132ms)","trace[2079465185] 'compare' (duration: 23.311394ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:21.324Z","caller":"traceutil/trace.go:171","msg":"trace[1845798960] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"116.500587ms","start":"2026-08-06T06:57:21.20746Z","end":"2026-08-06T06:57:21.32396Z","steps":["trace[1845798960] 'process raft request' (duration: 116.304765ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:22.112795Z","caller":"traceutil/trace.go:171","msg":"trace[706651494] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"332.610136ms","start":"2026-08-06T06:57:21.780161Z","end":"2026-08-06T06:57:22.112771Z","steps":["trace[706651494] 'process raft request' (duration: 331.970897ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:22.112916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:21.780132Z","time spent":"332.725908ms","remote":"127.0.0.1:39524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T06:57:23.956183Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.254881239s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-06T06:57:24.306074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.02370991s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-06T06:57:24.306423Z","caller":"traceutil/trace.go:171","msg":"trace[1445648591] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"2.139360545s","start":"2026-08-06T06:57:22.167032Z","end":"2026-08-06T06:57:24.306393Z","steps":["trace[1445648591] 'process raft request' (duration: 115.173899ms)","trace[1445648591] 'compare' (duration: 2.023511198s)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:24.306583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:22.167012Z","time spent":"2.139480717s","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T06:57:24.307006Z","caller":"traceutil/trace.go:171","msg":"trace[801366982] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:686; }","duration":"1.817947947s","start":"2026-08-06T06:57:22.488457Z","end":"2026-08-06T06:57:24.306405Z","steps":["trace[801366982] 'read index received' (duration: 74.57µs)","trace[801366982] 'applied index is now lower than readState.Index' (duration: 1.817868447s)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:24.582421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.201509ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-08-06T06:57:24.582455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.093945125s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:24.582588Z","caller":"traceutil/trace.go:171","msg":"trace[590528957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"2.094128207s","start":"2026-08-06T06:57:22.488414Z","end":"2026-08-06T06:57:24.582543Z","steps":["trace[590528957] 'agreement among raft nodes before linearized reading' (duration: 1.81808599s)","trace[590528957] 'range keys from in-memory index tree' (duration: 275.838855ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:24.582743Z","caller":"traceutil/trace.go:171","msg":"trace[46495390] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"275.500049ms","start":"2026-08-06T06:57:24.307209Z","end":"2026-08-06T06:57:24.582709Z","steps":["trace[46495390] 'read index received' (duration: 74.881µs)","trace[46495390] 'applied index is now lower than readState.Index' (duration: 275.420778ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:24.583035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.609531972s","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-06T06:57:24.583139Z","caller":"traceutil/trace.go:171","msg":"trace[878162575] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:658; }","duration":"1.609693044s","start":"2026-08-06T06:57:22.973416Z","end":"2026-08-06T06:57:24.583109Z","steps":["trace[878162575] 'agreement among raft nodes before linearized reading' (duration: 1.609308449s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:24.583202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:22.973392Z","time spent":"1.609797525s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-06T06:57:24.583765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:22.488395Z","time spent":"2.095331252s","remote":"127.0.0.1:39452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-06T06:57:26.875884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.047080113s","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-06T06:57:26.876011Z","caller":"traceutil/trace.go:171","msg":"trace[2033007808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:659; }","duration":"4.047267215s","start":"2026-08-06T06:57:22.828711Z","end":"2026-08-06T06:57:26.875978Z","steps":["trace[2033007808] 'agreement among raft nodes before linearized reading' (duration: 1.754144442s)","trace[2033007808] 'range keys from in-memory index tree' (duration: 2.292787858s)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:26.876071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:22.828683Z","time spent":"4.047376587s","remote":"127.0.0.1:39698","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-06T06:57:26.876174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.374939395s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:26.876334Z","caller":"traceutil/trace.go:171","msg":"trace[395875792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"2.375145137s","start":"2026-08-06T06:57:24.501159Z","end":"2026-08-06T06:57:26.876304Z","steps":["trace[395875792] 'agreement among raft nodes before linearized reading' (duration: 81.930133ms)","trace[395875792] 'range keys from in-memory index tree' (duration: 2.293024392s)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:26.876385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:24.501144Z","time spent":"2.375231069s","remote":"127.0.0.1:39440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-06T06:57:26.876448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.566338212s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-06T06:57:26.876498Z","caller":"traceutil/trace.go:171","msg":"trace[588168011] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:659; }","duration":"2.566434543s","start":"2026-08-06T06:57:24.310048Z","end":"2026-08-06T06:57:26.876484Z","steps":["trace[588168011] 'agreement among raft nodes before linearized reading' (duration: 273.006347ms)","trace[588168011] 'range keys from in-memory index tree' (duration: 2.293347675s)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:26.876503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.05823229s","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-06T06:57:26.876537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:24.310021Z","time spent":"2.566508884s","remote":"127.0.0.1:39612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-08-06T06:57:26.87658Z","caller":"traceutil/trace.go:171","msg":"trace[833942760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:659; }","duration":"4.058378292s","start":"2026-08-06T06:57:22.818179Z","end":"2026-08-06T06:57:26.876557Z","steps":["trace[833942760] 'agreement among raft nodes before linearized reading' (duration: 1.764834344s)","trace[833942760] 'range keys from in-memory index tree' (duration: 2.293339146s)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:26.87663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:22.818148Z","time spent":"4.058474533s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T06:57:26.87678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.264093862s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T06:57:26.87685Z","caller":"traceutil/trace.go:171","msg":"trace[1428394256] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:689; }","duration":"1.745154173s","start":"2026-08-06T06:57:25.131684Z","end":"2026-08-06T06:57:26.876838Z","steps":["trace[1428394256] 'read index received' (duration: 47.22µs)","trace[1428394256] 'applied index is now lower than readState.Index' (duration: 1.745105983s)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:26.87693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.902942497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-06T06:57:26.877004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"968.219631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-06T06:57:26.877016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.745322865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T06:57:26.876996Z","caller":"traceutil/trace.go:171","msg":"trace[1221417637] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"2.286479445s","start":"2026-08-06T06:57:24.590477Z","end":"2026-08-06T06:57:26.876957Z","steps":["trace[1221417637] 'process raft request' (duration: 22.1345ms)","trace[1221417637] 'compare' (duration: 2.263548965s)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:26.877062Z","caller":"traceutil/trace.go:171","msg":"trace[1904447255] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:660; }","duration":"1.745409586s","start":"2026-08-06T06:57:25.131639Z","end":"2026-08-06T06:57:26.877048Z","steps":["trace[1904447255] 'agreement among raft nodes before linearized reading' (duration: 1.745282295s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:26.87707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.955428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:26.877104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:25.131615Z","time spent":"1.745480537s","remote":"127.0.0.1:39764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-08-06T06:57:26.877125Z","caller":"traceutil/trace.go:171","msg":"trace[1183323969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"371.0809ms","start":"2026-08-06T06:57:26.50603Z","end":"2026-08-06T06:57:26.877111Z","steps":["trace[1183323969] 'agreement among raft nodes before linearized reading' (duration: 370.942458ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:26.87716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:26.506002Z","time spent":"371.152171ms","remote":"127.0.0.1:39452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-06T06:57:26.87704Z","caller":"traceutil/trace.go:171","msg":"trace[2110943685] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:660; }","duration":"968.289831ms","start":"2026-08-06T06:57:25.908742Z","end":"2026-08-06T06:57:26.877031Z","steps":["trace[2110943685] 'agreement among raft nodes before linearized reading' (duration: 968.19326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:26.877201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:25.908724Z","time spent":"968.464824ms","remote":"127.0.0.1:39706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":29,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-08-06T06:57:26.8772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:24.590448Z","time spent":"2.286648687s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:57:26.877194Z","caller":"traceutil/trace.go:171","msg":"trace[453043449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:659; }","duration":"3.903210131s","start":"2026-08-06T06:57:22.973805Z","end":"2026-08-06T06:57:26.877015Z","steps":["trace[453043449] 'agreement among raft nodes before linearized reading' (duration: 1.609005035s)","trace[453043449] 'range keys from in-memory index tree' (duration: 2.293614699s)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:26.87731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:22.973761Z","time spent":"3.903531575s","remote":"127.0.0.1:39698","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-06T06:57:27.389361Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721274932980364401,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T06:57:27.890188Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721274932980364401,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T06:57:27.926082Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.037188306s","expected-duration":"1s"} {"level":"info","ts":"2026-08-06T06:57:27.933285Z","caller":"traceutil/trace.go:171","msg":"trace[217892755] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"1.04449514s","start":"2026-08-06T06:57:26.888759Z","end":"2026-08-06T06:57:27.933254Z","steps":["trace[217892755] 'process raft request' (duration: 1.037622993s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:27.933537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:26.888728Z","time spent":"1.044675742s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:57:27.933591Z","caller":"traceutil/trace.go:171","msg":"trace[97358075] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:690; }","duration":"1.044656322s","start":"2026-08-06T06:57:26.888908Z","end":"2026-08-06T06:57:27.933564Z","steps":["trace[97358075] 'read index received' (duration: 1.03744432s)","trace[97358075] 'applied index is now lower than readState.Index' (duration: 7.210842ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:27.933867Z","caller":"traceutil/trace.go:171","msg":"trace[1484536373] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"1.044824085s","start":"2026-08-06T06:57:26.889008Z","end":"2026-08-06T06:57:27.933832Z","steps":["trace[1484536373] 'process raft request' (duration: 1.04446794s)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:27.933925Z","caller":"traceutil/trace.go:171","msg":"trace[1666979477] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"1.04374098s","start":"2026-08-06T06:57:26.890161Z","end":"2026-08-06T06:57:27.933902Z","steps":["trace[1666979477] 'process raft request' (duration: 1.043369455s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:27.934047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:26.890148Z","time spent":"1.043839821s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T06:57:27.934068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:26.888983Z","time spent":"1.044971976s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T06:57:27.934275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045324551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-06T06:57:27.934452Z","caller":"traceutil/trace.go:171","msg":"trace[1326643852] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:663; }","duration":"1.045444172s","start":"2026-08-06T06:57:26.888866Z","end":"2026-08-06T06:57:27.934311Z","steps":["trace[1326643852] 'agreement among raft nodes before linearized reading' (duration: 1.045044097s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:27.934488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:26.888844Z","time spent":"1.045636385s","remote":"127.0.0.1:39612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-08-06T06:57:27.934547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042470833s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:27.934591Z","caller":"traceutil/trace.go:171","msg":"trace[640980284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"1.042544724s","start":"2026-08-06T06:57:26.892031Z","end":"2026-08-06T06:57:27.934576Z","steps":["trace[640980284] 'agreement among raft nodes before linearized reading' (duration: 1.042469863s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:27.934585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045454962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18c9250839d8dff7\" ","response":"range_response_count:1 size:774"} {"level":"warn","ts":"2026-08-06T06:57:27.934633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:26.892014Z","time spent":"1.042612946s","remote":"127.0.0.1:39440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-06T06:57:27.934644Z","caller":"traceutil/trace.go:171","msg":"trace[523816457] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18c9250839d8dff7; range_end:; response_count:1; response_revision:663; }","duration":"1.045541814s","start":"2026-08-06T06:57:26.889086Z","end":"2026-08-06T06:57:27.934628Z","steps":["trace[523816457] 'agreement among raft nodes before linearized reading' (duration: 1.045321901s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:27.934689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:26.889081Z","time spent":"1.045598025s","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":796,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18c9250839d8dff7\" "} {"level":"warn","ts":"2026-08-06T06:57:27.934739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.823011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-06T06:57:27.934794Z","caller":"traceutil/trace.go:171","msg":"trace[1082850582] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:663; }","duration":"523.919192ms","start":"2026-08-06T06:57:27.410862Z","end":"2026-08-06T06:57:27.934781Z","steps":["trace[1082850582] 'agreement among raft nodes before linearized reading' (duration: 523.603957ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:27.934843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:27.410837Z","time spent":"523.998672ms","remote":"127.0.0.1:39472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.207\" "} {"level":"info","ts":"2026-08-06T06:57:30.679146Z","caller":"traceutil/trace.go:171","msg":"trace[921444932] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"181.765721ms","start":"2026-08-06T06:57:30.497358Z","end":"2026-08-06T06:57:30.679124Z","steps":["trace[921444932] 'process raft request' (duration: 181.61509ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:30.775477Z","caller":"traceutil/trace.go:171","msg":"trace[1035254786] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"103.938971ms","start":"2026-08-06T06:57:30.671519Z","end":"2026-08-06T06:57:30.775458Z","steps":["trace[1035254786] 'process raft request' (duration: 103.891431ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:30.775542Z","caller":"traceutil/trace.go:171","msg":"trace[1274416295] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"235.717423ms","start":"2026-08-06T06:57:30.539779Z","end":"2026-08-06T06:57:30.775496Z","steps":["trace[1274416295] 'process raft request' (duration: 235.583471ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:30.775478Z","caller":"traceutil/trace.go:171","msg":"trace[2115396177] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"263.079316ms","start":"2026-08-06T06:57:30.512371Z","end":"2026-08-06T06:57:30.775451Z","steps":["trace[2115396177] 'process raft request' (duration: 262.790652ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:31.639175Z","caller":"traceutil/trace.go:171","msg":"trace[113845315] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"735.092797ms","start":"2026-08-06T06:57:30.904054Z","end":"2026-08-06T06:57:31.639147Z","steps":["trace[113845315] 'process raft request' (duration: 670.457788ms)","trace[113845315] 'compare' (duration: 64.350156ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:31.639329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:30.90404Z","time spent":"735.209688ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:57:32.298843Z","caller":"traceutil/trace.go:171","msg":"trace[1023109041] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"156.845373ms","start":"2026-08-06T06:57:32.141973Z","end":"2026-08-06T06:57:32.298818Z","steps":["trace[1023109041] 'process raft request' (duration: 156.486509ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:32.46108Z","caller":"traceutil/trace.go:171","msg":"trace[1995705585] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"153.552342ms","start":"2026-08-06T06:57:32.307501Z","end":"2026-08-06T06:57:32.461053Z","steps":["trace[1995705585] 'process raft request' (duration: 130.147941ms)","trace[1995705585] 'compare' (duration: 23.28795ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:32.509064Z","caller":"traceutil/trace.go:171","msg":"trace[178574901] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"122.97709ms","start":"2026-08-06T06:57:32.386057Z","end":"2026-08-06T06:57:32.509034Z","steps":["trace[178574901] 'process raft request' (duration: 122.798578ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:32.655186Z","caller":"traceutil/trace.go:171","msg":"trace[50994144] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"140.113465ms","start":"2026-08-06T06:57:32.515045Z","end":"2026-08-06T06:57:32.655158Z","steps":["trace[50994144] 'process raft request' (duration: 139.958733ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:32.797323Z","caller":"traceutil/trace.go:171","msg":"trace[1433586519] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"103.983695ms","start":"2026-08-06T06:57:32.693304Z","end":"2026-08-06T06:57:32.797288Z","steps":["trace[1433586519] 'process raft request' (duration: 96.373191ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:32.892242Z","caller":"traceutil/trace.go:171","msg":"trace[1459174704] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:750; }","duration":"189.700692ms","start":"2026-08-06T06:57:32.702515Z","end":"2026-08-06T06:57:32.892216Z","steps":["trace[1459174704] 'read index received' (duration: 38.5249ms)","trace[1459174704] 'applied index is now lower than readState.Index' (duration: 151.174072ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:32.892769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.225929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:32.892898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.417886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:32.892963Z","caller":"traceutil/trace.go:171","msg":"trace[1325583408] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:720; }","duration":"135.502267ms","start":"2026-08-06T06:57:32.75744Z","end":"2026-08-06T06:57:32.892942Z","steps":["trace[1325583408] 'agreement among raft nodes before linearized reading' (duration: 135.427096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:32.893025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.853244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:32.893097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.483629ms","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":"warn","ts":"2026-08-06T06:57:32.893202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.130878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:32.893226Z","caller":"traceutil/trace.go:171","msg":"trace[687156370] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:720; }","duration":"190.170568ms","start":"2026-08-06T06:57:32.703049Z","end":"2026-08-06T06:57:32.893219Z","steps":["trace[687156370] 'agreement among raft nodes before linearized reading' (duration: 190.129847ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:32.893253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.124217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:32.893291Z","caller":"traceutil/trace.go:171","msg":"trace[618958065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:720; }","duration":"169.234928ms","start":"2026-08-06T06:57:32.724047Z","end":"2026-08-06T06:57:32.893282Z","steps":["trace[618958065] 'agreement among raft nodes before linearized reading' (duration: 169.143487ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:32.893406Z","caller":"traceutil/trace.go:171","msg":"trace[2012345874] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:720; }","duration":"189.678552ms","start":"2026-08-06T06:57:32.703532Z","end":"2026-08-06T06:57:32.893211Z","steps":["trace[2012345874] 'agreement among raft nodes before linearized reading' (duration: 189.455198ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:32.893492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.339561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:32.893525Z","caller":"traceutil/trace.go:171","msg":"trace[2078840521] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:720; }","duration":"170.372971ms","start":"2026-08-06T06:57:32.723144Z","end":"2026-08-06T06:57:32.893517Z","steps":["trace[2078840521] 'agreement among raft nodes before linearized reading' (duration: 170.324261ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:32.892902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.181483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:32.89357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.477317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:32.893601Z","caller":"traceutil/trace.go:171","msg":"trace[607652498] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:720; }","duration":"135.930062ms","start":"2026-08-06T06:57:32.757664Z","end":"2026-08-06T06:57:32.893594Z","steps":["trace[607652498] 'agreement among raft nodes before linearized reading' (duration: 135.162532ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:32.893616Z","caller":"traceutil/trace.go:171","msg":"trace[191447610] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:720; }","duration":"135.539518ms","start":"2026-08-06T06:57:32.758061Z","end":"2026-08-06T06:57:32.893601Z","steps":["trace[191447610] 'agreement among raft nodes before linearized reading' (duration: 135.484338ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:32.893156Z","caller":"traceutil/trace.go:171","msg":"trace[1171903546] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:720; }","duration":"170.002827ms","start":"2026-08-06T06:57:32.723111Z","end":"2026-08-06T06:57:32.893114Z","steps":["trace[1171903546] 'agreement among raft nodes before linearized reading' (duration: 169.796903ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:32.892928Z","caller":"traceutil/trace.go:171","msg":"trace[1865408518] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:720; }","duration":"190.431771ms","start":"2026-08-06T06:57:32.702481Z","end":"2026-08-06T06:57:32.892913Z","steps":["trace[1865408518] 'agreement among raft nodes before linearized reading' (duration: 190.131748ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:32.892817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.225297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:32.895422Z","caller":"traceutil/trace.go:171","msg":"trace[1154637346] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:720; }","duration":"192.88374ms","start":"2026-08-06T06:57:32.702523Z","end":"2026-08-06T06:57:32.895407Z","steps":["trace[1154637346] 'agreement among raft nodes before linearized reading' (duration: 190.202697ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:33.021273Z","caller":"traceutil/trace.go:171","msg":"trace[938355152] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"114.672527ms","start":"2026-08-06T06:57:32.906578Z","end":"2026-08-06T06:57:33.02125Z","steps":["trace[938355152] 'process raft request' (duration: 114.488335ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:33.613718Z","caller":"traceutil/trace.go:171","msg":"trace[2112406736] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"106.801101ms","start":"2026-08-06T06:57:33.506893Z","end":"2026-08-06T06:57:33.613694Z","steps":["trace[2112406736] 'process raft request' (duration: 106.029401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.921285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.626273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:33.921316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.214451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.921354Z","caller":"traceutil/trace.go:171","msg":"trace[459173008] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:736; }","duration":"149.729354ms","start":"2026-08-06T06:57:33.771609Z","end":"2026-08-06T06:57:33.921339Z","steps":["trace[459173008] 'agreement among raft nodes before linearized reading' (duration: 149.616732ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:33.921388Z","caller":"traceutil/trace.go:171","msg":"trace[1290016202] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:736; }","duration":"104.333562ms","start":"2026-08-06T06:57:33.817038Z","end":"2026-08-06T06:57:33.921372Z","steps":["trace[1290016202] 'agreement among raft nodes before linearized reading' (duration: 104.19911ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.921625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.312941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.92166Z","caller":"traceutil/trace.go:171","msg":"trace[1829421789] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:736; }","duration":"150.396551ms","start":"2026-08-06T06:57:33.771253Z","end":"2026-08-06T06:57:33.92165Z","steps":["trace[1829421789] 'agreement among raft nodes before linearized reading' (duration: 150.32548ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.921652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.692834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:33.921767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.376343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:33.921781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.437064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:33.921799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.537783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.921813Z","caller":"traceutil/trace.go:171","msg":"trace[381281651] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:736; }","duration":"121.451074ms","start":"2026-08-06T06:57:33.800352Z","end":"2026-08-06T06:57:33.921803Z","steps":["trace[381281651] 'agreement among raft nodes before linearized reading' (duration: 121.380083ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:33.921818Z","caller":"traceutil/trace.go:171","msg":"trace[970531681] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:736; }","duration":"121.477494ms","start":"2026-08-06T06:57:33.80033Z","end":"2026-08-06T06:57:33.921808Z","steps":["trace[970531681] 'agreement among raft nodes before linearized reading' (duration: 121.418523ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:33.921824Z","caller":"traceutil/trace.go:171","msg":"trace[679900394] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:736; }","duration":"150.611734ms","start":"2026-08-06T06:57:33.771205Z","end":"2026-08-06T06:57:33.921817Z","steps":["trace[679900394] 'agreement among raft nodes before linearized reading' (duration: 150.571294ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:33.921854Z","caller":"traceutil/trace.go:171","msg":"trace[1224985706] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:736; }","duration":"103.868405ms","start":"2026-08-06T06:57:33.817862Z","end":"2026-08-06T06:57:33.92173Z","steps":["trace[1224985706] 'agreement among raft nodes before linearized reading' (duration: 103.616462ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.92191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.262848ms","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-06T06:57:33.921596Z","caller":"traceutil/trace.go:171","msg":"trace[1757884364] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"153.423138ms","start":"2026-08-06T06:57:33.768069Z","end":"2026-08-06T06:57:33.921493Z","steps":["trace[1757884364] 'process raft request' (duration: 152.992672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.921993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.011914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.922019Z","caller":"traceutil/trace.go:171","msg":"trace[1848674200] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:736; }","duration":"170.069005ms","start":"2026-08-06T06:57:33.751943Z","end":"2026-08-06T06:57:33.922013Z","steps":["trace[1848674200] 'agreement among raft nodes before linearized reading' (duration: 170.032324ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.922098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.249757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.922135Z","caller":"traceutil/trace.go:171","msg":"trace[1483397280] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:736; }","duration":"170.302118ms","start":"2026-08-06T06:57:33.751825Z","end":"2026-08-06T06:57:33.922127Z","steps":["trace[1483397280] 'agreement among raft nodes before linearized reading' (duration: 170.241567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.922153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.067995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.922173Z","caller":"traceutil/trace.go:171","msg":"trace[2035320200] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:736; }","duration":"183.102496ms","start":"2026-08-06T06:57:33.739065Z","end":"2026-08-06T06:57:33.922167Z","steps":["trace[2035320200] 'agreement among raft nodes before linearized reading' (duration: 183.065765ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.922061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.556695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.922245Z","caller":"traceutil/trace.go:171","msg":"trace[197624911] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:736; }","duration":"121.838498ms","start":"2026-08-06T06:57:33.800388Z","end":"2026-08-06T06:57:33.922227Z","steps":["trace[197624911] 'agreement among raft nodes before linearized reading' (duration: 121.279372ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.922271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.173282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.921932Z","caller":"traceutil/trace.go:171","msg":"trace[2061183761] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:736; }","duration":"183.299729ms","start":"2026-08-06T06:57:33.738626Z","end":"2026-08-06T06:57:33.921926Z","steps":["trace[2061183761] 'agreement among raft nodes before linearized reading' (duration: 183.264798ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:33.922397Z","caller":"traceutil/trace.go:171","msg":"trace[665401967] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:736; }","duration":"105.424395ms","start":"2026-08-06T06:57:33.816948Z","end":"2026-08-06T06:57:33.922372Z","steps":["trace[665401967] 'agreement among raft nodes before linearized reading' (duration: 105.180072ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.921963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.515818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:33.922799Z","caller":"traceutil/trace.go:171","msg":"trace[1758677087] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:736; }","duration":"170.356408ms","start":"2026-08-06T06:57:33.752426Z","end":"2026-08-06T06:57:33.922782Z","steps":["trace[1758677087] 'agreement among raft nodes before linearized reading' (duration: 169.519298ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:33.923232Z","caller":"traceutil/trace.go:171","msg":"trace[1975389862] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"102.458208ms","start":"2026-08-06T06:57:33.820753Z","end":"2026-08-06T06:57:33.923211Z","steps":["trace[1975389862] 'process raft request' (duration: 100.413533ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:33.923253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.591662ms","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-06T06:57:33.923378Z","caller":"traceutil/trace.go:171","msg":"trace[1160623860] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:736; }","duration":"145.735984ms","start":"2026-08-06T06:57:33.777629Z","end":"2026-08-06T06:57:33.923365Z","steps":["trace[1160623860] 'agreement among raft nodes before linearized reading' (duration: 145.538932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:34.064914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.867234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:34.065024Z","caller":"traceutil/trace.go:171","msg":"trace[648544415] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:736; }","duration":"130.032176ms","start":"2026-08-06T06:57:33.934968Z","end":"2026-08-06T06:57:34.065Z","steps":["trace[648544415] 'range keys from in-memory index tree' (duration: 129.799133ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:34.065074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.874163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:34.065208Z","caller":"traceutil/trace.go:171","msg":"trace[900825622] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"129.379347ms","start":"2026-08-06T06:57:33.935805Z","end":"2026-08-06T06:57:34.065185Z","steps":["trace[900825622] 'process raft request' (duration: 78.954477ms)","trace[900825622] 'compare' (duration: 49.833963ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:34.065161Z","caller":"traceutil/trace.go:171","msg":"trace[219556010] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:736; }","duration":"129.980535ms","start":"2026-08-06T06:57:33.935162Z","end":"2026-08-06T06:57:34.065142Z","steps":["trace[219556010] 'count revisions from in-memory index tree' (duration: 129.781681ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:34.065998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.748172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:34.06625Z","caller":"traceutil/trace.go:171","msg":"trace[83215921] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:736; }","duration":"130.936276ms","start":"2026-08-06T06:57:33.935219Z","end":"2026-08-06T06:57:34.066156Z","steps":["trace[83215921] 'range keys from in-memory index tree' (duration: 129.723302ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:34.144946Z","caller":"traceutil/trace.go:171","msg":"trace[1974986667] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:769; }","duration":"156.842711ms","start":"2026-08-06T06:57:33.988082Z","end":"2026-08-06T06:57:34.144925Z","steps":["trace[1974986667] 'read index received' (duration: 26.833212ms)","trace[1974986667] 'applied index is now lower than readState.Index' (duration: 130.008839ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:34.145053Z","caller":"traceutil/trace.go:171","msg":"trace[1895581579] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"206.941551ms","start":"2026-08-06T06:57:33.938069Z","end":"2026-08-06T06:57:34.145011Z","steps":["trace[1895581579] 'process raft request' (duration: 206.772179ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:34.145369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.022113ms","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-06T06:57:34.145401Z","caller":"traceutil/trace.go:171","msg":"trace[140268688] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:738; }","duration":"157.355868ms","start":"2026-08-06T06:57:33.988037Z","end":"2026-08-06T06:57:34.145393Z","steps":["trace[140268688] 'agreement among raft nodes before linearized reading' (duration: 156.982893ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:34.153687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.412962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-06T06:57:34.153687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.688266ms","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-06T06:57:34.153748Z","caller":"traceutil/trace.go:171","msg":"trace[570336515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:739; }","duration":"163.497173ms","start":"2026-08-06T06:57:33.990238Z","end":"2026-08-06T06:57:34.153735Z","steps":["trace[570336515] 'agreement among raft nodes before linearized reading' (duration: 163.33555ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:34.153756Z","caller":"traceutil/trace.go:171","msg":"trace[1629635924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:739; }","duration":"163.784897ms","start":"2026-08-06T06:57:33.989958Z","end":"2026-08-06T06:57:34.153743Z","steps":["trace[1629635924] 'agreement among raft nodes before linearized reading' (duration: 163.587793ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:34.280414Z","caller":"traceutil/trace.go:171","msg":"trace[1698403421] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"123.413878ms","start":"2026-08-06T06:57:34.156935Z","end":"2026-08-06T06:57:34.280348Z","steps":["trace[1698403421] 'process raft request' (duration: 123.075094ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:34.366417Z","caller":"traceutil/trace.go:171","msg":"trace[1644390495] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"208.852598ms","start":"2026-08-06T06:57:34.157538Z","end":"2026-08-06T06:57:34.36639Z","steps":["trace[1644390495] 'process raft request' (duration: 208.677726ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:34.366668Z","caller":"traceutil/trace.go:171","msg":"trace[152584552] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"207.658475ms","start":"2026-08-06T06:57:34.158983Z","end":"2026-08-06T06:57:34.366642Z","steps":["trace[152584552] 'process raft request' (duration: 207.365261ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:34.366667Z","caller":"traceutil/trace.go:171","msg":"trace[1989160029] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:773; }","duration":"162.181565ms","start":"2026-08-06T06:57:34.204451Z","end":"2026-08-06T06:57:34.366632Z","steps":["trace[1989160029] 'read index received' (duration: 75.644801ms)","trace[1989160029] 'applied index is now lower than readState.Index' (duration: 86.534544ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:34.366823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.352667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T06:57:34.366877Z","caller":"traceutil/trace.go:171","msg":"trace[1919834534] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:743; }","duration":"162.477049ms","start":"2026-08-06T06:57:34.204384Z","end":"2026-08-06T06:57:34.366861Z","steps":["trace[1919834534] 'agreement among raft nodes before linearized reading' (duration: 162.336887ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:34.770713Z","caller":"traceutil/trace.go:171","msg":"trace[470939795] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:776; }","duration":"403.846177ms","start":"2026-08-06T06:57:34.366832Z","end":"2026-08-06T06:57:34.770678Z","steps":["trace[470939795] 'read index received' (duration: 381.971118ms)","trace[470939795] 'applied index is now lower than readState.Index' (duration: 21.873079ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:34.770868Z","caller":"traceutil/trace.go:171","msg":"trace[1532034422] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"479.570209ms","start":"2026-08-06T06:57:34.291261Z","end":"2026-08-06T06:57:34.770831Z","steps":["trace[1532034422] 'process raft request' (duration: 457.69752ms)","trace[1532034422] 'compare' (duration: 21.440714ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:34.77099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:34.291233Z","time spent":"479.69589ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T06:57:34.771073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.36445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-08-06T06:57:34.77112Z","caller":"traceutil/trace.go:171","msg":"trace[1668071468] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:744; }","duration":"467.484311ms","start":"2026-08-06T06:57:34.303623Z","end":"2026-08-06T06:57:34.771107Z","steps":["trace[1668071468] 'agreement among raft nodes before linearized reading' (duration: 467.204777ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:34.771169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:34.303599Z","time spent":"467.560351ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5199,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"info","ts":"2026-08-06T06:57:34.783818Z","caller":"traceutil/trace.go:171","msg":"trace[373710363] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"411.805945ms","start":"2026-08-06T06:57:34.371985Z","end":"2026-08-06T06:57:34.783791Z","steps":["trace[373710363] 'process raft request' (duration: 411.365229ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:34.783936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:34.371961Z","time spent":"411.921377ms","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T06:57:34.786196Z","caller":"traceutil/trace.go:171","msg":"trace[451050187] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"254.712983ms","start":"2026-08-06T06:57:34.531456Z","end":"2026-08-06T06:57:34.786169Z","steps":["trace[451050187] 'process raft request' (duration: 254.537211ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:34.78621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.970404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T06:57:34.78645Z","caller":"traceutil/trace.go:171","msg":"trace[1938742757] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:746; }","duration":"228.279067ms","start":"2026-08-06T06:57:34.558149Z","end":"2026-08-06T06:57:34.786428Z","steps":["trace[1938742757] 'agreement among raft nodes before linearized reading' (duration: 227.967784ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:34.928555Z","caller":"traceutil/trace.go:171","msg":"trace[2063972987] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"127.918303ms","start":"2026-08-06T06:57:34.8006Z","end":"2026-08-06T06:57:34.928518Z","steps":["trace[2063972987] 'process raft request' (duration: 127.60625ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:35.054824Z","caller":"traceutil/trace.go:171","msg":"trace[1503738850] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"119.956531ms","start":"2026-08-06T06:57:34.93481Z","end":"2026-08-06T06:57:35.054767Z","steps":["trace[1503738850] 'process raft request' (duration: 64.419152ms)","trace[1503738850] 'compare' (duration: 55.182435ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:35.52555Z","caller":"traceutil/trace.go:171","msg":"trace[477824648] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"221.646541ms","start":"2026-08-06T06:57:35.303871Z","end":"2026-08-06T06:57:35.525517Z","steps":["trace[477824648] 'read index received' (duration: 162.302905ms)","trace[477824648] 'applied index is now lower than readState.Index' (duration: 59.342486ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:35.525911Z","caller":"traceutil/trace.go:171","msg":"trace[550246170] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"231.512251ms","start":"2026-08-06T06:57:35.29435Z","end":"2026-08-06T06:57:35.525863Z","steps":["trace[550246170] 'process raft request' (duration: 171.989443ms)","trace[550246170] 'compare' (duration: 58.939551ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:35.526014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.108886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-08-06T06:57:35.52608Z","caller":"traceutil/trace.go:171","msg":"trace[1584317558] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:753; }","duration":"222.249057ms","start":"2026-08-06T06:57:35.303818Z","end":"2026-08-06T06:57:35.526068Z","steps":["trace[1584317558] 'agreement among raft nodes before linearized reading' (duration: 221.948764ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:35.895638Z","caller":"traceutil/trace.go:171","msg":"trace[881885031] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"147.877667ms","start":"2026-08-06T06:57:35.747724Z","end":"2026-08-06T06:57:35.895602Z","steps":["trace[881885031] 'process raft request' (duration: 146.881686ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:38.252219Z","caller":"traceutil/trace.go:171","msg":"trace[1930706694] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"141.815404ms","start":"2026-08-06T06:57:38.110378Z","end":"2026-08-06T06:57:38.252193Z","steps":["trace[1930706694] 'process raft request' (duration: 141.624032ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:38.252214Z","caller":"traceutil/trace.go:171","msg":"trace[1851671057] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:803; }","duration":"109.969412ms","start":"2026-08-06T06:57:38.142215Z","end":"2026-08-06T06:57:38.252185Z","steps":["trace[1851671057] 'read index received' (duration: 109.699918ms)","trace[1851671057] 'applied index is now lower than readState.Index' (duration: 268.544µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:38.252896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.65725ms","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-06T06:57:38.252969Z","caller":"traceutil/trace.go:171","msg":"trace[493552165] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:770; }","duration":"110.777571ms","start":"2026-08-06T06:57:38.142174Z","end":"2026-08-06T06:57:38.252952Z","steps":["trace[493552165] 'agreement among raft nodes before linearized reading' (duration: 110.152734ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:38.545565Z","caller":"traceutil/trace.go:171","msg":"trace[994016885] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:806; }","duration":"129.175602ms","start":"2026-08-06T06:57:38.416364Z","end":"2026-08-06T06:57:38.54554Z","steps":["trace[994016885] 'read index received' (duration: 16.214325ms)","trace[994016885] 'applied index is now lower than readState.Index' (duration: 112.960467ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:38.545571Z","caller":"traceutil/trace.go:171","msg":"trace[1535605869] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"132.967617ms","start":"2026-08-06T06:57:38.412576Z","end":"2026-08-06T06:57:38.545544Z","steps":["trace[1535605869] 'process raft request' (duration: 132.287789ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:38.545714Z","caller":"traceutil/trace.go:171","msg":"trace[627645627] transaction","detail":"{read_only:false; number_of_response:0; response_revision:774; }","duration":"132.161187ms","start":"2026-08-06T06:57:38.413441Z","end":"2026-08-06T06:57:38.545602Z","steps":["trace[627645627] 'process raft request' (duration: 132.063466ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:38.54587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.492985ms","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-06T06:57:38.545936Z","caller":"traceutil/trace.go:171","msg":"trace[13021761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:774; }","duration":"129.618217ms","start":"2026-08-06T06:57:38.416304Z","end":"2026-08-06T06:57:38.545922Z","steps":["trace[13021761] 'agreement among raft nodes before linearized reading' (duration: 129.342134ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:43.895267Z","caller":"traceutil/trace.go:171","msg":"trace[1398362600] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"112.963829ms","start":"2026-08-06T06:57:43.782278Z","end":"2026-08-06T06:57:43.895241Z","steps":["trace[1398362600] 'process raft request' (duration: 112.802757ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:47.54808Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721274932980364771,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T06:57:48.049828Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721274932980364771,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T06:57:48.358049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.892293659s","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-06T06:57:48.358235Z","caller":"traceutil/trace.go:171","msg":"trace[1473793820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:832; }","duration":"1.892531832s","start":"2026-08-06T06:57:46.465669Z","end":"2026-08-06T06:57:48.358201Z","steps":["trace[1473793820] 'range keys from in-memory index tree' (duration: 1.892011526s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.3583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:46.465642Z","time spent":"1.892642073s","remote":"127.0.0.1:39698","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-06T06:57:48.358632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.729621271s","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-06T06:57:48.358746Z","caller":"traceutil/trace.go:171","msg":"trace[2107756487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:832; }","duration":"1.729792222s","start":"2026-08-06T06:57:46.628928Z","end":"2026-08-06T06:57:48.35872Z","steps":["trace[2107756487] 'range keys from in-memory index tree' (duration: 1.729242887s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.358806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:46.628894Z","time spent":"1.729899434s","remote":"127.0.0.1:39698","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-06T06:57:48.358821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.052842444s","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-06T06:57:48.358922Z","caller":"traceutil/trace.go:171","msg":"trace[807227902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:832; }","duration":"2.053016596s","start":"2026-08-06T06:57:46.305883Z","end":"2026-08-06T06:57:48.358899Z","steps":["trace[807227902] 'range keys from in-memory index tree' (duration: 2.052641212s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.358975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:46.305868Z","time spent":"2.053097467s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-06T06:57:48.35919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.044028073s","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-06T06:57:48.359229Z","caller":"traceutil/trace.go:171","msg":"trace[773274557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:832; }","duration":"2.044097324s","start":"2026-08-06T06:57:46.315121Z","end":"2026-08-06T06:57:48.359218Z","steps":["trace[773274557] 'range keys from in-memory index tree' (duration: 2.043901302s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.35926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:46.315106Z","time spent":"2.044147505s","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T06:57:48.359319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.932453682s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T06:57:48.359361Z","caller":"traceutil/trace.go:171","msg":"trace[1941228456] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:832; }","duration":"1.932530103s","start":"2026-08-06T06:57:46.426819Z","end":"2026-08-06T06:57:48.35935Z","steps":["trace[1941228456] 'count revisions from in-memory index tree' (duration: 1.932370051s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.359392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:46.426743Z","time spent":"1.932640874s","remote":"127.0.0.1:39682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-08-06T06:57:48.358155Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.585468235s","expected-duration":"1s"} {"level":"info","ts":"2026-08-06T06:57:48.360474Z","caller":"traceutil/trace.go:171","msg":"trace[723392193] linearizableReadLoop","detail":"{readStateIndex:869; appliedIndex:868; }","duration":"1.312984966s","start":"2026-08-06T06:57:47.047457Z","end":"2026-08-06T06:57:48.360442Z","steps":["trace[723392193] 'read index received' (duration: 1.312585462s)","trace[723392193] 'applied index is now lower than readState.Index' (duration: 398.044µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:57:48.360753Z","caller":"traceutil/trace.go:171","msg":"trace[1833985273] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"1.58864711s","start":"2026-08-06T06:57:46.771981Z","end":"2026-08-06T06:57:48.360628Z","steps":["trace[1833985273] 'process raft request' (duration: 1.588236506s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.361033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.313582743s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T06:57:48.361074Z","caller":"traceutil/trace.go:171","msg":"trace[995936264] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:833; }","duration":"1.313664984s","start":"2026-08-06T06:57:47.047398Z","end":"2026-08-06T06:57:48.361063Z","steps":["trace[995936264] 'agreement among raft nodes before linearized reading' (duration: 1.313607264s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.361099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:47.047375Z","time spent":"1.313718124s","remote":"127.0.0.1:39916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-06T06:57:48.361176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:46.771952Z","time spent":"1.588938464s","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T06:57:48.361245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.319821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:48.361267Z","caller":"traceutil/trace.go:171","msg":"trace[1964258556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:833; }","duration":"873.393122ms","start":"2026-08-06T06:57:47.487868Z","end":"2026-08-06T06:57:48.361262Z","steps":["trace[1964258556] 'agreement among raft nodes before linearized reading' (duration: 873.354972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.361291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:47.487838Z","time spent":"873.450463ms","remote":"127.0.0.1:39440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-06T06:57:48.361356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.370092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:57:48.361429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.827716ms","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-06T06:57:48.361508Z","caller":"traceutil/trace.go:171","msg":"trace[809553514] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:833; }","duration":"587.658234ms","start":"2026-08-06T06:57:47.773797Z","end":"2026-08-06T06:57:48.361455Z","steps":["trace[809553514] 'agreement among raft nodes before linearized reading' (duration: 587.23711ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.361598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:47.773758Z","time spent":"587.826337ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-06T06:57:48.360763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.528181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-06T06:57:48.361734Z","caller":"traceutil/trace.go:171","msg":"trace[1319662057] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:833; }","duration":"956.531971ms","start":"2026-08-06T06:57:47.405173Z","end":"2026-08-06T06:57:48.361705Z","steps":["trace[1319662057] 'agreement among raft nodes before linearized reading' (duration: 955.51451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.361823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:47.405132Z","time spent":"956.671243ms","remote":"127.0.0.1:39472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.207\" "} {"level":"info","ts":"2026-08-06T06:57:48.361557Z","caller":"traceutil/trace.go:171","msg":"trace[395394144] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:833; }","duration":"454.039078ms","start":"2026-08-06T06:57:47.907504Z","end":"2026-08-06T06:57:48.361543Z","steps":["trace[395394144] 'agreement among raft nodes before linearized reading' (duration: 453.649824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:57:48.362415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:57:47.90748Z","time spent":"454.922419ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-06T06:57:54.119347Z","caller":"traceutil/trace.go:171","msg":"trace[1965003146] linearizableReadLoop","detail":"{readStateIndex:929; appliedIndex:928; }","duration":"106.818958ms","start":"2026-08-06T06:57:54.012495Z","end":"2026-08-06T06:57:54.119314Z","steps":["trace[1965003146] 'read index received' (duration: 106.600515ms)","trace[1965003146] 'applied index is now lower than readState.Index' (duration: 217.603µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:57:54.119545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.00773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:57:54.119599Z","caller":"traceutil/trace.go:171","msg":"trace[651284918] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:0; response_revision:891; }","duration":"107.131181ms","start":"2026-08-06T06:57:54.012454Z","end":"2026-08-06T06:57:54.119585Z","steps":["trace[651284918] 'agreement among raft nodes before linearized reading' (duration: 106.99357ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:57:54.119968Z","caller":"traceutil/trace.go:171","msg":"trace[263406230] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"181.809139ms","start":"2026-08-06T06:57:53.938022Z","end":"2026-08-06T06:57:54.119831Z","steps":["trace[263406230] 'process raft request' (duration: 181.148632ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:00.402536Z","caller":"traceutil/trace.go:171","msg":"trace[877664729] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"207.886979ms","start":"2026-08-06T06:58:00.19462Z","end":"2026-08-06T06:58:00.402507Z","steps":["trace[877664729] 'process raft request' (duration: 207.672957ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:00.739695Z","caller":"traceutil/trace.go:171","msg":"trace[1490731947] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1019; }","duration":"307.153193ms","start":"2026-08-06T06:58:00.432512Z","end":"2026-08-06T06:58:00.739665Z","steps":["trace[1490731947] 'read index received' (duration: 304.395283ms)","trace[1490731947] 'applied index is now lower than readState.Index' (duration: 2.75717ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:58:00.739825Z","caller":"traceutil/trace.go:171","msg":"trace[1779194546] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"530.81504ms","start":"2026-08-06T06:58:00.209Z","end":"2026-08-06T06:58:00.739815Z","steps":["trace[1779194546] 'process raft request' (duration: 527.891528ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:00.74006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:58:00.208969Z","time spent":"530.885341ms","remote":"127.0.0.1:35134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1671,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T06:58:00.740069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.539917ms","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-06T06:58:00.740156Z","caller":"traceutil/trace.go:171","msg":"trace[1804416444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:981; }","duration":"307.665199ms","start":"2026-08-06T06:58:00.432469Z","end":"2026-08-06T06:58:00.740134Z","steps":["trace[1804416444] 'agreement among raft nodes before linearized reading' (duration: 307.376776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:00.740198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:58:00.432452Z","time spent":"307.737979ms","remote":"127.0.0.1:39698","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-06T06:58:00.752746Z","caller":"traceutil/trace.go:171","msg":"trace[1258273446] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"272.208379ms","start":"2026-08-06T06:58:00.480519Z","end":"2026-08-06T06:58:00.752727Z","steps":["trace[1258273446] 'process raft request' (duration: 272.089778ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:00.752987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.352058ms","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-06T06:58:00.753089Z","caller":"traceutil/trace.go:171","msg":"trace[1804033390] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:982; }","duration":"310.467669ms","start":"2026-08-06T06:58:00.442598Z","end":"2026-08-06T06:58:00.753066Z","steps":["trace[1804033390] 'agreement among raft nodes before linearized reading' (duration: 310.165496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:00.753134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.514987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T06:58:00.753062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.592956ms","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-06T06:58:00.753199Z","caller":"traceutil/trace.go:171","msg":"trace[480519547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"265.615818ms","start":"2026-08-06T06:58:00.487572Z","end":"2026-08-06T06:58:00.753188Z","steps":["trace[480519547] 'agreement among raft nodes before linearized reading' (duration: 265.498187ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:00.753151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.154123ms","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-06T06:58:00.753321Z","caller":"traceutil/trace.go:171","msg":"trace[451494104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:982; }","duration":"293.455346ms","start":"2026-08-06T06:58:00.459849Z","end":"2026-08-06T06:58:00.753304Z","steps":["trace[451494104] 'agreement among raft nodes before linearized reading' (duration: 293.096103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:00.753144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:58:00.44256Z","time spent":"310.57446ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-06T06:58:00.753352Z","caller":"traceutil/trace.go:171","msg":"trace[885039429] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:982; }","duration":"291.864748ms","start":"2026-08-06T06:58:00.461423Z","end":"2026-08-06T06:58:00.753288Z","steps":["trace[885039429] 'agreement among raft nodes before linearized reading' (duration: 291.348563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:00.752987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.562966ms","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-06T06:58:00.753504Z","caller":"traceutil/trace.go:171","msg":"trace[1847988964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:982; }","duration":"292.125521ms","start":"2026-08-06T06:58:00.46136Z","end":"2026-08-06T06:58:00.753486Z","steps":["trace[1847988964] 'agreement among raft nodes before linearized reading' (duration: 291.474625ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:00.884756Z","caller":"traceutil/trace.go:171","msg":"trace[1886763441] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1021; }","duration":"129.570729ms","start":"2026-08-06T06:58:00.755151Z","end":"2026-08-06T06:58:00.884722Z","steps":["trace[1886763441] 'read index received' (duration: 120.528523ms)","trace[1886763441] 'applied index is now lower than readState.Index' (duration: 9.034196ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:58:00.88478Z","caller":"traceutil/trace.go:171","msg":"trace[1227721085] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"137.06103ms","start":"2026-08-06T06:58:00.747688Z","end":"2026-08-06T06:58:00.884749Z","steps":["trace[1227721085] 'process raft request' (duration: 136.836037ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:00.884805Z","caller":"traceutil/trace.go:171","msg":"trace[255197909] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"126.653838ms","start":"2026-08-06T06:58:00.758122Z","end":"2026-08-06T06:58:00.884776Z","steps":["trace[255197909] 'process raft request' (duration: 126.601597ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:00.884915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.743171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T06:58:00.88494Z","caller":"traceutil/trace.go:171","msg":"trace[1874372467] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:988; }","duration":"129.802873ms","start":"2026-08-06T06:58:00.755129Z","end":"2026-08-06T06:58:00.884932Z","steps":["trace[1874372467] 'agreement among raft nodes before linearized reading' (duration: 129.702722ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:00.884993Z","caller":"traceutil/trace.go:171","msg":"trace[2065199943] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"127.843471ms","start":"2026-08-06T06:58:00.75714Z","end":"2026-08-06T06:58:00.884983Z","steps":["trace[2065199943] 'process raft request' (duration: 127.446247ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:00.885066Z","caller":"traceutil/trace.go:171","msg":"trace[1566955502] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"140.84831ms","start":"2026-08-06T06:58:00.744201Z","end":"2026-08-06T06:58:00.88505Z","steps":["trace[1566955502] 'process raft request' (duration: 131.51046ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:00.885192Z","caller":"traceutil/trace.go:171","msg":"trace[1460659761] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"127.170073ms","start":"2026-08-06T06:58:00.758011Z","end":"2026-08-06T06:58:00.885181Z","steps":["trace[1460659761] 'process raft request' (duration: 126.612037ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:00.885226Z","caller":"traceutil/trace.go:171","msg":"trace[931910355] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"127.136363ms","start":"2026-08-06T06:58:00.758082Z","end":"2026-08-06T06:58:00.885218Z","steps":["trace[931910355] 'process raft request' (duration: 126.606257ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:01.528629Z","caller":"traceutil/trace.go:171","msg":"trace[358484997] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"255.73186ms","start":"2026-08-06T06:58:01.272878Z","end":"2026-08-06T06:58:01.52861Z","steps":["trace[358484997] 'process raft request' (duration: 255.637349ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:02.074321Z","caller":"traceutil/trace.go:171","msg":"trace[2124896721] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"170.578036ms","start":"2026-08-06T06:58:01.903712Z","end":"2026-08-06T06:58:02.07429Z","steps":["trace[2124896721] 'process raft request' (duration: 170.400125ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:09.041896Z","caller":"traceutil/trace.go:171","msg":"trace[1824973778] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1068; }","duration":"104.958525ms","start":"2026-08-06T06:58:08.936896Z","end":"2026-08-06T06:58:09.041855Z","steps":["trace[1824973778] 'read index received' (duration: 104.747593ms)","trace[1824973778] 'applied index is now lower than readState.Index' (duration: 210.092µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:58:09.042186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.266558ms","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-06T06:58:09.042294Z","caller":"traceutil/trace.go:171","msg":"trace[1784333957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1028; }","duration":"105.397969ms","start":"2026-08-06T06:58:08.936866Z","end":"2026-08-06T06:58:09.042264Z","steps":["trace[1784333957] 'agreement among raft nodes before linearized reading' (duration: 105.117577ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:09.042804Z","caller":"traceutil/trace.go:171","msg":"trace[1854635105] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"106.247038ms","start":"2026-08-06T06:58:08.936508Z","end":"2026-08-06T06:58:09.042755Z","steps":["trace[1854635105] 'process raft request' (duration: 105.201028ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:19.456989Z","caller":"traceutil/trace.go:171","msg":"trace[1806315451] linearizableReadLoop","detail":"{readStateIndex:1104; appliedIndex:1103; }","duration":"258.563574ms","start":"2026-08-06T06:58:19.198407Z","end":"2026-08-06T06:58:19.45697Z","steps":["trace[1806315451] 'read index received' (duration: 258.360411ms)","trace[1806315451] 'applied index is now lower than readState.Index' (duration: 202.403µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:58:19.45707Z","caller":"traceutil/trace.go:171","msg":"trace[684563819] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"294.647281ms","start":"2026-08-06T06:58:19.162386Z","end":"2026-08-06T06:58:19.457034Z","steps":["trace[684563819] 'process raft request' (duration: 294.465628ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:19.457173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.753096ms","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-06T06:58:19.457195Z","caller":"traceutil/trace.go:171","msg":"trace[712525166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1061; }","duration":"258.829447ms","start":"2026-08-06T06:58:19.198358Z","end":"2026-08-06T06:58:19.457188Z","steps":["trace[712525166] 'agreement among raft nodes before linearized reading' (duration: 258.716326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:19.457395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.970037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-08-06T06:58:19.457395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.612095ms","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-06T06:58:19.457446Z","caller":"traceutil/trace.go:171","msg":"trace[1237968189] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1061; }","duration":"255.046679ms","start":"2026-08-06T06:58:19.202384Z","end":"2026-08-06T06:58:19.457431Z","steps":["trace[1237968189] 'agreement among raft nodes before linearized reading' (duration: 254.888057ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:19.457451Z","caller":"traceutil/trace.go:171","msg":"trace[1726673567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"250.689666ms","start":"2026-08-06T06:58:19.206748Z","end":"2026-08-06T06:58:19.457437Z","steps":["trace[1726673567] 'agreement among raft nodes before linearized reading' (duration: 250.538735ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:19.457638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.861408ms","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-06T06:58:19.457699Z","caller":"traceutil/trace.go:171","msg":"trace[1047615456] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1061; }","duration":"253.938668ms","start":"2026-08-06T06:58:19.20374Z","end":"2026-08-06T06:58:19.457679Z","steps":["trace[1047615456] 'agreement among raft nodes before linearized reading' (duration: 253.751527ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:19.635369Z","caller":"traceutil/trace.go:171","msg":"trace[145549213] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"173.5256ms","start":"2026-08-06T06:58:19.461823Z","end":"2026-08-06T06:58:19.635348Z","steps":["trace[145549213] 'process raft request' (duration: 173.106016ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:19.63541Z","caller":"traceutil/trace.go:171","msg":"trace[668429826] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"172.860042ms","start":"2026-08-06T06:58:19.462526Z","end":"2026-08-06T06:58:19.635386Z","steps":["trace[668429826] 'process raft request' (duration: 172.786032ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:19.635689Z","caller":"traceutil/trace.go:171","msg":"trace[1049058881] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"173.784482ms","start":"2026-08-06T06:58:19.461896Z","end":"2026-08-06T06:58:19.635681Z","steps":["trace[1049058881] 'process raft request' (duration: 173.333638ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:27.836225Z","caller":"traceutil/trace.go:171","msg":"trace[590568215] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"161.308345ms","start":"2026-08-06T06:58:27.674895Z","end":"2026-08-06T06:58:27.836203Z","steps":["trace[590568215] 'process raft request' (duration: 114.236842ms)","trace[590568215] 'compare' (duration: 46.953092ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:58:27.836598Z","caller":"traceutil/trace.go:171","msg":"trace[1660245067] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"159.622879ms","start":"2026-08-06T06:58:27.676955Z","end":"2026-08-06T06:58:27.836577Z","steps":["trace[1660245067] 'process raft request' (duration: 159.224335ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:27.836623Z","caller":"traceutil/trace.go:171","msg":"trace[611786385] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"159.044133ms","start":"2026-08-06T06:58:27.677548Z","end":"2026-08-06T06:58:27.836592Z","steps":["trace[611786385] 'process raft request' (duration: 158.885372ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:29.019332Z","caller":"traceutil/trace.go:171","msg":"trace[2027709959] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"442.43804ms","start":"2026-08-06T06:58:28.576866Z","end":"2026-08-06T06:58:29.019304Z","steps":["trace[2027709959] 'process raft request' (duration: 442.294349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:29.019637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:58:28.576825Z","time spent":"442.577571ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T06:58:29.778678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.53589ms","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-06T06:58:29.778737Z","caller":"traceutil/trace.go:171","msg":"trace[683510644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1098; }","duration":"130.632231ms","start":"2026-08-06T06:58:29.648091Z","end":"2026-08-06T06:58:29.778723Z","steps":["trace[683510644] 'range keys from in-memory index tree' (duration: 130.407639ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:29.95484Z","caller":"traceutil/trace.go:171","msg":"trace[799122157] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"114.531347ms","start":"2026-08-06T06:58:29.840291Z","end":"2026-08-06T06:58:29.954822Z","steps":["trace[799122157] 'read index received' (duration: 114.421776ms)","trace[799122157] 'applied index is now lower than readState.Index' (duration: 108.661µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:58:29.954916Z","caller":"traceutil/trace.go:171","msg":"trace[242629499] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"172.733984ms","start":"2026-08-06T06:58:29.782175Z","end":"2026-08-06T06:58:29.954909Z","steps":["trace[242629499] 'process raft request' (duration: 172.541043ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:29.955063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.76364ms","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-06T06:58:29.955085Z","caller":"traceutil/trace.go:171","msg":"trace[1599743239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1099; }","duration":"114.83682ms","start":"2026-08-06T06:58:29.840241Z","end":"2026-08-06T06:58:29.955078Z","steps":["trace[1599743239] 'agreement among raft nodes before linearized reading' (duration: 114.754349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:29.955152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.81893ms","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-06T06:58:29.955166Z","caller":"traceutil/trace.go:171","msg":"trace[1790918622] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1099; }","duration":"113.863431ms","start":"2026-08-06T06:58:29.841299Z","end":"2026-08-06T06:58:29.955163Z","steps":["trace[1790918622] 'agreement among raft nodes before linearized reading' (duration: 113.82398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:29.955228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.634388ms","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-06T06:58:29.955291Z","caller":"traceutil/trace.go:171","msg":"trace[76892858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1099; }","duration":"114.695799ms","start":"2026-08-06T06:58:29.840574Z","end":"2026-08-06T06:58:29.95527Z","steps":["trace[76892858] 'agreement among raft nodes before linearized reading' (duration: 114.543617ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:58:30.151633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.409165ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T06:58:30.15185Z","caller":"traceutil/trace.go:171","msg":"trace[1006113268] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"192.485398ms","start":"2026-08-06T06:58:29.959333Z","end":"2026-08-06T06:58:30.151819Z","steps":["trace[1006113268] 'process raft request' (duration: 39.816631ms)","trace[1006113268] 'compare' (duration: 152.080252ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:58:30.151888Z","caller":"traceutil/trace.go:171","msg":"trace[339681690] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"192.502889ms","start":"2026-08-06T06:58:29.959368Z","end":"2026-08-06T06:58:30.151871Z","steps":["trace[339681690] 'process raft request' (duration: 192.363217ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:30.152009Z","caller":"traceutil/trace.go:171","msg":"trace[530540462] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"192.61696ms","start":"2026-08-06T06:58:29.959378Z","end":"2026-08-06T06:58:30.151994Z","steps":["trace[530540462] 'process raft request' (duration: 192.458718ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:30.437203Z","caller":"traceutil/trace.go:171","msg":"trace[803624414] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"416.150232ms","start":"2026-08-06T06:58:30.021022Z","end":"2026-08-06T06:58:30.437173Z","steps":["trace[803624414] 'process raft request' (duration: 350.302134ms)","trace[803624414] 'compare' (duration: 65.725707ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T06:58:30.437377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:58:30.021002Z","time spent":"416.278253ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T06:58:32.230644Z","caller":"traceutil/trace.go:171","msg":"trace[394438321] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"178.27517ms","start":"2026-08-06T06:58:32.05202Z","end":"2026-08-06T06:58:32.230295Z","steps":["trace[394438321] 'process raft request' (duration: 178.119949ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:32.237668Z","caller":"traceutil/trace.go:171","msg":"trace[2062613222] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"100.20204ms","start":"2026-08-06T06:58:32.13743Z","end":"2026-08-06T06:58:32.237632Z","steps":["trace[2062613222] 'process raft request' (duration: 100.023178ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:50.400038Z","caller":"traceutil/trace.go:171","msg":"trace[71996352] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"222.376246ms","start":"2026-08-06T06:58:50.177644Z","end":"2026-08-06T06:58:50.40002Z","steps":["trace[71996352] 'process raft request' (duration: 222.241604ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:56.766997Z","caller":"traceutil/trace.go:171","msg":"trace[1402622111] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"123.910961ms","start":"2026-08-06T06:58:56.64306Z","end":"2026-08-06T06:58:56.766971Z","steps":["trace[1402622111] 'process raft request' (duration: 123.74547ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:58:56.770475Z","caller":"traceutil/trace.go:171","msg":"trace[1211225890] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"126.838467ms","start":"2026-08-06T06:58:56.643615Z","end":"2026-08-06T06:58:56.770454Z","steps":["trace[1211225890] 'process raft request' (duration: 126.724956ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T06:59:38.396227Z","caller":"traceutil/trace.go:171","msg":"trace[104599940] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"183.436739ms","start":"2026-08-06T06:59:38.212692Z","end":"2026-08-06T06:59:38.396129Z","steps":["trace[104599940] 'process raft request' (duration: 183.278762ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:59:47.342437Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721274932980366086,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-06T06:59:47.40108Z","caller":"traceutil/trace.go:171","msg":"trace[609697304] linearizableReadLoop","detail":"{readStateIndex:1452; appliedIndex:1451; }","duration":"559.62074ms","start":"2026-08-06T06:59:46.841438Z","end":"2026-08-06T06:59:47.401059Z","steps":["trace[609697304] 'read index received' (duration: 559.473145ms)","trace[609697304] 'applied index is now lower than readState.Index' (duration: 146.775µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T06:59:47.401139Z","caller":"traceutil/trace.go:171","msg":"trace[1853966433] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"632.066147ms","start":"2026-08-06T06:59:46.769057Z","end":"2026-08-06T06:59:47.401123Z","steps":["trace[1853966433] 'process raft request' (duration: 631.869131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:59:47.401269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.835827ms","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-06T06:59:47.401302Z","caller":"traceutil/trace.go:171","msg":"trace[1150835002] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1389; }","duration":"559.91619ms","start":"2026-08-06T06:59:46.841376Z","end":"2026-08-06T06:59:47.401292Z","steps":["trace[1150835002] 'agreement among raft nodes before linearized reading' (duration: 559.788376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:59:47.401329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:59:46.84135Z","time spent":"559.973972ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-06T06:59:47.401284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:59:46.769046Z","time spent":"632.13058ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T06:59:47.401525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.162678ms","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-06T06:59:47.401639Z","caller":"traceutil/trace.go:171","msg":"trace[1421618760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1389; }","duration":"376.311983ms","start":"2026-08-06T06:59:47.025306Z","end":"2026-08-06T06:59:47.401618Z","steps":["trace[1421618760] 'agreement among raft nodes before linearized reading' (duration: 376.099006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:59:47.401739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:59:47.02529Z","time spent":"376.437717ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T06:59:47.40188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.245312ms","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-06T06:59:47.402067Z","caller":"traceutil/trace.go:171","msg":"trace[2135695298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1389; }","duration":"379.710778ms","start":"2026-08-06T06:59:47.022198Z","end":"2026-08-06T06:59:47.401909Z","steps":["trace[2135695298] 'agreement among raft nodes before linearized reading' (duration: 379.107317ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T06:59:47.402252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T06:59:47.022179Z","time spent":"379.920755ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-06T07:00:02.760917Z","caller":"traceutil/trace.go:171","msg":"trace[1220972528] linearizableReadLoop","detail":"{readStateIndex:1511; appliedIndex:1510; }","duration":"136.831367ms","start":"2026-08-06T07:00:02.624062Z","end":"2026-08-06T07:00:02.760893Z","steps":["trace[1220972528] 'read index received' (duration: 136.765715ms)","trace[1220972528] 'applied index is now lower than readState.Index' (duration: 64.452µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:00:02.760973Z","caller":"traceutil/trace.go:171","msg":"trace[857201512] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"164.167818ms","start":"2026-08-06T07:00:02.596775Z","end":"2026-08-06T07:00:02.760943Z","steps":["trace[857201512] 'process raft request' (duration: 163.931461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:00:02.761115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.048074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-08-06T07:00:02.761207Z","caller":"traceutil/trace.go:171","msg":"trace[1708179959] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1444; }","duration":"137.170238ms","start":"2026-08-06T07:00:02.624004Z","end":"2026-08-06T07:00:02.761174Z","steps":["trace[1708179959] 'agreement among raft nodes before linearized reading' (duration: 136.994893ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:00:02.765423Z","caller":"traceutil/trace.go:171","msg":"trace[135126455] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"110.154977ms","start":"2026-08-06T07:00:02.655252Z","end":"2026-08-06T07:00:02.765407Z","steps":["trace[135126455] 'process raft request' (duration: 109.831817ms)"],"step_count":1}