{"level":"warn","ts":"2026-04-20T01:59:04.140203Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T01:59:04.140282Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33: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.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33: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-04-20T01:59:04.140345Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T01:59:04.140354Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-20T01:59:04.140371Z","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-04-20T01:59:04.140992Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]} {"level":"info","ts":"2026-04-20T01:59:04.141066Z","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.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33: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-04-20T01:59:04.149592Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.331988ms"} {"level":"info","ts":"2026-04-20T01:59:04.19674Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"} {"level":"info","ts":"2026-04-20T01:59:04.196959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T01:59:04.197054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"} {"level":"info","ts":"2026-04-20T01:59:04.197073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T01:59:04.197094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"} {"level":"info","ts":"2026-04-20T01:59:04.197162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"warn","ts":"2026-04-20T01:59:04.219431Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T01:59:04.228279Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T01:59:04.236585Z","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-04-20T01:59:04.247754Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T01:59:04.248424Z","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-04-20T01:59:04.248519Z","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-04-20T01:59:04.248539Z","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-04-20T01:59:04.24803Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T01:59:04.251858Z","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-04-20T01:59:04.252095Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T01:59:04.252131Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T01:59:04.252259Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-20T01:59:04.252281Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-20T01:59:04.255218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"info","ts":"2026-04-20T01:59:04.255329Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-20T01:59:04.798142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T01:59:04.798238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T01:59:04.798272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"} {"level":"info","ts":"2026-04-20T01:59:04.798457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"} {"level":"info","ts":"2026-04-20T01:59:04.798547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-20T01:59:04.798683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"} {"level":"info","ts":"2026-04-20T01:59:04.798783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-20T01:59:04.80498Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T01:59:04.811731Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T01:59:04.81174Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T01:59:04.811999Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T01:59:04.815103Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"} {"level":"info","ts":"2026-04-20T01:59:04.81524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T01:59:04.834249Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T01:59:04.834581Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T01:59:04.834714Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T01:59:04.835004Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T01:59:04.83524Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-20T01:59:06.600234Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155920568354164,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T01:59:06.879095Z","caller":"traceutil/trace.go:171","msg":"trace[1910451497] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"786.055746ms","start":"2026-04-20T01:59:06.093021Z","end":"2026-04-20T01:59:06.879077Z","steps":["trace[1910451497] 'process raft request' (duration: 785.864404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:06.879586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.093012Z","time spent":"786.148277ms","remote":"127.0.0.1:53672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:08.602348Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.723303506s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T01:59:08.603239Z","caller":"traceutil/trace.go:171","msg":"trace[979031709] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"2.503078158s","start":"2026-04-20T01:59:06.100124Z","end":"2026-04-20T01:59:08.603202Z","steps":["trace[979031709] 'read index received' (duration: 778.826493ms)","trace[979031709] 'applied index is now lower than readState.Index' (duration: 1.724250665s)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:08.603249Z","caller":"traceutil/trace.go:171","msg":"trace[707655167] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"2.435392964s","start":"2026-04-20T01:59:06.16783Z","end":"2026-04-20T01:59:08.603223Z","steps":["trace[707655167] 'process raft request' (duration: 2.435180252s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:08.603291Z","caller":"traceutil/trace.go:171","msg":"trace[1421432479] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"2.503575265s","start":"2026-04-20T01:59:06.099692Z","end":"2026-04-20T01:59:08.603267Z","steps":["trace[1421432479] 'process raft request' (duration: 2.503210171s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:08.603323Z","caller":"traceutil/trace.go:171","msg":"trace[2012758957] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"2.434963438s","start":"2026-04-20T01:59:06.168345Z","end":"2026-04-20T01:59:08.603308Z","steps":["trace[2012758957] 'process raft request' (duration: 2.434701696s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:08.60337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.167812Z","time spent":"2.435497194s","remote":"127.0.0.1:54024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:08.6034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.099673Z","time spent":"2.503667646s","remote":"127.0.0.1:53658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:08.603482Z","caller":"traceutil/trace.go:171","msg":"trace[1568690898] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.434662475s","start":"2026-04-20T01:59:06.168802Z","end":"2026-04-20T01:59:08.603465Z","steps":["trace[1568690898] 'process raft request' (duration: 2.434339112s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:08.603549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.168793Z","time spent":"2.434727196s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:08.603602Z","caller":"traceutil/trace.go:171","msg":"trace[1942360015] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.422585976s","start":"2026-04-20T01:59:06.180988Z","end":"2026-04-20T01:59:08.603574Z","steps":["trace[1942360015] 'process raft request' (duration: 2.422182532s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:08.60367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.180975Z","time spent":"2.422665478s","remote":"127.0.0.1:53774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:08.603674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.503542744s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-20T01:59:08.603731Z","caller":"traceutil/trace.go:171","msg":"trace[426505069] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"2.503628385s","start":"2026-04-20T01:59:06.100094Z","end":"2026-04-20T01:59:08.603722Z","steps":["trace[426505069] 'agreement among raft nodes before linearized reading' (duration: 2.503501713s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:08.603723Z","caller":"traceutil/trace.go:171","msg":"trace[444129141] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.435254972s","start":"2026-04-20T01:59:06.168455Z","end":"2026-04-20T01:59:08.60371Z","steps":["trace[444129141] 'process raft request' (duration: 2.434660806s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:08.603753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.100087Z","time spent":"2.503661817s","remote":"127.0.0.1:53774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-20T01:59:08.60374Z","caller":"traceutil/trace.go:171","msg":"trace[273259274] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.435312233s","start":"2026-04-20T01:59:06.168363Z","end":"2026-04-20T01:59:08.603676Z","steps":["trace[273259274] 'process raft request' (duration: 2.434732376s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:08.603776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.168446Z","time spent":"2.435307573s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:08.603842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.168333Z","time spent":"2.435464024s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:08.603855Z","caller":"traceutil/trace.go:171","msg":"trace[1308824285] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"2.435472745s","start":"2026-04-20T01:59:06.168363Z","end":"2026-04-20T01:59:08.603836Z","steps":["trace[1308824285] 'process raft request' (duration: 2.434710096s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:08.603959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.168342Z","time spent":"2.435555975s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:08.604074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.16833Z","time spent":"2.435017549s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:09.080967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000036173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-20T01:59:09.081062Z","caller":"traceutil/trace.go:171","msg":"trace[1863147553] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000212314s","start":"2026-04-20T01:59:07.080827Z","end":"2026-04-20T01:59:09.081039Z","steps":["trace[1863147553] 'agreement among raft nodes before linearized reading' (duration: 2.000051903s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.08111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:07.080816Z","time spent":"2.000283206s","remote":"127.0.0.1:53590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T01:59:09.104105Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155920568354175,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T01:59:09.633363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.022714ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-20T01:59:09.633525Z","caller":"traceutil/trace.go:171","msg":"trace[1122813786] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"2.061087459s","start":"2026-04-20T01:59:07.57242Z","end":"2026-04-20T01:59:09.633507Z","steps":["trace[1122813786] 'process raft request' (duration: 1.845751941s)","trace[1122813786] 'compare' (duration: 214.911313ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:09.633599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:07.572394Z","time spent":"2.06118507s","remote":"127.0.0.1:53838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:09.635842Z","caller":"traceutil/trace.go:171","msg":"trace[97334644] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"1.028405725s","start":"2026-04-20T01:59:08.607411Z","end":"2026-04-20T01:59:09.635817Z","steps":["trace[97334644] 'process raft request' (duration: 1.028215203s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.635949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:08.607391Z","time spent":"1.028508936s","remote":"127.0.0.1:54024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:09.636203Z","caller":"traceutil/trace.go:171","msg":"trace[1608078404] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"1.028335704s","start":"2026-04-20T01:59:08.607853Z","end":"2026-04-20T01:59:09.636188Z","steps":["trace[1608078404] 'process raft request' (duration: 1.028028311s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.636269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:08.607847Z","time spent":"1.028397015s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:09.636344Z","caller":"traceutil/trace.go:171","msg":"trace[658788587] linearizableReadLoop","detail":"{readStateIndex:22; appliedIndex:13; }","duration":"1.033032728s","start":"2026-04-20T01:59:08.603284Z","end":"2026-04-20T01:59:09.636317Z","steps":["trace[658788587] 'read index received' (duration: 814.899438ms)","trace[658788587] 'applied index is now lower than readState.Index' (duration: 218.13189ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:09.636446Z","caller":"traceutil/trace.go:171","msg":"trace[1848336215] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"1.028638208s","start":"2026-04-20T01:59:08.607798Z","end":"2026-04-20T01:59:09.636436Z","steps":["trace[1848336215] 'process raft request' (duration: 1.02789002s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.636493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:08.607787Z","time spent":"1.028685558s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:09.63658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.202269301s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:09.636623Z","caller":"traceutil/trace.go:171","msg":"trace[524396354] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:19; }","duration":"2.202352532s","start":"2026-04-20T01:59:07.434259Z","end":"2026-04-20T01:59:09.636611Z","steps":["trace[524396354] 'agreement among raft nodes before linearized reading' (duration: 2.20215541s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.636633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.468695744s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:09.636634Z","caller":"traceutil/trace.go:171","msg":"trace[145241536] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"1.028625577s","start":"2026-04-20T01:59:08.607993Z","end":"2026-04-20T01:59:09.636619Z","steps":["trace[145241536] 'process raft request' (duration: 1.02801769s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:09.636682Z","caller":"traceutil/trace.go:171","msg":"trace[1078910741] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:19; }","duration":"3.468761474s","start":"2026-04-20T01:59:06.167905Z","end":"2026-04-20T01:59:09.636666Z","steps":["trace[1078910741] 'agreement among raft nodes before linearized reading' (duration: 3.468679053s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.636664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:07.434238Z","time spent":"2.202406143s","remote":"127.0.0.1:53842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-04-20T01:59:09.63672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.167891Z","time spent":"3.468818536s","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-04-20T01:59:09.636716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:08.607983Z","time spent":"1.028694827s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:09.636791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.469061217s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:09.636826Z","caller":"traceutil/trace.go:171","msg":"trace[63460874] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"1.028727028s","start":"2026-04-20T01:59:08.608094Z","end":"2026-04-20T01:59:09.636821Z","steps":["trace[63460874] 'process raft request' (duration: 1.02803346s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.63687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:08.608086Z","time spent":"1.028768238s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:09.636922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.570636389s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:09.636958Z","caller":"traceutil/trace.go:171","msg":"trace[1654868786] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:19; }","duration":"2.570699621s","start":"2026-04-20T01:59:07.066249Z","end":"2026-04-20T01:59:09.636949Z","steps":["trace[1654868786] 'agreement among raft nodes before linearized reading' (duration: 2.570620659s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.63698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.417265315s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T01:59:09.637005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:07.066203Z","time spent":"2.570788923s","remote":"127.0.0.1:53944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-04-20T01:59:09.637027Z","caller":"traceutil/trace.go:171","msg":"trace[989765757] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:19; }","duration":"3.417341746s","start":"2026-04-20T01:59:06.219675Z","end":"2026-04-20T01:59:09.637017Z","steps":["trace[989765757] 'agreement among raft nodes before linearized reading' (duration: 3.417268595s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.63706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.219657Z","time spent":"3.417396746s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-20T01:59:09.637086Z","caller":"traceutil/trace.go:171","msg":"trace[844913911] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"1.023134496s","start":"2026-04-20T01:59:08.613938Z","end":"2026-04-20T01:59:09.637072Z","steps":["trace[844913911] 'process raft request' (duration: 1.022257286s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.636565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.570117355s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:09.637143Z","caller":"traceutil/trace.go:171","msg":"trace[1804705921] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:19; }","duration":"2.570730812s","start":"2026-04-20T01:59:07.066402Z","end":"2026-04-20T01:59:09.637133Z","steps":["trace[1804705921] 'agreement among raft nodes before linearized reading' (duration: 2.570028514s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.637173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:08.613914Z","time spent":"1.023217257s","remote":"127.0.0.1:53774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:09.637181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:07.066396Z","time spent":"2.570775742s","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-04-20T01:59:09.63719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.393549092s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:09.63721Z","caller":"traceutil/trace.go:171","msg":"trace[78863926] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:19; }","duration":"3.393628133s","start":"2026-04-20T01:59:06.243576Z","end":"2026-04-20T01:59:09.637204Z","steps":["trace[78863926] 'agreement among raft nodes before linearized reading' (duration: 3.393593083s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.637233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.243543Z","time spent":"3.393686345s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-20T01:59:09.637211Z","caller":"traceutil/trace.go:171","msg":"trace[882936874] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"1.027321073s","start":"2026-04-20T01:59:08.609879Z","end":"2026-04-20T01:59:09.6372Z","steps":["trace[882936874] 'process raft request' (duration: 1.026282761s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.63728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:08.609865Z","time spent":"1.027391344s","remote":"127.0.0.1:53982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:09.637539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.471796869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:09.637576Z","caller":"traceutil/trace.go:171","msg":"trace[226603548] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; response_count:0; response_revision:19; }","duration":"3.471838799s","start":"2026-04-20T01:59:06.165728Z","end":"2026-04-20T01:59:09.637567Z","steps":["trace[226603548] 'agreement among raft nodes before linearized reading' (duration: 3.471777208s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.637603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.165673Z","time spent":"3.47192451s","remote":"127.0.0.1:53634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.33\" "} {"level":"info","ts":"2026-04-20T01:59:09.636807Z","caller":"traceutil/trace.go:171","msg":"trace[2051484561] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"1.028752169s","start":"2026-04-20T01:59:08.608048Z","end":"2026-04-20T01:59:09.636801Z","steps":["trace[2051484561] 'process raft request' (duration: 1.02799664s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.639057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:08.608043Z","time spent":"1.030964503s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:09.636941Z","caller":"traceutil/trace.go:171","msg":"trace[1234860442] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:19; }","duration":"3.469145329s","start":"2026-04-20T01:59:06.167697Z","end":"2026-04-20T01:59:09.636842Z","steps":["trace[1234860442] 'agreement among raft nodes before linearized reading' (duration: 3.469036448s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:09.640854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.167683Z","time spent":"3.473136723s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-20T01:59:10.296712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.437379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-20T01:59:10.297004Z","caller":"traceutil/trace.go:171","msg":"trace[466880044] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"321.863345ms","start":"2026-04-20T01:59:09.975106Z","end":"2026-04-20T01:59:10.296969Z","steps":["trace[466880044] 'process raft request' (duration: 153.89109ms)","trace[466880044] 'compare' (duration: 167.287407ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:10.297167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:09.975093Z","time spent":"321.983357ms","remote":"127.0.0.1:54022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1216,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:10.297463Z","caller":"traceutil/trace.go:171","msg":"trace[1418074045] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"318.530919ms","start":"2026-04-20T01:59:09.978908Z","end":"2026-04-20T01:59:10.297439Z","steps":["trace[1418074045] 'process raft request' (duration: 318.468829ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:10.297515Z","caller":"traceutil/trace.go:171","msg":"trace[894176034] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"320.854684ms","start":"2026-04-20T01:59:09.976621Z","end":"2026-04-20T01:59:10.297476Z","steps":["trace[894176034] 'process raft request' (duration: 320.256108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:10.297711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:09.976609Z","time spent":"320.993796ms","remote":"127.0.0.1:53944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":665,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:10.297571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:09.978886Z","time spent":"318.64441ms","remote":"127.0.0.1:54022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:11.464269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.373496ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-20T01:59:11.464527Z","caller":"traceutil/trace.go:171","msg":"trace[293021329] linearizableReadLoop","detail":"{readStateIndex:71; appliedIndex:68; }","duration":"998.159764ms","start":"2026-04-20T01:59:10.466349Z","end":"2026-04-20T01:59:11.464508Z","steps":["trace[293021329] 'read index received' (duration: 9.445105ms)","trace[293021329] 'applied index is now lower than readState.Index' (duration: 988.713619ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:11.464644Z","caller":"traceutil/trace.go:171","msg":"trace[612999628] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"1.162890672s","start":"2026-04-20T01:59:10.301739Z","end":"2026-04-20T01:59:11.46463Z","steps":["trace[612999628] 'process raft request' (duration: 174.042832ms)","trace[612999628] 'compare' (duration: 988.243244ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:11.464728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:10.301724Z","time spent":"1.162958073s","remote":"127.0.0.1:54022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1199,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:11.464957Z","caller":"traceutil/trace.go:171","msg":"trace[1788444504] transaction","detail":"{read_only:false; response_revision:66; number_of_response:1; }","duration":"1.135225047s","start":"2026-04-20T01:59:10.32967Z","end":"2026-04-20T01:59:11.464895Z","steps":["trace[1788444504] 'process raft request' (duration: 1.134713551s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:11.465111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:10.329651Z","time spent":"1.135391758s","remote":"127.0.0.1:53944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":600,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:11.465478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"999.107814ms","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:4"} {"level":"info","ts":"2026-04-20T01:59:11.46568Z","caller":"traceutil/trace.go:171","msg":"trace[487797539] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:67; }","duration":"999.303837ms","start":"2026-04-20T01:59:10.466344Z","end":"2026-04-20T01:59:11.465648Z","steps":["trace[487797539] 'agreement among raft nodes before linearized reading' (duration: 999.077774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:11.46584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:10.466304Z","time spent":"999.514989ms","remote":"127.0.0.1:53738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-04-20T01:59:11.465477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.489889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:11.466291Z","caller":"traceutil/trace.go:171","msg":"trace[1453321135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:67; }","duration":"808.329239ms","start":"2026-04-20T01:59:10.657922Z","end":"2026-04-20T01:59:11.466252Z","steps":["trace[1453321135] 'agreement among raft nodes before linearized reading' (duration: 807.429888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:11.46635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:10.657901Z","time spent":"808.43335ms","remote":"127.0.0.1:53590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T01:59:11.464993Z","caller":"traceutil/trace.go:171","msg":"trace[2003995846] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"1.135215157s","start":"2026-04-20T01:59:10.329755Z","end":"2026-04-20T01:59:11.46497Z","steps":["trace[2003995846] 'process raft request' (duration: 1.134688031s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:11.466552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:10.329746Z","time spent":"1.136754203s","remote":"127.0.0.1:54022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":702,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:11.863783Z","caller":"traceutil/trace.go:171","msg":"trace[1385324206] linearizableReadLoop","detail":"{readStateIndex:72; appliedIndex:71; }","duration":"393.749207ms","start":"2026-04-20T01:59:11.470008Z","end":"2026-04-20T01:59:11.863757Z","steps":["trace[1385324206] 'read index received' (duration: 303.056236ms)","trace[1385324206] 'applied index is now lower than readState.Index' (duration: 90.691911ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:11.863885Z","caller":"traceutil/trace.go:171","msg":"trace[1973241927] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"394.272924ms","start":"2026-04-20T01:59:11.469602Z","end":"2026-04-20T01:59:11.863875Z","steps":["trace[1973241927] 'process raft request' (duration: 303.34966ms)","trace[1973241927] 'compare' (duration: 90.629061ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:11.864034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:11.469588Z","time spent":"394.322145ms","remote":"127.0.0.1:53782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:11.864119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.091952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:11.864243Z","caller":"traceutil/trace.go:171","msg":"trace[1069637113] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:68; }","duration":"394.205333ms","start":"2026-04-20T01:59:11.46998Z","end":"2026-04-20T01:59:11.864186Z","steps":["trace[1069637113] 'agreement among raft nodes before linearized reading' (duration: 394.042081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:11.864308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:11.469967Z","time spent":"394.324455ms","remote":"127.0.0.1:53944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"warn","ts":"2026-04-20T01:59:11.865976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.737257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T01:59:11.866062Z","caller":"traceutil/trace.go:171","msg":"trace[644523601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:70; }","duration":"202.87131ms","start":"2026-04-20T01:59:11.66317Z","end":"2026-04-20T01:59:11.866041Z","steps":["trace[644523601] 'agreement among raft nodes before linearized reading' (duration: 202.673007ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:11.866101Z","caller":"traceutil/trace.go:171","msg":"trace[1214717529] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"394.956463ms","start":"2026-04-20T01:59:11.471124Z","end":"2026-04-20T01:59:11.86608Z","steps":["trace[1214717529] 'process raft request' (duration: 394.525467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:11.866209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:11.471104Z","time spent":"395.046023ms","remote":"127.0.0.1:54022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:11.866365Z","caller":"traceutil/trace.go:171","msg":"trace[172535315] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"394.302604ms","start":"2026-04-20T01:59:11.472055Z","end":"2026-04-20T01:59:11.866358Z","steps":["trace[172535315] 'process raft request' (duration: 393.729968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:11.86642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:11.472043Z","time spent":"394.346915ms","remote":"127.0.0.1:54022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1089,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:12.530006Z","caller":"traceutil/trace.go:171","msg":"trace[637982603] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"131.646778ms","start":"2026-04-20T01:59:12.398328Z","end":"2026-04-20T01:59:12.529975Z","steps":["trace[637982603] 'process raft request' (duration: 129.228331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:12.88395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.304204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T01:59:12.884077Z","caller":"traceutil/trace.go:171","msg":"trace[1108062351] transaction","detail":"{read_only:false; response_revision:153; number_of_response:1; }","duration":"174.089829ms","start":"2026-04-20T01:59:12.709959Z","end":"2026-04-20T01:59:12.884049Z","steps":["trace[1108062351] 'process raft request' (duration: 42.620423ms)","trace[1108062351] 'compare' (duration: 131.164242ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:12.885084Z","caller":"traceutil/trace.go:171","msg":"trace[1797234504] linearizableReadLoop","detail":"{readStateIndex:159; appliedIndex:158; }","duration":"127.131999ms","start":"2026-04-20T01:59:12.757928Z","end":"2026-04-20T01:59:12.88506Z","steps":["trace[1797234504] 'read index received' (duration: 126.946447ms)","trace[1797234504] 'applied index is now lower than readState.Index' (duration: 183.982µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:12.885234Z","caller":"traceutil/trace.go:171","msg":"trace[294873045] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"165.686617ms","start":"2026-04-20T01:59:12.719504Z","end":"2026-04-20T01:59:12.885191Z","steps":["trace[294873045] 'process raft request' (duration: 165.448515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:12.885308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.363741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:12.88552Z","caller":"traceutil/trace.go:171","msg":"trace[1135998695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:154; }","duration":"127.615835ms","start":"2026-04-20T01:59:12.757882Z","end":"2026-04-20T01:59:12.885498Z","steps":["trace[1135998695] 'agreement among raft nodes before linearized reading' (duration: 127.286571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:13.1145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.658175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T01:59:13.114614Z","caller":"traceutil/trace.go:171","msg":"trace[1078436419] linearizableReadLoop","detail":"{readStateIndex:166; appliedIndex:165; }","duration":"157.57242ms","start":"2026-04-20T01:59:12.957024Z","end":"2026-04-20T01:59:13.114597Z","steps":["trace[1078436419] 'read index received' (duration: 40.673702ms)","trace[1078436419] 'applied index is now lower than readState.Index' (duration: 116.897598ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:13.114674Z","caller":"traceutil/trace.go:171","msg":"trace[2038731415] transaction","detail":"{read_only:false; response_revision:161; number_of_response:1; }","duration":"164.246462ms","start":"2026-04-20T01:59:12.95039Z","end":"2026-04-20T01:59:13.114636Z","steps":["trace[2038731415] 'process raft request' (duration: 47.381825ms)","trace[2038731415] 'compare' (duration: 116.533774ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:13.11474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.684911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:13.11477Z","caller":"traceutil/trace.go:171","msg":"trace[2009925528] range","detail":"{range_begin:/registry/clusterroles/system:controller:expand-controller; range_end:; response_count:0; response_revision:161; }","duration":"157.768522ms","start":"2026-04-20T01:59:12.956992Z","end":"2026-04-20T01:59:13.114761Z","steps":["trace[2009925528] 'agreement among raft nodes before linearized reading' (duration: 157.64866ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:13.334476Z","caller":"traceutil/trace.go:171","msg":"trace[1502725735] transaction","detail":"{read_only:false; response_revision:163; number_of_response:1; }","duration":"216.61241ms","start":"2026-04-20T01:59:13.117827Z","end":"2026-04-20T01:59:13.33444Z","steps":["trace[1502725735] 'process raft request' (duration: 214.956112ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:13.684327Z","caller":"traceutil/trace.go:171","msg":"trace[765228705] linearizableReadLoop","detail":"{readStateIndex:180; appliedIndex:179; }","duration":"126.628452ms","start":"2026-04-20T01:59:13.557671Z","end":"2026-04-20T01:59:13.684299Z","steps":["trace[765228705] 'read index received' (duration: 116.543643ms)","trace[765228705] 'applied index is now lower than readState.Index' (duration: 10.083689ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:13.684412Z","caller":"traceutil/trace.go:171","msg":"trace[1116265813] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"149.504369ms","start":"2026-04-20T01:59:13.534889Z","end":"2026-04-20T01:59:13.684394Z","steps":["trace[1116265813] 'process raft request' (duration: 139.293629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:13.684462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.770253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:13.6845Z","caller":"traceutil/trace.go:171","msg":"trace[285580230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:175; }","duration":"126.844305ms","start":"2026-04-20T01:59:13.557641Z","end":"2026-04-20T01:59:13.684486Z","steps":["trace[285580230] 'agreement among raft nodes before linearized reading' (duration: 126.754804ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:14.511299Z","caller":"traceutil/trace.go:171","msg":"trace[75521335] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"109.911633ms","start":"2026-04-20T01:59:14.401358Z","end":"2026-04-20T01:59:14.51127Z","steps":["trace[75521335] 'process raft request' (duration: 109.774852ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:14.652817Z","caller":"traceutil/trace.go:171","msg":"trace[1191099044] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"158.528231ms","start":"2026-04-20T01:59:14.494263Z","end":"2026-04-20T01:59:14.652791Z","steps":["trace[1191099044] 'process raft request' (duration: 158.43029ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:14.653312Z","caller":"traceutil/trace.go:171","msg":"trace[1251186547] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"231.890134ms","start":"2026-04-20T01:59:14.421363Z","end":"2026-04-20T01:59:14.653253Z","steps":["trace[1251186547] 'process raft request' (duration: 154.65553ms)","trace[1251186547] 'compare' (duration: 76.571637ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:15.35888Z","caller":"traceutil/trace.go:171","msg":"trace[1430747214] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"118.953049ms","start":"2026-04-20T01:59:15.239891Z","end":"2026-04-20T01:59:15.358844Z","steps":["trace[1430747214] 'process raft request' (duration: 86.103171ms)","trace[1430747214] 'compare' (duration: 32.610435ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:16.784749Z","caller":"traceutil/trace.go:171","msg":"trace[1473269457] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"138.341402ms","start":"2026-04-20T01:59:16.646385Z","end":"2026-04-20T01:59:16.784726Z","steps":["trace[1473269457] 'process raft request' (duration: 136.18916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:16.991146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.840261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T01:59:16.991439Z","caller":"traceutil/trace.go:171","msg":"trace[129503264] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"200.815939ms","start":"2026-04-20T01:59:16.790596Z","end":"2026-04-20T01:59:16.991412Z","steps":["trace[129503264] 'process raft request' (duration: 95.643204ms)","trace[129503264] 'compare' (duration: 104.680739ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:16.991586Z","caller":"traceutil/trace.go:171","msg":"trace[660826027] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"105.521699ms","start":"2026-04-20T01:59:16.885971Z","end":"2026-04-20T01:59:16.991493Z","steps":["trace[660826027] 'process raft request' (duration: 105.415718ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:30.258112Z","caller":"traceutil/trace.go:171","msg":"trace[973241558] linearizableReadLoop","detail":"{readStateIndex:478; appliedIndex:477; }","duration":"171.216522ms","start":"2026-04-20T01:59:30.086874Z","end":"2026-04-20T01:59:30.25809Z","steps":["trace[973241558] 'read index received' (duration: 171.161681ms)","trace[973241558] 'applied index is now lower than readState.Index' (duration: 53.921µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:30.258354Z","caller":"traceutil/trace.go:171","msg":"trace[1271708800] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"312.993834ms","start":"2026-04-20T01:59:29.945347Z","end":"2026-04-20T01:59:30.25834Z","steps":["trace[1271708800] 'process raft request' (duration: 312.621551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.258462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:29.945331Z","time spent":"313.052994ms","remote":"127.0.0.1:53842","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-04-20T01:59:30.258569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.692585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T01:59:30.258595Z","caller":"traceutil/trace.go:171","msg":"trace[842497955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:458; }","duration":"171.736147ms","start":"2026-04-20T01:59:30.086849Z","end":"2026-04-20T01:59:30.258585Z","steps":["trace[842497955] 'agreement among raft nodes before linearized reading' (duration: 171.691535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:30.285763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.18714ms","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-04-20T01:59:30.285826Z","caller":"traceutil/trace.go:171","msg":"trace[631924727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:459; }","duration":"198.295741ms","start":"2026-04-20T01:59:30.087515Z","end":"2026-04-20T01:59:30.285811Z","steps":["trace[631924727] 'agreement among raft nodes before linearized reading' (duration: 197.917418ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:31.230569Z","caller":"traceutil/trace.go:171","msg":"trace[1650243453] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"102.439706ms","start":"2026-04-20T01:59:31.128105Z","end":"2026-04-20T01:59:31.230545Z","steps":["trace[1650243453] 'process raft request' (duration: 102.326855ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:33.421286Z","caller":"traceutil/trace.go:171","msg":"trace[508996963] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"183.605303ms","start":"2026-04-20T01:59:33.237654Z","end":"2026-04-20T01:59:33.421259Z","steps":["trace[508996963] 'process raft request' (duration: 183.439261ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:34.530422Z","caller":"traceutil/trace.go:171","msg":"trace[1930998348] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"124.363468ms","start":"2026-04-20T01:59:34.40603Z","end":"2026-04-20T01:59:34.530394Z","steps":["trace[1930998348] 'process raft request' (duration: 124.231987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:39.664709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.131683ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-20T01:59:39.664841Z","caller":"traceutil/trace.go:171","msg":"trace[1031889715] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:500; }","duration":"128.460029ms","start":"2026-04-20T01:59:39.536359Z","end":"2026-04-20T01:59:39.664819Z","steps":["trace[1031889715] 'read index received' (duration: 40.001µs)","trace[1031889715] 'applied index is now lower than readState.Index' (duration: 128.418138ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:39.665038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.662631ms","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-04-20T01:59:39.665079Z","caller":"traceutil/trace.go:171","msg":"trace[1138129706] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:479; }","duration":"128.742662ms","start":"2026-04-20T01:59:39.536318Z","end":"2026-04-20T01:59:39.665061Z","steps":["trace[1138129706] 'agreement among raft nodes before linearized reading' (duration: 128.640821ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:42.335188Z","caller":"traceutil/trace.go:171","msg":"trace[2143472696] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"489.749526ms","start":"2026-04-20T01:59:41.845405Z","end":"2026-04-20T01:59:42.335154Z","steps":["trace[2143472696] 'process raft request' (duration: 489.582694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:42.335354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.845382Z","time spent":"489.905068ms","remote":"127.0.0.1:53646","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-04-20T01:59:42.879465Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155920568355168,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T01:59:43.088658Z","caller":"traceutil/trace.go:171","msg":"trace[1090447629] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"1.241506399s","start":"2026-04-20T01:59:41.847119Z","end":"2026-04-20T01:59:43.088625Z","steps":["trace[1090447629] 'process raft request' (duration: 1.241301357s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.088784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.847105Z","time spent":"1.241622859s","remote":"127.0.0.1:53646","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-04-20T01:59:43.088932Z","caller":"traceutil/trace.go:171","msg":"trace[885245455] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.230853212s","start":"2026-04-20T01:59:41.858072Z","end":"2026-04-20T01:59:43.088925Z","steps":["trace[885245455] 'process raft request' (duration: 1.23062121s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.088962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.858053Z","time spent":"1.230893782s","remote":"127.0.0.1:53646","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-04-20T01:59:43.089022Z","caller":"traceutil/trace.go:171","msg":"trace[1618602562] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"1.241845153s","start":"2026-04-20T01:59:41.847171Z","end":"2026-04-20T01:59:43.089016Z","steps":["trace[1618602562] 'process raft request' (duration: 1.241385958s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.08905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.847165Z","time spent":"1.241873853s","remote":"127.0.0.1:53646","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-04-20T01:59:43.089234Z","caller":"traceutil/trace.go:171","msg":"trace[1846708926] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"1.23607694s","start":"2026-04-20T01:59:41.85315Z","end":"2026-04-20T01:59:43.089227Z","steps":["trace[1846708926] 'process raft request' (duration: 1.235453184s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.089198Z","caller":"traceutil/trace.go:171","msg":"trace[1621738349] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.223415316s","start":"2026-04-20T01:59:41.865732Z","end":"2026-04-20T01:59:43.089148Z","steps":["trace[1621738349] 'process raft request' (duration: 1.223030982s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.08923Z","caller":"traceutil/trace.go:171","msg":"trace[844934705] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.223505306s","start":"2026-04-20T01:59:41.865665Z","end":"2026-04-20T01:59:43.08917Z","steps":["trace[844934705] 'process raft request' (duration: 1.223066791s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.089245Z","caller":"traceutil/trace.go:171","msg":"trace[2008828443] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"1.074682411s","start":"2026-04-20T01:59:42.014533Z","end":"2026-04-20T01:59:43.089215Z","steps":["trace[2008828443] 'process raft request' (duration: 1.074621741s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.089333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.865727Z","time spent":"1.223543126s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:43.089365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.865646Z","time spent":"1.223660287s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:43.089391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:42.014511Z","time spent":"1.074812522s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:43.089267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.85313Z","time spent":"1.23612223s","remote":"127.0.0.1:53646","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-04-20T01:59:43.089512Z","caller":"traceutil/trace.go:171","msg":"trace[1188968254] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.20101501s","start":"2026-04-20T01:59:41.888482Z","end":"2026-04-20T01:59:43.089497Z","steps":["trace[1188968254] 'process raft request' (duration: 1.200369094s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.08953Z","caller":"traceutil/trace.go:171","msg":"trace[1733352215] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.186125795s","start":"2026-04-20T01:59:41.903394Z","end":"2026-04-20T01:59:43.08952Z","steps":["trace[1733352215] 'process raft request' (duration: 1.185665942s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.089615Z","caller":"traceutil/trace.go:171","msg":"trace[719299332] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.20417914s","start":"2026-04-20T01:59:41.885379Z","end":"2026-04-20T01:59:43.089558Z","steps":["trace[719299332] 'process raft request' (duration: 1.203423603s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.089616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.888463Z","time spent":"1.20107626s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:43.089622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.903349Z","time spent":"1.186205696s","remote":"127.0.0.1:53646","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-04-20T01:59:43.089664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.885361Z","time spent":"1.20428306s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:43.089292Z","caller":"traceutil/trace.go:171","msg":"trace[1051585681] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.23596758s","start":"2026-04-20T01:59:41.853319Z","end":"2026-04-20T01:59:43.089286Z","steps":["trace[1051585681] 'process raft request' (duration: 1.235336164s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.089729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:41.853299Z","time spent":"1.236403684s","remote":"127.0.0.1:53646","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-04-20T01:59:43.451066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.650336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T01:59:43.451458Z","caller":"traceutil/trace.go:171","msg":"trace[1712305628] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.108879628s","start":"2026-04-20T01:59:42.342557Z","end":"2026-04-20T01:59:43.451437Z","steps":["trace[1712305628] 'process raft request' (duration: 1.108620606s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.451552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:42.342516Z","time spent":"1.10898689s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:43.451566Z","caller":"traceutil/trace.go:171","msg":"trace[676034307] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.110646424s","start":"2026-04-20T01:59:42.340872Z","end":"2026-04-20T01:59:43.451518Z","steps":["trace[676034307] 'process raft request' (duration: 913.474634ms)","trace[676034307] 'compare' (duration: 196.522344ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:43.451697Z","caller":"traceutil/trace.go:171","msg":"trace[1385163336] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:542; }","duration":"1.072431457s","start":"2026-04-20T01:59:42.379183Z","end":"2026-04-20T01:59:43.451615Z","steps":["trace[1385163336] 'read index received' (duration: 709.074056ms)","trace[1385163336] 'applied index is now lower than readState.Index' (duration: 363.354671ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:43.451747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:42.340834Z","time spent":"1.110823927s","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:43.451868Z","caller":"traceutil/trace.go:171","msg":"trace[2001328951] transaction","detail":"{read_only:false; number_of_response:1; response_revision:533; }","duration":"1.108575976s","start":"2026-04-20T01:59:42.343272Z","end":"2026-04-20T01:59:43.451848Z","steps":["trace[2001328951] 'process raft request' (duration: 1.107985291s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.452009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:42.343263Z","time spent":"1.108640887s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:43.452064Z","caller":"traceutil/trace.go:171","msg":"trace[920437657] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"357.391988ms","start":"2026-04-20T01:59:43.094649Z","end":"2026-04-20T01:59:43.452041Z","steps":["trace[920437657] 'process raft request' (duration: 356.646051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.45215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.094629Z","time spent":"357.483568ms","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:43.452203Z","caller":"traceutil/trace.go:171","msg":"trace[2127522275] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"356.116566ms","start":"2026-04-20T01:59:43.096063Z","end":"2026-04-20T01:59:43.452179Z","steps":["trace[2127522275] 'process raft request' (duration: 355.890814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.452194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.072977473s","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-04-20T01:59:43.452275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.096043Z","time spent":"356.197606ms","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:43.452286Z","caller":"traceutil/trace.go:171","msg":"trace[1795190564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:534; }","duration":"1.073115163s","start":"2026-04-20T01:59:42.379145Z","end":"2026-04-20T01:59:43.45226Z","steps":["trace[1795190564] 'agreement among raft nodes before linearized reading' (duration: 1.072762121s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.452335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:42.379132Z","time spent":"1.073194004s","remote":"127.0.0.1:53842","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-04-20T01:59:43.452428Z","caller":"traceutil/trace.go:171","msg":"trace[1744864776] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"346.148316ms","start":"2026-04-20T01:59:43.106261Z","end":"2026-04-20T01:59:43.452409Z","steps":["trace[1744864776] 'process raft request' (duration: 345.849603ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.452472Z","caller":"traceutil/trace.go:171","msg":"trace[1925479686] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"346.387859ms","start":"2026-04-20T01:59:43.106067Z","end":"2026-04-20T01:59:43.452455Z","steps":["trace[1925479686] 'process raft request' (duration: 345.973795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.452521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.106247Z","time spent":"346.227037ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:43.452547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.106046Z","time spent":"346.471159ms","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:43.452624Z","caller":"traceutil/trace.go:171","msg":"trace[179518816] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"341.651386ms","start":"2026-04-20T01:59:43.11096Z","end":"2026-04-20T01:59:43.452612Z","steps":["trace[179518816] 'process raft request' (duration: 341.226372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.452668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.110945Z","time spent":"341.700626ms","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:43.452732Z","caller":"traceutil/trace.go:171","msg":"trace[1444735781] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"304.988915ms","start":"2026-04-20T01:59:43.147724Z","end":"2026-04-20T01:59:43.452713Z","steps":["trace[1444735781] 'process raft request' (duration: 304.933954ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.452761Z","caller":"traceutil/trace.go:171","msg":"trace[2100109315] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"339.89289ms","start":"2026-04-20T01:59:43.112852Z","end":"2026-04-20T01:59:43.452745Z","steps":["trace[2100109315] 'process raft request' (duration: 339.662588ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.452793Z","caller":"traceutil/trace.go:171","msg":"trace[1951286162] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"340.840268ms","start":"2026-04-20T01:59:43.11194Z","end":"2026-04-20T01:59:43.45278Z","steps":["trace[1951286162] 'process raft request' (duration: 340.312653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.452808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.147694Z","time spent":"305.081746ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:43.452842Z","caller":"traceutil/trace.go:171","msg":"trace[550332325] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"336.508289ms","start":"2026-04-20T01:59:43.116321Z","end":"2026-04-20T01:59:43.452829Z","steps":["trace[550332325] 'process raft request' (duration: 336.273827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.452863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.112819Z","time spent":"339.97881ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:43.452944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.116311Z","time spent":"336.559209ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:43.452868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.111932Z","time spent":"340.893859ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:43.453833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054054041s","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-04-20T01:59:43.453864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.859422ms","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-04-20T01:59:43.453868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.611822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:43.453921Z","caller":"traceutil/trace.go:171","msg":"trace[200734620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:542; }","duration":"1.054192283s","start":"2026-04-20T01:59:42.399709Z","end":"2026-04-20T01:59:43.453902Z","steps":["trace[200734620] 'agreement among raft nodes before linearized reading' (duration: 1.05390931s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.453924Z","caller":"traceutil/trace.go:171","msg":"trace[1332983740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:542; }","duration":"835.960654ms","start":"2026-04-20T01:59:42.617948Z","end":"2026-04-20T01:59:43.453909Z","steps":["trace[1332983740] 'agreement among raft nodes before linearized reading' (duration: 835.723171ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:43.453943Z","caller":"traceutil/trace.go:171","msg":"trace[1309240388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"844.680213ms","start":"2026-04-20T01:59:42.609238Z","end":"2026-04-20T01:59:43.453918Z","steps":["trace[1309240388] 'agreement among raft nodes before linearized reading' (duration: 844.493251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:43.453963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:42.399681Z","time spent":"1.054272683s","remote":"127.0.0.1:53842","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-04-20T01:59:43.453967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:42.617926Z","time spent":"836.031814ms","remote":"127.0.0.1:53842","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-04-20T01:59:43.453979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:42.609194Z","time spent":"844.777644ms","remote":"127.0.0.1:53590","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-04-20T01:59:44.017282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.827242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-20T01:59:44.017402Z","caller":"traceutil/trace.go:171","msg":"trace[395121218] transaction","detail":"{read_only:false; number_of_response:0; response_revision:545; }","duration":"530.596112ms","start":"2026-04-20T01:59:43.486788Z","end":"2026-04-20T01:59:44.017384Z","steps":["trace[395121218] 'process raft request' (duration: 275.611039ms)","trace[395121218] 'compare' (duration: 254.768791ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:44.017473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.486758Z","time spent":"530.676453ms","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:44.162032Z","caller":"traceutil/trace.go:171","msg":"trace[2101748888] transaction","detail":"{read_only:false; number_of_response:0; response_revision:545; }","duration":"674.399756ms","start":"2026-04-20T01:59:43.487602Z","end":"2026-04-20T01:59:44.162002Z","steps":["trace[2101748888] 'process raft request' (duration: 674.187585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.162218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.487577Z","time spent":"674.563637ms","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:44.162353Z","caller":"traceutil/trace.go:171","msg":"trace[1677554060] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"666.98646ms","start":"2026-04-20T01:59:43.495335Z","end":"2026-04-20T01:59:44.162322Z","steps":["trace[1677554060] 'process raft request' (duration: 666.540505ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:44.162452Z","caller":"traceutil/trace.go:171","msg":"trace[399785533] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"664.655599ms","start":"2026-04-20T01:59:43.49774Z","end":"2026-04-20T01:59:44.162395Z","steps":["trace[399785533] 'process raft request' (duration: 664.261295ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:44.162626Z","caller":"traceutil/trace.go:171","msg":"trace[2030542949] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"653.056164ms","start":"2026-04-20T01:59:43.509561Z","end":"2026-04-20T01:59:44.162617Z","steps":["trace[2030542949] 'process raft request' (duration: 652.508749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.162654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.497701Z","time spent":"664.917741ms","remote":"127.0.0.1:54092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:44.16268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.509537Z","time spent":"653.120664ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:44.162496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.495311Z","time spent":"667.10985ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:44.162754Z","caller":"traceutil/trace.go:171","msg":"trace[1726107669] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"653.021624ms","start":"2026-04-20T01:59:43.509717Z","end":"2026-04-20T01:59:44.162739Z","steps":["trace[1726107669] 'process raft request' (duration: 652.756522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.162845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.509711Z","time spent":"653.082264ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:44.163117Z","caller":"traceutil/trace.go:171","msg":"trace[151696232] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"652.031644ms","start":"2026-04-20T01:59:43.511063Z","end":"2026-04-20T01:59:44.163095Z","steps":["trace[151696232] 'process raft request' (duration: 651.717491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.163254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.511042Z","time spent":"652.144476ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:44.163285Z","caller":"traceutil/trace.go:171","msg":"trace[835230233] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"618.560613ms","start":"2026-04-20T01:59:43.544709Z","end":"2026-04-20T01:59:44.16327Z","steps":["trace[835230233] 'process raft request' (duration: 618.304821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.16335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.544684Z","time spent":"618.634513ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:44.163461Z","caller":"traceutil/trace.go:171","msg":"trace[1010069020] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:569; }","duration":"444.380289ms","start":"2026-04-20T01:59:43.719065Z","end":"2026-04-20T01:59:44.163445Z","steps":["trace[1010069020] 'read index received' (duration: 43.360742ms)","trace[1010069020] 'applied index is now lower than readState.Index' (duration: 401.018727ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:44.16353Z","caller":"traceutil/trace.go:171","msg":"trace[1036748517] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"613.488356ms","start":"2026-04-20T01:59:43.550031Z","end":"2026-04-20T01:59:44.163519Z","steps":["trace[1036748517] 'process raft request' (duration: 613.134523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.163588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.550015Z","time spent":"613.543836ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:44.163881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.306698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-04-20T01:59:44.163926Z","caller":"traceutil/trace.go:171","msg":"trace[682893756] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:552; }","duration":"145.397709ms","start":"2026-04-20T01:59:44.018516Z","end":"2026-04-20T01:59:44.163914Z","steps":["trace[682893756] 'agreement among raft nodes before linearized reading' (duration: 145.218357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.166218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.060003ms","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-04-20T01:59:44.166323Z","caller":"traceutil/trace.go:171","msg":"trace[458630766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:552; }","duration":"447.284175ms","start":"2026-04-20T01:59:43.719016Z","end":"2026-04-20T01:59:44.1663Z","steps":["trace[458630766] 'agreement among raft nodes before linearized reading' (duration: 444.58876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.166375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:43.718996Z","time spent":"447.368005ms","remote":"127.0.0.1:53842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T01:59:44.488864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.234568ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-20T01:59:44.489152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:44.165548Z","time spent":"323.593181ms","remote":"127.0.0.1:53634","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-20T01:59:44.489316Z","caller":"traceutil/trace.go:171","msg":"trace[732021223] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"316.161235ms","start":"2026-04-20T01:59:44.173121Z","end":"2026-04-20T01:59:44.489282Z","steps":["trace[732021223] 'process raft request' (duration: 315.917083ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:44.48941Z","caller":"traceutil/trace.go:171","msg":"trace[798043141] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"316.101935ms","start":"2026-04-20T01:59:44.173265Z","end":"2026-04-20T01:59:44.489367Z","steps":["trace[798043141] 'process raft request' (duration: 315.934294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.489491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:44.173076Z","time spent":"316.323036ms","remote":"127.0.0.1:53842","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-04-20T01:59:44.489534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:44.173254Z","time spent":"316.222506ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:44.489522Z","caller":"traceutil/trace.go:171","msg":"trace[1606193542] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"315.418179ms","start":"2026-04-20T01:59:44.174053Z","end":"2026-04-20T01:59:44.489471Z","steps":["trace[1606193542] 'process raft request' (duration: 315.185747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:44.489712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:44.17404Z","time spent":"315.57542ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:44.489358Z","caller":"traceutil/trace.go:171","msg":"trace[1128052316] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"271.031189ms","start":"2026-04-20T01:59:44.218311Z","end":"2026-04-20T01:59:44.489343Z","steps":["trace[1128052316] 'process raft request' (duration: 270.961328ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:45.207527Z","caller":"traceutil/trace.go:171","msg":"trace[871044819] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"270.096504ms","start":"2026-04-20T01:59:44.937409Z","end":"2026-04-20T01:59:45.207505Z","steps":["trace[871044819] 'process raft request' (duration: 261.061083ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:45.212461Z","caller":"traceutil/trace.go:171","msg":"trace[325860799] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"262.482035ms","start":"2026-04-20T01:59:44.94995Z","end":"2026-04-20T01:59:45.212432Z","steps":["trace[325860799] 'process raft request' (duration: 262.207622ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:45.212744Z","caller":"traceutil/trace.go:171","msg":"trace[837147844] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"234.144459ms","start":"2026-04-20T01:59:44.978572Z","end":"2026-04-20T01:59:45.212716Z","steps":["trace[837147844] 'process raft request' (duration: 233.922518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:45.981088Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155920568355233,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T01:59:46.418716Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.090663315s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-20T01:59:47.276319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.591496ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:47.276583Z","caller":"traceutil/trace.go:171","msg":"trace[883657472] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:577; }","duration":"432.859958ms","start":"2026-04-20T01:59:46.843707Z","end":"2026-04-20T01:59:47.276567Z","steps":["trace[883657472] 'range keys from in-memory index tree' (duration: 432.580486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:47.276513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.494572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T01:59:47.277395Z","caller":"traceutil/trace.go:171","msg":"trace[1502286438] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.958846012s","start":"2026-04-20T01:59:45.318517Z","end":"2026-04-20T01:59:47.277363Z","steps":["trace[1502286438] 'process raft request' (duration: 1.100453682s)","trace[1502286438] 'compare' (duration: 857.170539ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:47.277699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:45.3185Z","time spent":"1.959105516s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:47.291066Z","caller":"traceutil/trace.go:171","msg":"trace[1883911331] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:604; }","duration":"1.810802284s","start":"2026-04-20T01:59:45.48025Z","end":"2026-04-20T01:59:47.291053Z","steps":["trace[1883911331] 'read index received' (duration: 938.578101ms)","trace[1883911331] 'applied index is now lower than readState.Index' (duration: 872.222813ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:47.291077Z","caller":"traceutil/trace.go:171","msg":"trace[1525901957] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.968626839s","start":"2026-04-20T01:59:45.322418Z","end":"2026-04-20T01:59:47.291045Z","steps":["trace[1525901957] 'process raft request' (duration: 1.968227355s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:47.291194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.810824764s","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-04-20T01:59:47.291221Z","caller":"traceutil/trace.go:171","msg":"trace[655262503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"1.810971026s","start":"2026-04-20T01:59:45.480243Z","end":"2026-04-20T01:59:47.291214Z","steps":["trace[655262503] 'agreement among raft nodes before linearized reading' (duration: 1.810915005s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:47.291229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:45.322393Z","time spent":"1.96875509s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:47.291242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:45.480221Z","time spent":"1.811016617s","remote":"127.0.0.1:53842","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-04-20T01:59:47.291331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.417444ms","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-04-20T01:59:47.291349Z","caller":"traceutil/trace.go:171","msg":"trace[782884432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"797.469445ms","start":"2026-04-20T01:59:46.493875Z","end":"2026-04-20T01:59:47.291344Z","steps":["trace[782884432] 'agreement among raft nodes before linearized reading' (duration: 797.381035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:47.291379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.681259373s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:47.291445Z","caller":"traceutil/trace.go:171","msg":"trace[1101377032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"1.681365633s","start":"2026-04-20T01:59:45.610066Z","end":"2026-04-20T01:59:47.291432Z","steps":["trace[1101377032] 'agreement among raft nodes before linearized reading' (duration: 1.681265132s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:47.291471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.811216457s","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-04-20T01:59:47.291486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:45.610047Z","time spent":"1.681430513s","remote":"127.0.0.1:53590","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-04-20T01:59:47.291052Z","caller":"traceutil/trace.go:171","msg":"trace[1108354818] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"215.778262ms","start":"2026-04-20T01:59:47.075247Z","end":"2026-04-20T01:59:47.291026Z","steps":["trace[1108354818] 'process raft request' (duration: 215.722732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:47.291362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:46.493855Z","time spent":"797.503936ms","remote":"127.0.0.1:53842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T01:59:47.29167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.802592951s","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-04-20T01:59:47.291778Z","caller":"traceutil/trace.go:171","msg":"trace[2031214236] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"1.802697772s","start":"2026-04-20T01:59:45.489067Z","end":"2026-04-20T01:59:47.291765Z","steps":["trace[2031214236] 'agreement among raft nodes before linearized reading' (duration: 1.8025274s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:47.291832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:45.489031Z","time spent":"1.802794192s","remote":"127.0.0.1:53842","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-04-20T01:59:47.291807Z","caller":"traceutil/trace.go:171","msg":"trace[1775689242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"1.811298169s","start":"2026-04-20T01:59:45.480211Z","end":"2026-04-20T01:59:47.291509Z","steps":["trace[1775689242] 'agreement among raft nodes before linearized reading' (duration: 1.810926446s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:47.292015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:45.480192Z","time spent":"1.811796063s","remote":"127.0.0.1:53842","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-04-20T01:59:47.7992Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155920568355251,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T01:59:48.422505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.627258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T01:59:48.423195Z","caller":"traceutil/trace.go:171","msg":"trace[1994306950] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.127072372s","start":"2026-04-20T01:59:47.296082Z","end":"2026-04-20T01:59:48.423155Z","steps":["trace[1994306950] 'process raft request' (duration: 545.715998ms)","trace[1994306950] 'compare' (duration: 580.502136ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:48.423454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:47.296059Z","time spent":"1.127213933s","remote":"127.0.0.1:53842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:48.423485Z","caller":"traceutil/trace.go:171","msg":"trace[491416155] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"1.127265973s","start":"2026-04-20T01:59:47.296202Z","end":"2026-04-20T01:59:48.423468Z","steps":["trace[491416155] 'process raft request' (duration: 1.12692708s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:48.423647Z","caller":"traceutil/trace.go:171","msg":"trace[209867605] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.127440685s","start":"2026-04-20T01:59:47.296169Z","end":"2026-04-20T01:59:48.42361Z","steps":["trace[209867605] 'process raft request' (duration: 1.127172543s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:48.423703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:47.296193Z","time spent":"1.127457235s","remote":"127.0.0.1:53842","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-04-20T01:59:48.423804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:47.296136Z","time spent":"1.127587907s","remote":"127.0.0.1:53842","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-04-20T01:59:48.423816Z","caller":"traceutil/trace.go:171","msg":"trace[1325179777] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.10663709s","start":"2026-04-20T01:59:47.317162Z","end":"2026-04-20T01:59:48.423799Z","steps":["trace[1325179777] 'process raft request' (duration: 1.106267097s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:48.424129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:47.317144Z","time spent":"1.106911672s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:48.423217Z","caller":"traceutil/trace.go:171","msg":"trace[870933407] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.127073512s","start":"2026-04-20T01:59:47.296123Z","end":"2026-04-20T01:59:48.423196Z","steps":["trace[870933407] 'process raft request' (duration: 1.126919161s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:48.424503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:47.2961Z","time spent":"1.128341823s","remote":"127.0.0.1:53842","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-04-20T01:59:48.425487Z","caller":"traceutil/trace.go:171","msg":"trace[1655942499] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"1.033976343s","start":"2026-04-20T01:59:47.391486Z","end":"2026-04-20T01:59:48.425463Z","steps":["trace[1655942499] 'process raft request' (duration: 1.032073016s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:48.425568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:47.391456Z","time spent":"1.034066243s","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:48.425646Z","caller":"traceutil/trace.go:171","msg":"trace[1219917953] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:607; }","duration":"1.126555637s","start":"2026-04-20T01:59:47.299071Z","end":"2026-04-20T01:59:48.425626Z","steps":["trace[1219917953] 'read index received' (duration: 542.742232ms)","trace[1219917953] 'applied index is now lower than readState.Index' (duration: 583.812615ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:48.425738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126665879s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:48.425774Z","caller":"traceutil/trace.go:171","msg":"trace[2036490206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"1.126730789s","start":"2026-04-20T01:59:47.299034Z","end":"2026-04-20T01:59:48.425765Z","steps":["trace[2036490206] 'agreement among raft nodes before linearized reading' (duration: 1.126646387s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:48.425771Z","caller":"traceutil/trace.go:171","msg":"trace[631847132] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"988.351437ms","start":"2026-04-20T01:59:47.437409Z","end":"2026-04-20T01:59:48.42576Z","steps":["trace[631847132] 'process raft request' (duration: 987.445868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:48.42581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:47.299021Z","time spent":"1.126781669s","remote":"127.0.0.1:53590","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-04-20T01:59:48.425838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:47.437376Z","time spent":"988.439047ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:48.704047Z","caller":"traceutil/trace.go:171","msg":"trace[978003978] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"142.756856ms","start":"2026-04-20T01:59:48.561261Z","end":"2026-04-20T01:59:48.704018Z","steps":["trace[978003978] 'process raft request' (duration: 109.576362ms)","trace[978003978] 'compare' (duration: 33.068123ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:48.796691Z","caller":"traceutil/trace.go:171","msg":"trace[1855550837] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:620; }","duration":"206.247189ms","start":"2026-04-20T01:59:48.590398Z","end":"2026-04-20T01:59:48.796645Z","steps":["trace[1855550837] 'read index received' (duration: 80.670865ms)","trace[1855550837] 'applied index is now lower than readState.Index' (duration: 125.575144ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:48.796717Z","caller":"traceutil/trace.go:171","msg":"trace[696942015] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"228.874701ms","start":"2026-04-20T01:59:48.567817Z","end":"2026-04-20T01:59:48.796692Z","steps":["trace[696942015] 'process raft request' (duration: 228.556289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:48.796845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.432261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-20T01:59:48.796871Z","caller":"traceutil/trace.go:171","msg":"trace[883697276] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:595; }","duration":"206.500842ms","start":"2026-04-20T01:59:48.590363Z","end":"2026-04-20T01:59:48.796864Z","steps":["trace[883697276] 'agreement among raft nodes before linearized reading' (duration: 206.3959ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:48.981451Z","caller":"traceutil/trace.go:171","msg":"trace[1778047229] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"177.435123ms","start":"2026-04-20T01:59:48.803987Z","end":"2026-04-20T01:59:48.981423Z","steps":["trace[1778047229] 'read index received' (duration: 106.465174ms)","trace[1778047229] 'applied index is now lower than readState.Index' (duration: 70.968699ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T01:59:48.981703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.692846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-04-20T01:59:48.9817Z","caller":"traceutil/trace.go:171","msg":"trace[188496336] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"263.490278ms","start":"2026-04-20T01:59:48.718183Z","end":"2026-04-20T01:59:48.981674Z","steps":["trace[188496336] 'process raft request' (duration: 191.978233ms)","trace[188496336] 'compare' (duration: 71.096851ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:48.981738Z","caller":"traceutil/trace.go:171","msg":"trace[1469970776] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:596; }","duration":"177.745037ms","start":"2026-04-20T01:59:48.80398Z","end":"2026-04-20T01:59:48.981726Z","steps":["trace[1469970776] 'agreement among raft nodes before linearized reading' (duration: 177.566924ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:48.982338Z","caller":"traceutil/trace.go:171","msg":"trace[953688118] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"154.078848ms","start":"2026-04-20T01:59:48.828246Z","end":"2026-04-20T01:59:48.982325Z","steps":["trace[953688118] 'process raft request' (duration: 153.979606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:54.66858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.187602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pbcdc\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-20T01:59:54.668669Z","caller":"traceutil/trace.go:171","msg":"trace[899918869] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pbcdc; range_end:; response_count:1; response_revision:629; }","duration":"121.32184ms","start":"2026-04-20T01:59:54.547326Z","end":"2026-04-20T01:59:54.668648Z","steps":["trace[899918869] 'range keys from in-memory index tree' (duration: 121.027504ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:54.763553Z","caller":"traceutil/trace.go:171","msg":"trace[852809754] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"196.119707ms","start":"2026-04-20T01:59:54.567409Z","end":"2026-04-20T01:59:54.763529Z","steps":["trace[852809754] 'process raft request' (duration: 195.591931ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:55.387281Z","caller":"traceutil/trace.go:171","msg":"trace[778520669] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"703.463916ms","start":"2026-04-20T01:59:54.683704Z","end":"2026-04-20T01:59:55.387168Z","steps":["trace[778520669] 'process raft request' (duration: 702.535102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:55.387458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:54.683673Z","time spent":"703.690327ms","remote":"127.0.0.1:53782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T01:59:55.392566Z","caller":"traceutil/trace.go:171","msg":"trace[111622464] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"561.896486ms","start":"2026-04-20T01:59:54.830638Z","end":"2026-04-20T01:59:55.392535Z","steps":["trace[111622464] 'process raft request' (duration: 561.016043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:55.392875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:54.830611Z","time spent":"562.044482ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T01:59:56.965989Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155920568355452,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T01:59:57.466611Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155920568355452,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T01:59:57.526295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.981673ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:57.526425Z","caller":"traceutil/trace.go:171","msg":"trace[974894909] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:632; }","duration":"682.122542ms","start":"2026-04-20T01:59:56.844285Z","end":"2026-04-20T01:59:57.526407Z","steps":["trace[974894909] 'range keys from in-memory index tree' (duration: 681.957152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:57.526612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.919289537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T01:59:57.526674Z","caller":"traceutil/trace.go:171","msg":"trace[314677962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"1.919387081s","start":"2026-04-20T01:59:55.60727Z","end":"2026-04-20T01:59:57.526657Z","steps":["trace[314677962] 'range keys from in-memory index tree' (duration: 1.919231844s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:57.526702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:55.607255Z","time spent":"1.919440384s","remote":"127.0.0.1:53602","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-04-20T01:59:57.559836Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.761894583s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T01:59:57.561018Z","caller":"traceutil/trace.go:171","msg":"trace[701087144] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"1.095345444s","start":"2026-04-20T01:59:56.465647Z","end":"2026-04-20T01:59:57.560993Z","steps":["trace[701087144] 'read index received' (duration: 1.094344677s)","trace[701087144] 'applied index is now lower than readState.Index' (duration: 999.817µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T01:59:57.561203Z","caller":"traceutil/trace.go:171","msg":"trace[1026315461] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"1.765047293s","start":"2026-04-20T01:59:55.796065Z","end":"2026-04-20T01:59:57.561113Z","steps":["trace[1026315461] 'process raft request' (duration: 1.764294938s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:57.561288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095615006s","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-04-20T01:59:57.561312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093230403s","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-04-20T01:59:57.561346Z","caller":"traceutil/trace.go:171","msg":"trace[764053527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:633; }","duration":"1.095722671s","start":"2026-04-20T01:59:56.465606Z","end":"2026-04-20T01:59:57.561328Z","steps":["trace[764053527] 'agreement among raft nodes before linearized reading' (duration: 1.095538713s)"],"step_count":1} {"level":"info","ts":"2026-04-20T01:59:57.561385Z","caller":"traceutil/trace.go:171","msg":"trace[1342000854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"1.093319177s","start":"2026-04-20T01:59:56.468045Z","end":"2026-04-20T01:59:57.561365Z","steps":["trace[1342000854] 'agreement among raft nodes before linearized reading' (duration: 1.093149859s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:57.5614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:56.465585Z","time spent":"1.095799915s","remote":"127.0.0.1:53842","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-04-20T01:59:57.561428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:56.468035Z","time spent":"1.09338183s","remote":"127.0.0.1:53842","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-04-20T01:59:57.561428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091717362s","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-04-20T01:59:57.561519Z","caller":"traceutil/trace.go:171","msg":"trace[868677644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"1.091827388s","start":"2026-04-20T01:59:56.469665Z","end":"2026-04-20T01:59:57.561492Z","steps":["trace[868677644] 'agreement among raft nodes before linearized reading' (duration: 1.091568385s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:57.56157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:56.469657Z","time spent":"1.091903801s","remote":"127.0.0.1:53842","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-04-20T01:59:57.561679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:55.79603Z","time spent":"1.765330826s","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T01:59:57.561799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.092378152s","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-04-20T01:59:57.561864Z","caller":"traceutil/trace.go:171","msg":"trace[267134048] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"1.092462516s","start":"2026-04-20T01:59:56.469385Z","end":"2026-04-20T01:59:57.561848Z","steps":["trace[267134048] 'agreement among raft nodes before linearized reading' (duration: 1.092312089s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:57.561908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:56.469375Z","time spent":"1.092520429s","remote":"127.0.0.1:53842","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-04-20T01:59:59.223482Z","caller":"traceutil/trace.go:171","msg":"trace[2023240639] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"533.92499ms","start":"2026-04-20T01:59:58.68953Z","end":"2026-04-20T01:59:59.223455Z","steps":["trace[2023240639] 'process raft request' (duration: 529.726838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T01:59:59.223639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:58.689514Z","time spent":"534.052546ms","remote":"127.0.0.1:53678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":856,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T01:59:59.241004Z","caller":"traceutil/trace.go:171","msg":"trace[325011364] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"186.695857ms","start":"2026-04-20T01:59:59.054287Z","end":"2026-04-20T01:59:59.240983Z","steps":["trace[325011364] 'process raft request' (duration: 185.221769ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:03.349099Z","caller":"traceutil/trace.go:171","msg":"trace[726681048] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"319.309741ms","start":"2026-04-20T02:00:03.029765Z","end":"2026-04-20T02:00:03.349075Z","steps":["trace[726681048] 'process raft request' (duration: 319.020569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.349234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:03.029744Z","time spent":"319.434686ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T02:00:03.522317Z","caller":"traceutil/trace.go:171","msg":"trace[2045535876] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:752; }","duration":"308.53678ms","start":"2026-04-20T02:00:03.213719Z","end":"2026-04-20T02:00:03.522256Z","steps":["trace[2045535876] 'read index received' (duration: 135.117899ms)","trace[2045535876] 'applied index is now lower than readState.Index' (duration: 173.417851ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:03.522419Z","caller":"traceutil/trace.go:171","msg":"trace[2080855313] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"458.388363ms","start":"2026-04-20T02:00:03.063989Z","end":"2026-04-20T02:00:03.522378Z","steps":["trace[2080855313] 'process raft request' (duration: 457.43018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.522706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.925567ms","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":"warn","ts":"2026-04-20T02:00:03.522821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:03.06396Z","time spent":"458.694386ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:00:03.522814Z","caller":"traceutil/trace.go:171","msg":"trace[174749671] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:722; }","duration":"309.131276ms","start":"2026-04-20T02:00:03.213662Z","end":"2026-04-20T02:00:03.522794Z","steps":["trace[174749671] 'agreement among raft nodes before linearized reading' (duration: 308.75525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.522893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:03.213639Z","time spent":"309.243042ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"info","ts":"2026-04-20T02:00:03.779538Z","caller":"traceutil/trace.go:171","msg":"trace[1889441692] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:754; }","duration":"257.097675ms","start":"2026-04-20T02:00:03.522418Z","end":"2026-04-20T02:00:03.779515Z","steps":["trace[1889441692] 'read index received' (duration: 166.587263ms)","trace[1889441692] 'applied index is now lower than readState.Index' (duration: 90.509361ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:03.779662Z","caller":"traceutil/trace.go:171","msg":"trace[1593152888] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"361.527754ms","start":"2026-04-20T02:00:03.418092Z","end":"2026-04-20T02:00:03.779619Z","steps":["trace[1593152888] 'process raft request' (duration: 271.014332ms)","trace[1593152888] 'compare' (duration: 90.253461ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:00:03.779838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.211873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"warn","ts":"2026-04-20T02:00:03.779715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.664015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T02:00:03.77994Z","caller":"traceutil/trace.go:171","msg":"trace[1393019328] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:723; }","duration":"378.358599ms","start":"2026-04-20T02:00:03.401567Z","end":"2026-04-20T02:00:03.779925Z","steps":["trace[1393019328] 'agreement among raft nodes before linearized reading' (duration: 378.046615ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:03.779949Z","caller":"traceutil/trace.go:171","msg":"trace[783148521] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:723; }","duration":"357.954989ms","start":"2026-04-20T02:00:03.421978Z","end":"2026-04-20T02:00:03.779933Z","steps":["trace[783148521] 'agreement among raft nodes before linearized reading' (duration: 357.611694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.780052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:03.401542Z","time spent":"378.495845ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13252,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-04-20T02:00:03.780157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:03.421945Z","time spent":"358.198999ms","remote":"127.0.0.1:53842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:00:03.77996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:03.418063Z","time spent":"361.783686ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:00:03.811442Z","caller":"traceutil/trace.go:171","msg":"trace[1804667836] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"191.631267ms","start":"2026-04-20T02:00:03.619786Z","end":"2026-04-20T02:00:03.811417Z","steps":["trace[1804667836] 'process raft request' (duration: 191.489191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.811627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.126016ms","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-04-20T02:00:03.811638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.969641ms","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-04-20T02:00:03.811678Z","caller":"traceutil/trace.go:171","msg":"trace[35580712] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:724; }","duration":"216.22243ms","start":"2026-04-20T02:00:03.595445Z","end":"2026-04-20T02:00:03.811667Z","steps":["trace[35580712] 'agreement among raft nodes before linearized reading' (duration: 216.075764ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:03.811696Z","caller":"traceutil/trace.go:171","msg":"trace[1027839778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:724; }","duration":"211.055714ms","start":"2026-04-20T02:00:03.600627Z","end":"2026-04-20T02:00:03.811682Z","steps":["trace[1027839778] 'agreement among raft nodes before linearized reading' (duration: 210.854405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.811847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.050589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:03.812004Z","caller":"traceutil/trace.go:171","msg":"trace[1442930928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:724; }","duration":"196.255289ms","start":"2026-04-20T02:00:03.615723Z","end":"2026-04-20T02:00:03.811979Z","steps":["trace[1442930928] 'agreement among raft nodes before linearized reading' (duration: 195.895453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.811888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.377824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"warn","ts":"2026-04-20T02:00:03.81207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.569638ms","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-04-20T02:00:03.81211Z","caller":"traceutil/trace.go:171","msg":"trace[266110858] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:724; }","duration":"210.635356ms","start":"2026-04-20T02:00:03.601459Z","end":"2026-04-20T02:00:03.812095Z","steps":["trace[266110858] 'agreement among raft nodes before linearized reading' (duration: 210.361724ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:03.812189Z","caller":"traceutil/trace.go:171","msg":"trace[592359156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:724; }","duration":"211.708564ms","start":"2026-04-20T02:00:03.600417Z","end":"2026-04-20T02:00:03.812125Z","steps":["trace[592359156] 'agreement among raft nodes before linearized reading' (duration: 211.335837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.812295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.967745ms","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-04-20T02:00:03.812341Z","caller":"traceutil/trace.go:171","msg":"trace[669043307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:724; }","duration":"212.047538ms","start":"2026-04-20T02:00:03.600282Z","end":"2026-04-20T02:00:03.812329Z","steps":["trace[669043307] 'agreement among raft nodes before linearized reading' (duration: 211.86339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:03.81246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.790864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pbcdc\" ","response":"range_response_count:1 size:18333"} {"level":"info","ts":"2026-04-20T02:00:03.812492Z","caller":"traceutil/trace.go:171","msg":"trace[1887659875] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pbcdc; range_end:; response_count:1; response_revision:724; }","duration":"194.856377ms","start":"2026-04-20T02:00:03.617626Z","end":"2026-04-20T02:00:03.812483Z","steps":["trace[1887659875] 'agreement among raft nodes before linearized reading' (duration: 193.78605ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:03.998832Z","caller":"traceutil/trace.go:171","msg":"trace[489986387] linearizableReadLoop","detail":"{readStateIndex:757; appliedIndex:756; }","duration":"187.405461ms","start":"2026-04-20T02:00:03.811395Z","end":"2026-04-20T02:00:03.9988Z","steps":["trace[489986387] 'read index received' (duration: 126.480451ms)","trace[489986387] 'applied index is now lower than readState.Index' (duration: 60.92376ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:03.999034Z","caller":"traceutil/trace.go:171","msg":"trace[1788141771] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"214.969745ms","start":"2026-04-20T02:00:03.783916Z","end":"2026-04-20T02:00:03.998886Z","steps":["trace[1788141771] 'process raft request' (duration: 153.845207ms)","trace[1788141771] 'compare' (duration: 60.91577ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:00:03.99918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.65072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-04-20T02:00:03.999222Z","caller":"traceutil/trace.go:171","msg":"trace[316898229] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:725; }","duration":"197.791516ms","start":"2026-04-20T02:00:03.80142Z","end":"2026-04-20T02:00:03.999211Z","steps":["trace[316898229] 'agreement among raft nodes before linearized reading' (duration: 197.510104ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.019657Z","caller":"traceutil/trace.go:171","msg":"trace[434634052] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"203.883774ms","start":"2026-04-20T02:00:03.815734Z","end":"2026-04-20T02:00:04.019618Z","steps":["trace[434634052] 'process raft request' (duration: 203.641274ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.019976Z","caller":"traceutil/trace.go:171","msg":"trace[1940952236] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"203.30284ms","start":"2026-04-20T02:00:03.816663Z","end":"2026-04-20T02:00:04.019966Z","steps":["trace[1940952236] 'process raft request' (duration: 202.923403ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.02007Z","caller":"traceutil/trace.go:171","msg":"trace[1178591227] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"203.598622ms","start":"2026-04-20T02:00:03.816465Z","end":"2026-04-20T02:00:04.020064Z","steps":["trace[1178591227] 'process raft request' (duration: 203.068209ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.020061Z","caller":"traceutil/trace.go:171","msg":"trace[164419340] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"202.725574ms","start":"2026-04-20T02:00:03.81731Z","end":"2026-04-20T02:00:04.020036Z","steps":["trace[164419340] 'process raft request' (duration: 202.309135ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.020212Z","caller":"traceutil/trace.go:171","msg":"trace[879946365] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"191.499154ms","start":"2026-04-20T02:00:03.828696Z","end":"2026-04-20T02:00:04.020195Z","steps":["trace[879946365] 'process raft request' (duration: 191.113187ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.020371Z","caller":"traceutil/trace.go:171","msg":"trace[628799089] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"141.360004ms","start":"2026-04-20T02:00:03.879001Z","end":"2026-04-20T02:00:04.02036Z","steps":["trace[628799089] 'process raft request' (duration: 140.959797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.020458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.046762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.020537Z","caller":"traceutil/trace.go:171","msg":"trace[2002558520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:731; }","duration":"207.163377ms","start":"2026-04-20T02:00:03.813359Z","end":"2026-04-20T02:00:04.020522Z","steps":["trace[2002558520] 'agreement among raft nodes before linearized reading' (duration: 207.025131ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.667248Z","caller":"traceutil/trace.go:171","msg":"trace[1739142311] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"218.8774ms","start":"2026-04-20T02:00:04.448334Z","end":"2026-04-20T02:00:04.667211Z","steps":["trace[1739142311] 'process raft request' (duration: 218.770966ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.680462Z","caller":"traceutil/trace.go:171","msg":"trace[560592105] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:767; }","duration":"190.726005ms","start":"2026-04-20T02:00:04.48972Z","end":"2026-04-20T02:00:04.680446Z","steps":["trace[560592105] 'read index received' (duration: 177.689301ms)","trace[560592105] 'applied index is now lower than readState.Index' (duration: 13.034534ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:04.680691Z","caller":"traceutil/trace.go:171","msg":"trace[2099999825] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"197.951437ms","start":"2026-04-20T02:00:04.482726Z","end":"2026-04-20T02:00:04.680678Z","steps":["trace[2099999825] 'process raft request' (duration: 197.630653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.681007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.207565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.681051Z","caller":"traceutil/trace.go:171","msg":"trace[1604940288] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:735; }","duration":"131.292439ms","start":"2026-04-20T02:00:04.549747Z","end":"2026-04-20T02:00:04.68104Z","steps":["trace[1604940288] 'agreement among raft nodes before linearized reading' (duration: 131.147483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.681003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.964335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.681191Z","caller":"traceutil/trace.go:171","msg":"trace[1136266986] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:735; }","duration":"191.460597ms","start":"2026-04-20T02:00:04.489697Z","end":"2026-04-20T02:00:04.681158Z","steps":["trace[1136266986] 'agreement among raft nodes before linearized reading' (duration: 190.915003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.681532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.337956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.681585Z","caller":"traceutil/trace.go:171","msg":"trace[420500698] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:735; }","duration":"164.395208ms","start":"2026-04-20T02:00:04.517176Z","end":"2026-04-20T02:00:04.681571Z","steps":["trace[420500698] 'agreement among raft nodes before linearized reading' (duration: 164.329755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.681858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.464781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:00:04.681535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.679246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.682086Z","caller":"traceutil/trace.go:171","msg":"trace[603374916] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:735; }","duration":"164.929651ms","start":"2026-04-20T02:00:04.51714Z","end":"2026-04-20T02:00:04.68207Z","steps":["trace[603374916] 'agreement among raft nodes before linearized reading' (duration: 164.43632ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:04.682097Z","caller":"traceutil/trace.go:171","msg":"trace[1022753740] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:735; }","duration":"132.241179ms","start":"2026-04-20T02:00:04.549843Z","end":"2026-04-20T02:00:04.682084Z","steps":["trace[1022753740] 'agreement among raft nodes before linearized reading' (duration: 131.664045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.682254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.025672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.682338Z","caller":"traceutil/trace.go:171","msg":"trace[1475696534] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:735; }","duration":"192.125106ms","start":"2026-04-20T02:00:04.490201Z","end":"2026-04-20T02:00:04.682326Z","steps":["trace[1475696534] 'agreement among raft nodes before linearized reading' (duration: 192.017452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.682271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.44731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.683436Z","caller":"traceutil/trace.go:171","msg":"trace[946204670] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:735; }","duration":"133.614269ms","start":"2026-04-20T02:00:04.549799Z","end":"2026-04-20T02:00:04.683414Z","steps":["trace[946204670] 'agreement among raft nodes before linearized reading' (duration: 132.443039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.681311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.465206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.683641Z","caller":"traceutil/trace.go:171","msg":"trace[803991442] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:735; }","duration":"193.882372ms","start":"2026-04-20T02:00:04.489746Z","end":"2026-04-20T02:00:04.683628Z","steps":["trace[803991442] 'agreement among raft nodes before linearized reading' (duration: 190.997096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:04.681467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.276858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:00:04.683951Z","caller":"traceutil/trace.go:171","msg":"trace[809030928] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:735; }","duration":"158.750405ms","start":"2026-04-20T02:00:04.525141Z","end":"2026-04-20T02:00:04.683891Z","steps":["trace[809030928] 'agreement among raft nodes before linearized reading' (duration: 156.273927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:41.525536Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155920568356006,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:00:41.906178Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.155231687s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:00:41.996476Z","caller":"traceutil/trace.go:171","msg":"trace[1058786013] linearizableReadLoop","detail":"{readStateIndex:924; appliedIndex:923; }","duration":"971.990073ms","start":"2026-04-20T02:00:41.024463Z","end":"2026-04-20T02:00:41.996453Z","steps":["trace[1058786013] 'read index received' (duration: 882.016909ms)","trace[1058786013] 'applied index is now lower than readState.Index' (duration: 89.971974ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:00:41.996517Z","caller":"traceutil/trace.go:171","msg":"trace[226156190] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"1.251938751s","start":"2026-04-20T02:00:40.744542Z","end":"2026-04-20T02:00:41.996481Z","steps":["trace[226156190] 'process raft request' (duration: 1.161960627s)","trace[226156190] 'compare' (duration: 89.737887ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:00:41.996721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:40.74453Z","time spent":"1.252093275s","remote":"127.0.0.1:53782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4021,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:00:41.997276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.782548ms","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-04-20T02:00:41.997351Z","caller":"traceutil/trace.go:171","msg":"trace[77783803] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:882; }","duration":"972.915441ms","start":"2026-04-20T02:00:41.024419Z","end":"2026-04-20T02:00:41.997335Z","steps":["trace[77783803] 'agreement among raft nodes before linearized reading' (duration: 972.099757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:41.997387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:41.0244Z","time spent":"972.978694ms","remote":"127.0.0.1:53914","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":"info","ts":"2026-04-20T02:00:41.99882Z","caller":"traceutil/trace.go:171","msg":"trace[2116101470] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"372.297583ms","start":"2026-04-20T02:00:41.626502Z","end":"2026-04-20T02:00:41.9988Z","steps":["trace[2116101470] 'process raft request' (duration: 372.168809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:00:41.99896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:41.626484Z","time spent":"372.398236ms","remote":"127.0.0.1:53842","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-04-20T02:00:48.342958Z","caller":"traceutil/trace.go:171","msg":"trace[833240180] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"110.789635ms","start":"2026-04-20T02:00:48.232146Z","end":"2026-04-20T02:00:48.342935Z","steps":["trace[833240180] 'process raft request' (duration: 110.310322ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:48.346797Z","caller":"traceutil/trace.go:171","msg":"trace[1958376473] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"113.296586ms","start":"2026-04-20T02:00:48.233478Z","end":"2026-04-20T02:00:48.346775Z","steps":["trace[1958376473] 'process raft request' (duration: 113.144091ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:48.347247Z","caller":"traceutil/trace.go:171","msg":"trace[993436574] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"113.658005ms","start":"2026-04-20T02:00:48.233572Z","end":"2026-04-20T02:00:48.34723Z","steps":["trace[993436574] 'process raft request' (duration: 113.164101ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:48.347353Z","caller":"traceutil/trace.go:171","msg":"trace[162436372] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"113.552593ms","start":"2026-04-20T02:00:48.233784Z","end":"2026-04-20T02:00:48.347336Z","steps":["trace[162436372] 'process raft request' (duration: 113.312497ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:00:48.348131Z","caller":"traceutil/trace.go:171","msg":"trace[2143843669] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"111.504905ms","start":"2026-04-20T02:00:48.236597Z","end":"2026-04-20T02:00:48.348102Z","steps":["trace[2143843669] 'process raft request' (duration: 110.641721ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:01:24.693889Z","caller":"traceutil/trace.go:171","msg":"trace[2078115396] linearizableReadLoop","detail":"{readStateIndex:1206; appliedIndex:1205; }","duration":"182.604588ms","start":"2026-04-20T02:01:24.51126Z","end":"2026-04-20T02:01:24.693865Z","steps":["trace[2078115396] 'read index received' (duration: 182.482955ms)","trace[2078115396] 'applied index is now lower than readState.Index' (duration: 120.563µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:01:24.694135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.848472ms","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-04-20T02:01:24.694164Z","caller":"traceutil/trace.go:171","msg":"trace[987266883] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1154; }","duration":"182.916103ms","start":"2026-04-20T02:01:24.51124Z","end":"2026-04-20T02:01:24.694157Z","steps":["trace[987266883] 'agreement among raft nodes before linearized reading' (duration: 182.75457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:01:24.694241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.798511ms","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-04-20T02:01:24.694326Z","caller":"traceutil/trace.go:171","msg":"trace[524045419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1154; }","duration":"174.907673ms","start":"2026-04-20T02:01:24.519389Z","end":"2026-04-20T02:01:24.694297Z","steps":["trace[524045419] 'agreement among raft nodes before linearized reading' (duration: 174.696468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:01:24.694375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.019415ms","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-04-20T02:01:24.694433Z","caller":"traceutil/trace.go:171","msg":"trace[2107250507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1154; }","duration":"175.102998ms","start":"2026-04-20T02:01:24.519315Z","end":"2026-04-20T02:01:24.694418Z","steps":["trace[2107250507] 'agreement among raft nodes before linearized reading' (duration: 174.918794ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:01:24.694594Z","caller":"traceutil/trace.go:171","msg":"trace[105057852] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"183.442606ms","start":"2026-04-20T02:01:24.511124Z","end":"2026-04-20T02:01:24.694567Z","steps":["trace[105057852] 'process raft request' (duration: 182.610858ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:57.089691Z","caller":"traceutil/trace.go:171","msg":"trace[2109312738] linearizableReadLoop","detail":"{readStateIndex:1571; appliedIndex:1570; }","duration":"120.248527ms","start":"2026-04-20T02:02:56.96941Z","end":"2026-04-20T02:02:57.089658Z","steps":["trace[2109312738] 'read index received' (duration: 120.054585ms)","trace[2109312738] 'applied index is now lower than readState.Index' (duration: 192.902µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:02:57.089772Z","caller":"traceutil/trace.go:171","msg":"trace[386765575] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"123.896231ms","start":"2026-04-20T02:02:56.965844Z","end":"2026-04-20T02:02:57.08974Z","steps":["trace[386765575] 'process raft request' (duration: 123.653558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:57.089962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.529262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-04-20T02:02:57.090004Z","caller":"traceutil/trace.go:171","msg":"trace[1335715412] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:1498; }","duration":"120.610144ms","start":"2026-04-20T02:02:56.969384Z","end":"2026-04-20T02:02:57.089994Z","steps":["trace[1335715412] 'agreement among raft nodes before linearized reading' (duration: 120.424461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:57.090862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.576644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4456"} {"level":"info","ts":"2026-04-20T02:02:57.090977Z","caller":"traceutil/trace.go:171","msg":"trace[2023154899] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:1498; }","duration":"118.740506ms","start":"2026-04-20T02:02:56.97221Z","end":"2026-04-20T02:02:57.090951Z","steps":["trace[2023154899] 'agreement among raft nodes before linearized reading' (duration: 117.756451ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:03.331601Z","caller":"traceutil/trace.go:171","msg":"trace[1987547680] linearizableReadLoop","detail":"{readStateIndex:1592; appliedIndex:1591; }","duration":"141.734697ms","start":"2026-04-20T02:03:03.189836Z","end":"2026-04-20T02:03:03.331571Z","steps":["trace[1987547680] 'read index received' (duration: 141.506764ms)","trace[1987547680] 'applied index is now lower than readState.Index' (duration: 226.853µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:03:03.33167Z","caller":"traceutil/trace.go:171","msg":"trace[719197967] transaction","detail":"{read_only:false; response_revision:1518; number_of_response:1; }","duration":"149.339147ms","start":"2026-04-20T02:03:03.182288Z","end":"2026-04-20T02:03:03.331628Z","steps":["trace[719197967] 'process raft request' (duration: 149.116024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:03.331807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.945181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-0cylye\" ","response":"range_response_count:1 size:540"} {"level":"warn","ts":"2026-04-20T02:03:03.332694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.966655ms","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-04-20T02:03:03.33278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.673383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T02:03:03.332815Z","caller":"traceutil/trace.go:171","msg":"trace[1870409375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1518; }","duration":"121.129148ms","start":"2026-04-20T02:03:03.211661Z","end":"2026-04-20T02:03:03.33279Z","steps":["trace[1870409375] 'agreement among raft nodes before linearized reading' (duration: 120.178705ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:03.332861Z","caller":"traceutil/trace.go:171","msg":"trace[722935846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1518; }","duration":"139.657646ms","start":"2026-04-20T02:03:03.193153Z","end":"2026-04-20T02:03:03.33281Z","steps":["trace[722935846] 'agreement among raft nodes before linearized reading' (duration: 138.591402ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:03.3327Z","caller":"traceutil/trace.go:171","msg":"trace[1307604327] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-0cylye; range_end:; response_count:1; response_revision:1518; }","duration":"142.051862ms","start":"2026-04-20T02:03:03.189808Z","end":"2026-04-20T02:03:03.33186Z","steps":["trace[1307604327] 'agreement among raft nodes before linearized reading' (duration: 141.91459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:03.33672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.004541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-679c578f5-kfcpz\" ","response":"range_response_count:1 size:3720"} {"level":"info","ts":"2026-04-20T02:03:03.336796Z","caller":"traceutil/trace.go:171","msg":"trace[1350682578] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-679c578f5-kfcpz; range_end:; response_count:1; response_revision:1518; }","duration":"100.099582ms","start":"2026-04-20T02:03:03.236665Z","end":"2026-04-20T02:03:03.336765Z","steps":["trace[1350682578] 'agreement among raft nodes before linearized reading' (duration: 95.13382ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:03.456675Z","caller":"traceutil/trace.go:171","msg":"trace[1596938313] linearizableReadLoop","detail":"{readStateIndex:1595; appliedIndex:1592; }","duration":"116.214057ms","start":"2026-04-20T02:03:03.34043Z","end":"2026-04-20T02:03:03.456644Z","steps":["trace[1596938313] 'read index received' (duration: 52.250069ms)","trace[1596938313] 'applied index is now lower than readState.Index' (duration: 63.962708ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:03:03.456785Z","caller":"traceutil/trace.go:171","msg":"trace[1391368483] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"116.673634ms","start":"2026-04-20T02:03:03.340094Z","end":"2026-04-20T02:03:03.456768Z","steps":["trace[1391368483] 'process raft request' (duration: 116.489052ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:03.456804Z","caller":"traceutil/trace.go:171","msg":"trace[709617432] transaction","detail":"{read_only:false; response_revision:1520; number_of_response:1; }","duration":"116.705675ms","start":"2026-04-20T02:03:03.340052Z","end":"2026-04-20T02:03:03.456758Z","steps":["trace[709617432] 'process raft request' (duration: 114.832817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:03.45701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.556242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-679c578f5-kfcpz\" ","response":"range_response_count:1 size:3720"} {"level":"info","ts":"2026-04-20T02:03:03.457076Z","caller":"traceutil/trace.go:171","msg":"trace[511338900] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-679c578f5-kfcpz; range_end:; response_count:1; response_revision:1521; }","duration":"116.682474ms","start":"2026-04-20T02:03:03.340373Z","end":"2026-04-20T02:03:03.457056Z","steps":["trace[511338900] 'agreement among raft nodes before linearized reading' (duration: 116.429119ms)"],"step_count":1}