{"level":"warn","ts":"2026-05-10T00:45:00.256558Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-10T00:45:00.256683Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246: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.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246: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-05-10T00:45:00.256777Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-10T00:45:00.256799Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-05-10T00:45:00.256824Z","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-05-10T00:45:00.257697Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]} {"level":"info","ts":"2026-05-10T00:45:00.257829Z","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.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246: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-05-10T00:45:00.264395Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.241998ms"} {"level":"info","ts":"2026-05-10T00:45:00.273047Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"} {"level":"info","ts":"2026-05-10T00:45:00.273158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"} {"level":"info","ts":"2026-05-10T00:45:00.273189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"} {"level":"info","ts":"2026-05-10T00:45:00.273212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-10T00:45:00.273222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"} {"level":"info","ts":"2026-05-10T00:45:00.273266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"warn","ts":"2026-05-10T00:45:00.281787Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-10T00:45:00.283221Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-10T00:45:00.28459Z","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-05-10T00:45:00.289786Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-10T00:45:00.290041Z","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-05-10T00:45:00.290254Z","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-05-10T00:45:00.290281Z","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-05-10T00:45:00.29015Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-10T00:45:00.296197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"info","ts":"2026-05-10T00:45:00.296382Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-05-10T00:45:00.298051Z","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-05-10T00:45:00.298204Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-05-10T00:45:00.298256Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-05-10T00:45:00.298838Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-10T00:45:00.29878Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-10T00:45:00.874592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"} {"level":"info","ts":"2026-05-10T00:45:00.875546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-10T00:45:00.876044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"} {"level":"info","ts":"2026-05-10T00:45:00.876076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"} {"level":"info","ts":"2026-05-10T00:45:00.876086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-05-10T00:45:00.8761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"} {"level":"info","ts":"2026-05-10T00:45:00.876113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-05-10T00:45:00.877281Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:45:00.87789Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"} {"level":"info","ts":"2026-05-10T00:45:00.878042Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T00:45:00.878121Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T00:45:00.878401Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:45:00.878504Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:45:00.878541Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:45:00.88166Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"} {"level":"info","ts":"2026-05-10T00:45:00.881663Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-10T00:45:00.881815Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-10T00:45:00.881844Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-10T00:45:02.432114Z","caller":"traceutil/trace.go:171","msg":"trace[638282332] linearizableReadLoop","detail":"{readStateIndex:8; appliedIndex:6; }","duration":"142.033751ms","start":"2026-05-10T00:45:02.290051Z","end":"2026-05-10T00:45:02.432085Z","steps":["trace[638282332] 'read index received' (duration: 24.847297ms)","trace[638282332] 'applied index is now lower than readState.Index' (duration: 117.185054ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:02.432255Z","caller":"traceutil/trace.go:171","msg":"trace[1429928965] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"141.512676ms","start":"2026-05-10T00:45:02.290731Z","end":"2026-05-10T00:45:02.432244Z","steps":["trace[1429928965] 'process raft request' (duration: 141.188953ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.432201Z","caller":"traceutil/trace.go:171","msg":"trace[161325689] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"142.143602ms","start":"2026-05-10T00:45:02.290006Z","end":"2026-05-10T00:45:02.432149Z","steps":["trace[161325689] 'process raft request' (duration: 137.453849ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.432536Z","caller":"traceutil/trace.go:171","msg":"trace[1502469653] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"128.481867ms","start":"2026-05-10T00:45:02.304024Z","end":"2026-05-10T00:45:02.432506Z","steps":["trace[1502469653] 'process raft request' (duration: 127.989582ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.432711Z","caller":"traceutil/trace.go:171","msg":"trace[1432719536] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"142.507395ms","start":"2026-05-10T00:45:02.290185Z","end":"2026-05-10T00:45:02.432692Z","steps":["trace[1432719536] 'process raft request' (duration: 141.689248ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.432697Z","caller":"traceutil/trace.go:171","msg":"trace[609651881] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"141.800319ms","start":"2026-05-10T00:45:02.290859Z","end":"2026-05-10T00:45:02.43266Z","steps":["trace[609651881] 'process raft request' (duration: 141.119233ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.432789Z","caller":"traceutil/trace.go:171","msg":"trace[368287446] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"142.037831ms","start":"2026-05-10T00:45:02.29074Z","end":"2026-05-10T00:45:02.432778Z","steps":["trace[368287446] 'process raft request' (duration: 141.214903ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.432889Z","caller":"traceutil/trace.go:171","msg":"trace[1609126238] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"119.115351ms","start":"2026-05-10T00:45:02.313633Z","end":"2026-05-10T00:45:02.432748Z","steps":["trace[1609126238] 'process raft request' (duration: 118.416814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:02.433731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.626025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:45:02.434887Z","caller":"traceutil/trace.go:171","msg":"trace[1958915116] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"144.870167ms","start":"2026-05-10T00:45:02.289996Z","end":"2026-05-10T00:45:02.434866Z","steps":["trace[1958915116] 'agreement among raft nodes before linearized reading' (duration: 142.591556ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.450808Z","caller":"traceutil/trace.go:171","msg":"trace[505652119] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"131.03714ms","start":"2026-05-10T00:45:02.319695Z","end":"2026-05-10T00:45:02.450732Z","steps":["trace[505652119] 'process raft request' (duration: 130.903639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:02.450882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.624111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-10T00:45:02.450943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.447134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-10T00:45:02.451138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.414359ms","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-05-10T00:45:02.451154Z","caller":"traceutil/trace.go:171","msg":"trace[436529691] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"154.581286ms","start":"2026-05-10T00:45:02.296438Z","end":"2026-05-10T00:45:02.451019Z","steps":["trace[436529691] 'agreement among raft nodes before linearized reading' (duration: 154.359614ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.450981Z","caller":"traceutil/trace.go:171","msg":"trace[1118392707] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"112.760632ms","start":"2026-05-10T00:45:02.338202Z","end":"2026-05-10T00:45:02.450962Z","steps":["trace[1118392707] 'agreement among raft nodes before linearized reading' (duration: 112.582101ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.451204Z","caller":"traceutil/trace.go:171","msg":"trace[1731174079] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"160.5637ms","start":"2026-05-10T00:45:02.290619Z","end":"2026-05-10T00:45:02.451182Z","steps":["trace[1731174079] 'agreement among raft nodes before linearized reading' (duration: 160.441359ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:02.70173Z","caller":"traceutil/trace.go:171","msg":"trace[1484246343] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"122.067868ms","start":"2026-05-10T00:45:02.579594Z","end":"2026-05-10T00:45:02.701662Z","steps":["trace[1484246343] 'process raft request' (duration: 74.429882ms)","trace[1484246343] 'compare' (duration: 47.282033ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:02.953071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.233261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-10T00:45:02.953496Z","caller":"traceutil/trace.go:171","msg":"trace[1501041559] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"185.79102ms","start":"2026-05-10T00:45:02.767668Z","end":"2026-05-10T00:45:02.953459Z","steps":["trace[1501041559] 'process raft request' (duration: 41.56261ms)","trace[1501041559] 'compare' (duration: 143.11996ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:02.953518Z","caller":"traceutil/trace.go:171","msg":"trace[1112065351] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"180.505542ms","start":"2026-05-10T00:45:02.77298Z","end":"2026-05-10T00:45:02.953486Z","steps":["trace[1112065351] 'process raft request' (duration: 180.31464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:03.280862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.234834ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-10T00:45:03.281152Z","caller":"traceutil/trace.go:171","msg":"trace[1754397735] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"238.184251ms","start":"2026-05-10T00:45:03.04295Z","end":"2026-05-10T00:45:03.281135Z","steps":["trace[1754397735] 'process raft request' (duration: 45.572224ms)","trace[1754397735] 'compare' (duration: 192.072332ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:03.281271Z","caller":"traceutil/trace.go:171","msg":"trace[242482249] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"236.198523ms","start":"2026-05-10T00:45:03.045034Z","end":"2026-05-10T00:45:03.281233Z","steps":["trace[242482249] 'process raft request' (duration: 235.960111ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:03.483444Z","caller":"traceutil/trace.go:171","msg":"trace[1387569402] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"122.33607ms","start":"2026-05-10T00:45:03.361078Z","end":"2026-05-10T00:45:03.483414Z","steps":["trace[1387569402] 'process raft request' (duration: 122.285309ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:03.483524Z","caller":"traceutil/trace.go:171","msg":"trace[2021100435] linearizableReadLoop","detail":"{readStateIndex:70; appliedIndex:69; }","duration":"127.678548ms","start":"2026-05-10T00:45:03.355838Z","end":"2026-05-10T00:45:03.483516Z","steps":["trace[2021100435] 'read index received' (duration: 123.38048ms)","trace[2021100435] 'applied index is now lower than readState.Index' (duration: 4.297218ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:03.483606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.752184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:45:03.483489Z","caller":"traceutil/trace.go:171","msg":"trace[690248727] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"124.228847ms","start":"2026-05-10T00:45:03.359245Z","end":"2026-05-10T00:45:03.483474Z","steps":["trace[690248727] 'process raft request' (duration: 124.072156ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:03.483639Z","caller":"traceutil/trace.go:171","msg":"trace[233822307] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:68; }","duration":"143.833644ms","start":"2026-05-10T00:45:03.339796Z","end":"2026-05-10T00:45:03.48363Z","steps":["trace[233822307] 'agreement among raft nodes before linearized reading' (duration: 143.764624ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:03.483398Z","caller":"traceutil/trace.go:171","msg":"trace[1133823697] transaction","detail":"{read_only:false; response_revision:66; number_of_response:1; }","duration":"153.459362ms","start":"2026-05-10T00:45:03.329892Z","end":"2026-05-10T00:45:03.483352Z","steps":["trace[1133823697] 'process raft request' (duration: 149.372525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:03.483834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.185552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-cluster-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:45:03.4839Z","caller":"traceutil/trace.go:171","msg":"trace[906100909] range","detail":"{range_begin:/registry/priorityclasses/system-cluster-critical; range_end:; response_count:0; response_revision:68; }","duration":"193.269894ms","start":"2026-05-10T00:45:03.290614Z","end":"2026-05-10T00:45:03.483884Z","steps":["trace[906100909] 'agreement among raft nodes before linearized reading' (duration: 193.175853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:03.483963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.072124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:45:03.484159Z","caller":"traceutil/trace.go:171","msg":"trace[995581878] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:68; }","duration":"125.311647ms","start":"2026-05-10T00:45:03.358828Z","end":"2026-05-10T00:45:03.48414Z","steps":["trace[995581878] 'agreement among raft nodes before linearized reading' (duration: 125.027015ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:04.47017Z","caller":"traceutil/trace.go:171","msg":"trace[2004019717] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"105.095416ms","start":"2026-05-10T00:45:04.365043Z","end":"2026-05-10T00:45:04.470139Z","steps":["trace[2004019717] 'process raft request' (duration: 100.566165ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:10.814756Z","caller":"traceutil/trace.go:171","msg":"trace[1265793051] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:318; }","duration":"117.945709ms","start":"2026-05-10T00:45:10.696781Z","end":"2026-05-10T00:45:10.814726Z","steps":["trace[1265793051] 'read index received' (duration: 100.53612ms)","trace[1265793051] 'applied index is now lower than readState.Index' (duration: 17.408569ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:10.814931Z","caller":"traceutil/trace.go:171","msg":"trace[1071058743] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"141.819193ms","start":"2026-05-10T00:45:10.673057Z","end":"2026-05-10T00:45:10.814876Z","steps":["trace[1071058743] 'process raft request' (duration: 124.188342ms)","trace[1071058743] 'compare' (duration: 17.338119ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:10.815521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.088956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-10T00:45:10.81577Z","caller":"traceutil/trace.go:171","msg":"trace[628216388] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:309; }","duration":"100.4303ms","start":"2026-05-10T00:45:10.715313Z","end":"2026-05-10T00:45:10.815743Z","steps":["trace[628216388] 'agreement among raft nodes before linearized reading' (duration: 99.636773ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:10.815817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.009708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-05-10T00:45:10.815954Z","caller":"traceutil/trace.go:171","msg":"trace[512435155] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:309; }","duration":"119.172829ms","start":"2026-05-10T00:45:10.696729Z","end":"2026-05-10T00:45:10.815902Z","steps":["trace[512435155] 'agreement among raft nodes before linearized reading' (duration: 118.919477ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.167185Z","caller":"traceutil/trace.go:171","msg":"trace[520787977] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"150.418706ms","start":"2026-05-10T00:45:11.016739Z","end":"2026-05-10T00:45:11.167157Z","steps":["trace[520787977] 'process raft request' (duration: 150.381176ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.167234Z","caller":"traceutil/trace.go:171","msg":"trace[462837603] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"154.045368ms","start":"2026-05-10T00:45:11.013152Z","end":"2026-05-10T00:45:11.167197Z","steps":["trace[462837603] 'process raft request' (duration: 153.896286ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.16742Z","caller":"traceutil/trace.go:171","msg":"trace[1979437710] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"157.002692ms","start":"2026-05-10T00:45:11.010359Z","end":"2026-05-10T00:45:11.167362Z","steps":["trace[1979437710] 'process raft request' (duration: 97.408016ms)","trace[1979437710] 'compare' (duration: 59.065841ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:11.167654Z","caller":"traceutil/trace.go:171","msg":"trace[1529818834] linearizableReadLoop","detail":"{readStateIndex:332; appliedIndex:330; }","duration":"151.620446ms","start":"2026-05-10T00:45:11.016006Z","end":"2026-05-10T00:45:11.167627Z","steps":["trace[1529818834] 'read index received' (duration: 91.725418ms)","trace[1529818834] 'applied index is now lower than readState.Index' (duration: 59.892508ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:11.167876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.815929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-10T00:45:11.167912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.615202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-10T00:45:11.167937Z","caller":"traceutil/trace.go:171","msg":"trace[757546184] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:323; }","duration":"151.95095ms","start":"2026-05-10T00:45:11.015968Z","end":"2026-05-10T00:45:11.167919Z","steps":["trace[757546184] 'agreement among raft nodes before linearized reading' (duration: 151.815019ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.167985Z","caller":"traceutil/trace.go:171","msg":"trace[891367034] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:323; }","duration":"101.772474ms","start":"2026-05-10T00:45:11.066194Z","end":"2026-05-10T00:45:11.167966Z","steps":["trace[891367034] 'agreement among raft nodes before linearized reading' (duration: 101.614663ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.388365Z","caller":"traceutil/trace.go:171","msg":"trace[1409821976] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"214.638241ms","start":"2026-05-10T00:45:11.173698Z","end":"2026-05-10T00:45:11.388336Z","steps":["trace[1409821976] 'process raft request' (duration: 159.642134ms)","trace[1409821976] 'compare' (duration: 54.854856ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:11.415354Z","caller":"traceutil/trace.go:171","msg":"trace[1352004269] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"239.32716ms","start":"2026-05-10T00:45:11.176001Z","end":"2026-05-10T00:45:11.415329Z","steps":["trace[1352004269] 'process raft request' (duration: 239.221569ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.415375Z","caller":"traceutil/trace.go:171","msg":"trace[733740849] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:334; }","duration":"198.555804ms","start":"2026-05-10T00:45:11.216791Z","end":"2026-05-10T00:45:11.415346Z","steps":["trace[733740849] 'read index received' (duration: 116.486588ms)","trace[733740849] 'applied index is now lower than readState.Index' (duration: 82.068046ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:11.415419Z","caller":"traceutil/trace.go:171","msg":"trace[1086534661] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"237.531876ms","start":"2026-05-10T00:45:11.177861Z","end":"2026-05-10T00:45:11.415393Z","steps":["trace[1086534661] 'process raft request' (duration: 237.402995ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.415505Z","caller":"traceutil/trace.go:171","msg":"trace[1200375141] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"237.487735ms","start":"2026-05-10T00:45:11.177961Z","end":"2026-05-10T00:45:11.415448Z","steps":["trace[1200375141] 'process raft request' (duration: 237.351464ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.415364Z","caller":"traceutil/trace.go:171","msg":"trace[718623792] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"240.990065ms","start":"2026-05-10T00:45:11.174329Z","end":"2026-05-10T00:45:11.415319Z","steps":["trace[718623792] 'process raft request' (duration: 240.782213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:11.41582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.993768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-10T00:45:11.4159Z","caller":"traceutil/trace.go:171","msg":"trace[1570798976] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:329; }","duration":"199.15563ms","start":"2026-05-10T00:45:11.216726Z","end":"2026-05-10T00:45:11.415882Z","steps":["trace[1570798976] 'agreement among raft nodes before linearized reading' (duration: 198.734606ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.5715Z","caller":"traceutil/trace.go:171","msg":"trace[140559617] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"103.163906ms","start":"2026-05-10T00:45:11.468286Z","end":"2026-05-10T00:45:11.57145Z","steps":["trace[140559617] 'process raft request' (duration: 103.112555ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.571572Z","caller":"traceutil/trace.go:171","msg":"trace[1972752060] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"105.098212ms","start":"2026-05-10T00:45:11.466441Z","end":"2026-05-10T00:45:11.57154Z","steps":["trace[1972752060] 'process raft request' (duration: 87.820826ms)","trace[1972752060] 'compare' (duration: 16.601681ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:11.571733Z","caller":"traceutil/trace.go:171","msg":"trace[1918983679] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"104.996291ms","start":"2026-05-10T00:45:11.466717Z","end":"2026-05-10T00:45:11.571713Z","steps":["trace[1918983679] 'process raft request' (duration: 104.573427ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.571776Z","caller":"traceutil/trace.go:171","msg":"trace[1105108990] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"105.148182ms","start":"2026-05-10T00:45:11.466606Z","end":"2026-05-10T00:45:11.571755Z","steps":["trace[1105108990] 'process raft request' (duration: 104.503637ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.571782Z","caller":"traceutil/trace.go:171","msg":"trace[875958445] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"103.881411ms","start":"2026-05-10T00:45:11.467885Z","end":"2026-05-10T00:45:11.571766Z","steps":["trace[875958445] 'process raft request' (duration: 103.463518ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:11.571928Z","caller":"traceutil/trace.go:171","msg":"trace[1215211938] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"105.297183ms","start":"2026-05-10T00:45:11.466608Z","end":"2026-05-10T00:45:11.571905Z","steps":["trace[1215211938] 'process raft request' (duration: 104.632278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:12.030845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.545463ms","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-05-10T00:45:12.030944Z","caller":"traceutil/trace.go:171","msg":"trace[1801228874] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:350; }","duration":"119.647434ms","start":"2026-05-10T00:45:11.91127Z","end":"2026-05-10T00:45:12.030917Z","steps":["trace[1801228874] 'range keys from in-memory index tree' (duration: 119.446412ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:13.704736Z","caller":"traceutil/trace.go:171","msg":"trace[2095017035] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"206.685638ms","start":"2026-05-10T00:45:13.498017Z","end":"2026-05-10T00:45:13.704702Z","steps":["trace[2095017035] 'process raft request' (duration: 183.0643ms)","trace[2095017035] 'compare' (duration: 23.479667ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:14.791247Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836960392102016065,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-10T00:45:14.987499Z","caller":"traceutil/trace.go:171","msg":"trace[1872959642] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:376; }","duration":"696.603604ms","start":"2026-05-10T00:45:14.290863Z","end":"2026-05-10T00:45:14.987467Z","steps":["trace[1872959642] 'read index received' (duration: 696.445812ms)","trace[1872959642] 'applied index is now lower than readState.Index' (duration: 156.382µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:14.987545Z","caller":"traceutil/trace.go:171","msg":"trace[209936165] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"922.940353ms","start":"2026-05-10T00:45:14.064576Z","end":"2026-05-10T00:45:14.987516Z","steps":["trace[209936165] 'process raft request' (duration: 922.660961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:14.987667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.787805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:14.987702Z","caller":"traceutil/trace.go:171","msg":"trace[1197993534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:366; }","duration":"696.877356ms","start":"2026-05-10T00:45:14.290812Z","end":"2026-05-10T00:45:14.98769Z","steps":["trace[1197993534] 'agreement among raft nodes before linearized reading' (duration: 696.810125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:14.987738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:14.290793Z","time spent":"696.939247ms","remote":"127.0.0.1:41284","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-05-10T00:45:14.987718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:14.064558Z","time spent":"923.048834ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:45:14.987912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.178517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T00:45:14.98799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.254266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-10T00:45:14.988073Z","caller":"traceutil/trace.go:171","msg":"trace[502097726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:366; }","duration":"651.403968ms","start":"2026-05-10T00:45:14.336628Z","end":"2026-05-10T00:45:14.988032Z","steps":["trace[502097726] 'agreement among raft nodes before linearized reading' (duration: 651.093266ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:14.988121Z","caller":"traceutil/trace.go:171","msg":"trace[2070838195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:366; }","duration":"528.463688ms","start":"2026-05-10T00:45:14.459625Z","end":"2026-05-10T00:45:14.988089Z","steps":["trace[2070838195] 'agreement among raft nodes before linearized reading' (duration: 528.163745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:14.988147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:14.336612Z","time spent":"651.522599ms","remote":"127.0.0.1:41276","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-05-10T00:45:14.988206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:14.459603Z","time spent":"528.589959ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T00:45:17.341529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.106676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:45:17.341699Z","caller":"traceutil/trace.go:171","msg":"trace[958847392] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"243.079686ms","start":"2026-05-10T00:45:17.0986Z","end":"2026-05-10T00:45:17.341679Z","steps":["trace[958847392] 'process raft request' (duration: 116.718148ms)","trace[958847392] 'compare' (duration: 125.871634ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:17.659608Z","caller":"traceutil/trace.go:171","msg":"trace[1673135727] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"235.171693ms","start":"2026-05-10T00:45:17.424407Z","end":"2026-05-10T00:45:17.659579Z","steps":["trace[1673135727] 'process raft request' (duration: 235.031532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:19.631434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.934919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:45:19.631557Z","caller":"traceutil/trace.go:171","msg":"trace[1360142147] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"252.248946ms","start":"2026-05-10T00:45:19.379286Z","end":"2026-05-10T00:45:19.631535Z","steps":["trace[1360142147] 'process raft request' (duration: 43.120896ms)","trace[1360142147] 'compare' (duration: 208.777677ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:21.206835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.710991ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-10T00:45:21.206957Z","caller":"traceutil/trace.go:171","msg":"trace[402633062] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:394; }","duration":"158.333347ms","start":"2026-05-10T00:45:21.048603Z","end":"2026-05-10T00:45:21.206936Z","steps":["trace[402633062] 'read index received' (duration: 38.651µs)","trace[402633062] 'applied index is now lower than readState.Index' (duration: 158.293286ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:21.207069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.451728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-10T00:45:21.207103Z","caller":"traceutil/trace.go:171","msg":"trace[1625500734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:382; }","duration":"158.537498ms","start":"2026-05-10T00:45:21.048554Z","end":"2026-05-10T00:45:21.207092Z","steps":["trace[1625500734] 'agreement among raft nodes before linearized reading' (duration: 158.433557ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:21.383562Z","caller":"traceutil/trace.go:171","msg":"trace[1181049563] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:395; }","duration":"160.163811ms","start":"2026-05-10T00:45:21.22337Z","end":"2026-05-10T00:45:21.383533Z","steps":["trace[1181049563] 'read index received' (duration: 160.0146ms)","trace[1181049563] 'applied index is now lower than readState.Index' (duration: 148.141µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:21.38373Z","caller":"traceutil/trace.go:171","msg":"trace[1921217672] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"172.574459ms","start":"2026-05-10T00:45:21.211117Z","end":"2026-05-10T00:45:21.383691Z","steps":["trace[1921217672] 'process raft request' (duration: 172.236737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:21.383853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.455533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-05-10T00:45:21.384076Z","caller":"traceutil/trace.go:171","msg":"trace[205562314] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:383; }","duration":"160.689225ms","start":"2026-05-10T00:45:21.223361Z","end":"2026-05-10T00:45:21.384051Z","steps":["trace[205562314] 'agreement among raft nodes before linearized reading' (duration: 160.352712ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:28.034661Z","caller":"traceutil/trace.go:171","msg":"trace[1806925836] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"187.317656ms","start":"2026-05-10T00:45:27.847303Z","end":"2026-05-10T00:45:28.034621Z","steps":["trace[1806925836] 'process raft request' (duration: 187.035004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:36.76685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836960392102016308,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-10T00:45:36.891794Z","caller":"traceutil/trace.go:171","msg":"trace[404018036] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"625.184579ms","start":"2026-05-10T00:45:36.266591Z","end":"2026-05-10T00:45:36.891776Z","steps":["trace[404018036] 'read index received' (duration: 624.982707ms)","trace[404018036] 'applied index is now lower than readState.Index' (duration: 201.052µs)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:36.891951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.182113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:36.891995Z","caller":"traceutil/trace.go:171","msg":"trace[208350502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"559.285064ms","start":"2026-05-10T00:45:36.332695Z","end":"2026-05-10T00:45:36.89198Z","steps":["trace[208350502] 'agreement among raft nodes before linearized reading' (duration: 559.199643ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:36.891947Z","caller":"traceutil/trace.go:171","msg":"trace[551075294] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"789.090929ms","start":"2026-05-10T00:45:36.102791Z","end":"2026-05-10T00:45:36.891882Z","steps":["trace[551075294] 'process raft request' (duration: 788.840296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:36.892022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.355571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:36.892107Z","caller":"traceutil/trace.go:171","msg":"trace[342697113] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:483; }","duration":"625.550753ms","start":"2026-05-10T00:45:36.266538Z","end":"2026-05-10T00:45:36.892088Z","steps":["trace[342697113] 'agreement among raft nodes before linearized reading' (duration: 625.347831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:36.892157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:36.266519Z","time spent":"625.622854ms","remote":"127.0.0.1:41404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-10T00:45:36.892043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:36.332681Z","time spent":"559.353225ms","remote":"127.0.0.1:41284","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-05-10T00:45:36.892192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:36.102766Z","time spent":"789.294241ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T00:45:37.498414Z","caller":"traceutil/trace.go:171","msg":"trace[997616162] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"190.5075ms","start":"2026-05-10T00:45:37.307856Z","end":"2026-05-10T00:45:37.498364Z","steps":["trace[997616162] 'process raft request' (duration: 190.336962ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.619808Z","caller":"traceutil/trace.go:171","msg":"trace[1297000489] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"309.531775ms","start":"2026-05-10T00:45:37.310243Z","end":"2026-05-10T00:45:37.619775Z","steps":["trace[1297000489] 'process raft request' (duration: 309.307735ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.619913Z","caller":"traceutil/trace.go:171","msg":"trace[860787703] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"303.122964ms","start":"2026-05-10T00:45:37.316759Z","end":"2026-05-10T00:45:37.619882Z","steps":["trace[860787703] 'process raft request' (duration: 302.905554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:37.619975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:37.310222Z","time spent":"309.672572ms","remote":"127.0.0.1:41340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T00:45:37.620057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:37.316713Z","time spent":"303.274621ms","remote":"127.0.0.1:41340","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-05-10T00:45:37.620175Z","caller":"traceutil/trace.go:171","msg":"trace[1184491804] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"300.552797ms","start":"2026-05-10T00:45:37.31956Z","end":"2026-05-10T00:45:37.620113Z","steps":["trace[1184491804] 'process raft request' (duration: 300.150819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:37.620443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:37.319535Z","time spent":"300.807729ms","remote":"127.0.0.1:41340","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-05-10T00:45:37.620528Z","caller":"traceutil/trace.go:171","msg":"trace[1023297879] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"298.713294ms","start":"2026-05-10T00:45:37.321803Z","end":"2026-05-10T00:45:37.620517Z","steps":["trace[1023297879] 'process raft request' (duration: 297.956079ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.620638Z","caller":"traceutil/trace.go:171","msg":"trace[708364582] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"298.549477ms","start":"2026-05-10T00:45:37.322071Z","end":"2026-05-10T00:45:37.62062Z","steps":["trace[708364582] 'process raft request' (duration: 298.278104ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.620702Z","caller":"traceutil/trace.go:171","msg":"trace[545037296] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"293.664815ms","start":"2026-05-10T00:45:37.327028Z","end":"2026-05-10T00:45:37.620693Z","steps":["trace[545037296] 'process raft request' (duration: 293.472776ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.622054Z","caller":"traceutil/trace.go:171","msg":"trace[1522440193] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:501; }","duration":"122.478622ms","start":"2026-05-10T00:45:37.499558Z","end":"2026-05-10T00:45:37.622036Z","steps":["trace[1522440193] 'read index received' (duration: 120.051002ms)","trace[1522440193] 'applied index is now lower than readState.Index' (duration: 2.42643ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:37.62214Z","caller":"traceutil/trace.go:171","msg":"trace[17552219] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"295.045237ms","start":"2026-05-10T00:45:37.327087Z","end":"2026-05-10T00:45:37.622132Z","steps":["trace[17552219] 'process raft request' (duration: 293.676405ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.622236Z","caller":"traceutil/trace.go:171","msg":"trace[867725200] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"281.567896ms","start":"2026-05-10T00:45:37.340642Z","end":"2026-05-10T00:45:37.62221Z","steps":["trace[867725200] 'process raft request' (duration: 281.289203ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.622304Z","caller":"traceutil/trace.go:171","msg":"trace[1085480091] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"255.982403ms","start":"2026-05-10T00:45:37.36631Z","end":"2026-05-10T00:45:37.622292Z","steps":["trace[1085480091] 'process raft request' (duration: 255.671899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:37.622494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.936753ms","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-05-10T00:45:37.622549Z","caller":"traceutil/trace.go:171","msg":"trace[2034724211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:494; }","duration":"123.042768ms","start":"2026-05-10T00:45:37.499493Z","end":"2026-05-10T00:45:37.622536Z","steps":["trace[2034724211] 'agreement among raft nodes before linearized reading' (duration: 122.890651ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.622562Z","caller":"traceutil/trace.go:171","msg":"trace[2082114246] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"291.981888ms","start":"2026-05-10T00:45:37.330564Z","end":"2026-05-10T00:45:37.622546Z","steps":["trace[2082114246] 'process raft request' (duration: 291.304747ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.666664Z","caller":"traceutil/trace.go:171","msg":"trace[1403751814] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"159.513233ms","start":"2026-05-10T00:45:37.507128Z","end":"2026-05-10T00:45:37.666641Z","steps":["trace[1403751814] 'process raft request' (duration: 158.966028ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.666836Z","caller":"traceutil/trace.go:171","msg":"trace[1298485835] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"158.837962ms","start":"2026-05-10T00:45:37.507976Z","end":"2026-05-10T00:45:37.666814Z","steps":["trace[1298485835] 'process raft request' (duration: 158.300648ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.666924Z","caller":"traceutil/trace.go:171","msg":"trace[2075587306] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"151.683628ms","start":"2026-05-10T00:45:37.515209Z","end":"2026-05-10T00:45:37.666893Z","steps":["trace[2075587306] 'process raft request' (duration: 151.401405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:37.666876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.044908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-10T00:45:37.666953Z","caller":"traceutil/trace.go:171","msg":"trace[837704944] transaction","detail":"{read_only:false; number_of_response:1; response_revision:496; }","duration":"157.351905ms","start":"2026-05-10T00:45:37.509536Z","end":"2026-05-10T00:45:37.666887Z","steps":["trace[837704944] 'process raft request' (duration: 156.839772ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.667102Z","caller":"traceutil/trace.go:171","msg":"trace[264960651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:497; }","duration":"149.383323ms","start":"2026-05-10T00:45:37.517682Z","end":"2026-05-10T00:45:37.667066Z","steps":["trace[264960651] 'agreement among raft nodes before linearized reading' (duration: 149.07711ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.905947Z","caller":"traceutil/trace.go:171","msg":"trace[1834977708] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"280.015205ms","start":"2026-05-10T00:45:37.625891Z","end":"2026-05-10T00:45:37.905906Z","steps":["trace[1834977708] 'process raft request' (duration: 189.258464ms)","trace[1834977708] 'compare' (duration: 90.414085ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:37.905977Z","caller":"traceutil/trace.go:171","msg":"trace[137351406] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"275.790043ms","start":"2026-05-10T00:45:37.63015Z","end":"2026-05-10T00:45:37.90594Z","steps":["trace[137351406] 'process raft request' (duration: 275.617396ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.906168Z","caller":"traceutil/trace.go:171","msg":"trace[985008879] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"271.780391ms","start":"2026-05-10T00:45:37.634378Z","end":"2026-05-10T00:45:37.906159Z","steps":["trace[985008879] 'process raft request' (duration: 271.694717ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.905975Z","caller":"traceutil/trace.go:171","msg":"trace[1998213098] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"275.293841ms","start":"2026-05-10T00:45:37.630654Z","end":"2026-05-10T00:45:37.905948Z","steps":["trace[1998213098] 'process raft request' (duration: 275.203287ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.906262Z","caller":"traceutil/trace.go:171","msg":"trace[2086598458] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"265.847351ms","start":"2026-05-10T00:45:37.640395Z","end":"2026-05-10T00:45:37.906242Z","steps":["trace[2086598458] 'process raft request' (duration: 265.715925ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.90629Z","caller":"traceutil/trace.go:171","msg":"trace[1753306078] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"273.695568ms","start":"2026-05-10T00:45:37.632479Z","end":"2026-05-10T00:45:37.906175Z","steps":["trace[1753306078] 'process raft request' (duration: 273.417955ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.906457Z","caller":"traceutil/trace.go:171","msg":"trace[1751545640] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"264.544592ms","start":"2026-05-10T00:45:37.641878Z","end":"2026-05-10T00:45:37.906422Z","steps":["trace[1751545640] 'process raft request' (duration: 264.28211ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.906666Z","caller":"traceutil/trace.go:171","msg":"trace[1483668706] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"264.351754ms","start":"2026-05-10T00:45:37.6423Z","end":"2026-05-10T00:45:37.906652Z","steps":["trace[1483668706] 'process raft request' (duration: 264.287081ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.906721Z","caller":"traceutil/trace.go:171","msg":"trace[743484720] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"264.462968ms","start":"2026-05-10T00:45:37.642247Z","end":"2026-05-10T00:45:37.90671Z","steps":["trace[743484720] 'process raft request' (duration: 264.210297ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.938787Z","caller":"traceutil/trace.go:171","msg":"trace[943804283] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"208.11635ms","start":"2026-05-10T00:45:37.730646Z","end":"2026-05-10T00:45:37.938763Z","steps":["trace[943804283] 'process raft request' (duration: 208.081789ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.939364Z","caller":"traceutil/trace.go:171","msg":"trace[937979543] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"266.276081ms","start":"2026-05-10T00:45:37.673079Z","end":"2026-05-10T00:45:37.939355Z","steps":["trace[937979543] 'process raft request' (duration: 265.280486ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.939526Z","caller":"traceutil/trace.go:171","msg":"trace[1285703749] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"266.370615ms","start":"2026-05-10T00:45:37.673149Z","end":"2026-05-10T00:45:37.939519Z","steps":["trace[1285703749] 'process raft request' (duration: 265.355269ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.939597Z","caller":"traceutil/trace.go:171","msg":"trace[665790076] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"262.520501ms","start":"2026-05-10T00:45:37.677072Z","end":"2026-05-10T00:45:37.939592Z","steps":["trace[665790076] 'process raft request' (duration: 261.480164ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:37.93966Z","caller":"traceutil/trace.go:171","msg":"trace[1681598010] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"253.388337ms","start":"2026-05-10T00:45:37.686266Z","end":"2026-05-10T00:45:37.939654Z","steps":["trace[1681598010] 'process raft request' (duration: 252.402332ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:38.728605Z","caller":"traceutil/trace.go:171","msg":"trace[44583203] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"114.088967ms","start":"2026-05-10T00:45:38.614496Z","end":"2026-05-10T00:45:38.728584Z","steps":["trace[44583203] 'process raft request' (duration: 92.96876ms)","trace[44583203] 'compare' (duration: 20.9603ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:39.381786Z","caller":"traceutil/trace.go:171","msg":"trace[405702463] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"472.478576ms","start":"2026-05-10T00:45:38.909218Z","end":"2026-05-10T00:45:39.381697Z","steps":["trace[405702463] 'process raft request' (duration: 448.334646ms)","trace[405702463] 'compare' (duration: 23.931241ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:39.381994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:38.909192Z","time spent":"472.704946ms","remote":"127.0.0.1:41588","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-05-10T00:45:39.387633Z","caller":"traceutil/trace.go:171","msg":"trace[1193974603] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"419.030545ms","start":"2026-05-10T00:45:38.968548Z","end":"2026-05-10T00:45:39.387578Z","steps":["trace[1193974603] 'process raft request' (duration: 418.760243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:39.387779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:38.96851Z","time spent":"419.204553ms","remote":"127.0.0.1:41340","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-05-10T00:45:39.388058Z","caller":"traceutil/trace.go:171","msg":"trace[863348694] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"411.79092ms","start":"2026-05-10T00:45:38.976245Z","end":"2026-05-10T00:45:39.388036Z","steps":["trace[863348694] 'process raft request' (duration: 411.266707ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:39.38851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:38.976226Z","time spent":"411.915665ms","remote":"127.0.0.1:41340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:45:39.721696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.623108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:29476"} {"level":"info","ts":"2026-05-10T00:45:39.721825Z","caller":"traceutil/trace.go:171","msg":"trace[1410542030] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:560; }","duration":"113.814026ms","start":"2026-05-10T00:45:39.60799Z","end":"2026-05-10T00:45:39.721804Z","steps":["trace[1410542030] 'range keys from in-memory index tree' (duration: 113.393367ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:39.725923Z","caller":"traceutil/trace.go:171","msg":"trace[270666862] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"102.639431ms","start":"2026-05-10T00:45:39.623266Z","end":"2026-05-10T00:45:39.725905Z","steps":["trace[270666862] 'process raft request' (duration: 102.193721ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:42.754397Z","caller":"traceutil/trace.go:171","msg":"trace[78957439] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"113.634602ms","start":"2026-05-10T00:45:42.640735Z","end":"2026-05-10T00:45:42.754369Z","steps":["trace[78957439] 'process raft request' (duration: 113.107459ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:46.153907Z","caller":"traceutil/trace.go:171","msg":"trace[2133344441] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"172.484103ms","start":"2026-05-10T00:45:45.98139Z","end":"2026-05-10T00:45:46.153874Z","steps":["trace[2133344441] 'read index received' (duration: 172.252283ms)","trace[2133344441] 'applied index is now lower than readState.Index' (duration: 230.47µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:46.153972Z","caller":"traceutil/trace.go:171","msg":"trace[47574245] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"213.645363ms","start":"2026-05-10T00:45:45.940306Z","end":"2026-05-10T00:45:46.153951Z","steps":["trace[47574245] 'process raft request' (duration: 213.369002ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:46.154209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.792495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-10T00:45:46.154306Z","caller":"traceutil/trace.go:171","msg":"trace[1932325936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"172.918351ms","start":"2026-05-10T00:45:45.981343Z","end":"2026-05-10T00:45:46.154261Z","steps":["trace[1932325936] 'agreement among raft nodes before linearized reading' (duration: 172.713002ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:46.310729Z","caller":"traceutil/trace.go:171","msg":"trace[120758812] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"152.235867ms","start":"2026-05-10T00:45:46.158467Z","end":"2026-05-10T00:45:46.310703Z","steps":["trace[120758812] 'process raft request' (duration: 152.101791ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:46.325992Z","caller":"traceutil/trace.go:171","msg":"trace[771669686] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"167.362315ms","start":"2026-05-10T00:45:46.158619Z","end":"2026-05-10T00:45:46.325982Z","steps":["trace[771669686] 'process raft request' (duration: 167.296402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:46.690639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.005101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cnmd7\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-10T00:45:46.690755Z","caller":"traceutil/trace.go:171","msg":"trace[1770982642] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cnmd7; range_end:; response_count:1; response_revision:606; }","duration":"168.184187ms","start":"2026-05-10T00:45:46.522544Z","end":"2026-05-10T00:45:46.690728Z","steps":["trace[1770982642] 'range keys from in-memory index tree' (duration: 167.728349ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:46.926342Z","caller":"traceutil/trace.go:171","msg":"trace[168949451] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"221.744045ms","start":"2026-05-10T00:45:46.704564Z","end":"2026-05-10T00:45:46.926308Z","steps":["trace[168949451] 'process raft request' (duration: 217.795023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:47.794727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.860703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-10T00:45:47.794779Z","caller":"traceutil/trace.go:171","msg":"trace[1577461771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"382.951957ms","start":"2026-05-10T00:45:47.41181Z","end":"2026-05-10T00:45:47.794762Z","steps":["trace[1577461771] 'range keys from in-memory index tree' (duration: 382.674306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:47.794819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:47.411723Z","time spent":"383.088003ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-10T00:45:47.794695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.432345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:47.794948Z","caller":"traceutil/trace.go:171","msg":"trace[1920473991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"461.690935ms","start":"2026-05-10T00:45:47.333189Z","end":"2026-05-10T00:45:47.79488Z","steps":["trace[1920473991] 'range keys from in-memory index tree' (duration: 461.248788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:47.79506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:47.33317Z","time spent":"461.846151ms","remote":"127.0.0.1:41284","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-05-10T00:45:47.956521Z","caller":"traceutil/trace.go:171","msg":"trace[974482194] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"157.239397ms","start":"2026-05-10T00:45:47.799256Z","end":"2026-05-10T00:45:47.956495Z","steps":["trace[974482194] 'process raft request' (duration: 157.094951ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:49.942443Z","caller":"traceutil/trace.go:171","msg":"trace[1832922858] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"269.336344ms","start":"2026-05-10T00:45:49.67308Z","end":"2026-05-10T00:45:49.942416Z","steps":["trace[1832922858] 'process raft request' (duration: 269.21668ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:51.674564Z","caller":"traceutil/trace.go:171","msg":"trace[833467374] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"103.817813ms","start":"2026-05-10T00:45:51.570725Z","end":"2026-05-10T00:45:51.674543Z","steps":["trace[833467374] 'process raft request' (duration: 102.834085ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:54.724623Z","caller":"traceutil/trace.go:171","msg":"trace[963940571] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"299.829227ms","start":"2026-05-10T00:45:54.424767Z","end":"2026-05-10T00:45:54.724596Z","steps":["trace[963940571] 'process raft request' (duration: 299.669491ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:54.923789Z","caller":"traceutil/trace.go:171","msg":"trace[218838773] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:716; }","duration":"464.395952ms","start":"2026-05-10T00:45:54.459371Z","end":"2026-05-10T00:45:54.923767Z","steps":["trace[218838773] 'read index received' (duration: 265.087932ms)","trace[218838773] 'applied index is now lower than readState.Index' (duration: 199.30726ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:54.924116Z","caller":"traceutil/trace.go:171","msg":"trace[866567565] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"490.407971ms","start":"2026-05-10T00:45:54.433697Z","end":"2026-05-10T00:45:54.924105Z","steps":["trace[866567565] 'process raft request' (duration: 489.991926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.924261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.433688Z","time spent":"490.456153ms","remote":"127.0.0.1:41588","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-05-10T00:45:54.924527Z","caller":"traceutil/trace.go:171","msg":"trace[1914050820] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"351.690911ms","start":"2026-05-10T00:45:54.572827Z","end":"2026-05-10T00:45:54.924518Z","steps":["trace[1914050820] 'process raft request' (duration: 350.891631ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.924601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.572808Z","time spent":"351.772643ms","remote":"127.0.0.1:41388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":614,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T00:45:54.924781Z","caller":"traceutil/trace.go:171","msg":"trace[2029910103] transaction","detail":"{read_only:false; number_of_response:1; response_revision:697; }","duration":"346.113142ms","start":"2026-05-10T00:45:54.57866Z","end":"2026-05-10T00:45:54.924773Z","steps":["trace[2029910103] 'process raft request' (duration: 345.084484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.924832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.578608Z","time spent":"346.197055ms","remote":"127.0.0.1:41502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30,"response count":0,"response size":4463,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:45:54.924943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.567015ms","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-05-10T00:45:54.925015Z","caller":"traceutil/trace.go:171","msg":"trace[57047600] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:697; }","duration":"465.672629ms","start":"2026-05-10T00:45:54.459327Z","end":"2026-05-10T00:45:54.925Z","steps":["trace[57047600] 'agreement among raft nodes before linearized reading' (duration: 465.585695ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:54.923797Z","caller":"traceutil/trace.go:171","msg":"trace[432618677] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"494.721612ms","start":"2026-05-10T00:45:54.429054Z","end":"2026-05-10T00:45:54.923775Z","steps":["trace[432618677] 'process raft request' (duration: 494.505634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.925041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.45931Z","time spent":"465.722621ms","remote":"127.0.0.1:40150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-05-10T00:45:54.925326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.429025Z","time spent":"496.049011ms","remote":"127.0.0.1:41502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4415,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:45:54.925436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.951819ms","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-05-10T00:45:54.925545Z","caller":"traceutil/trace.go:171","msg":"trace[1724941484] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:697; }","duration":"466.107515ms","start":"2026-05-10T00:45:54.459404Z","end":"2026-05-10T00:45:54.925512Z","steps":["trace[1724941484] 'agreement among raft nodes before linearized reading' (duration: 465.885536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.925608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.4594Z","time spent":"466.195499ms","remote":"127.0.0.1:40150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-10T00:45:54.925635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.214534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:54.9257Z","caller":"traceutil/trace.go:171","msg":"trace[1541481873] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:697; }","duration":"299.302137ms","start":"2026-05-10T00:45:54.626388Z","end":"2026-05-10T00:45:54.92569Z","steps":["trace[1541481873] 'agreement among raft nodes before linearized reading' (duration: 299.217624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.925918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.336482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:54.925945Z","caller":"traceutil/trace.go:171","msg":"trace[980146841] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:697; }","duration":"283.389825ms","start":"2026-05-10T00:45:54.642549Z","end":"2026-05-10T00:45:54.925939Z","steps":["trace[980146841] 'agreement among raft nodes before linearized reading' (duration: 283.345263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.925963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.2436ms","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-05-10T00:45:54.926053Z","caller":"traceutil/trace.go:171","msg":"trace[1528330715] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:697; }","duration":"433.361694ms","start":"2026-05-10T00:45:54.492672Z","end":"2026-05-10T00:45:54.926034Z","steps":["trace[1528330715] 'agreement among raft nodes before linearized reading' (duration: 433.200318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.926095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.492668Z","time spent":"433.419577ms","remote":"127.0.0.1:40156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-10T00:45:54.926109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.551721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:54.926132Z","caller":"traceutil/trace.go:171","msg":"trace[1618354938] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:697; }","duration":"283.604363ms","start":"2026-05-10T00:45:54.642521Z","end":"2026-05-10T00:45:54.926126Z","steps":["trace[1618354938] 'agreement among raft nodes before linearized reading' (duration: 283.54449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.926283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.783799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:54.92631Z","caller":"traceutil/trace.go:171","msg":"trace[303551075] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:697; }","duration":"283.858201ms","start":"2026-05-10T00:45:54.642445Z","end":"2026-05-10T00:45:54.926304Z","steps":["trace[303551075] 'agreement among raft nodes before linearized reading' (duration: 283.788269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.926454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.421522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cnmd7\" ","response":"range_response_count:1 size:18516"} {"level":"info","ts":"2026-05-10T00:45:54.926482Z","caller":"traceutil/trace.go:171","msg":"trace[2068693362] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cnmd7; range_end:; response_count:1; response_revision:697; }","duration":"343.476974ms","start":"2026-05-10T00:45:54.582998Z","end":"2026-05-10T00:45:54.926475Z","steps":["trace[2068693362] 'agreement among raft nodes before linearized reading' (duration: 343.333058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.9265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.582985Z","time spent":"343.510955ms","remote":"127.0.0.1:41512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18539,"request content":"key:\"/registry/pods/kube-system/cilium-cnmd7\" "} {"level":"warn","ts":"2026-05-10T00:45:54.926561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.949066ms","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-05-10T00:45:54.926626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.914165ms","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-05-10T00:45:54.926632Z","caller":"traceutil/trace.go:171","msg":"trace[73913488] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:697; }","duration":"434.04821ms","start":"2026-05-10T00:45:54.492569Z","end":"2026-05-10T00:45:54.926617Z","steps":["trace[73913488] 'agreement among raft nodes before linearized reading' (duration: 433.947176ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:54.926649Z","caller":"traceutil/trace.go:171","msg":"trace[457493374] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:697; }","duration":"433.947067ms","start":"2026-05-10T00:45:54.492696Z","end":"2026-05-10T00:45:54.926643Z","steps":["trace[457493374] 'agreement among raft nodes before linearized reading' (duration: 433.910796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.926671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.492692Z","time spent":"433.973538ms","remote":"127.0.0.1:40156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-05-10T00:45:54.926715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.275408ms","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-05-10T00:45:54.92677Z","caller":"traceutil/trace.go:171","msg":"trace[170683371] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:697; }","duration":"467.337541ms","start":"2026-05-10T00:45:54.459425Z","end":"2026-05-10T00:45:54.926763Z","steps":["trace[170683371] 'agreement among raft nodes before linearized reading' (duration: 467.266399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:54.926676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.492549Z","time spent":"434.109892ms","remote":"127.0.0.1:40156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-10T00:45:54.926877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:54.459421Z","time spent":"467.377643ms","remote":"127.0.0.1:40150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-10T00:45:54.92722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.657371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:45:54.927254Z","caller":"traceutil/trace.go:171","msg":"trace[144139652] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:697; }","duration":"299.750024ms","start":"2026-05-10T00:45:54.627497Z","end":"2026-05-10T00:45:54.927247Z","steps":["trace[144139652] 'agreement among raft nodes before linearized reading' (duration: 299.700573ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:55.098266Z","caller":"traceutil/trace.go:171","msg":"trace[1863199692] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"163.612859ms","start":"2026-05-10T00:45:54.934617Z","end":"2026-05-10T00:45:55.09823Z","steps":["trace[1863199692] 'process raft request' (duration: 161.126708ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:55.170158Z","caller":"traceutil/trace.go:171","msg":"trace[2007980444] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"226.701361ms","start":"2026-05-10T00:45:54.943421Z","end":"2026-05-10T00:45:55.170122Z","steps":["trace[2007980444] 'process raft request' (duration: 226.529465ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:55.236603Z","caller":"traceutil/trace.go:171","msg":"trace[858273287] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"122.036518ms","start":"2026-05-10T00:45:55.114537Z","end":"2026-05-10T00:45:55.236573Z","steps":["trace[858273287] 'process raft request' (duration: 121.563131ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:04.676668Z","caller":"traceutil/trace.go:171","msg":"trace[1500610284] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"556.053292ms","start":"2026-05-10T00:46:04.120588Z","end":"2026-05-10T00:46:04.676641Z","steps":["trace[1500610284] 'process raft request' (duration: 555.897086ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:04.676755Z","caller":"traceutil/trace.go:171","msg":"trace[1093041463] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:792; }","duration":"393.340745ms","start":"2026-05-10T00:46:04.283392Z","end":"2026-05-10T00:46:04.676733Z","steps":["trace[1093041463] 'read index received' (duration: 393.329304ms)","trace[1093041463] 'applied index is now lower than readState.Index' (duration: 9.571µs)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:46:04.67688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:46:04.120558Z","time spent":"556.225647ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:46:04.676954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.555342ms","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-05-10T00:46:04.677004Z","caller":"traceutil/trace.go:171","msg":"trace[237383592] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:765; }","duration":"393.653114ms","start":"2026-05-10T00:46:04.28334Z","end":"2026-05-10T00:46:04.676993Z","steps":["trace[237383592] 'agreement among raft nodes before linearized reading' (duration: 393.486989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:46:04.677039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:46:04.283316Z","time spent":"393.714627ms","remote":"127.0.0.1:41588","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-05-10T00:46:04.69917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.939002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T00:46:04.699419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.87243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:46:04.699477Z","caller":"traceutil/trace.go:171","msg":"trace[1877003681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:766; }","duration":"366.979253ms","start":"2026-05-10T00:46:04.332484Z","end":"2026-05-10T00:46:04.699463Z","steps":["trace[1877003681] 'agreement among raft nodes before linearized reading' (duration: 366.8706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:46:04.699517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:46:04.332457Z","time spent":"367.053016ms","remote":"127.0.0.1:41276","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-05-10T00:46:04.69942Z","caller":"traceutil/trace.go:171","msg":"trace[1430980127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:766; }","duration":"408.225972ms","start":"2026-05-10T00:46:04.291173Z","end":"2026-05-10T00:46:04.699399Z","steps":["trace[1430980127] 'agreement among raft nodes before linearized reading' (duration: 407.916142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:46:04.699612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:46:04.291159Z","time spent":"408.436859ms","remote":"127.0.0.1:41284","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-05-10T00:46:04.69925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.735003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-10T00:46:04.699792Z","caller":"traceutil/trace.go:171","msg":"trace[115297583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:766; }","duration":"255.345543ms","start":"2026-05-10T00:46:04.444427Z","end":"2026-05-10T00:46:04.699773Z","steps":["trace[115297583] 'agreement among raft nodes before linearized reading' (duration: 254.727502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:46:04.924333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.831313ms","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-05-10T00:46:04.924472Z","caller":"traceutil/trace.go:171","msg":"trace[571414436] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:766; }","duration":"142.989478ms","start":"2026-05-10T00:46:04.781463Z","end":"2026-05-10T00:46:04.924452Z","steps":["trace[571414436] 'range keys from in-memory index tree' (duration: 142.815342ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:04.924714Z","caller":"traceutil/trace.go:171","msg":"trace[1082997885] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"242.713701ms","start":"2026-05-10T00:46:04.681961Z","end":"2026-05-10T00:46:04.924674Z","steps":["trace[1082997885] 'process raft request' (duration: 240.713764ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:04.931581Z","caller":"traceutil/trace.go:171","msg":"trace[1790764492] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"226.120416ms","start":"2026-05-10T00:46:04.705437Z","end":"2026-05-10T00:46:04.931558Z","steps":["trace[1790764492] 'process raft request' (duration: 225.880758ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:04.931762Z","caller":"traceutil/trace.go:171","msg":"trace[1060760748] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:793; }","duration":"163.055458ms","start":"2026-05-10T00:46:04.768409Z","end":"2026-05-10T00:46:04.931464Z","steps":["trace[1060760748] 'read index received' (duration: 154.308426ms)","trace[1060760748] 'applied index is now lower than readState.Index' (duration: 8.745612ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:46:04.931943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.522115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-10T00:46:04.932105Z","caller":"traceutil/trace.go:171","msg":"trace[1678766340] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:768; }","duration":"163.641479ms","start":"2026-05-10T00:46:04.768346Z","end":"2026-05-10T00:46:04.931988Z","steps":["trace[1678766340] 'agreement among raft nodes before linearized reading' (duration: 163.356049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:46:19.135681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.488429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-05-10T00:46:19.135755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.101889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-10T00:46:19.135782Z","caller":"traceutil/trace.go:171","msg":"trace[702485722] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:930; }","duration":"100.633593ms","start":"2026-05-10T00:46:19.03513Z","end":"2026-05-10T00:46:19.135764Z","steps":["trace[702485722] 'range keys from in-memory index tree' (duration: 100.351955ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:19.13583Z","caller":"traceutil/trace.go:171","msg":"trace[1124159294] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:930; }","duration":"107.243833ms","start":"2026-05-10T00:46:19.028568Z","end":"2026-05-10T00:46:19.135811Z","steps":["trace[1124159294] 'range keys from in-memory index tree' (duration: 106.906574ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:27.308603Z","caller":"traceutil/trace.go:171","msg":"trace[1790307227] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"116.490332ms","start":"2026-05-10T00:46:27.19209Z","end":"2026-05-10T00:46:27.30858Z","steps":["trace[1790307227] 'process raft request' (duration: 116.43875ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:27.308732Z","caller":"traceutil/trace.go:171","msg":"trace[727522555] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"117.145789ms","start":"2026-05-10T00:46:27.191555Z","end":"2026-05-10T00:46:27.308701Z","steps":["trace[727522555] 'process raft request' (duration: 82.689515ms)","trace[727522555] 'compare' (duration: 34.111455ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:48:28.047857Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836960392102019080,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T00:48:28.542629Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.027878354s","expected-duration":"1s"} {"level":"info","ts":"2026-05-10T00:48:28.543071Z","caller":"traceutil/trace.go:171","msg":"trace[1112973225] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"1.028371901s","start":"2026-05-10T00:48:27.514673Z","end":"2026-05-10T00:48:28.543044Z","steps":["trace[1112973225] 'process raft request' (duration: 1.028173698s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.543224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:27.514659Z","time spent":"1.028489233s","remote":"127.0.0.1:41588","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-05-10T00:48:28.561285Z","caller":"traceutil/trace.go:171","msg":"trace[1138367774] linearizableReadLoop","detail":"{readStateIndex:1470; appliedIndex:1468; }","duration":"1.013964181s","start":"2026-05-10T00:48:27.547299Z","end":"2026-05-10T00:48:28.561263Z","steps":["trace[1138367774] 'read index received' (duration: 995.555569ms)","trace[1138367774] 'applied index is now lower than readState.Index' (duration: 18.407772ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:48:28.561357Z","caller":"traceutil/trace.go:171","msg":"trace[1046461240] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"831.251265ms","start":"2026-05-10T00:48:27.730073Z","end":"2026-05-10T00:48:28.561324Z","steps":["trace[1046461240] 'process raft request' (duration: 831.065062ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:28.561399Z","caller":"traceutil/trace.go:171","msg":"trace[648843256] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"479.947411ms","start":"2026-05-10T00:48:28.081432Z","end":"2026-05-10T00:48:28.56138Z","steps":["trace[648843256] 'process raft request' (duration: 479.804279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.561512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:27.730054Z","time spent":"831.377736ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:48:28.561531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014207164s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-05-10T00:48:28.561553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:28.081416Z","time spent":"480.015612ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T00:48:28.561576Z","caller":"traceutil/trace.go:171","msg":"trace[93852665] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:1411; }","duration":"1.014291655s","start":"2026-05-10T00:48:27.547273Z","end":"2026-05-10T00:48:28.561564Z","steps":["trace[93852665] 'agreement among raft nodes before linearized reading' (duration: 1.014102012s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.561645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:27.547259Z","time spent":"1.014375176s","remote":"127.0.0.1:41418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":6554,"request content":"key:\"/registry/configmaps/kube-system/cilium-config\" "} {"level":"warn","ts":"2026-05-10T00:48:28.561812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.077356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-05-10T00:48:28.561861Z","caller":"traceutil/trace.go:171","msg":"trace[1210281562] range","detail":"{range_begin:/registry/roles/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1411; }","duration":"993.169186ms","start":"2026-05-10T00:48:27.568678Z","end":"2026-05-10T00:48:28.561847Z","steps":["trace[1210281562] 'agreement among raft nodes before linearized reading' (duration: 993.075845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.561898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:27.568661Z","time spent":"993.229658ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":732,"request content":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" "} {"level":"warn","ts":"2026-05-10T00:48:28.561926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.585078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-10T00:48:28.561951Z","caller":"traceutil/trace.go:171","msg":"trace[1258719920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1411; }","duration":"556.636319ms","start":"2026-05-10T00:48:28.005306Z","end":"2026-05-10T00:48:28.561942Z","steps":["trace[1258719920] 'agreement among raft nodes before linearized reading' (duration: 556.578768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.56197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:28.005294Z","time spent":"556.671689ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T00:48:28.561946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.259423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-10T00:48:28.56201Z","caller":"traceutil/trace.go:171","msg":"trace[273872779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1411; }","duration":"412.377514ms","start":"2026-05-10T00:48:28.149616Z","end":"2026-05-10T00:48:28.561993Z","steps":["trace[273872779] 'agreement among raft nodes before linearized reading' (duration: 412.179562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.562015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.975467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T00:48:28.562051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:28.149599Z","time spent":"412.446535ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-10T00:48:28.562055Z","caller":"traceutil/trace.go:171","msg":"trace[1745030930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1411; }","duration":"229.052367ms","start":"2026-05-10T00:48:28.332988Z","end":"2026-05-10T00:48:28.562041Z","steps":["trace[1745030930] 'agreement among raft nodes before linearized reading' (duration: 228.997016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.562065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.318083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/\" range_end:\"/registry/services/endpoints/kube-system0\" limit:500 ","response":"range_response_count:1 size:756"} {"level":"info","ts":"2026-05-10T00:48:28.562095Z","caller":"traceutil/trace.go:171","msg":"trace[1847671449] range","detail":"{range_begin:/registry/services/endpoints/kube-system/; range_end:/registry/services/endpoints/kube-system0; response_count:1; response_revision:1411; }","duration":"985.386205ms","start":"2026-05-10T00:48:27.576698Z","end":"2026-05-10T00:48:28.562084Z","steps":["trace[1847671449] 'agreement among raft nodes before linearized reading' (duration: 985.295723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.562102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.283357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-10T00:48:28.562118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:27.57668Z","time spent":"985.432015ms","remote":"127.0.0.1:41494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":779,"request content":"key:\"/registry/services/endpoints/kube-system/\" range_end:\"/registry/services/endpoints/kube-system0\" limit:500 "} {"level":"info","ts":"2026-05-10T00:48:28.562123Z","caller":"traceutil/trace.go:171","msg":"trace[1206788156] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1411; }","duration":"661.329577ms","start":"2026-05-10T00:48:27.900787Z","end":"2026-05-10T00:48:28.562116Z","steps":["trace[1206788156] 'agreement among raft nodes before linearized reading' (duration: 661.292667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.561858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.45519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-10T00:48:28.562141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:27.900775Z","time spent":"661.360937ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-10T00:48:28.562148Z","caller":"traceutil/trace.go:171","msg":"trace[759170828] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1411; }","duration":"630.773074ms","start":"2026-05-10T00:48:27.931368Z","end":"2026-05-10T00:48:28.562141Z","steps":["trace[759170828] 'agreement among raft nodes before linearized reading' (duration: 630.399339ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.562173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:27.931356Z","time spent":"630.811116ms","remote":"127.0.0.1:41588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-10T00:48:28.562215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.890484ms","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-05-10T00:48:28.562251Z","caller":"traceutil/trace.go:171","msg":"trace[1664243788] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1411; }","duration":"702.970276ms","start":"2026-05-10T00:48:27.859272Z","end":"2026-05-10T00:48:28.562243Z","steps":["trace[1664243788] 'agreement among raft nodes before linearized reading' (duration: 702.856704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:28.562281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:27.859255Z","time spent":"703.019886ms","remote":"127.0.0.1:41588","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-05-10T00:48:34.746823Z","caller":"traceutil/trace.go:171","msg":"trace[1056209790] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"181.960661ms","start":"2026-05-10T00:48:34.564842Z","end":"2026-05-10T00:48:34.746803Z","steps":["trace[1056209790] 'process raft request' (duration: 181.782188ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:34.747933Z","caller":"traceutil/trace.go:171","msg":"trace[523859706] linearizableReadLoop","detail":"{readStateIndex:1491; appliedIndex:1489; }","duration":"156.875657ms","start":"2026-05-10T00:48:34.591033Z","end":"2026-05-10T00:48:34.747909Z","steps":["trace[523859706] 'read index received' (duration: 155.644521ms)","trace[523859706] 'applied index is now lower than readState.Index' (duration: 1.230086ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:48:34.748192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.995858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-10T00:48:34.748225Z","caller":"traceutil/trace.go:171","msg":"trace[2007396143] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"159.285168ms","start":"2026-05-10T00:48:34.58891Z","end":"2026-05-10T00:48:34.748195Z","steps":["trace[2007396143] 'process raft request' (duration: 158.889583ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:34.748272Z","caller":"traceutil/trace.go:171","msg":"trace[2040189262] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:1430; }","duration":"133.09774ms","start":"2026-05-10T00:48:34.615141Z","end":"2026-05-10T00:48:34.748239Z","steps":["trace[2040189262] 'agreement among raft nodes before linearized reading' (duration: 132.972229ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:34.748317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.733138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-10T00:48:34.748313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.118262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-10T00:48:34.748396Z","caller":"traceutil/trace.go:171","msg":"trace[490618918] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:1430; }","duration":"113.297654ms","start":"2026-05-10T00:48:34.635084Z","end":"2026-05-10T00:48:34.748381Z","steps":["trace[490618918] 'agreement among raft nodes before linearized reading' (duration: 113.080451ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:34.748396Z","caller":"traceutil/trace.go:171","msg":"trace[1864374885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1430; }","duration":"150.822819ms","start":"2026-05-10T00:48:34.597551Z","end":"2026-05-10T00:48:34.748374Z","steps":["trace[1864374885] 'agreement among raft nodes before linearized reading' (duration: 150.681117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:34.748334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.437091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-10T00:48:34.748503Z","caller":"traceutil/trace.go:171","msg":"trace[1312127741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1430; }","duration":"156.640164ms","start":"2026-05-10T00:48:34.591852Z","end":"2026-05-10T00:48:34.748492Z","steps":["trace[1312127741] 'agreement among raft nodes before linearized reading' (duration: 156.385021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:34.748195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.15434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-10T00:48:34.748554Z","caller":"traceutil/trace.go:171","msg":"trace[833327146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1430; }","duration":"157.566756ms","start":"2026-05-10T00:48:34.590975Z","end":"2026-05-10T00:48:34.748542Z","steps":["trace[833327146] 'agreement among raft nodes before linearized reading' (duration: 157.0919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:34.748195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.32823ms","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-05-10T00:48:34.748632Z","caller":"traceutil/trace.go:171","msg":"trace[726263743] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1430; }","duration":"156.789556ms","start":"2026-05-10T00:48:34.591829Z","end":"2026-05-10T00:48:34.748619Z","steps":["trace[726263743] 'agreement among raft nodes before linearized reading' (duration: 156.270209ms)"],"step_count":1}