{"level":"warn","ts":"2026-08-12T10:53:03.038729Z","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-12T10:53:03.038811Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-12T10:53:03.03887Z","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-12T10:53:03.038879Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-08-12T10:53:03.038894Z","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-12T10:53:03.039483Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-08-12T10:53:03.039563Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-12T10:53:03.044545Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.769049ms"} {"level":"info","ts":"2026-08-12T10:53:03.054411Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-08-12T10:53:03.054513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-08-12T10:53:03.054539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-08-12T10:53:03.05455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-12T10:53:03.054559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-08-12T10:53:03.054597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-08-12T10:53:03.06521Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-12T10:53:03.066725Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-12T10:53:03.069348Z","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-12T10:53:03.073846Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-12T10:53:03.07448Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-12T10:53:03.074474Z","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-12T10:53:03.074601Z","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-12T10:53:03.074631Z","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-12T10:53:03.077101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-08-12T10:53:03.077213Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-08-12T10:53:03.079145Z","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-12T10:53:03.079425Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-12T10:53:03.07946Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-12T10:53:03.079564Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-08-12T10:53:03.079581Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-08-12T10:53:03.354833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-08-12T10:53:03.354962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-12T10:53:03.355034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-08-12T10:53:03.355063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-08-12T10:53:03.355075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-08-12T10:53:03.355096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-08-12T10:53:03.355128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-08-12T10:53:03.356141Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-08-12T10:53:03.356261Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T10:53:03.356348Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T10:53:03.356385Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T10:53:03.35643Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-12T10:53:03.356564Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-12T10:53:03.357871Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T10:53:03.357975Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T10:53:03.358019Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T10:53:03.359225Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-08-12T10:53:03.359432Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-12T10:53:08.019049Z","caller":"traceutil/trace.go:171","msg":"trace[1000398867] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"486.415275ms","start":"2026-08-12T10:53:07.532592Z","end":"2026-08-12T10:53:08.019007Z","steps":["trace[1000398867] 'process raft request' (duration: 486.253658ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:53:08.019953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:53:07.532509Z","time spent":"486.637622ms","remote":"127.0.0.1:38634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11440,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-12T10:53:08.054437Z","caller":"traceutil/trace.go:171","msg":"trace[1338976760] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"518.89619ms","start":"2026-08-12T10:53:07.535516Z","end":"2026-08-12T10:53:08.054412Z","steps":["trace[1338976760] 'process raft request' (duration: 518.670801ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:53:08.054801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:53:07.535509Z","time spent":"519.008024ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:53:08.276569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.57047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:53:08.276882Z","caller":"traceutil/trace.go:171","msg":"trace[1408985086] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"251.147725ms","start":"2026-08-12T10:53:08.025523Z","end":"2026-08-12T10:53:08.27667Z","steps":["trace[1408985086] 'process raft request' (duration: 109.260032ms)","trace[1408985086] 'compare' (duration: 141.389574ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:53:39.044031Z","caller":"traceutil/trace.go:171","msg":"trace[201511132] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"128.99913ms","start":"2026-08-12T10:53:38.915013Z","end":"2026-08-12T10:53:39.044012Z","steps":["trace[201511132] 'process raft request' (duration: 128.876096ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.176427Z","caller":"traceutil/trace.go:171","msg":"trace[1809922175] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"260.627117ms","start":"2026-08-12T10:53:38.915773Z","end":"2026-08-12T10:53:39.1764Z","steps":["trace[1809922175] 'process raft request' (duration: 260.332588ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.176603Z","caller":"traceutil/trace.go:171","msg":"trace[1238675807] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"256.833646ms","start":"2026-08-12T10:53:38.919758Z","end":"2026-08-12T10:53:39.176591Z","steps":["trace[1238675807] 'process raft request' (duration: 256.699072ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.176601Z","caller":"traceutil/trace.go:171","msg":"trace[323887194] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"260.69123ms","start":"2026-08-12T10:53:38.91584Z","end":"2026-08-12T10:53:39.176531Z","steps":["trace[323887194] 'process raft request' (duration: 260.451183ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.176652Z","caller":"traceutil/trace.go:171","msg":"trace[664603778] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"259.350146ms","start":"2026-08-12T10:53:38.917225Z","end":"2026-08-12T10:53:39.176575Z","steps":["trace[664603778] 'process raft request' (duration: 259.129439ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.176878Z","caller":"traceutil/trace.go:171","msg":"trace[1531744506] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"254.859243ms","start":"2026-08-12T10:53:38.921994Z","end":"2026-08-12T10:53:39.176853Z","steps":["trace[1531744506] 'process raft request' (duration: 254.512862ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.177039Z","caller":"traceutil/trace.go:171","msg":"trace[1218071392] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"254.125489ms","start":"2026-08-12T10:53:38.92284Z","end":"2026-08-12T10:53:39.176965Z","steps":["trace[1218071392] 'process raft request' (duration: 253.714936ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.177095Z","caller":"traceutil/trace.go:171","msg":"trace[1499243322] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"251.921049ms","start":"2026-08-12T10:53:38.925137Z","end":"2026-08-12T10:53:39.177058Z","steps":["trace[1499243322] 'process raft request' (duration: 251.724913ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.177176Z","caller":"traceutil/trace.go:171","msg":"trace[1616308912] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"247.562438ms","start":"2026-08-12T10:53:38.929594Z","end":"2026-08-12T10:53:39.177157Z","steps":["trace[1616308912] 'process raft request' (duration: 247.32846ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.177432Z","caller":"traceutil/trace.go:171","msg":"trace[1331569534] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"223.07218ms","start":"2026-08-12T10:53:38.954339Z","end":"2026-08-12T10:53:39.177411Z","steps":["trace[1331569534] 'process raft request' (duration: 222.817992ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.177435Z","caller":"traceutil/trace.go:171","msg":"trace[841925437] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"244.047375ms","start":"2026-08-12T10:53:38.933332Z","end":"2026-08-12T10:53:39.177379Z","steps":["trace[841925437] 'process raft request' (duration: 243.745355ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.177642Z","caller":"traceutil/trace.go:171","msg":"trace[1305905661] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:539; }","duration":"198.088368ms","start":"2026-08-12T10:53:38.979509Z","end":"2026-08-12T10:53:39.177598Z","steps":["trace[1305905661] 'read index received' (duration: 65.270811ms)","trace[1305905661] 'applied index is now lower than readState.Index' (duration: 132.814027ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:53:39.178038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.493332ms","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-12T10:53:39.178197Z","caller":"traceutil/trace.go:171","msg":"trace[1264609958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:533; }","duration":"198.702947ms","start":"2026-08-12T10:53:38.97947Z","end":"2026-08-12T10:53:39.178173Z","steps":["trace[1264609958] 'agreement among raft nodes before linearized reading' (duration: 198.323316ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.185937Z","caller":"traceutil/trace.go:171","msg":"trace[1284587858] transaction","detail":"{read_only:false; number_of_response:1; response_revision:536; }","duration":"133.711985ms","start":"2026-08-12T10:53:39.052201Z","end":"2026-08-12T10:53:39.185912Z","steps":["trace[1284587858] 'process raft request' (duration: 133.675874ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.186149Z","caller":"traceutil/trace.go:171","msg":"trace[879816903] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"137.593339ms","start":"2026-08-12T10:53:39.048549Z","end":"2026-08-12T10:53:39.186143Z","steps":["trace[879816903] 'process raft request' (duration: 137.064852ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.186288Z","caller":"traceutil/trace.go:171","msg":"trace[824809844] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"135.984327ms","start":"2026-08-12T10:53:39.050298Z","end":"2026-08-12T10:53:39.186282Z","steps":["trace[824809844] 'process raft request' (duration: 135.490142ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:39.18637Z","caller":"traceutil/trace.go:171","msg":"trace[78331940] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"134.704967ms","start":"2026-08-12T10:53:39.051659Z","end":"2026-08-12T10:53:39.186364Z","steps":["trace[78331940] 'process raft request' (duration: 134.16807ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:43.709667Z","caller":"traceutil/trace.go:171","msg":"trace[1537230659] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"148.030991ms","start":"2026-08-12T10:53:43.561619Z","end":"2026-08-12T10:53:43.70965Z","steps":["trace[1537230659] 'read index received' (duration: 147.082001ms)","trace[1537230659] 'applied index is now lower than readState.Index' (duration: 948.35µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:53:43.710432Z","caller":"traceutil/trace.go:171","msg":"trace[917761143] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"165.492189ms","start":"2026-08-12T10:53:43.544933Z","end":"2026-08-12T10:53:43.710425Z","steps":["trace[917761143] 'process raft request' (duration: 164.042374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:53:43.710697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.25775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:53:43.71073Z","caller":"traceutil/trace.go:171","msg":"trace[1862474347] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:616; }","duration":"113.352284ms","start":"2026-08-12T10:53:43.597367Z","end":"2026-08-12T10:53:43.710719Z","steps":["trace[1862474347] 'agreement among raft nodes before linearized reading' (duration: 113.287741ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:53:43.710718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.022394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:53:43.71078Z","caller":"traceutil/trace.go:171","msg":"trace[67756323] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:616; }","duration":"113.108436ms","start":"2026-08-12T10:53:43.597656Z","end":"2026-08-12T10:53:43.710764Z","steps":["trace[67756323] 'agreement among raft nodes before linearized reading' (duration: 112.985702ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:53:43.710905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.270202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:53:43.710931Z","caller":"traceutil/trace.go:171","msg":"trace[1134201620] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:616; }","duration":"113.591061ms","start":"2026-08-12T10:53:43.597334Z","end":"2026-08-12T10:53:43.710925Z","steps":["trace[1134201620] 'agreement among raft nodes before linearized reading' (duration: 113.283672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:53:43.711158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.539908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-12T10:53:43.711178Z","caller":"traceutil/trace.go:171","msg":"trace[2030519412] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"149.58502ms","start":"2026-08-12T10:53:43.561589Z","end":"2026-08-12T10:53:43.711174Z","steps":["trace[2030519412] 'agreement among raft nodes before linearized reading' (duration: 148.988341ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:44.402708Z","caller":"traceutil/trace.go:171","msg":"trace[1174182200] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"126.826008ms","start":"2026-08-12T10:53:44.275852Z","end":"2026-08-12T10:53:44.402678Z","steps":["trace[1174182200] 'process raft request' (duration: 78.800329ms)","trace[1174182200] 'compare' (duration: 47.841953ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:53:45.358711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.841451ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:53:45.358843Z","caller":"traceutil/trace.go:171","msg":"trace[1746928354] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:626; }","duration":"204.980635ms","start":"2026-08-12T10:53:45.153844Z","end":"2026-08-12T10:53:45.358825Z","steps":["trace[1746928354] 'range keys from in-memory index tree' (duration: 204.828331ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:53:45.359262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.19324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:53:45.359357Z","caller":"traceutil/trace.go:171","msg":"trace[1449253600] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"130.75563ms","start":"2026-08-12T10:53:45.228591Z","end":"2026-08-12T10:53:45.359346Z","steps":["trace[1449253600] 'read index received' (duration: 48.021µs)","trace[1449253600] 'applied index is now lower than readState.Index' (duration: 130.706409ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:53:45.359524Z","caller":"traceutil/trace.go:171","msg":"trace[779218733] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"473.499994ms","start":"2026-08-12T10:53:44.88601Z","end":"2026-08-12T10:53:45.35951Z","steps":["trace[779218733] 'process raft request' (duration: 69.003114ms)","trace[779218733] 'compare' (duration: 403.460948ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:53:45.359585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:53:44.885989Z","time spent":"473.569935ms","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-12T10:53:45.359849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.253016ms","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-12T10:53:45.359885Z","caller":"traceutil/trace.go:171","msg":"trace[977221615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"131.289537ms","start":"2026-08-12T10:53:45.228586Z","end":"2026-08-12T10:53:45.359876Z","steps":["trace[977221615] 'agreement among raft nodes before linearized reading' (duration: 131.142553ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:45.522523Z","caller":"traceutil/trace.go:171","msg":"trace[1057506937] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"141.701961ms","start":"2026-08-12T10:53:45.380794Z","end":"2026-08-12T10:53:45.522496Z","steps":["trace[1057506937] 'read index received' (duration: 100.018786ms)","trace[1057506937] 'applied index is now lower than readState.Index' (duration: 41.682145ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:53:45.522668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.839974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:53:45.522715Z","caller":"traceutil/trace.go:171","msg":"trace[2035141266] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:628; }","duration":"141.909207ms","start":"2026-08-12T10:53:45.38079Z","end":"2026-08-12T10:53:45.522699Z","steps":["trace[2035141266] 'agreement among raft nodes before linearized reading' (duration: 141.817044ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:45.522753Z","caller":"traceutil/trace.go:171","msg":"trace[1013136164] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"142.96624ms","start":"2026-08-12T10:53:45.379761Z","end":"2026-08-12T10:53:45.522727Z","steps":["trace[1013136164] 'process raft request' (duration: 100.932414ms)","trace[1013136164] 'compare' (duration: 41.649814ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:53:45.52564Z","caller":"traceutil/trace.go:171","msg":"trace[395855873] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"130.971278ms","start":"2026-08-12T10:53:45.394655Z","end":"2026-08-12T10:53:45.525627Z","steps":["trace[395855873] 'process raft request' (duration: 130.894795ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:53:59.956198Z","caller":"traceutil/trace.go:171","msg":"trace[206975095] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"117.819904ms","start":"2026-08-12T10:53:59.838347Z","end":"2026-08-12T10:53:59.956166Z","steps":["trace[206975095] 'read index received' (duration: 117.566057ms)","trace[206975095] 'applied index is now lower than readState.Index' (duration: 252.697µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:53:59.956292Z","caller":"traceutil/trace.go:171","msg":"trace[2132393830] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"138.290202ms","start":"2026-08-12T10:53:59.817978Z","end":"2026-08-12T10:53:59.956268Z","steps":["trace[2132393830] 'process raft request' (duration: 137.993114ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:53:59.956453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.079452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-12T10:53:59.956532Z","caller":"traceutil/trace.go:171","msg":"trace[1072794075] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:785; }","duration":"118.217056ms","start":"2026-08-12T10:53:59.838299Z","end":"2026-08-12T10:53:59.956516Z","steps":["trace[1072794075] 'agreement among raft nodes before linearized reading' (duration: 117.99536ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:54:00.157903Z","caller":"traceutil/trace.go:171","msg":"trace[1291672632] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"197.32964ms","start":"2026-08-12T10:53:59.960548Z","end":"2026-08-12T10:54:00.157877Z","steps":["trace[1291672632] 'process raft request' (duration: 196.411454ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:24.8635Z","caller":"traceutil/trace.go:171","msg":"trace[519619228] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"151.623622ms","start":"2026-08-12T10:55:24.711856Z","end":"2026-08-12T10:55:24.86348Z","steps":["trace[519619228] 'process raft request' (duration: 151.5093ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:25.472229Z","caller":"traceutil/trace.go:171","msg":"trace[544847141] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"125.349775ms","start":"2026-08-12T10:55:25.346847Z","end":"2026-08-12T10:55:25.472197Z","steps":["trace[544847141] 'process raft request' (duration: 124.787881ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:27.041047Z","caller":"traceutil/trace.go:171","msg":"trace[1838697753] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"106.097614ms","start":"2026-08-12T10:55:26.934883Z","end":"2026-08-12T10:55:27.04098Z","steps":["trace[1838697753] 'process raft request' (duration: 81.654296ms)","trace[1838697753] 'compare' (duration: 24.069929ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:27.041172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.135441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-08-12T10:55:27.041002Z","caller":"traceutil/trace.go:171","msg":"trace[1958696365] linearizableReadLoop","detail":"{readStateIndex:1253; appliedIndex:1252; }","duration":"104.852254ms","start":"2026-08-12T10:55:26.936031Z","end":"2026-08-12T10:55:27.040883Z","steps":["trace[1958696365] 'read index received' (duration: 80.444106ms)","trace[1958696365] 'applied index is now lower than readState.Index' (duration: 24.406918ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:27.041269Z","caller":"traceutil/trace.go:171","msg":"trace[1837554043] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1210; }","duration":"105.270843ms","start":"2026-08-12T10:55:26.935976Z","end":"2026-08-12T10:55:27.041247Z","steps":["trace[1837554043] 'agreement among raft nodes before linearized reading' (duration: 105.061528ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:30.70746Z","caller":"traceutil/trace.go:171","msg":"trace[283076484] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1263; }","duration":"229.055523ms","start":"2026-08-12T10:55:30.478383Z","end":"2026-08-12T10:55:30.707438Z","steps":["trace[283076484] 'read index received' (duration: 228.866008ms)","trace[283076484] 'applied index is now lower than readState.Index' (duration: 188.565µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:30.707587Z","caller":"traceutil/trace.go:171","msg":"trace[2086304805] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"240.980644ms","start":"2026-08-12T10:55:30.466587Z","end":"2026-08-12T10:55:30.707567Z","steps":["trace[2086304805] 'process raft request' (duration: 240.702157ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:30.707636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.240616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-08-12T10:55:30.707676Z","caller":"traceutil/trace.go:171","msg":"trace[1043593168] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1221; }","duration":"229.321379ms","start":"2026-08-12T10:55:30.478343Z","end":"2026-08-12T10:55:30.707665Z","steps":["trace[1043593168] 'agreement among raft nodes before linearized reading' (duration: 229.176475ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:31.402049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.87721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:31.40217Z","caller":"traceutil/trace.go:171","msg":"trace[2096175718] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"330.723842ms","start":"2026-08-12T10:55:31.071426Z","end":"2026-08-12T10:55:31.40215Z","steps":["trace[2096175718] 'process raft request' (duration: 48.655397ms)","trace[2096175718] 'compare' (duration: 281.739757ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:31.402236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:31.071402Z","time spent":"330.804954ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:55:31.695451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.384577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-12T10:55:31.69557Z","caller":"traceutil/trace.go:171","msg":"trace[420905399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1223; }","duration":"182.552001ms","start":"2026-08-12T10:55:31.51299Z","end":"2026-08-12T10:55:31.695542Z","steps":["trace[420905399] 'range keys from in-memory index tree' (duration: 182.110281ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:32.408873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.120076ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-12T10:55:32.409304Z","caller":"traceutil/trace.go:171","msg":"trace[1139031222] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"130.327807ms","start":"2026-08-12T10:55:32.278951Z","end":"2026-08-12T10:55:32.409279Z","steps":["trace[1139031222] 'process raft request' (duration: 130.03589ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:34.344203Z","caller":"traceutil/trace.go:171","msg":"trace[143650402] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"164.636666ms","start":"2026-08-12T10:55:34.179542Z","end":"2026-08-12T10:55:34.344178Z","steps":["trace[143650402] 'process raft request' (duration: 164.480452ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:36.004514Z","caller":"traceutil/trace.go:171","msg":"trace[1645394972] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1281; }","duration":"233.297401ms","start":"2026-08-12T10:55:35.771185Z","end":"2026-08-12T10:55:36.004482Z","steps":["trace[1645394972] 'read index received' (duration: 182.813428ms)","trace[1645394972] 'applied index is now lower than readState.Index' (duration: 50.482873ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:36.004596Z","caller":"traceutil/trace.go:171","msg":"trace[1456906662] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"234.961511ms","start":"2026-08-12T10:55:35.769591Z","end":"2026-08-12T10:55:36.004553Z","steps":["trace[1456906662] 'process raft request' (duration: 184.484117ms)","trace[1456906662] 'compare' (duration: 50.250479ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:36.004714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.503986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-08-12T10:55:36.004791Z","caller":"traceutil/trace.go:171","msg":"trace[1733506517] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:1; response_revision:1238; }","duration":"233.599638ms","start":"2026-08-12T10:55:35.771173Z","end":"2026-08-12T10:55:36.004772Z","steps":["trace[1733506517] 'agreement among raft nodes before linearized reading' (duration: 233.425524ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:36.743074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.497514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:36.743181Z","caller":"traceutil/trace.go:171","msg":"trace[1976976296] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"298.290047ms","start":"2026-08-12T10:55:36.444871Z","end":"2026-08-12T10:55:36.743161Z","steps":["trace[1976976296] 'process raft request' (duration: 57.6395ms)","trace[1976976296] 'compare' (duration: 240.391241ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:36.763625Z","caller":"traceutil/trace.go:171","msg":"trace[1593282033] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"312.438429ms","start":"2026-08-12T10:55:36.451166Z","end":"2026-08-12T10:55:36.763605Z","steps":["trace[1593282033] 'process raft request' (duration: 312.313606ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:36.763947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:36.451147Z","time spent":"312.543622ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:55:36.981922Z","caller":"traceutil/trace.go:171","msg":"trace[1358200426] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"153.25004ms","start":"2026-08-12T10:55:36.828644Z","end":"2026-08-12T10:55:36.981895Z","steps":["trace[1358200426] 'process raft request' (duration: 53.611976ms)","trace[1358200426] 'compare' (duration: 99.470541ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:36.982324Z","caller":"traceutil/trace.go:171","msg":"trace[760214969] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1288; }","duration":"113.973221ms","start":"2026-08-12T10:55:36.868289Z","end":"2026-08-12T10:55:36.982262Z","steps":["trace[760214969] 'read index received' (duration: 13.909536ms)","trace[760214969] 'applied index is now lower than readState.Index' (duration: 100.061495ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:36.982338Z","caller":"traceutil/trace.go:171","msg":"trace[1247791379] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"153.584198ms","start":"2026-08-12T10:55:36.8287Z","end":"2026-08-12T10:55:36.982284Z","steps":["trace[1247791379] 'process raft request' (duration: 153.138757ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:36.983434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.133568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-12T10:55:36.983609Z","caller":"traceutil/trace.go:171","msg":"trace[1115230805] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:1245; }","duration":"115.352212ms","start":"2026-08-12T10:55:36.868242Z","end":"2026-08-12T10:55:36.983594Z","steps":["trace[1115230805] 'agreement among raft nodes before linearized reading' (duration: 114.147104ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:37.207268Z","caller":"traceutil/trace.go:171","msg":"trace[442990639] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"221.474423ms","start":"2026-08-12T10:55:36.985745Z","end":"2026-08-12T10:55:37.20722Z","steps":["trace[442990639] 'process raft request' (duration: 210.63515ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:37.207229Z","caller":"traceutil/trace.go:171","msg":"trace[873007135] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1290; }","duration":"221.025012ms","start":"2026-08-12T10:55:36.986178Z","end":"2026-08-12T10:55:37.207203Z","steps":["trace[873007135] 'read index received' (duration: 10.947516ms)","trace[873007135] 'applied index is now lower than readState.Index' (duration: 210.076466ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:37.207658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.460733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5548"} {"level":"info","ts":"2026-08-12T10:55:37.207751Z","caller":"traceutil/trace.go:171","msg":"trace[1086216825] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1246; }","duration":"221.595946ms","start":"2026-08-12T10:55:36.986125Z","end":"2026-08-12T10:55:37.207721Z","steps":["trace[1086216825] 'agreement among raft nodes before linearized reading' (duration: 221.201027ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:37.214523Z","caller":"traceutil/trace.go:171","msg":"trace[234825647] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"216.426825ms","start":"2026-08-12T10:55:36.998074Z","end":"2026-08-12T10:55:37.214501Z","steps":["trace[234825647] 'process raft request' (duration: 216.305272ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:37.214638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.216402ms","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-12T10:55:37.214697Z","caller":"traceutil/trace.go:171","msg":"trace[1124908985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1247; }","duration":"140.329034ms","start":"2026-08-12T10:55:37.074355Z","end":"2026-08-12T10:55:37.214684Z","steps":["trace[1124908985] 'agreement among raft nodes before linearized reading' (duration: 140.123159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:37.443449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.988689ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:37.44379Z","caller":"traceutil/trace.go:171","msg":"trace[1647835327] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"224.799661ms","start":"2026-08-12T10:55:37.218972Z","end":"2026-08-12T10:55:37.443771Z","steps":["trace[1647835327] 'process raft request' (duration: 92.350061ms)","trace[1647835327] 'compare' (duration: 131.799254ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:37.443894Z","caller":"traceutil/trace.go:171","msg":"trace[1956635122] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1294; }","duration":"188.093051ms","start":"2026-08-12T10:55:37.255486Z","end":"2026-08-12T10:55:37.443579Z","steps":["trace[1956635122] 'read index received' (duration: 55.724343ms)","trace[1956635122] 'applied index is now lower than readState.Index' (duration: 132.367038ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:37.444121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.558445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/local-path-storage/\" range_end:\"/registry/resourcequotas/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-12T10:55:37.444249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.777603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-12T10:55:37.444168Z","caller":"traceutil/trace.go:171","msg":"trace[1794968119] range","detail":"{range_begin:/registry/resourcequotas/local-path-storage/; range_end:/registry/resourcequotas/local-path-storage0; response_count:0; response_revision:1249; }","duration":"224.630067ms","start":"2026-08-12T10:55:37.219522Z","end":"2026-08-12T10:55:37.444152Z","steps":["trace[1794968119] 'agreement among raft nodes before linearized reading' (duration: 224.547915ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:37.444318Z","caller":"traceutil/trace.go:171","msg":"trace[942350591] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1249; }","duration":"184.846066ms","start":"2026-08-12T10:55:37.259445Z","end":"2026-08-12T10:55:37.444291Z","steps":["trace[942350591] 'agreement among raft nodes before linearized reading' (duration: 184.659281ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:37.787285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.202593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:37.78831Z","caller":"traceutil/trace.go:171","msg":"trace[1367934278] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"341.791569ms","start":"2026-08-12T10:55:37.446455Z","end":"2026-08-12T10:55:37.788246Z","steps":["trace[1367934278] 'process raft request' (duration: 179.519141ms)","trace[1367934278] 'compare' (duration: 160.581458ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:37.788344Z","caller":"traceutil/trace.go:171","msg":"trace[225596033] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"341.736467ms","start":"2026-08-12T10:55:37.44657Z","end":"2026-08-12T10:55:37.788306Z","steps":["trace[225596033] 'read index received' (duration: 179.366457ms)","trace[225596033] 'applied index is now lower than readState.Index' (duration: 162.282508ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:37.788436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.844909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-08-12T10:55:37.788634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:37.446425Z","time spent":"341.983972ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-12T10:55:37.788715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.398028ms","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-12T10:55:37.788791Z","caller":"traceutil/trace.go:171","msg":"trace[1226880962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1250; }","duration":"326.529701ms","start":"2026-08-12T10:55:37.462243Z","end":"2026-08-12T10:55:37.788773Z","steps":["trace[1226880962] 'agreement among raft nodes before linearized reading' (duration: 326.277125ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:37.788847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:37.462225Z","time spent":"326.609673ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-12T10:55:37.789586Z","caller":"traceutil/trace.go:171","msg":"trace[1468248986] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1250; }","duration":"342.176068ms","start":"2026-08-12T10:55:37.44651Z","end":"2026-08-12T10:55:37.788686Z","steps":["trace[1468248986] 'agreement among raft nodes before linearized reading' (duration: 341.805109ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:37.789683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:37.44648Z","time spent":"343.178211ms","remote":"127.0.0.1:38792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-08-12T10:55:38.300286Z","caller":"traceutil/trace.go:171","msg":"trace[66134775] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1297; }","duration":"310.200352ms","start":"2026-08-12T10:55:37.990054Z","end":"2026-08-12T10:55:38.300255Z","steps":["trace[66134775] 'read index received' (duration: 221.343764ms)","trace[66134775] 'applied index is now lower than readState.Index' (duration: 88.855688ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:38.300484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.775358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-12T10:55:38.300512Z","caller":"traceutil/trace.go:171","msg":"trace[1341546848] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1252; }","duration":"287.855939ms","start":"2026-08-12T10:55:38.012648Z","end":"2026-08-12T10:55:38.300504Z","steps":["trace[1341546848] 'agreement among raft nodes before linearized reading' (duration: 287.740446ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:38.300527Z","caller":"traceutil/trace.go:171","msg":"trace[1801213975] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"475.226514ms","start":"2026-08-12T10:55:37.825271Z","end":"2026-08-12T10:55:38.300497Z","steps":["trace[1801213975] 'process raft request' (duration: 386.266134ms)","trace[1801213975] 'compare' (duration: 88.622742ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:38.30068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:37.825248Z","time spent":"475.362818ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3564,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:55:38.300545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.479308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-08-12T10:55:38.300767Z","caller":"traceutil/trace.go:171","msg":"trace[2143960060] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1252; }","duration":"310.755276ms","start":"2026-08-12T10:55:37.989998Z","end":"2026-08-12T10:55:38.300753Z","steps":["trace[2143960060] 'agreement among raft nodes before linearized reading' (duration: 310.386826ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:38.3008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:37.989977Z","time spent":"310.813966ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":920,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-08-12T10:55:38.541831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.431575ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:38.542127Z","caller":"traceutil/trace.go:171","msg":"trace[702776473] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"237.81966ms","start":"2026-08-12T10:55:38.304289Z","end":"2026-08-12T10:55:38.542109Z","steps":["trace[702776473] 'process raft request' (duration: 99.030346ms)","trace[702776473] 'compare' (duration: 138.307273ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:39.001872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.466965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:39.002161Z","caller":"traceutil/trace.go:171","msg":"trace[435859812] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"364.287836ms","start":"2026-08-12T10:55:38.63785Z","end":"2026-08-12T10:55:39.002138Z","steps":["trace[435859812] 'process raft request' (duration: 364.216055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:39.002314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:38.637817Z","time spent":"364.45541ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:55:39.002195Z","caller":"traceutil/trace.go:171","msg":"trace[886576366] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"456.062521ms","start":"2026-08-12T10:55:38.546098Z","end":"2026-08-12T10:55:39.002161Z","steps":["trace[886576366] 'process raft request' (duration: 146.210108ms)","trace[886576366] 'compare' (duration: 309.354822ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:39.002519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:38.546074Z","time spent":"456.358819ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:55:39.323069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656054662799218919,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-12T10:55:39.470184Z","caller":"traceutil/trace.go:171","msg":"trace[65646028] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1301; }","duration":"647.374022ms","start":"2026-08-12T10:55:38.822784Z","end":"2026-08-12T10:55:39.470158Z","steps":["trace[65646028] 'read index received' (duration: 596.966295ms)","trace[65646028] 'applied index is now lower than readState.Index' (duration: 50.406717ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:39.470309Z","caller":"traceutil/trace.go:171","msg":"trace[1492353298] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"701.034407ms","start":"2026-08-12T10:55:38.769261Z","end":"2026-08-12T10:55:39.470296Z","steps":["trace[1492353298] 'process raft request' (duration: 650.578619ms)","trace[1492353298] 'compare' (duration: 50.002067ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:39.470646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.843922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" ","response":"range_response_count:1 size:3579"} {"level":"warn","ts":"2026-08-12T10:55:39.470673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:38.769239Z","time spent":"701.094348ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:55:39.470724Z","caller":"traceutil/trace.go:171","msg":"trace[526701231] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb; range_end:; response_count:1; response_revision:1256; }","duration":"647.968986ms","start":"2026-08-12T10:55:38.822736Z","end":"2026-08-12T10:55:39.470705Z","steps":["trace[526701231] 'agreement among raft nodes before linearized reading' (duration: 647.704371ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:39.47104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:38.822713Z","time spent":"648.196771ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3602,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" "} {"level":"warn","ts":"2026-08-12T10:55:39.471231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.351853ms","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-12T10:55:39.471414Z","caller":"traceutil/trace.go:171","msg":"trace[1929415397] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1256; }","duration":"484.460273ms","start":"2026-08-12T10:55:38.986821Z","end":"2026-08-12T10:55:39.471281Z","steps":["trace[1929415397] 'agreement among raft nodes before linearized reading' (duration: 484.208808ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:39.471481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:38.986797Z","time spent":"484.666588ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-12T10:55:39.736419Z","caller":"traceutil/trace.go:171","msg":"trace[1843781534] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1303; }","duration":"120.026453ms","start":"2026-08-12T10:55:39.616369Z","end":"2026-08-12T10:55:39.736396Z","steps":["trace[1843781534] 'read index received' (duration: 53.221593ms)","trace[1843781534] 'applied index is now lower than readState.Index' (duration: 66.80382ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:39.736583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.197397ms","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-12T10:55:39.736571Z","caller":"traceutil/trace.go:171","msg":"trace[244083871] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"260.305849ms","start":"2026-08-12T10:55:39.476238Z","end":"2026-08-12T10:55:39.736544Z","steps":["trace[244083871] 'process raft request' (duration: 193.363225ms)","trace[244083871] 'compare' (duration: 66.609946ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:39.736616Z","caller":"traceutil/trace.go:171","msg":"trace[229428461] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1259; }","duration":"120.279019ms","start":"2026-08-12T10:55:39.616327Z","end":"2026-08-12T10:55:39.736606Z","steps":["trace[229428461] 'agreement among raft nodes before linearized reading' (duration: 120.167406ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:39.736868Z","caller":"traceutil/trace.go:171","msg":"trace[85666355] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"140.309746ms","start":"2026-08-12T10:55:39.596548Z","end":"2026-08-12T10:55:39.736858Z","steps":["trace[85666355] 'process raft request' (duration: 139.786444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:40.172424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.160867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:40.172575Z","caller":"traceutil/trace.go:171","msg":"trace[677852953] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1305; }","duration":"350.411909ms","start":"2026-08-12T10:55:39.822143Z","end":"2026-08-12T10:55:40.172555Z","steps":["trace[677852953] 'read index received' (duration: 201.754541ms)","trace[677852953] 'applied index is now lower than readState.Index' (duration: 148.655658ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:40.172639Z","caller":"traceutil/trace.go:171","msg":"trace[2094311701] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"426.777822ms","start":"2026-08-12T10:55:39.745817Z","end":"2026-08-12T10:55:40.172595Z","steps":["trace[2094311701] 'process raft request' (duration: 278.094213ms)","trace[2094311701] 'compare' (duration: 147.670915ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:40.172797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:39.745782Z","time spent":"426.933446ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2228,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-12T10:55:40.173087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.935951ms","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-12T10:55:40.173138Z","caller":"traceutil/trace.go:171","msg":"trace[184510674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1260; }","duration":"351.018353ms","start":"2026-08-12T10:55:39.822107Z","end":"2026-08-12T10:55:40.173125Z","steps":["trace[184510674] 'agreement among raft nodes before linearized reading' (duration: 350.503091ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:40.173174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:39.822092Z","time spent":"351.073314ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-12T10:55:40.545432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.083905ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:40.545803Z","caller":"traceutil/trace.go:171","msg":"trace[1244637635] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"368.446185ms","start":"2026-08-12T10:55:40.177283Z","end":"2026-08-12T10:55:40.54573Z","steps":["trace[1244637635] 'process raft request' (duration: 174.986862ms)","trace[1244637635] 'compare' (duration: 192.86718ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:40.546045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:40.17726Z","time spent":"368.622759ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:55:40.546358Z","caller":"traceutil/trace.go:171","msg":"trace[1016300482] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1306; }","duration":"108.329698ms","start":"2026-08-12T10:55:40.437993Z","end":"2026-08-12T10:55:40.546323Z","steps":["trace[1016300482] 'read index received' (duration: 76.922µs)","trace[1016300482] 'applied index is now lower than readState.Index' (duration: 108.246886ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:40.546567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.552173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:40.546609Z","caller":"traceutil/trace.go:171","msg":"trace[910747012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1261; }","duration":"108.646924ms","start":"2026-08-12T10:55:40.437952Z","end":"2026-08-12T10:55:40.546599Z","steps":["trace[910747012] 'agreement among raft nodes before linearized reading' (duration: 108.543901ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:40.762923Z","caller":"traceutil/trace.go:171","msg":"trace[693473562] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1307; }","duration":"179.225991ms","start":"2026-08-12T10:55:40.58367Z","end":"2026-08-12T10:55:40.762896Z","steps":["trace[693473562] 'read index received' (duration: 108.759748ms)","trace[693473562] 'applied index is now lower than readState.Index' (duration: 70.465213ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:40.762979Z","caller":"traceutil/trace.go:171","msg":"trace[1561771941] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"212.61948ms","start":"2026-08-12T10:55:40.550286Z","end":"2026-08-12T10:55:40.762906Z","steps":["trace[1561771941] 'process raft request' (duration: 142.042844ms)","trace[1561771941] 'compare' (duration: 70.450323ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:40.763096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.395064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T10:55:40.763138Z","caller":"traceutil/trace.go:171","msg":"trace[832922263] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1262; }","duration":"179.499208ms","start":"2026-08-12T10:55:40.583629Z","end":"2026-08-12T10:55:40.763128Z","steps":["trace[832922263] 'agreement among raft nodes before linearized reading' (duration: 179.394676ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:41.049795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.019788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:41.04986Z","caller":"traceutil/trace.go:171","msg":"trace[805508627] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1262; }","duration":"150.139322ms","start":"2026-08-12T10:55:40.899706Z","end":"2026-08-12T10:55:41.049845Z","steps":["trace[805508627] 'count revisions from in-memory index tree' (duration: 149.912826ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:41.950582Z","caller":"traceutil/trace.go:171","msg":"trace[1431075877] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1309; }","duration":"430.384741ms","start":"2026-08-12T10:55:41.520162Z","end":"2026-08-12T10:55:41.950547Z","steps":["trace[1431075877] 'read index received' (duration: 430.143555ms)","trace[1431075877] 'applied index is now lower than readState.Index' (duration: 240.086µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:41.95092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.727968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-12T10:55:41.950954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.336027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" ","response":"range_response_count:1 size:3579"} {"level":"warn","ts":"2026-08-12T10:55:41.950963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.488289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:41.951001Z","caller":"traceutil/trace.go:171","msg":"trace[2028452160] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1264; }","duration":"430.879082ms","start":"2026-08-12T10:55:41.520104Z","end":"2026-08-12T10:55:41.950983Z","steps":["trace[2028452160] 'agreement among raft nodes before linearized reading' (duration: 430.569655ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:41.951052Z","caller":"traceutil/trace.go:171","msg":"trace[1216131218] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1264; }","duration":"175.632594ms","start":"2026-08-12T10:55:41.7754Z","end":"2026-08-12T10:55:41.951032Z","steps":["trace[1216131218] 'agreement among raft nodes before linearized reading' (duration: 175.45172ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:41.951089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.360586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-12T10:55:41.951058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:41.520082Z","time spent":"430.968383ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-12T10:55:41.951147Z","caller":"traceutil/trace.go:171","msg":"trace[1832244286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1264; }","duration":"211.421777ms","start":"2026-08-12T10:55:41.739712Z","end":"2026-08-12T10:55:41.951133Z","steps":["trace[1832244286] 'agreement among raft nodes before linearized reading' (duration: 211.225402ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:41.951125Z","caller":"traceutil/trace.go:171","msg":"trace[1862993220] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"476.349881ms","start":"2026-08-12T10:55:41.474761Z","end":"2026-08-12T10:55:41.951111Z","steps":["trace[1862993220] 'process raft request' (duration: 475.646305ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:41.950976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.217308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1490"} {"level":"warn","ts":"2026-08-12T10:55:41.951265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:41.474739Z","time spent":"476.450994ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:55:41.95127Z","caller":"traceutil/trace.go:171","msg":"trace[1166244017] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1264; }","duration":"116.578357ms","start":"2026-08-12T10:55:41.834679Z","end":"2026-08-12T10:55:41.951257Z","steps":["trace[1166244017] 'agreement among raft nodes before linearized reading' (duration: 116.092276ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:41.951Z","caller":"traceutil/trace.go:171","msg":"trace[1082590736] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb; range_end:; response_count:1; response_revision:1264; }","duration":"399.438579ms","start":"2026-08-12T10:55:41.551549Z","end":"2026-08-12T10:55:41.950988Z","steps":["trace[1082590736] 'agreement among raft nodes before linearized reading' (duration: 399.150902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:41.951416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:41.551533Z","time spent":"399.867909ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3602,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" "} {"level":"warn","ts":"2026-08-12T10:55:42.240668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.095003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:42.240826Z","caller":"traceutil/trace.go:171","msg":"trace[1149490002] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"284.694799ms","start":"2026-08-12T10:55:41.956115Z","end":"2026-08-12T10:55:42.24081Z","steps":["trace[1149490002] 'process raft request' (duration: 284.646188ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:42.241028Z","caller":"traceutil/trace.go:171","msg":"trace[1426767052] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"284.927875ms","start":"2026-08-12T10:55:41.956069Z","end":"2026-08-12T10:55:42.240996Z","steps":["trace[1426767052] 'process raft request' (duration: 98.420423ms)","trace[1426767052] 'compare' (duration: 185.799355ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:42.26653Z","caller":"traceutil/trace.go:171","msg":"trace[1573445192] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"170.90392ms","start":"2026-08-12T10:55:42.095611Z","end":"2026-08-12T10:55:42.266515Z","steps":["trace[1573445192] 'process raft request' (duration: 170.809487ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:42.450049Z","caller":"traceutil/trace.go:171","msg":"trace[1707134108] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"215.994789ms","start":"2026-08-12T10:55:42.234021Z","end":"2026-08-12T10:55:42.450016Z","steps":["trace[1707134108] 'process raft request' (duration: 116.517903ms)","trace[1707134108] 'compare' (duration: 99.265661ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:42.643542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.575336ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-08-12T10:55:42.643903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.482328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:42.643956Z","caller":"traceutil/trace.go:171","msg":"trace[1609317690] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1268; }","duration":"206.575309ms","start":"2026-08-12T10:55:42.437368Z","end":"2026-08-12T10:55:42.643943Z","steps":["trace[1609317690] 'agreement among raft nodes before linearized reading' (duration: 206.476667ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:42.643897Z","caller":"traceutil/trace.go:171","msg":"trace[2064967615] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1313; }","duration":"206.220431ms","start":"2026-08-12T10:55:42.437409Z","end":"2026-08-12T10:55:42.64363Z","steps":["trace[2064967615] 'read index received' (duration: 12.341767ms)","trace[2064967615] 'applied index is now lower than readState.Index' (duration: 193.877024ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:42.941669Z","caller":"traceutil/trace.go:171","msg":"trace[2072640785] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"293.397122ms","start":"2026-08-12T10:55:42.648247Z","end":"2026-08-12T10:55:42.941644Z","steps":["trace[2072640785] 'process raft request' (duration: 293.112035ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:42.941817Z","caller":"traceutil/trace.go:171","msg":"trace[321815445] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1315; }","duration":"258.104729ms","start":"2026-08-12T10:55:42.683447Z","end":"2026-08-12T10:55:42.941552Z","steps":["trace[321815445] 'read index received' (duration: 257.74303ms)","trace[321815445] 'applied index is now lower than readState.Index' (duration: 360.559µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:42.941929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.462807ms","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":"info","ts":"2026-08-12T10:55:42.94199Z","caller":"traceutil/trace.go:171","msg":"trace[240280367] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1269; }","duration":"258.571149ms","start":"2026-08-12T10:55:42.683403Z","end":"2026-08-12T10:55:42.941974Z","steps":["trace[240280367] 'agreement among raft nodes before linearized reading' (duration: 258.454707ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:42.942442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.965554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-12T10:55:42.94249Z","caller":"traceutil/trace.go:171","msg":"trace[256221865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1269; }","duration":"175.046315ms","start":"2026-08-12T10:55:42.767432Z","end":"2026-08-12T10:55:42.942478Z","steps":["trace[256221865] 'agreement among raft nodes before linearized reading' (duration: 174.518784ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:43.057325Z","caller":"traceutil/trace.go:171","msg":"trace[262509195] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1316; }","duration":"101.840031ms","start":"2026-08-12T10:55:42.955464Z","end":"2026-08-12T10:55:43.057304Z","steps":["trace[262509195] 'read index received' (duration: 56.749511ms)","trace[262509195] 'applied index is now lower than readState.Index' (duration: 45.08967ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:43.057489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.004944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-08-12T10:55:43.057517Z","caller":"traceutil/trace.go:171","msg":"trace[2111621108] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb; range_end:; response_count:1; response_revision:1271; }","duration":"102.060965ms","start":"2026-08-12T10:55:42.955449Z","end":"2026-08-12T10:55:43.05751Z","steps":["trace[2111621108] 'agreement among raft nodes before linearized reading' (duration: 101.929982ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:43.057552Z","caller":"traceutil/trace.go:171","msg":"trace[1243839164] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"112.674894ms","start":"2026-08-12T10:55:42.944844Z","end":"2026-08-12T10:55:43.057519Z","steps":["trace[1243839164] 'process raft request' (duration: 67.356349ms)","trace[1243839164] 'compare' (duration: 44.969446ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:43.057615Z","caller":"traceutil/trace.go:171","msg":"trace[291190690] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"110.893291ms","start":"2026-08-12T10:55:42.946685Z","end":"2026-08-12T10:55:43.057578Z","steps":["trace[291190690] 'process raft request' (duration: 110.571684ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:44.238037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.727353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-08-12T10:55:44.238114Z","caller":"traceutil/trace.go:171","msg":"trace[906663394] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb; range_end:; response_count:1; response_revision:1273; }","duration":"175.865337ms","start":"2026-08-12T10:55:44.062231Z","end":"2026-08-12T10:55:44.238096Z","steps":["trace[906663394] 'range keys from in-memory index tree' (duration: 175.528259ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:44.412394Z","caller":"traceutil/trace.go:171","msg":"trace[1786864024] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"163.517439ms","start":"2026-08-12T10:55:44.248846Z","end":"2026-08-12T10:55:44.412364Z","steps":["trace[1786864024] 'process raft request' (duration: 163.342905ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:44.66197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.560433ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:44.662064Z","caller":"traceutil/trace.go:171","msg":"trace[1416980535] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1321; }","duration":"217.470053ms","start":"2026-08-12T10:55:44.444578Z","end":"2026-08-12T10:55:44.662048Z","steps":["trace[1416980535] 'read index received' (duration: 80.695675ms)","trace[1416980535] 'applied index is now lower than readState.Index' (duration: 136.773358ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:44.66213Z","caller":"traceutil/trace.go:171","msg":"trace[1732830379] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"412.199788ms","start":"2026-08-12T10:55:44.249869Z","end":"2026-08-12T10:55:44.662069Z","steps":["trace[1732830379] 'process raft request' (duration: 275.451001ms)","trace[1732830379] 'compare' (duration: 136.45634ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:44.662238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.662208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:44.662275Z","caller":"traceutil/trace.go:171","msg":"trace[341077975] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1275; }","duration":"217.740109ms","start":"2026-08-12T10:55:44.444525Z","end":"2026-08-12T10:55:44.662265Z","steps":["trace[341077975] 'agreement among raft nodes before linearized reading' (duration: 217.565465ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:44.662248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:44.249857Z","time spent":"412.348271ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:55:45.336567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.262322ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:45.336671Z","caller":"traceutil/trace.go:171","msg":"trace[533022806] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1276; }","duration":"182.384995ms","start":"2026-08-12T10:55:45.154271Z","end":"2026-08-12T10:55:45.336656Z","steps":["trace[533022806] 'range keys from in-memory index tree' (duration: 182.24416ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:45.336922Z","caller":"traceutil/trace.go:171","msg":"trace[165325574] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"116.574495ms","start":"2026-08-12T10:55:45.22034Z","end":"2026-08-12T10:55:45.336914Z","steps":["trace[165325574] 'read index received' (duration: 47.360879ms)","trace[165325574] 'applied index is now lower than readState.Index' (duration: 69.212956ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:45.337216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.850582ms","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-12T10:55:45.33726Z","caller":"traceutil/trace.go:171","msg":"trace[915155925] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"272.541037ms","start":"2026-08-12T10:55:45.064598Z","end":"2026-08-12T10:55:45.337139Z","steps":["trace[915155925] 'process raft request' (duration: 203.103145ms)","trace[915155925] 'compare' (duration: 68.779886ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:45.337313Z","caller":"traceutil/trace.go:171","msg":"trace[42957388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1277; }","duration":"116.980396ms","start":"2026-08-12T10:55:45.2203Z","end":"2026-08-12T10:55:45.337281Z","steps":["trace[42957388] 'agreement among raft nodes before linearized reading' (duration: 116.72982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:45.558411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.965378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:45.558491Z","caller":"traceutil/trace.go:171","msg":"trace[1732546422] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1278; }","duration":"121.09001ms","start":"2026-08-12T10:55:45.437381Z","end":"2026-08-12T10:55:45.558471Z","steps":["trace[1732546422] 'range keys from in-memory index tree' (duration: 120.899526ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:47.17501Z","caller":"traceutil/trace.go:171","msg":"trace[1430261193] linearizableReadLoop","detail":"{readStateIndex:1330; appliedIndex:1329; }","duration":"127.170636ms","start":"2026-08-12T10:55:47.047809Z","end":"2026-08-12T10:55:47.17498Z","steps":["trace[1430261193] 'read index received' (duration: 67.943015ms)","trace[1430261193] 'applied index is now lower than readState.Index' (duration: 59.226311ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:47.17504Z","caller":"traceutil/trace.go:171","msg":"trace[497668404] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"162.448944ms","start":"2026-08-12T10:55:47.012555Z","end":"2026-08-12T10:55:47.175004Z","steps":["trace[497668404] 'process raft request' (duration: 103.277053ms)","trace[497668404] 'compare' (duration: 58.987617ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:47.175275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.446053ms","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-12T10:55:47.175342Z","caller":"traceutil/trace.go:171","msg":"trace[593294538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1282; }","duration":"127.542826ms","start":"2026-08-12T10:55:47.047785Z","end":"2026-08-12T10:55:47.175328Z","steps":["trace[593294538] 'agreement among raft nodes before linearized reading' (duration: 127.30388ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:48.246592Z","caller":"traceutil/trace.go:171","msg":"trace[360045831] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"196.381006ms","start":"2026-08-12T10:55:48.050183Z","end":"2026-08-12T10:55:48.246564Z","steps":["trace[360045831] 'process raft request' (duration: 196.184512ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:48.246578Z","caller":"traceutil/trace.go:171","msg":"trace[874752810] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1333; }","duration":"192.417854ms","start":"2026-08-12T10:55:48.054137Z","end":"2026-08-12T10:55:48.246554Z","steps":["trace[874752810] 'read index received' (duration: 192.206439ms)","trace[874752810] 'applied index is now lower than readState.Index' (duration: 210.285µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:48.246997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.831784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:48.247082Z","caller":"traceutil/trace.go:171","msg":"trace[1535754835] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1286; }","duration":"192.967726ms","start":"2026-08-12T10:55:48.054093Z","end":"2026-08-12T10:55:48.247061Z","steps":["trace[1535754835] 'agreement among raft nodes before linearized reading' (duration: 192.584638ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:48.316388Z","caller":"traceutil/trace.go:171","msg":"trace[5703051] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"231.586902ms","start":"2026-08-12T10:55:48.084785Z","end":"2026-08-12T10:55:48.316372Z","steps":["trace[5703051] 'process raft request' (duration: 231.49155ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:49.183919Z","caller":"traceutil/trace.go:171","msg":"trace[1686172] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"171.104227ms","start":"2026-08-12T10:55:49.01279Z","end":"2026-08-12T10:55:49.183894Z","steps":["trace[1686172] 'process raft request' (duration: 170.964294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:49.894534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.307649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:49.894649Z","caller":"traceutil/trace.go:171","msg":"trace[1631714084] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"682.002604ms","start":"2026-08-12T10:55:49.212626Z","end":"2026-08-12T10:55:49.894629Z","steps":["trace[1631714084] 'process raft request' (duration: 415.52286ms)","trace[1631714084] 'compare' (duration: 266.201697ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:49.89471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:49.212598Z","time spent":"682.084066ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:55:49.896431Z","caller":"traceutil/trace.go:171","msg":"trace[1232843207] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1339; }","duration":"443.16754ms","start":"2026-08-12T10:55:49.453243Z","end":"2026-08-12T10:55:49.89641Z","steps":["trace[1232843207] 'read index received' (duration: 174.924146ms)","trace[1232843207] 'applied index is now lower than readState.Index' (duration: 268.242384ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:49.896564Z","caller":"traceutil/trace.go:171","msg":"trace[1565799914] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"547.303309ms","start":"2026-08-12T10:55:49.349245Z","end":"2026-08-12T10:55:49.896548Z","steps":["trace[1565799914] 'process raft request' (duration: 547.023812ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:49.896717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:49.349219Z","time spent":"547.409421ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:55:49.896745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.517048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-08-12T10:55:49.896793Z","caller":"traceutil/trace.go:171","msg":"trace[1358624019] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb; range_end:; response_count:1; response_revision:1293; }","duration":"440.613441ms","start":"2026-08-12T10:55:49.456166Z","end":"2026-08-12T10:55:49.89678Z","steps":["trace[1358624019] 'agreement among raft nodes before linearized reading' (duration: 440.468487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:49.896841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:49.45614Z","time spent":"440.687793ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3602,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" "} {"level":"warn","ts":"2026-08-12T10:55:49.896925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.676262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-12T10:55:49.896972Z","caller":"traceutil/trace.go:171","msg":"trace[1880924051] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1293; }","duration":"443.753284ms","start":"2026-08-12T10:55:49.453208Z","end":"2026-08-12T10:55:49.896961Z","steps":["trace[1880924051] 'agreement among raft nodes before linearized reading' (duration: 443.629071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:49.897007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:49.453192Z","time spent":"443.805795ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-12T10:55:49.897055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.889035ms","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-12T10:55:49.897091Z","caller":"traceutil/trace.go:171","msg":"trace[188225127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1293; }","duration":"420.942996ms","start":"2026-08-12T10:55:49.476139Z","end":"2026-08-12T10:55:49.897082Z","steps":["trace[188225127] 'agreement among raft nodes before linearized reading' (duration: 420.849524ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:49.897123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:49.476124Z","time spent":"420.992547ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-12T10:55:49.897225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.888716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-08-12T10:55:49.897344Z","caller":"traceutil/trace.go:171","msg":"trace[1395724932] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb; range_end:; response_count:1; response_revision:1293; }","duration":"137.123541ms","start":"2026-08-12T10:55:49.760193Z","end":"2026-08-12T10:55:49.897317Z","steps":["trace[1395724932] 'agreement among raft nodes before linearized reading' (duration: 136.629039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:50.14398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.169813ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:50.144087Z","caller":"traceutil/trace.go:171","msg":"trace[1496130114] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"236.485597ms","start":"2026-08-12T10:55:49.907576Z","end":"2026-08-12T10:55:50.144062Z","steps":["trace[1496130114] 'process raft request' (duration: 101.136879ms)","trace[1496130114] 'compare' (duration: 135.062671ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:50.14447Z","caller":"traceutil/trace.go:171","msg":"trace[935834310] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"232.823142ms","start":"2026-08-12T10:55:49.911628Z","end":"2026-08-12T10:55:50.144451Z","steps":["trace[935834310] 'process raft request' (duration: 232.643038ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:50.144625Z","caller":"traceutil/trace.go:171","msg":"trace[1172100006] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"229.122416ms","start":"2026-08-12T10:55:49.915475Z","end":"2026-08-12T10:55:50.144597Z","steps":["trace[1172100006] 'process raft request' (duration: 228.899511ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:50.405052Z","caller":"traceutil/trace.go:171","msg":"trace[1121272126] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"153.180889ms","start":"2026-08-12T10:55:50.251848Z","end":"2026-08-12T10:55:50.405029Z","steps":["trace[1121272126] 'process raft request' (duration: 153.053577ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:52.029362Z","caller":"traceutil/trace.go:171","msg":"trace[231028683] linearizableReadLoop","detail":"{readStateIndex:1349; appliedIndex:1348; }","duration":"121.926455ms","start":"2026-08-12T10:55:51.907409Z","end":"2026-08-12T10:55:52.029335Z","steps":["trace[231028683] 'read index received' (duration: 121.780861ms)","trace[231028683] 'applied index is now lower than readState.Index' (duration: 144.424µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:52.029432Z","caller":"traceutil/trace.go:171","msg":"trace[292303333] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"125.951117ms","start":"2026-08-12T10:55:51.903462Z","end":"2026-08-12T10:55:52.029413Z","steps":["trace[292303333] 'process raft request' (duration: 125.691451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:52.029598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.16571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb\" ","response":"range_response_count:1 size:3882"} {"level":"info","ts":"2026-08-12T10:55:52.029657Z","caller":"traceutil/trace.go:171","msg":"trace[357908507] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a2f88f2-f60f-4331-82dc-03e2e9780cbb; range_end:; response_count:1; response_revision:1301; }","duration":"122.274353ms","start":"2026-08-12T10:55:51.907369Z","end":"2026-08-12T10:55:52.029644Z","steps":["trace[357908507] 'agreement among raft nodes before linearized reading' (duration: 122.104659ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:52.364406Z","caller":"traceutil/trace.go:171","msg":"trace[1597386493] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1304; }","duration":"141.697169ms","start":"2026-08-12T10:55:52.222681Z","end":"2026-08-12T10:55:52.364378Z","steps":["trace[1597386493] 'process raft request' (duration: 141.507294ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:52.930442Z","caller":"traceutil/trace.go:171","msg":"trace[806860100] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"146.710614ms","start":"2026-08-12T10:55:52.783642Z","end":"2026-08-12T10:55:52.930353Z","steps":["trace[806860100] 'process raft request' (duration: 102.237018ms)","trace[806860100] 'compare' (duration: 44.176349ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:53.225193Z","caller":"traceutil/trace.go:171","msg":"trace[27903758] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"118.37804ms","start":"2026-08-12T10:55:53.106786Z","end":"2026-08-12T10:55:53.225164Z","steps":["trace[27903758] 'process raft request' (duration: 118.219855ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:53.532708Z","caller":"traceutil/trace.go:171","msg":"trace[1385113933] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"115.573234ms","start":"2026-08-12T10:55:53.417109Z","end":"2026-08-12T10:55:53.532682Z","steps":["trace[1385113933] 'process raft request' (duration: 115.096533ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:53.955668Z","caller":"traceutil/trace.go:171","msg":"trace[1163066141] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"125.712739ms","start":"2026-08-12T10:55:53.829928Z","end":"2026-08-12T10:55:53.955641Z","steps":["trace[1163066141] 'process raft request' (duration: 125.547924ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:54.079565Z","caller":"traceutil/trace.go:171","msg":"trace[877403870] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"112.971632ms","start":"2026-08-12T10:55:53.966558Z","end":"2026-08-12T10:55:54.079529Z","steps":["trace[877403870] 'process raft request' (duration: 38.176249ms)","trace[877403870] 'compare' (duration: 74.632499ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:54.27343Z","caller":"traceutil/trace.go:171","msg":"trace[1899160452] linearizableReadLoop","detail":"{readStateIndex:1369; appliedIndex:1368; }","duration":"173.948076ms","start":"2026-08-12T10:55:54.099452Z","end":"2026-08-12T10:55:54.2734Z","steps":["trace[1899160452] 'read index received' (duration: 114.006016ms)","trace[1899160452] 'applied index is now lower than readState.Index' (duration: 59.94095ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:54.273648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.190501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-08-12T10:55:54.273734Z","caller":"traceutil/trace.go:171","msg":"trace[278735762] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1320; }","duration":"174.309954ms","start":"2026-08-12T10:55:54.099402Z","end":"2026-08-12T10:55:54.273712Z","steps":["trace[278735762] 'agreement among raft nodes before linearized reading' (duration: 174.093699ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:54.273545Z","caller":"traceutil/trace.go:171","msg":"trace[612276029] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"188.355618ms","start":"2026-08-12T10:55:54.08515Z","end":"2026-08-12T10:55:54.273505Z","steps":["trace[612276029] 'process raft request' (duration: 128.408997ms)","trace[612276029] 'compare' (duration: 59.698826ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:58.808301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.076641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:55:58.808717Z","caller":"traceutil/trace.go:171","msg":"trace[1322329107] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"460.45177ms","start":"2026-08-12T10:55:58.348219Z","end":"2026-08-12T10:55:58.808671Z","steps":["trace[1322329107] 'process raft request' (duration: 50.909599ms)","trace[1322329107] 'compare' (duration: 408.836114ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:55:58.808822Z","caller":"traceutil/trace.go:171","msg":"trace[400910239] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"270.577012ms","start":"2026-08-12T10:55:58.538234Z","end":"2026-08-12T10:55:58.808811Z","steps":["trace[400910239] 'process raft request' (duration: 270.456789ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:55:58.808788Z","caller":"traceutil/trace.go:171","msg":"trace[1446337784] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"460.502491ms","start":"2026-08-12T10:55:58.348257Z","end":"2026-08-12T10:55:58.80876Z","steps":["trace[1446337784] 'process raft request' (duration: 460.150444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:58.808883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:58.348194Z","time spent":"460.600733ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:55:58.808746Z","caller":"traceutil/trace.go:171","msg":"trace[1832317355] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1386; }","duration":"371.250342ms","start":"2026-08-12T10:55:58.437478Z","end":"2026-08-12T10:55:58.808728Z","steps":["trace[1832317355] 'read index received' (duration: 304.661314ms)","trace[1832317355] 'applied index is now lower than readState.Index' (duration: 66.587818ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:55:58.808961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:58.348236Z","time spent":"460.637304ms","remote":"127.0.0.1:38784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:55:58.808909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.425706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:55:58.809354Z","caller":"traceutil/trace.go:171","msg":"trace[1572252204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1339; }","duration":"371.894777ms","start":"2026-08-12T10:55:58.437411Z","end":"2026-08-12T10:55:58.809306Z","steps":["trace[1572252204] 'agreement among raft nodes before linearized reading' (duration: 371.365336ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:55:58.809403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:55:58.437385Z","time spent":"372.006069ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-12T10:56:08.517353Z","caller":"traceutil/trace.go:171","msg":"trace[536634535] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"141.359801ms","start":"2026-08-12T10:56:08.375948Z","end":"2026-08-12T10:56:08.517308Z","steps":["trace[536634535] 'process raft request' (duration: 141.138416ms)"],"step_count":1}