{"level":"warn","ts":"2026-06-28T19:55:23.53979Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T19:55:23.539888Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-06-28T19:55:23.540042Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T19:55:23.540058Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-06-28T19:55:23.540084Z","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-06-28T19:55:23.540913Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-06-28T19:55:23.540995Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-06-28T19:55:23.543421Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.116276ms"} {"level":"info","ts":"2026-06-28T19:55:23.548137Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-06-28T19:55:23.548197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-06-28T19:55:23.548214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-06-28T19:55:23.548229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-28T19:55:23.548236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-06-28T19:55:23.548264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-06-28T19:55:23.552292Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-28T19:55:23.553575Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-28T19:55:23.55589Z","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-06-28T19:55:23.564548Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-28T19:55:23.56472Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-28T19:55:23.564789Z","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-06-28T19:55:23.564822Z","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-06-28T19:55:23.56483Z","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-06-28T19:55:23.565568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-06-28T19:55:23.566596Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-06-28T19:55:23.570834Z","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-06-28T19:55:23.571006Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-28T19:55:23.571035Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-28T19:55:23.571104Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-06-28T19:55:23.571116Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-06-28T19:55:24.549174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-06-28T19:55:24.549229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-28T19:55:24.54927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-06-28T19:55:24.549285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-06-28T19:55:24.549301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-06-28T19:55:24.549313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-06-28T19:55:24.549323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-06-28T19:55:24.550085Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-06-28T19:55:24.55011Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:55:24.550252Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:55:24.550225Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:55:24.55074Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-28T19:55:24.550832Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-28T19:55:24.550918Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:55:24.551062Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:55:24.55111Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:55:24.552713Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-28T19:55:24.55334Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-06-28T19:55:27.441636Z","caller":"traceutil/trace.go:171","msg":"trace[1766227650] transaction","detail":"{read_only:false; response_revision:180; number_of_response:1; }","duration":"170.583242ms","start":"2026-06-28T19:55:27.271034Z","end":"2026-06-28T19:55:27.441617Z","steps":["trace[1766227650] 'process raft request' (duration: 170.170511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:55:28.63366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.02483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:55:28.633783Z","caller":"traceutil/trace.go:171","msg":"trace[1313589974] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:204; }","duration":"370.212494ms","start":"2026-06-28T19:55:28.263554Z","end":"2026-06-28T19:55:28.633767Z","steps":["trace[1313589974] 'range keys from in-memory index tree' (duration: 369.905276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:55:28.633826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:55:28.263527Z","time spent":"370.290628ms","remote":"127.0.0.1:57582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-06-28T19:55:28.633716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.361501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:55:28.633967Z","caller":"traceutil/trace.go:171","msg":"trace[667856392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:204; }","duration":"518.632759ms","start":"2026-06-28T19:55:28.115282Z","end":"2026-06-28T19:55:28.633915Z","steps":["trace[667856392] 'range keys from in-memory index tree' (duration: 518.260338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:55:28.634031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:55:28.115261Z","time spent":"518.753362ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:55:28.635133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.120427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"info","ts":"2026-06-28T19:55:28.635392Z","caller":"traceutil/trace.go:171","msg":"trace[1116836483] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:204; }","duration":"471.318803ms","start":"2026-06-28T19:55:28.163921Z","end":"2026-06-28T19:55:28.63524Z","steps":["trace[1116836483] 'range keys from in-memory index tree' (duration: 469.942865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:55:28.635604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:55:28.163897Z","time spent":"471.681582ms","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-28T19:55:29.141446Z","caller":"traceutil/trace.go:171","msg":"trace[2049597693] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"503.374874ms","start":"2026-06-28T19:55:28.637779Z","end":"2026-06-28T19:55:29.141153Z","steps":["trace[2049597693] 'process raft request' (duration: 503.2062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:55:29.141893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:55:28.637738Z","time spent":"503.771895ms","remote":"127.0.0.1:57634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:55:29.144748Z","caller":"traceutil/trace.go:171","msg":"trace[1365764238] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"500.761604ms","start":"2026-06-28T19:55:28.643972Z","end":"2026-06-28T19:55:29.144733Z","steps":["trace[1365764238] 'process raft request' (duration: 500.710542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:55:29.144967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:55:28.643939Z","time spent":"500.856516ms","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:55:29.144889Z","caller":"traceutil/trace.go:171","msg":"trace[1786186456] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"503.945927ms","start":"2026-06-28T19:55:28.640858Z","end":"2026-06-28T19:55:29.144804Z","steps":["trace[1786186456] 'process raft request' (duration: 503.743872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:55:29.145229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:55:28.640834Z","time spent":"504.240176ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:55:33.289166Z","caller":"traceutil/trace.go:171","msg":"trace[1546996851] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"121.740064ms","start":"2026-06-28T19:55:33.167355Z","end":"2026-06-28T19:55:33.289095Z","steps":["trace[1546996851] 'process raft request' (duration: 121.57021ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:55:33.290012Z","caller":"traceutil/trace.go:171","msg":"trace[103713937] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"108.975995ms","start":"2026-06-28T19:55:33.181011Z","end":"2026-06-28T19:55:33.289987Z","steps":["trace[103713937] 'process raft request' (duration: 108.858562ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:01.554749Z","caller":"traceutil/trace.go:171","msg":"trace[1503026700] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"906.578119ms","start":"2026-06-28T19:56:00.648145Z","end":"2026-06-28T19:56:01.554723Z","steps":["trace[1503026700] 'process raft request' (duration: 906.415294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.555046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.648124Z","time spent":"906.862596ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:56:01.56332Z","caller":"traceutil/trace.go:171","msg":"trace[1414409465] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"912.380051ms","start":"2026-06-28T19:56:00.650913Z","end":"2026-06-28T19:56:01.563293Z","steps":["trace[1414409465] 'process raft request' (duration: 912.168956ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:01.563747Z","caller":"traceutil/trace.go:171","msg":"trace[2093257454] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"854.952858ms","start":"2026-06-28T19:56:00.708788Z","end":"2026-06-28T19:56:01.56374Z","steps":["trace[2093257454] 'process raft request' (duration: 854.835535ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:01.563717Z","caller":"traceutil/trace.go:171","msg":"trace[1668461765] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"875.916857ms","start":"2026-06-28T19:56:00.687778Z","end":"2026-06-28T19:56:01.563695Z","steps":["trace[1668461765] 'process raft request' (duration: 875.799354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.563826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.708752Z","time spent":"855.01527ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:56:01.563836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.687756Z","time spent":"876.03954ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:56:01.563939Z","caller":"traceutil/trace.go:171","msg":"trace[210805648] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"703.241565ms","start":"2026-06-28T19:56:00.86069Z","end":"2026-06-28T19:56:01.563932Z","steps":["trace[210805648] 'process raft request' (duration: 703.069541ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:01.56403Z","caller":"traceutil/trace.go:171","msg":"trace[1028505617] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:499; }","duration":"137.507913ms","start":"2026-06-28T19:56:01.426506Z","end":"2026-06-28T19:56:01.564014Z","steps":["trace[1028505617] 'read index received' (duration: 128.177041ms)","trace[1028505617] 'applied index is now lower than readState.Index' (duration: 9.329771ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:01.564171Z","caller":"traceutil/trace.go:171","msg":"trace[1333468226] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"793.048228ms","start":"2026-06-28T19:56:00.771101Z","end":"2026-06-28T19:56:01.564149Z","steps":["trace[1333468226] 'process raft request' (duration: 792.563785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.564247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.771074Z","time spent":"793.132342ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:56:01.563515Z","caller":"traceutil/trace.go:171","msg":"trace[715090426] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"903.472052ms","start":"2026-06-28T19:56:00.66003Z","end":"2026-06-28T19:56:01.563502Z","steps":["trace[715090426] 'process raft request' (duration: 903.264895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.564369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.65999Z","time spent":"904.340316ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:56:01.563984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.860648Z","time spent":"703.316557ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:56:01.56354Z","caller":"traceutil/trace.go:171","msg":"trace[409160930] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"912.559367ms","start":"2026-06-28T19:56:00.650976Z","end":"2026-06-28T19:56:01.563536Z","steps":["trace[409160930] 'process raft request' (duration: 912.205096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.564516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.650972Z","time spent":"913.504244ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:56:01.563581Z","caller":"traceutil/trace.go:171","msg":"trace[736310634] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"899.49819ms","start":"2026-06-28T19:56:00.664076Z","end":"2026-06-28T19:56:01.563574Z","steps":["trace[736310634] 'process raft request' (duration: 899.343215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.56458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.664047Z","time spent":"900.504228ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:56:01.563601Z","caller":"traceutil/trace.go:171","msg":"trace[778507779] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"899.51374ms","start":"2026-06-28T19:56:00.664081Z","end":"2026-06-28T19:56:01.563595Z","steps":["trace[778507779] 'process raft request' (duration: 899.293233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.564701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.664063Z","time spent":"900.615231ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:56:01.563622Z","caller":"traceutil/trace.go:171","msg":"trace[1554130575] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"895.426315ms","start":"2026-06-28T19:56:00.668191Z","end":"2026-06-28T19:56:01.563618Z","steps":["trace[1554130575] 'process raft request' (duration: 895.297131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.564833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.66818Z","time spent":"896.635699ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:56:01.563637Z","caller":"traceutil/trace.go:171","msg":"trace[788842103] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"898.043179ms","start":"2026-06-28T19:56:00.66559Z","end":"2026-06-28T19:56:01.563633Z","steps":["trace[788842103] 'process raft request' (duration: 897.864874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.5649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.665577Z","time spent":"899.310724ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:56:01.563677Z","caller":"traceutil/trace.go:171","msg":"trace[1721191918] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"875.785393ms","start":"2026-06-28T19:56:00.687885Z","end":"2026-06-28T19:56:01.56367Z","steps":["trace[1721191918] 'process raft request' (duration: 875.64532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:01.564961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.687877Z","time spent":"877.072259ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:56:01.569024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:00.650898Z","time spent":"912.815874ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:56:01.571701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.183858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-28T19:56:01.571768Z","caller":"traceutil/trace.go:171","msg":"trace[1465262862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:496; }","duration":"145.26181ms","start":"2026-06-28T19:56:01.426492Z","end":"2026-06-28T19:56:01.571753Z","steps":["trace[1465262862] 'agreement among raft nodes before linearized reading' (duration: 137.578054ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:04.085378Z","caller":"traceutil/trace.go:171","msg":"trace[947028454] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:583; }","duration":"198.150935ms","start":"2026-06-28T19:56:03.887208Z","end":"2026-06-28T19:56:04.085359Z","steps":["trace[947028454] 'read index received' (duration: 198.00318ms)","trace[947028454] 'applied index is now lower than readState.Index' (duration: 146.645µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:04.0855Z","caller":"traceutil/trace.go:171","msg":"trace[1215463787] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"492.824785ms","start":"2026-06-28T19:56:03.592665Z","end":"2026-06-28T19:56:04.08549Z","steps":["trace[1215463787] 'process raft request' (duration: 492.574398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.08559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:03.59264Z","time spent":"492.885897ms","remote":"127.0.0.1:57712","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-06-28T19:56:04.085792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.739271ms","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-06-28T19:56:04.085864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.650029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:04.085877Z","caller":"traceutil/trace.go:171","msg":"trace[66108007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:563; }","duration":"120.881145ms","start":"2026-06-28T19:56:03.964976Z","end":"2026-06-28T19:56:04.085857Z","steps":["trace[66108007] 'agreement among raft nodes before linearized reading' (duration: 120.665449ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:04.085908Z","caller":"traceutil/trace.go:171","msg":"trace[1978653800] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"198.714191ms","start":"2026-06-28T19:56:03.887183Z","end":"2026-06-28T19:56:04.085898Z","steps":["trace[1978653800] 'agreement among raft nodes before linearized reading' (duration: 198.652069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.543892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.898732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:56:04.543987Z","caller":"traceutil/trace.go:171","msg":"trace[233217181] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:584; }","duration":"443.657645ms","start":"2026-06-28T19:56:04.100314Z","end":"2026-06-28T19:56:04.543972Z","steps":["trace[233217181] 'read index received' (duration: 110.431273ms)","trace[233217181] 'applied index is now lower than readState.Index' (duration: 333.225392ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:04.543996Z","caller":"traceutil/trace.go:171","msg":"trace[823852552] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"451.851115ms","start":"2026-06-28T19:56:04.092129Z","end":"2026-06-28T19:56:04.54398Z","steps":["trace[823852552] 'process raft request' (duration: 118.635934ms)","trace[823852552] 'compare' (duration: 332.775709ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:56:04.544084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:04.092105Z","time spent":"451.926037ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:56:04.54411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.791168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:04.544174Z","caller":"traceutil/trace.go:171","msg":"trace[1619559503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"443.890111ms","start":"2026-06-28T19:56:04.100267Z","end":"2026-06-28T19:56:04.544157Z","steps":["trace[1619559503] 'agreement among raft nodes before linearized reading' (duration: 443.800139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.544178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.781849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-28T19:56:04.544209Z","caller":"traceutil/trace.go:171","msg":"trace[443166008] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"416.869111ms","start":"2026-06-28T19:56:04.127331Z","end":"2026-06-28T19:56:04.5442Z","steps":["trace[443166008] 'agreement among raft nodes before linearized reading' (duration: 416.747748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.544207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:04.100251Z","time spent":"443.949232ms","remote":"127.0.0.1:57446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T19:56:04.54425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:04.127313Z","time spent":"416.929573ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-28T19:56:04.544486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.517544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:04.544522Z","caller":"traceutil/trace.go:171","msg":"trace[1664387457] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:564; }","duration":"105.571457ms","start":"2026-06-28T19:56:04.438941Z","end":"2026-06-28T19:56:04.544513Z","steps":["trace[1664387457] 'agreement among raft nodes before linearized reading' (duration: 105.518844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.54453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.002159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:56:04.544665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.37386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:04.544698Z","caller":"traceutil/trace.go:171","msg":"trace[1145475257] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:564; }","duration":"168.218957ms","start":"2026-06-28T19:56:04.376464Z","end":"2026-06-28T19:56:04.544683Z","steps":["trace[1145475257] 'agreement among raft nodes before linearized reading' (duration: 168.020151ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:04.544705Z","caller":"traceutil/trace.go:171","msg":"trace[833268107] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:564; }","duration":"168.427693ms","start":"2026-06-28T19:56:04.376269Z","end":"2026-06-28T19:56:04.544697Z","steps":["trace[833268107] 'agreement among raft nodes before linearized reading' (duration: 168.369891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.544832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.638078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:04.544866Z","caller":"traceutil/trace.go:171","msg":"trace[1438487349] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:564; }","duration":"168.69723ms","start":"2026-06-28T19:56:04.376162Z","end":"2026-06-28T19:56:04.544859Z","steps":["trace[1438487349] 'agreement among raft nodes before linearized reading' (duration: 168.649999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.544917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.705667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:04.544942Z","caller":"traceutil/trace.go:171","msg":"trace[459696782] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:564; }","duration":"106.750489ms","start":"2026-06-28T19:56:04.438186Z","end":"2026-06-28T19:56:04.544936Z","steps":["trace[459696782] 'agreement among raft nodes before linearized reading' (duration: 106.713178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.545011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.682007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:56:04.545013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.560721ms","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-06-28T19:56:04.545029Z","caller":"traceutil/trace.go:171","msg":"trace[476583691] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:564; }","duration":"106.733598ms","start":"2026-06-28T19:56:04.438291Z","end":"2026-06-28T19:56:04.545025Z","steps":["trace[476583691] 'agreement among raft nodes before linearized reading' (duration: 106.707068ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:04.54504Z","caller":"traceutil/trace.go:171","msg":"trace[331572587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:564; }","duration":"391.621162ms","start":"2026-06-28T19:56:04.153411Z","end":"2026-06-28T19:56:04.545032Z","steps":["trace[331572587] 'agreement among raft nodes before linearized reading' (duration: 391.54139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:04.545066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:04.153391Z","time spent":"391.669173ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-28T19:56:04.545112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.796875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:56:04.545149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.867117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:04.545168Z","caller":"traceutil/trace.go:171","msg":"trace[1059210039] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:564; }","duration":"135.911208ms","start":"2026-06-28T19:56:04.409253Z","end":"2026-06-28T19:56:04.545164Z","steps":["trace[1059210039] 'agreement among raft nodes before linearized reading' (duration: 135.884997ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:04.545146Z","caller":"traceutil/trace.go:171","msg":"trace[272302524] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:564; }","duration":"135.833816ms","start":"2026-06-28T19:56:04.409303Z","end":"2026-06-28T19:56:04.545137Z","steps":["trace[272302524] 'agreement among raft nodes before linearized reading' (duration: 135.779895ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:08.239837Z","caller":"traceutil/trace.go:171","msg":"trace[579772019] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"111.664067ms","start":"2026-06-28T19:56:08.128146Z","end":"2026-06-28T19:56:08.23981Z","steps":["trace[579772019] 'process raft request' (duration: 111.05486ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:08.567082Z","caller":"traceutil/trace.go:171","msg":"trace[1691074488] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"286.991992ms","start":"2026-06-28T19:56:08.280071Z","end":"2026-06-28T19:56:08.567063Z","steps":["trace[1691074488] 'process raft request' (duration: 286.816927ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:08.64303Z","caller":"traceutil/trace.go:171","msg":"trace[973583463] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"346.934266ms","start":"2026-06-28T19:56:08.296073Z","end":"2026-06-28T19:56:08.643007Z","steps":["trace[973583463] 'process raft request' (duration: 346.785601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:08.643382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:08.296056Z","time spent":"347.201754ms","remote":"127.0.0.1:57910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:56:09.904025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.236483725s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:56:09.904368Z","caller":"traceutil/trace.go:171","msg":"trace[1285380908] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:615; }","duration":"1.248891104s","start":"2026-06-28T19:56:08.65546Z","end":"2026-06-28T19:56:09.904351Z","steps":["trace[1285380908] 'read index received' (duration: 12.179523ms)","trace[1285380908] 'applied index is now lower than readState.Index' (duration: 1.236710751s)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:09.904384Z","caller":"traceutil/trace.go:171","msg":"trace[280470479] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.255716236s","start":"2026-06-28T19:56:08.648648Z","end":"2026-06-28T19:56:09.904364Z","steps":["trace[280470479] 'process raft request' (duration: 1.255478949s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:09.904479Z","caller":"traceutil/trace.go:171","msg":"trace[154562732] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.255425009s","start":"2026-06-28T19:56:08.649019Z","end":"2026-06-28T19:56:09.904444Z","steps":["trace[154562732] 'process raft request' (duration: 1.255292044s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:09.904518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.24905616s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:09.904561Z","caller":"traceutil/trace.go:171","msg":"trace[813028470] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:596; }","duration":"1.249122192s","start":"2026-06-28T19:56:08.655424Z","end":"2026-06-28T19:56:09.904546Z","steps":["trace[813028470] 'agreement among raft nodes before linearized reading' (duration: 1.24905025s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:09.904488Z","caller":"traceutil/trace.go:171","msg":"trace[1396766641] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.256262522s","start":"2026-06-28T19:56:08.648169Z","end":"2026-06-28T19:56:09.904432Z","steps":["trace[1396766641] 'process raft request' (duration: 19.282553ms)","trace[1396766641] 'compare' (duration: 1.236064933s)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:56:09.904604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:08.655406Z","time spent":"1.249187023s","remote":"127.0.0.1:57684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-28T19:56:09.904617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:08.649011Z","time spent":"1.255532592s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:56:09.904631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:08.648627Z","time spent":"1.255926042s","remote":"127.0.0.1:57712","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-06-28T19:56:09.904733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:08.648149Z","time spent":"1.256500768s","remote":"127.0.0.1:57712","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-06-28T19:56:09.904759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042707651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:09.90478Z","caller":"traceutil/trace.go:171","msg":"trace[852830825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"1.042764053s","start":"2026-06-28T19:56:08.862009Z","end":"2026-06-28T19:56:09.904773Z","steps":["trace[852830825] 'agreement among raft nodes before linearized reading' (duration: 1.042728652s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:09.904795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:08.861989Z","time spent":"1.042803165s","remote":"127.0.0.1:57448","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-06-28T19:56:11.751192Z","caller":"traceutil/trace.go:171","msg":"trace[50837488] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"271.93392ms","start":"2026-06-28T19:56:11.479236Z","end":"2026-06-28T19:56:11.75117Z","steps":["trace[50837488] 'process raft request' (duration: 271.792846ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:12.507588Z","caller":"traceutil/trace.go:171","msg":"trace[809970708] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"149.238453ms","start":"2026-06-28T19:56:12.358324Z","end":"2026-06-28T19:56:12.507563Z","steps":["trace[809970708] 'process raft request' (duration: 56.193309ms)","trace[809970708] 'compare' (duration: 92.89031ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:12.737229Z","caller":"traceutil/trace.go:171","msg":"trace[1874126205] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"221.450442ms","start":"2026-06-28T19:56:12.515752Z","end":"2026-06-28T19:56:12.737203Z","steps":["trace[1874126205] 'process raft request' (duration: 220.069803ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:13.535689Z","caller":"traceutil/trace.go:171","msg":"trace[683643078] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"171.512699ms","start":"2026-06-28T19:56:13.364057Z","end":"2026-06-28T19:56:13.53557Z","steps":["trace[683643078] 'process raft request' (duration: 171.321184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:13.780541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.471477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-06-28T19:56:13.780648Z","caller":"traceutil/trace.go:171","msg":"trace[1888390663] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:657; }","duration":"103.612362ms","start":"2026-06-28T19:56:13.676993Z","end":"2026-06-28T19:56:13.780605Z","steps":["trace[1888390663] 'range keys from in-memory index tree' (duration: 103.17437ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:21.749006Z","caller":"traceutil/trace.go:171","msg":"trace[1342888676] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"322.5154ms","start":"2026-06-28T19:56:21.426467Z","end":"2026-06-28T19:56:21.748983Z","steps":["trace[1342888676] 'process raft request' (duration: 322.439848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:21.749162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:21.426459Z","time spent":"322.624843ms","remote":"127.0.0.1:57882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3852,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:56:21.749133Z","caller":"traceutil/trace.go:171","msg":"trace[1503912769] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"324.616839ms","start":"2026-06-28T19:56:21.424467Z","end":"2026-06-28T19:56:21.749084Z","steps":["trace[1503912769] 'process raft request' (duration: 324.27906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:21.749309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:21.424449Z","time spent":"324.776334ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:56:24.554994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.774109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-28T19:56:24.555122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.13172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9ncjm\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-06-28T19:56:24.55519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.562211ms","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-06-28T19:56:24.555205Z","caller":"traceutil/trace.go:171","msg":"trace[612971632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"584.993014ms","start":"2026-06-28T19:56:23.970153Z","end":"2026-06-28T19:56:24.555146Z","steps":["trace[612971632] 'range keys from in-memory index tree' (duration: 584.579614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:24.555019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.4752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-28T19:56:24.555019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.718477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-28T19:56:24.555389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:23.970142Z","time spent":"585.17141ms","remote":"127.0.0.1:57712","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":"info","ts":"2026-06-28T19:56:24.555503Z","caller":"traceutil/trace.go:171","msg":"trace[823570546] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9ncjm; range_end:; response_count:1; response_revision:752; }","duration":"154.215332ms","start":"2026-06-28T19:56:24.400944Z","end":"2026-06-28T19:56:24.55516Z","steps":["trace[823570546] 'range keys from in-memory index tree' (duration: 154.035818ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:24.555596Z","caller":"traceutil/trace.go:171","msg":"trace[1415892624] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:752; }","duration":"585.644113ms","start":"2026-06-28T19:56:23.969579Z","end":"2026-06-28T19:56:24.555223Z","steps":["trace[1415892624] 'range keys from in-memory index tree' (duration: 585.458168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:24.55567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:23.969556Z","time spent":"586.098396ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-28T19:56:24.556038Z","caller":"traceutil/trace.go:171","msg":"trace[958405589] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:752; }","duration":"585.125298ms","start":"2026-06-28T19:56:23.970209Z","end":"2026-06-28T19:56:24.555334Z","steps":["trace[958405589] 'range keys from in-memory index tree' (duration: 584.545213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:24.556089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:23.970187Z","time spent":"585.890011ms","remote":"127.0.0.1:57712","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":"info","ts":"2026-06-28T19:56:24.555786Z","caller":"traceutil/trace.go:171","msg":"trace[883115411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:752; }","duration":"311.841711ms","start":"2026-06-28T19:56:24.243488Z","end":"2026-06-28T19:56:24.55533Z","steps":["trace[883115411] 'range keys from in-memory index tree' (duration: 311.346238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:24.556398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:24.243469Z","time spent":"312.900341ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:56:25.701931Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.141689986s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:56:25.702461Z","caller":"traceutil/trace.go:171","msg":"trace[1759995356] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"1.142290453s","start":"2026-06-28T19:56:24.560136Z","end":"2026-06-28T19:56:25.702426Z","steps":["trace[1759995356] 'process raft request' (duration: 1.142103928s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:25.702671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:24.560113Z","time spent":"1.142447357s","remote":"127.0.0.1:57712","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-06-28T19:56:25.709061Z","caller":"traceutil/trace.go:171","msg":"trace[649790337] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:778; }","duration":"352.955146ms","start":"2026-06-28T19:56:25.356087Z","end":"2026-06-28T19:56:25.709043Z","steps":["trace[649790337] 'read index received' (duration: 346.181507ms)","trace[649790337] 'applied index is now lower than readState.Index' (duration: 6.772589ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:56:25.709199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.092711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:56:25.70925Z","caller":"traceutil/trace.go:171","msg":"trace[1682581454] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:757; }","duration":"353.211614ms","start":"2026-06-28T19:56:25.356028Z","end":"2026-06-28T19:56:25.70924Z","steps":["trace[1682581454] 'agreement among raft nodes before linearized reading' (duration: 353.07135ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:25.709238Z","caller":"traceutil/trace.go:171","msg":"trace[1155325292] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"1.148833596s","start":"2026-06-28T19:56:24.560376Z","end":"2026-06-28T19:56:25.70921Z","steps":["trace[1155325292] 'process raft request' (duration: 1.148460695s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:25.709288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:25.356007Z","time spent":"353.270176ms","remote":"127.0.0.1:57790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":67,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-06-28T19:56:25.709282Z","caller":"traceutil/trace.go:171","msg":"trace[1790741672] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"1.148749834s","start":"2026-06-28T19:56:24.560489Z","end":"2026-06-28T19:56:25.709239Z","steps":["trace[1790741672] 'process raft request' (duration: 1.148464445s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:25.709387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:24.560349Z","time spent":"1.148950119s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:56:25.709334Z","caller":"traceutil/trace.go:171","msg":"trace[1117394514] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"1.147644584s","start":"2026-06-28T19:56:24.561562Z","end":"2026-06-28T19:56:25.709206Z","steps":["trace[1117394514] 'process raft request' (duration: 1.147440967s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:25.709485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:24.560466Z","time spent":"1.148921319s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:56:25.709642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:24.561546Z","time spent":"1.147948571s","remote":"127.0.0.1:57634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:56:25.709957Z","caller":"traceutil/trace.go:171","msg":"trace[1506408959] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"1.149376451s","start":"2026-06-28T19:56:24.560558Z","end":"2026-06-28T19:56:25.709934Z","steps":["trace[1506408959] 'process raft request' (duration: 1.148421404s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:25.71005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:24.560551Z","time spent":"1.149441394s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:56:30.067832Z","caller":"traceutil/trace.go:171","msg":"trace[1945218298] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"122.84088ms","start":"2026-06-28T19:56:29.944965Z","end":"2026-06-28T19:56:30.067806Z","steps":["trace[1945218298] 'process raft request' (duration: 121.904724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:41.992402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.23293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:56:41.992476Z","caller":"traceutil/trace.go:171","msg":"trace[1210789612] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"134.612282ms","start":"2026-06-28T19:56:41.857847Z","end":"2026-06-28T19:56:41.99246Z","steps":["trace[1210789612] 'process raft request' (duration: 10.264139ms)","trace[1210789612] 'compare' (duration: 124.093426ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:41.99302Z","caller":"traceutil/trace.go:171","msg":"trace[1508453783] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"134.795418ms","start":"2026-06-28T19:56:41.858192Z","end":"2026-06-28T19:56:41.992988Z","steps":["trace[1508453783] 'process raft request' (duration: 134.638674ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:41.993273Z","caller":"traceutil/trace.go:171","msg":"trace[1027465965] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"134.889059ms","start":"2026-06-28T19:56:41.858366Z","end":"2026-06-28T19:56:41.993255Z","steps":["trace[1027465965] 'process raft request' (duration: 134.582281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:41.993395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.459184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:41.993286Z","caller":"traceutil/trace.go:171","msg":"trace[705363185] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:932; }","duration":"131.34879ms","start":"2026-06-28T19:56:41.86191Z","end":"2026-06-28T19:56:41.993259Z","steps":["trace[705363185] 'read index received' (duration: 6.302217ms)","trace[705363185] 'applied index is now lower than readState.Index' (duration: 125.045073ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:41.993416Z","caller":"traceutil/trace.go:171","msg":"trace[195269643] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"134.349855ms","start":"2026-06-28T19:56:41.859047Z","end":"2026-06-28T19:56:41.993397Z","steps":["trace[195269643] 'process raft request' (duration: 134.121438ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:41.993451Z","caller":"traceutil/trace.go:171","msg":"trace[1109553231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:905; }","duration":"131.559616ms","start":"2026-06-28T19:56:41.861879Z","end":"2026-06-28T19:56:41.993439Z","steps":["trace[1109553231] 'agreement among raft nodes before linearized reading' (duration: 131.462933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:46.119151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.339643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-28T19:56:46.119235Z","caller":"traceutil/trace.go:171","msg":"trace[1176009245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:914; }","duration":"103.461087ms","start":"2026-06-28T19:56:46.015752Z","end":"2026-06-28T19:56:46.119213Z","steps":["trace[1176009245] 'range keys from in-memory index tree' (duration: 103.183559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:46.119258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.22638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:56:46.119293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.067205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-28T19:56:46.11933Z","caller":"traceutil/trace.go:171","msg":"trace[1409499860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:914; }","duration":"109.113296ms","start":"2026-06-28T19:56:46.010205Z","end":"2026-06-28T19:56:46.119318Z","steps":["trace[1409499860] 'range keys from in-memory index tree' (duration: 109.015453ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:46.119333Z","caller":"traceutil/trace.go:171","msg":"trace[1657106271] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:914; }","duration":"135.333032ms","start":"2026-06-28T19:56:45.983984Z","end":"2026-06-28T19:56:46.119317Z","steps":["trace[1657106271] 'count revisions from in-memory index tree' (duration: 135.163787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:46.119232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.241349ms","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-06-28T19:56:46.119407Z","caller":"traceutil/trace.go:171","msg":"trace[1618125508] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:914; }","duration":"109.530567ms","start":"2026-06-28T19:56:46.009873Z","end":"2026-06-28T19:56:46.119404Z","steps":["trace[1618125508] 'range keys from in-memory index tree' (duration: 109.021332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:46.119437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.481421ms","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-06-28T19:56:46.119987Z","caller":"traceutil/trace.go:171","msg":"trace[1619149226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:914; }","duration":"112.075418ms","start":"2026-06-28T19:56:46.007894Z","end":"2026-06-28T19:56:46.119969Z","steps":["trace[1619149226] 'range keys from in-memory index tree' (duration: 111.291047ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:46.240421Z","caller":"traceutil/trace.go:171","msg":"trace[325761202] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"115.662479ms","start":"2026-06-28T19:56:46.124725Z","end":"2026-06-28T19:56:46.240388Z","steps":["trace[325761202] 'process raft request' (duration: 113.792096ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:46.24042Z","caller":"traceutil/trace.go:171","msg":"trace[378369318] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"115.621938ms","start":"2026-06-28T19:56:46.124776Z","end":"2026-06-28T19:56:46.240398Z","steps":["trace[378369318] 'process raft request' (duration: 115.486015ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:46.240562Z","caller":"traceutil/trace.go:171","msg":"trace[49584841] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"114.946819ms","start":"2026-06-28T19:56:46.125588Z","end":"2026-06-28T19:56:46.240535Z","steps":["trace[49584841] 'process raft request' (duration: 114.753944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:00.860771Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873732597130268,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:57:01.361167Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873732597130268,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:57:01.688715Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.353018453s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:57:01.689744Z","caller":"traceutil/trace.go:171","msg":"trace[2076778929] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"1.354110043s","start":"2026-06-28T19:57:00.335612Z","end":"2026-06-28T19:57:01.689722Z","steps":["trace[2076778929] 'process raft request' (duration: 1.353949628s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:01.689898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:00.335587Z","time spent":"1.354222065s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:03.747353Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.05845822s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:57:03.74767Z","caller":"traceutil/trace.go:171","msg":"trace[38047793] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1000; }","duration":"3.387115392s","start":"2026-06-28T19:57:00.360533Z","end":"2026-06-28T19:57:03.747649Z","steps":["trace[38047793] 'read index received' (duration: 1.329077473s)","trace[38047793] 'applied index is now lower than readState.Index' (duration: 2.058036919s)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:03.747805Z","caller":"traceutil/trace.go:171","msg":"trace[1373199209] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"2.808367515s","start":"2026-06-28T19:57:00.939412Z","end":"2026-06-28T19:57:03.747779Z","steps":["trace[1373199209] 'process raft request' (duration: 2.808110018s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.74788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.387336608s","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-06-28T19:57:03.747916Z","caller":"traceutil/trace.go:171","msg":"trace[746727719] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:967; }","duration":"3.387419s","start":"2026-06-28T19:57:00.360485Z","end":"2026-06-28T19:57:03.747904Z","steps":["trace[746727719] 'agreement among raft nodes before linearized reading' (duration: 3.387282246s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.747927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:00.939388Z","time spent":"2.808471027s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:03.747958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:00.360466Z","time spent":"3.387484111s","remote":"127.0.0.1:57712","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":"info","ts":"2026-06-28T19:57:03.796553Z","caller":"traceutil/trace.go:171","msg":"trace[1768827372] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"880.855073ms","start":"2026-06-28T19:57:02.915673Z","end":"2026-06-28T19:57:03.796528Z","steps":["trace[1768827372] 'process raft request' (duration: 880.537444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.796677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.915648Z","time spent":"880.964716ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:03.79696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.434657172s","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-06-28T19:57:03.797045Z","caller":"traceutil/trace.go:171","msg":"trace[880085327] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:969; }","duration":"3.434772715s","start":"2026-06-28T19:57:00.362233Z","end":"2026-06-28T19:57:03.797006Z","steps":["trace[880085327] 'agreement among raft nodes before linearized reading' (duration: 3.434534759s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.797087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.897857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-28T19:57:03.797086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:00.362223Z","time spent":"3.434852228s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-28T19:57:03.797132Z","caller":"traceutil/trace.go:171","msg":"trace[187233665] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:969; }","duration":"891.99902ms","start":"2026-06-28T19:57:02.905121Z","end":"2026-06-28T19:57:03.79712Z","steps":["trace[187233665] 'agreement among raft nodes before linearized reading' (duration: 891.912587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.797161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.90509Z","time spent":"892.062902ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:57:03.797177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.267289811s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:03.797227Z","caller":"traceutil/trace.go:171","msg":"trace[1829021537] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:969; }","duration":"1.267368203s","start":"2026-06-28T19:57:02.529843Z","end":"2026-06-28T19:57:03.797211Z","steps":["trace[1829021537] 'agreement among raft nodes before linearized reading' (duration: 1.267274101s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.79724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.827393135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:57:03.797274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.529826Z","time spent":"1.267435705s","remote":"127.0.0.1:57674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-06-28T19:57:03.797293Z","caller":"traceutil/trace.go:171","msg":"trace[2126615806] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:969; }","duration":"1.827462397s","start":"2026-06-28T19:57:01.969798Z","end":"2026-06-28T19:57:03.797261Z","steps":["trace[2126615806] 'agreement among raft nodes before linearized reading' (duration: 1.827413485s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.797325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:01.969778Z","time spent":"1.827534279s","remote":"127.0.0.1:57542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:57:03.797346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.748502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-28T19:57:03.797388Z","caller":"traceutil/trace.go:171","msg":"trace[610661042] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:969; }","duration":"102.787773ms","start":"2026-06-28T19:57:03.69459Z","end":"2026-06-28T19:57:03.797378Z","steps":["trace[610661042] 'agreement among raft nodes before linearized reading' (duration: 102.67352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.797516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.935546845s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:57:03.797699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.435244488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-28T19:57:03.797726Z","caller":"traceutil/trace.go:171","msg":"trace[1998278653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:969; }","duration":"3.435280079s","start":"2026-06-28T19:57:00.362436Z","end":"2026-06-28T19:57:03.797716Z","steps":["trace[1998278653] 'agreement among raft nodes before linearized reading' (duration: 3.435213058s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.797746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:00.362426Z","time spent":"3.43531525s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-28T19:57:03.797572Z","caller":"traceutil/trace.go:171","msg":"trace[1773630229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"1.935604346s","start":"2026-06-28T19:57:01.861932Z","end":"2026-06-28T19:57:03.797536Z","steps":["trace[1773630229] 'agreement among raft nodes before linearized reading' (duration: 1.935557564s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.797829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.111377129s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:03.797849Z","caller":"traceutil/trace.go:171","msg":"trace[1331599398] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:969; }","duration":"2.111463302s","start":"2026-06-28T19:57:01.686379Z","end":"2026-06-28T19:57:03.797842Z","steps":["trace[1331599398] 'agreement among raft nodes before linearized reading' (duration: 2.111431361s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.797873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:01.686359Z","time spent":"2.111505202s","remote":"127.0.0.1:57684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:57:03.798003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.200024317s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:03.798026Z","caller":"traceutil/trace.go:171","msg":"trace[1152860097] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:969; }","duration":"3.200048937s","start":"2026-06-28T19:57:00.597971Z","end":"2026-06-28T19:57:03.79802Z","steps":["trace[1152860097] 'agreement among raft nodes before linearized reading' (duration: 3.200010136s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.798043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:00.597957Z","time spent":"3.200082399s","remote":"127.0.0.1:57732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:57:03.796969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.701323681s","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-06-28T19:57:03.798299Z","caller":"traceutil/trace.go:171","msg":"trace[538271960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:969; }","duration":"1.702707328s","start":"2026-06-28T19:57:02.095582Z","end":"2026-06-28T19:57:03.798289Z","steps":["trace[538271960] 'agreement among raft nodes before linearized reading' (duration: 1.70130618s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.798333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.095551Z","time spent":"1.70277347s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-28T19:57:03.797801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:01.861917Z","time spent":"1.935873093s","remote":"127.0.0.1:57448","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-06-28T19:57:03.930358Z","caller":"traceutil/trace.go:171","msg":"trace[975562496] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1005; }","duration":"123.016411ms","start":"2026-06-28T19:57:03.807325Z","end":"2026-06-28T19:57:03.930342Z","steps":["trace[975562496] 'read index received' (duration: 86.605587ms)","trace[975562496] 'applied index is now lower than readState.Index' (duration: 36.409974ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:03.930447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.103433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:03.930466Z","caller":"traceutil/trace.go:171","msg":"trace[1033080970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"123.154874ms","start":"2026-06-28T19:57:03.807304Z","end":"2026-06-28T19:57:03.930459Z","steps":["trace[1033080970] 'agreement among raft nodes before linearized reading' (duration: 123.107452ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:03.930483Z","caller":"traceutil/trace.go:171","msg":"trace[1161104215] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"127.596176ms","start":"2026-06-28T19:57:03.802847Z","end":"2026-06-28T19:57:03.930443Z","steps":["trace[1161104215] 'process raft request' (duration: 127.448522ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:03.930551Z","caller":"traceutil/trace.go:171","msg":"trace[598029514] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"127.76257ms","start":"2026-06-28T19:57:03.802765Z","end":"2026-06-28T19:57:03.930528Z","steps":["trace[598029514] 'process raft request' (duration: 127.423482ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:03.930571Z","caller":"traceutil/trace.go:171","msg":"trace[28635500] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"127.626517ms","start":"2026-06-28T19:57:03.802882Z","end":"2026-06-28T19:57:03.930508Z","steps":["trace[28635500] 'process raft request' (duration: 127.438292ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:16.026543Z","caller":"traceutil/trace.go:171","msg":"trace[1776659289] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1045; }","duration":"166.353874ms","start":"2026-06-28T19:57:15.860163Z","end":"2026-06-28T19:57:16.026517Z","steps":["trace[1776659289] 'read index received' (duration: 166.147158ms)","trace[1776659289] 'applied index is now lower than readState.Index' (duration: 205.586µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:16.026594Z","caller":"traceutil/trace.go:171","msg":"trace[1400589478] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"172.243846ms","start":"2026-06-28T19:57:15.854317Z","end":"2026-06-28T19:57:16.026561Z","steps":["trace[1400589478] 'process raft request' (duration: 172.0513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:16.026719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.532209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:16.02678Z","caller":"traceutil/trace.go:171","msg":"trace[2058493528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"166.628062ms","start":"2026-06-28T19:57:15.860137Z","end":"2026-06-28T19:57:16.026765Z","steps":["trace[2058493528] 'agreement among raft nodes before linearized reading' (duration: 166.524229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:26.362049Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873732597130463,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:57:26.862665Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873732597130463,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:57:27.063501Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.229299214s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:57:27.06397Z","caller":"traceutil/trace.go:171","msg":"trace[148350276] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1079; }","duration":"1.202151085s","start":"2026-06-28T19:57:25.861797Z","end":"2026-06-28T19:57:27.063948Z","steps":["trace[148350276] 'read index received' (duration: 1.201859787s)","trace[148350276] 'applied index is now lower than readState.Index' (duration: 290.458µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:27.064158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202312401s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:27.064149Z","caller":"traceutil/trace.go:171","msg":"trace[1458608500] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"1.22991516s","start":"2026-06-28T19:57:25.834117Z","end":"2026-06-28T19:57:27.064032Z","steps":["trace[1458608500] 'process raft request' (duration: 1.229664473s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:27.064208Z","caller":"traceutil/trace.go:171","msg":"trace[255372612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1040; }","duration":"1.202439564s","start":"2026-06-28T19:57:25.861755Z","end":"2026-06-28T19:57:27.064194Z","steps":["trace[255372612] 'agreement among raft nodes before linearized reading' (duration: 1.202325171s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:27.06429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:25.861737Z","time spent":"1.202539056s","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T19:57:27.064383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.297093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-28T19:57:27.064388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:25.834098Z","time spent":"1.230118016s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:27.064508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.388955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-28T19:57:27.064542Z","caller":"traceutil/trace.go:171","msg":"trace[808846845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"890.444096ms","start":"2026-06-28T19:57:26.174091Z","end":"2026-06-28T19:57:27.064535Z","steps":["trace[808846845] 'agreement among raft nodes before linearized reading' (duration: 890.361024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:27.064571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:26.174085Z","time spent":"890.478928ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:57:27.064477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000605562s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-28T19:57:27.06469Z","caller":"traceutil/trace.go:171","msg":"trace[753871235] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1040; }","duration":"1.000861248s","start":"2026-06-28T19:57:26.0638Z","end":"2026-06-28T19:57:27.064662Z","steps":["trace[753871235] 'agreement among raft nodes before linearized reading' (duration: 1.000383346s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:27.064798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:26.06377Z","time spent":"1.001012283s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-28T19:57:27.064517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.121007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-28T19:57:27.064933Z","caller":"traceutil/trace.go:171","msg":"trace[1658656716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1040; }","duration":"890.611421ms","start":"2026-06-28T19:57:26.174299Z","end":"2026-06-28T19:57:27.064911Z","steps":["trace[1658656716] 'agreement among raft nodes before linearized reading' (duration: 889.883821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:27.06506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.372006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-28T19:57:27.065078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:26.174291Z","time spent":"890.717483ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-28T19:57:27.065135Z","caller":"traceutil/trace.go:171","msg":"trace[915092841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1040; }","duration":"893.487179ms","start":"2026-06-28T19:57:26.171637Z","end":"2026-06-28T19:57:27.065124Z","steps":["trace[915092841] 'agreement among raft nodes before linearized reading' (duration: 893.356276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:27.065166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:26.171616Z","time spent":"893.543041ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-28T19:57:27.064431Z","caller":"traceutil/trace.go:171","msg":"trace[613350812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1040; }","duration":"890.368354ms","start":"2026-06-28T19:57:26.174049Z","end":"2026-06-28T19:57:27.064417Z","steps":["trace[613350812] 'agreement among raft nodes before linearized reading' (duration: 890.2105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:27.065278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:26.174038Z","time spent":"891.234478ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-28T19:57:28.525609Z","caller":"traceutil/trace.go:171","msg":"trace[767383682] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"281.997451ms","start":"2026-06-28T19:57:28.243592Z","end":"2026-06-28T19:57:28.525589Z","steps":["trace[767383682] 'process raft request' (duration: 281.887058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:29.397229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.732347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:29.397292Z","caller":"traceutil/trace.go:171","msg":"trace[849712623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1047; }","duration":"537.84025ms","start":"2026-06-28T19:57:28.859438Z","end":"2026-06-28T19:57:29.397278Z","steps":["trace[849712623] 'range keys from in-memory index tree' (duration: 537.669456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:29.39732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:28.859418Z","time spent":"537.895792ms","remote":"127.0.0.1:57448","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-06-28T19:57:29.427404Z","caller":"traceutil/trace.go:171","msg":"trace[2128646550] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"355.172396ms","start":"2026-06-28T19:57:29.07221Z","end":"2026-06-28T19:57:29.427382Z","steps":["trace[2128646550] 'read index received' (duration: 354.986062ms)","trace[2128646550] 'applied index is now lower than readState.Index' (duration: 185.154µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:29.427498Z","caller":"traceutil/trace.go:171","msg":"trace[1475641895] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"357.467269ms","start":"2026-06-28T19:57:29.070022Z","end":"2026-06-28T19:57:29.42749Z","steps":["trace[1475641895] 'process raft request' (duration: 357.247144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:29.42758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:29.069988Z","time spent":"357.529711ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:29.427851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.838959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-28T19:57:29.427939Z","caller":"traceutil/trace.go:171","msg":"trace[276883902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1048; }","duration":"289.005584ms","start":"2026-06-28T19:57:29.138916Z","end":"2026-06-28T19:57:29.427921Z","steps":["trace[276883902] 'agreement among raft nodes before linearized reading' (duration: 288.755567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:29.427992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.738662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-28T19:57:29.428073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.44713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-28T19:57:29.428091Z","caller":"traceutil/trace.go:171","msg":"trace[1950261121] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1048; }","duration":"355.898527ms","start":"2026-06-28T19:57:29.072173Z","end":"2026-06-28T19:57:29.428072Z","steps":["trace[1950261121] 'agreement among raft nodes before linearized reading' (duration: 355.692801ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:29.428206Z","caller":"traceutil/trace.go:171","msg":"trace[1293757313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1048; }","duration":"275.600523ms","start":"2026-06-28T19:57:29.152574Z","end":"2026-06-28T19:57:29.428175Z","steps":["trace[1293757313] 'agreement among raft nodes before linearized reading' (duration: 275.258524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:29.428319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:29.072154Z","time spent":"356.144213ms","remote":"127.0.0.1:57882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:57:29.428042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.762658ms","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-06-28T19:57:29.428415Z","caller":"traceutil/trace.go:171","msg":"trace[302709067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1048; }","duration":"276.16384ms","start":"2026-06-28T19:57:29.152239Z","end":"2026-06-28T19:57:29.428403Z","steps":["trace[302709067] 'agreement among raft nodes before linearized reading' (duration: 275.713947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:29.428118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.841671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-28T19:57:29.428504Z","caller":"traceutil/trace.go:171","msg":"trace[443738842] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1048; }","duration":"276.245133ms","start":"2026-06-28T19:57:29.152253Z","end":"2026-06-28T19:57:29.428498Z","steps":["trace[443738842] 'agreement among raft nodes before linearized reading' (duration: 275.81227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:29.428126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.911763ms","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-06-28T19:57:29.428636Z","caller":"traceutil/trace.go:171","msg":"trace[228858916] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1048; }","duration":"276.445058ms","start":"2026-06-28T19:57:29.152178Z","end":"2026-06-28T19:57:29.428624Z","steps":["trace[228858916] 'agreement among raft nodes before linearized reading' (duration: 275.891182ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:33.585028Z","caller":"traceutil/trace.go:171","msg":"trace[914712753] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"100.87842ms","start":"2026-06-28T19:57:33.484127Z","end":"2026-06-28T19:57:33.585006Z","steps":["trace[914712753] 'process raft request' (duration: 100.647284ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:39.212826Z","caller":"traceutil/trace.go:171","msg":"trace[1177151727] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"316.086999ms","start":"2026-06-28T19:57:38.896716Z","end":"2026-06-28T19:57:39.212803Z","steps":["trace[1177151727] 'process raft request' (duration: 315.940915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:39.213143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:38.896697Z","time spent":"316.202643ms","remote":"127.0.0.1:57712","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-06-28T19:57:50.213184Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873732597130735,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-28T19:57:50.233919Z","caller":"traceutil/trace.go:171","msg":"trace[1511002373] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"842.30866ms","start":"2026-06-28T19:57:49.391556Z","end":"2026-06-28T19:57:50.233865Z","steps":["trace[1511002373] 'process raft request' (duration: 842.131534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:50.234074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:49.391541Z","time spent":"842.454833ms","remote":"127.0.0.1:57712","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-06-28T19:57:50.244589Z","caller":"traceutil/trace.go:171","msg":"trace[1889052147] linearizableReadLoop","detail":"{readStateIndex:1212; appliedIndex:1210; }","duration":"532.349739ms","start":"2026-06-28T19:57:49.712228Z","end":"2026-06-28T19:57:50.244577Z","steps":["trace[1889052147] 'read index received' (duration: 521.397477ms)","trace[1889052147] 'applied index is now lower than readState.Index' (duration: 10.951222ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:50.24478Z","caller":"traceutil/trace.go:171","msg":"trace[1844827008] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"546.643483ms","start":"2026-06-28T19:57:49.698128Z","end":"2026-06-28T19:57:50.244771Z","steps":["trace[1844827008] 'process raft request' (duration: 546.390486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:50.244839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:49.698101Z","time spent":"546.704105ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:50.244992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.76359ms","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-06-28T19:57:50.245018Z","caller":"traceutil/trace.go:171","msg":"trace[2009837053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1165; }","duration":"532.818932ms","start":"2026-06-28T19:57:49.712193Z","end":"2026-06-28T19:57:50.245012Z","steps":["trace[2009837053] 'agreement among raft nodes before linearized reading' (duration: 532.733099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:50.245039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:49.712179Z","time spent":"532.853343ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-28T19:57:50.245171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.137862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-28T19:57:50.245194Z","caller":"traceutil/trace.go:171","msg":"trace[592569621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1165; }","duration":"471.191774ms","start":"2026-06-28T19:57:49.773997Z","end":"2026-06-28T19:57:50.245188Z","steps":["trace[592569621] 'agreement among raft nodes before linearized reading' (duration: 471.123742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:50.245211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:49.773983Z","time spent":"471.224304ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-28T19:57:50.245359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.265606ms","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-06-28T19:57:50.245417Z","caller":"traceutil/trace.go:171","msg":"trace[92703468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1165; }","duration":"463.329247ms","start":"2026-06-28T19:57:49.782072Z","end":"2026-06-28T19:57:50.245401Z","steps":["trace[92703468] 'agreement among raft nodes before linearized reading' (duration: 463.245995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:50.245446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:49.782067Z","time spent":"463.372178ms","remote":"127.0.0.1:57712","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-06-28T19:57:50.24559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.530333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-28T19:57:50.24562Z","caller":"traceutil/trace.go:171","msg":"trace[610991238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1165; }","duration":"463.559684ms","start":"2026-06-28T19:57:49.782053Z","end":"2026-06-28T19:57:50.245613Z","steps":["trace[610991238] 'agreement among raft nodes before linearized reading' (duration: 463.486792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:50.245651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:49.782026Z","time spent":"463.619256ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:57:50.245791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.362336ms","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-06-28T19:57:50.245819Z","caller":"traceutil/trace.go:171","msg":"trace[614123317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1165; }","duration":"468.417157ms","start":"2026-06-28T19:57:49.777396Z","end":"2026-06-28T19:57:50.245813Z","steps":["trace[614123317] 'agreement among raft nodes before linearized reading' (duration: 468.347975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:50.245836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:49.777386Z","time spent":"468.446597ms","remote":"127.0.0.1:57712","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":"info","ts":"2026-06-28T19:58:06.592199Z","caller":"traceutil/trace.go:171","msg":"trace[73643771] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"136.886776ms","start":"2026-06-28T19:58:06.455284Z","end":"2026-06-28T19:58:06.592171Z","steps":["trace[73643771] 'process raft request' (duration: 104.22218ms)","trace[73643771] 'compare' (duration: 32.531171ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:06.602504Z","caller":"traceutil/trace.go:171","msg":"trace[330595028] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"145.889892ms","start":"2026-06-28T19:58:06.456596Z","end":"2026-06-28T19:58:06.602486Z","steps":["trace[330595028] 'process raft request' (duration: 145.84436ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:06.602628Z","caller":"traceutil/trace.go:171","msg":"trace[2052217210] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"147.079813ms","start":"2026-06-28T19:58:06.455544Z","end":"2026-06-28T19:58:06.602624Z","steps":["trace[2052217210] 'process raft request' (duration: 146.801106ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:06.602707Z","caller":"traceutil/trace.go:171","msg":"trace[1387348534] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"145.914343ms","start":"2026-06-28T19:58:06.456787Z","end":"2026-06-28T19:58:06.602702Z","steps":["trace[1387348534] 'process raft request' (duration: 145.672556ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:06.60281Z","caller":"traceutil/trace.go:171","msg":"trace[390836346] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"145.342337ms","start":"2026-06-28T19:58:06.457464Z","end":"2026-06-28T19:58:06.602806Z","steps":["trace[390836346] 'process raft request' (duration: 145.216894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:07.441614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.2813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:07.442332Z","caller":"traceutil/trace.go:171","msg":"trace[162792065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1242; }","duration":"581.059701ms","start":"2026-06-28T19:58:06.86123Z","end":"2026-06-28T19:58:07.44229Z","steps":["trace[162792065] 'range keys from in-memory index tree' (duration: 580.132847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:07.442587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:06.8612Z","time spent":"581.346407ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T19:58:07.441817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.646856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:58:07.442699Z","caller":"traceutil/trace.go:171","msg":"trace[508685638] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1242; }","duration":"314.5704ms","start":"2026-06-28T19:58:07.128101Z","end":"2026-06-28T19:58:07.442672Z","steps":["trace[508685638] 'count revisions from in-memory index tree' (duration: 313.562013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:07.442783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:07.128082Z","time spent":"314.676503ms","remote":"127.0.0.1:32860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-06-28T19:58:08.818162Z","caller":"traceutil/trace.go:171","msg":"trace[422929809] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"222.041927ms","start":"2026-06-28T19:58:08.596102Z","end":"2026-06-28T19:58:08.818144Z","steps":["trace[422929809] 'read index received' (duration: 221.842942ms)","trace[422929809] 'applied index is now lower than readState.Index' (duration: 198.465µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:08.8183Z","caller":"traceutil/trace.go:171","msg":"trace[1537085829] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"361.178781ms","start":"2026-06-28T19:58:08.457076Z","end":"2026-06-28T19:58:08.818255Z","steps":["trace[1537085829] 'process raft request' (duration: 360.927485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:08.818354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.236501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-28T19:58:08.819334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:08.457053Z","time spent":"362.193628ms","remote":"127.0.0.1:57712","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-06-28T19:58:08.819368Z","caller":"traceutil/trace.go:171","msg":"trace[1264513433] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1245; }","duration":"223.304909ms","start":"2026-06-28T19:58:08.596033Z","end":"2026-06-28T19:58:08.819338Z","steps":["trace[1264513433] 'agreement among raft nodes before linearized reading' (duration: 222.21169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:08.818473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.605668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-28T19:58:08.819535Z","caller":"traceutil/trace.go:171","msg":"trace[20235846] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1245; }","duration":"208.687246ms","start":"2026-06-28T19:58:08.61083Z","end":"2026-06-28T19:58:08.819517Z","steps":["trace[20235846] 'agreement among raft nodes before linearized reading' (duration: 207.566267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:08.818544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.330312ms","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-06-28T19:58:08.819615Z","caller":"traceutil/trace.go:171","msg":"trace[608151637] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1245; }","duration":"213.41044ms","start":"2026-06-28T19:58:08.606189Z","end":"2026-06-28T19:58:08.819599Z","steps":["trace[608151637] 'agreement among raft nodes before linearized reading' (duration: 212.311092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:08.818554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.961254ms","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-06-28T19:58:08.819953Z","caller":"traceutil/trace.go:171","msg":"trace[1660516796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1245; }","duration":"210.413392ms","start":"2026-06-28T19:58:08.609527Z","end":"2026-06-28T19:58:08.819941Z","steps":["trace[1660516796] 'agreement among raft nodes before linearized reading' (duration: 208.970184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:08.818547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.086753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-28T19:58:08.820057Z","caller":"traceutil/trace.go:171","msg":"trace[1616102159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1245; }","duration":"214.637612ms","start":"2026-06-28T19:58:08.605404Z","end":"2026-06-28T19:58:08.820042Z","steps":["trace[1616102159] 'agreement among raft nodes before linearized reading' (duration: 212.996019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:09.255033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.411493ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:58:09.255292Z","caller":"traceutil/trace.go:171","msg":"trace[1293644292] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"431.332868ms","start":"2026-06-28T19:58:08.823938Z","end":"2026-06-28T19:58:09.255271Z","steps":["trace[1293644292] 'process raft request' (duration: 431.206265ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:09.255299Z","caller":"traceutil/trace.go:171","msg":"trace[1578982764] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"430.6118ms","start":"2026-06-28T19:58:08.824668Z","end":"2026-06-28T19:58:09.25528Z","steps":["trace[1578982764] 'process raft request' (duration: 430.546798ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:09.255293Z","caller":"traceutil/trace.go:171","msg":"trace[340210896] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"432.396946ms","start":"2026-06-28T19:58:08.822836Z","end":"2026-06-28T19:58:09.255233Z","steps":["trace[340210896] 'process raft request' (duration: 116.682695ms)","trace[340210896] 'compare' (duration: 315.27375ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:09.255388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:08.823927Z","time spent":"431.410581ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:58:09.255382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:08.824652Z","time spent":"430.696122ms","remote":"127.0.0.1:57712","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-06-28T19:58:09.25551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:08.822814Z","time spent":"432.581122ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:58:09.255529Z","caller":"traceutil/trace.go:171","msg":"trace[1383463389] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1296; }","duration":"392.252624ms","start":"2026-06-28T19:58:08.86326Z","end":"2026-06-28T19:58:09.255513Z","steps":["trace[1383463389] 'read index received' (duration: 76.268997ms)","trace[1383463389] 'applied index is now lower than readState.Index' (duration: 315.982547ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:09.255614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.360118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:09.255653Z","caller":"traceutil/trace.go:171","msg":"trace[1704052891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1250; }","duration":"392.458641ms","start":"2026-06-28T19:58:08.863185Z","end":"2026-06-28T19:58:09.255643Z","steps":["trace[1704052891] 'agreement among raft nodes before linearized reading' (duration: 392.382479ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:09.255692Z","caller":"traceutil/trace.go:171","msg":"trace[1066507835] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"429.413268ms","start":"2026-06-28T19:58:08.826265Z","end":"2026-06-28T19:58:09.255679Z","steps":["trace[1066507835] 'process raft request' (duration: 429.174172ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:09.255684Z","caller":"traceutil/trace.go:171","msg":"trace[1285749495] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"430.835295ms","start":"2026-06-28T19:58:08.824821Z","end":"2026-06-28T19:58:09.255657Z","steps":["trace[1285749495] 'process raft request' (duration: 430.424734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:09.255813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:08.82625Z","time spent":"429.517241ms","remote":"127.0.0.1:57712","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-06-28T19:58:09.255682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:08.863163Z","time spent":"392.511952ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T19:58:09.255933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:08.824796Z","time spent":"431.01771ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:58:09.414653Z","caller":"traceutil/trace.go:171","msg":"trace[55690547] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"135.747166ms","start":"2026-06-28T19:58:09.278875Z","end":"2026-06-28T19:58:09.414623Z","steps":["trace[55690547] 'process raft request' (duration: 103.165243ms)","trace[55690547] 'compare' (duration: 32.353047ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:19.81918Z","caller":"traceutil/trace.go:171","msg":"trace[916005586] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"469.950871ms","start":"2026-06-28T19:58:19.349215Z","end":"2026-06-28T19:58:19.819166Z","steps":["trace[916005586] 'process raft request' (duration: 468.876942ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:19.819145Z","caller":"traceutil/trace.go:171","msg":"trace[1339939392] linearizableReadLoop","detail":"{readStateIndex:1375; appliedIndex:1374; }","duration":"468.306538ms","start":"2026-06-28T19:58:19.350798Z","end":"2026-06-28T19:58:19.819105Z","steps":["trace[1339939392] 'read index received' (duration: 467.251459ms)","trace[1339939392] 'applied index is now lower than readState.Index' (duration: 1.053339ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:19.81928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.349194Z","time spent":"470.032143ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:58:19.819429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.461745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-28T19:58:19.819455Z","caller":"traceutil/trace.go:171","msg":"trace[1209947818] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1322; }","duration":"467.509797ms","start":"2026-06-28T19:58:19.351938Z","end":"2026-06-28T19:58:19.819448Z","steps":["trace[1209947818] 'agreement among raft nodes before linearized reading' (duration: 467.427875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:19.819458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.653806ms","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-06-28T19:58:19.819513Z","caller":"traceutil/trace.go:171","msg":"trace[810066216] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1322; }","duration":"468.732928ms","start":"2026-06-28T19:58:19.350765Z","end":"2026-06-28T19:58:19.819498Z","steps":["trace[810066216] 'agreement among raft nodes before linearized reading' (duration: 468.576424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:19.819565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.536551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-28T19:58:19.81956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.350751Z","time spent":"468.79799ms","remote":"127.0.0.1:57712","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":"info","ts":"2026-06-28T19:58:19.819585Z","caller":"traceutil/trace.go:171","msg":"trace[1657330992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1322; }","duration":"466.574631ms","start":"2026-06-28T19:58:19.353006Z","end":"2026-06-28T19:58:19.81958Z","steps":["trace[1657330992] 'agreement among raft nodes before linearized reading' (duration: 466.53117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:19.819604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.352997Z","time spent":"466.602482ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:58:19.819474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.351923Z","time spent":"467.546108ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-28T19:58:19.819673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.005694ms","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-06-28T19:58:19.819693Z","caller":"traceutil/trace.go:171","msg":"trace[1766258771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1322; }","duration":"467.053664ms","start":"2026-06-28T19:58:19.352635Z","end":"2026-06-28T19:58:19.819689Z","steps":["trace[1766258771] 'agreement among raft nodes before linearized reading' (duration: 467.008013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:19.819709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.352622Z","time spent":"467.083715ms","remote":"127.0.0.1:57712","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-06-28T19:58:19.819526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.587511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-06-28T19:58:19.819793Z","caller":"traceutil/trace.go:171","msg":"trace[438052280] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1322; }","duration":"235.872798ms","start":"2026-06-28T19:58:19.583907Z","end":"2026-06-28T19:58:19.819779Z","steps":["trace[438052280] 'agreement among raft nodes before linearized reading' (duration: 235.57804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:20.884763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.481572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:58:20.884905Z","caller":"traceutil/trace.go:171","msg":"trace[539813398] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"1.060210861s","start":"2026-06-28T19:58:19.824673Z","end":"2026-06-28T19:58:20.884884Z","steps":["trace[539813398] 'process raft request' (duration: 423.551004ms)","trace[539813398] 'compare' (duration: 636.127993ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:20.884964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.824651Z","time spent":"1.060285623s","remote":"127.0.0.1:57712","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-06-28T19:58:20.885098Z","caller":"traceutil/trace.go:171","msg":"trace[1425856853] linearizableReadLoop","detail":"{readStateIndex:1380; appliedIndex:1375; }","duration":"1.026246712s","start":"2026-06-28T19:58:19.858845Z","end":"2026-06-28T19:58:20.885091Z","steps":["trace[1425856853] 'read index received' (duration: 389.394071ms)","trace[1425856853] 'applied index is now lower than readState.Index' (duration: 636.852071ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:20.885173Z","caller":"traceutil/trace.go:171","msg":"trace[962776095] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"1.060363985s","start":"2026-06-28T19:58:19.824802Z","end":"2026-06-28T19:58:20.885166Z","steps":["trace[962776095] 'process raft request' (duration: 1.060025476s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:20.885188Z","caller":"traceutil/trace.go:171","msg":"trace[77223843] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"1.059404731s","start":"2026-06-28T19:58:19.825755Z","end":"2026-06-28T19:58:20.88516Z","steps":["trace[77223843] 'process raft request' (duration: 1.059302628s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:20.885223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.824769Z","time spent":"1.060425697s","remote":"127.0.0.1:57712","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-06-28T19:58:20.885145Z","caller":"traceutil/trace.go:171","msg":"trace[1147532150] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"1.060243262s","start":"2026-06-28T19:58:19.82488Z","end":"2026-06-28T19:58:20.885123Z","steps":["trace[1147532150] 'process raft request' (duration: 1.060135159s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:20.885293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.824867Z","time spent":"1.060407796s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:58:20.885307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.825741Z","time spent":"1.059493843s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:58:20.8854Z","caller":"traceutil/trace.go:171","msg":"trace[1289005466] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"1.059595345s","start":"2026-06-28T19:58:19.825798Z","end":"2026-06-28T19:58:20.885393Z","steps":["trace[1289005466] 'process raft request' (duration: 1.059276367s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:20.885496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.825769Z","time spent":"1.059674388s","remote":"127.0.0.1:57712","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-06-28T19:58:20.885418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026579761s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:20.885574Z","caller":"traceutil/trace.go:171","msg":"trace[1838374626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1327; }","duration":"1.026759526s","start":"2026-06-28T19:58:19.858808Z","end":"2026-06-28T19:58:20.885567Z","steps":["trace[1838374626] 'agreement among raft nodes before linearized reading' (duration: 1.026593542s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:20.885595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.858794Z","time spent":"1.026795426s","remote":"127.0.0.1:57448","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-06-28T19:58:21.101608Z","caller":"traceutil/trace.go:171","msg":"trace[2075767088] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1380; }","duration":"216.44055ms","start":"2026-06-28T19:58:20.885143Z","end":"2026-06-28T19:58:21.101583Z","steps":["trace[2075767088] 'read index received' (duration: 212.60658ms)","trace[2075767088] 'applied index is now lower than readState.Index' (duration: 3.83307ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:21.101642Z","caller":"traceutil/trace.go:171","msg":"trace[814562398] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"352.521565ms","start":"2026-06-28T19:58:20.74909Z","end":"2026-06-28T19:58:21.101611Z","steps":["trace[814562398] 'process raft request' (duration: 348.741306ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:21.101715Z","caller":"traceutil/trace.go:171","msg":"trace[394399858] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"246.800546ms","start":"2026-06-28T19:58:20.854904Z","end":"2026-06-28T19:58:21.101705Z","steps":["trace[394399858] 'process raft request' (duration: 246.60272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:21.101815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:20.749071Z","time spent":"352.66201ms","remote":"127.0.0.1:57712","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-06-28T19:58:21.101966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.356942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:21.102004Z","caller":"traceutil/trace.go:171","msg":"trace[2057940127] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1329; }","duration":"964.446094ms","start":"2026-06-28T19:58:20.137546Z","end":"2026-06-28T19:58:21.101992Z","steps":["trace[2057940127] 'agreement among raft nodes before linearized reading' (duration: 964.349952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:21.102037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:20.137524Z","time spent":"964.503105ms","remote":"127.0.0.1:57766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:58:21.102129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.842264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:21.102159Z","caller":"traceutil/trace.go:171","msg":"trace[1852582822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1329; }","duration":"215.872945ms","start":"2026-06-28T19:58:20.886277Z","end":"2026-06-28T19:58:21.10215Z","steps":["trace[1852582822] 'agreement among raft nodes before linearized reading' (duration: 215.824784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:21.102314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0303648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-28T19:58:21.102336Z","caller":"traceutil/trace.go:171","msg":"trace[19249162] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1329; }","duration":"1.030419001s","start":"2026-06-28T19:58:20.07191Z","end":"2026-06-28T19:58:21.102329Z","steps":["trace[19249162] 'agreement among raft nodes before linearized reading' (duration: 1.030334868s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:21.102354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:20.071893Z","time spent":"1.030456633s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-28T19:58:21.102432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.227367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-28T19:58:21.102447Z","caller":"traceutil/trace.go:171","msg":"trace[749874656] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1329; }","duration":"139.281438ms","start":"2026-06-28T19:58:20.96316Z","end":"2026-06-28T19:58:21.102441Z","steps":["trace[749874656] 'agreement among raft nodes before linearized reading' (duration: 139.236047ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.13559Z","caller":"traceutil/trace.go:171","msg":"trace[1967422214] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"172.17268ms","start":"2026-06-28T19:58:34.963402Z","end":"2026-06-28T19:58:35.135575Z","steps":["trace[1967422214] 'process raft request' (duration: 172.124389ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.135707Z","caller":"traceutil/trace.go:171","msg":"trace[1779945212] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"173.351981ms","start":"2026-06-28T19:58:34.962349Z","end":"2026-06-28T19:58:35.135701Z","steps":["trace[1779945212] 'process raft request' (duration: 169.663855ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.135903Z","caller":"traceutil/trace.go:171","msg":"trace[585024922] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"171.77679ms","start":"2026-06-28T19:58:34.964089Z","end":"2026-06-28T19:58:35.135866Z","steps":["trace[585024922] 'process raft request' (duration: 171.461992ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:37.244427Z","caller":"traceutil/trace.go:171","msg":"trace[180089813] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"100.074222ms","start":"2026-06-28T19:58:37.144326Z","end":"2026-06-28T19:58:37.2444Z","steps":["trace[180089813] 'process raft request' (duration: 99.806064ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:42.173095Z","caller":"traceutil/trace.go:171","msg":"trace[1906908963] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"117.112878ms","start":"2026-06-28T19:58:42.05596Z","end":"2026-06-28T19:58:42.173073Z","steps":["trace[1906908963] 'process raft request' (duration: 116.978944ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:49.535515Z","caller":"traceutil/trace.go:171","msg":"trace[1781655453] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"112.5866ms","start":"2026-06-28T19:58:49.422913Z","end":"2026-06-28T19:58:49.5355Z","steps":["trace[1781655453] 'process raft request' (duration: 112.561869ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:49.535759Z","caller":"traceutil/trace.go:171","msg":"trace[1310510135] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"113.485253ms","start":"2026-06-28T19:58:49.422261Z","end":"2026-06-28T19:58:49.535746Z","steps":["trace[1310510135] 'process raft request' (duration: 100.918074ms)","trace[1310510135] 'compare' (duration: 12.066635ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:49.535894Z","caller":"traceutil/trace.go:171","msg":"trace[903660318] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"113.563115ms","start":"2026-06-28T19:58:49.422298Z","end":"2026-06-28T19:58:49.535861Z","steps":["trace[903660318] 'process raft request' (duration: 113.149564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:02:00.725966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.440933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-28T20:02:00.725994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.820042ms","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-06-28T20:02:00.725998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.70372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-28T20:02:00.726068Z","caller":"traceutil/trace.go:171","msg":"trace[858732857] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2353; }","duration":"123.949495ms","start":"2026-06-28T20:02:00.602102Z","end":"2026-06-28T20:02:00.726051Z","steps":["trace[858732857] 'range keys from in-memory index tree' (duration: 123.650668ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:00.726083Z","caller":"traceutil/trace.go:171","msg":"trace[687435305] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2353; }","duration":"118.836964ms","start":"2026-06-28T20:02:00.607228Z","end":"2026-06-28T20:02:00.726065Z","steps":["trace[687435305] 'range keys from in-memory index tree' (duration: 118.546156ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:00.726037Z","caller":"traceutil/trace.go:171","msg":"trace[837257240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2353; }","duration":"118.557647ms","start":"2026-06-28T20:02:00.607465Z","end":"2026-06-28T20:02:00.726022Z","steps":["trace[837257240] 'range keys from in-memory index tree' (duration: 118.294871ms)"],"step_count":1}