{"level":"warn","ts":"2026-07-02T15:19:08.12213Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T15:19:08.122216Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.181:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.181:2380","--initial-cluster=instance=https://199.19.213.181:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.181:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.181: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-07-02T15:19:08.122278Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T15:19:08.122288Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.181:2380"]} {"level":"info","ts":"2026-07-02T15:19:08.122303Z","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-07-02T15:19:08.122973Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"]} {"level":"info","ts":"2026-07-02T15:19:08.123073Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.181: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-07-02T15:19:08.131666Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.260121ms"} {"level":"info","ts":"2026-07-02T15:19:08.141277Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1a532052a1358225","cluster-id":"b34324311008a1d3"} {"level":"info","ts":"2026-07-02T15:19:08.141372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T15:19:08.141403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 0"} {"level":"info","ts":"2026-07-02T15:19:08.141438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1a532052a1358225 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T15:19:08.141453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 1"} {"level":"info","ts":"2026-07-02T15:19:08.141501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"} {"level":"warn","ts":"2026-07-02T15:19:08.149409Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T15:19:08.15084Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T15:19:08.152707Z","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-07-02T15:19:08.156141Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1a532052a1358225","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T15:19:08.15636Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1a532052a1358225","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T15:19:08.156468Z","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-07-02T15:19:08.156523Z","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-07-02T15:19:08.156533Z","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-07-02T15:19:08.157355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"} {"level":"info","ts":"2026-07-02T15:19:08.166024Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","added-peer-id":"1a532052a1358225","added-peer-peer-urls":["https://199.19.213.181:2380"]} {"level":"info","ts":"2026-07-02T15:19:08.167005Z","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-07-02T15:19:08.167218Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1a532052a1358225","initial-advertise-peer-urls":["https://199.19.213.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T15:19:08.167247Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T15:19:08.167312Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.181:2380"} {"level":"info","ts":"2026-07-02T15:19:08.167324Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.181:2380"} {"level":"info","ts":"2026-07-02T15:19:08.64517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T15:19:08.645221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T15:19:08.64524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgPreVoteResp from 1a532052a1358225 at term 1"} {"level":"info","ts":"2026-07-02T15:19:08.64525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became candidate at term 2"} {"level":"info","ts":"2026-07-02T15:19:08.645256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgVoteResp from 1a532052a1358225 at term 2"} {"level":"info","ts":"2026-07-02T15:19:08.645263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became leader at term 2"} {"level":"info","ts":"2026-07-02T15:19:08.64527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1a532052a1358225 elected leader 1a532052a1358225 at term 2"} {"level":"info","ts":"2026-07-02T15:19:08.698065Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1a532052a1358225","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.181:2379]}","request-path":"/0/members/1a532052a1358225/attributes","cluster-id":"b34324311008a1d3","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T15:19:08.698088Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T15:19:08.698658Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T15:19:08.698199Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T15:19:08.699123Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T15:19:08.699155Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T15:19:08.701408Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T15:19:08.701557Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T15:19:08.701597Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T15:19:08.701758Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T15:19:08.704286Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.181:2379"} {"level":"info","ts":"2026-07-02T15:19:10.202403Z","caller":"traceutil/trace.go:171","msg":"trace[1766114663] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"252.551796ms","start":"2026-07-02T15:19:09.949825Z","end":"2026-07-02T15:19:10.202377Z","steps":["trace[1766114663] 'process raft request' (duration: 251.031429ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.208882Z","caller":"traceutil/trace.go:171","msg":"trace[123389910] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"255.039966ms","start":"2026-07-02T15:19:09.953819Z","end":"2026-07-02T15:19:10.208859Z","steps":["trace[123389910] 'process raft request' (duration: 254.920543ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.208942Z","caller":"traceutil/trace.go:171","msg":"trace[512670835] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"256.973152ms","start":"2026-07-02T15:19:09.951917Z","end":"2026-07-02T15:19:10.20889Z","steps":["trace[512670835] 'process raft request' (duration: 256.689016ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.209199Z","caller":"traceutil/trace.go:171","msg":"trace[408874225] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"180.899587ms","start":"2026-07-02T15:19:10.028265Z","end":"2026-07-02T15:19:10.209165Z","steps":["trace[408874225] 'process raft request' (duration: 180.580379ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.209293Z","caller":"traceutil/trace.go:171","msg":"trace[1177542284] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"181.058192ms","start":"2026-07-02T15:19:10.028196Z","end":"2026-07-02T15:19:10.209254Z","steps":["trace[1177542284] 'process raft request' (duration: 180.61165ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.209353Z","caller":"traceutil/trace.go:171","msg":"trace[173923729] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:4; }","duration":"254.927284ms","start":"2026-07-02T15:19:09.954397Z","end":"2026-07-02T15:19:10.209324Z","steps":["trace[173923729] 'read index received' (duration: 246.533219ms)","trace[173923729] 'applied index is now lower than readState.Index' (duration: 8.393315ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:19:10.210291Z","caller":"traceutil/trace.go:171","msg":"trace[351636551] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"170.809371ms","start":"2026-07-02T15:19:10.038799Z","end":"2026-07-02T15:19:10.209609Z","steps":["trace[351636551] 'process raft request' (duration: 170.427021ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.209397Z","caller":"traceutil/trace.go:171","msg":"trace[261687125] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"181.370289ms","start":"2026-07-02T15:19:10.028015Z","end":"2026-07-02T15:19:10.209385Z","steps":["trace[261687125] 'process raft request' (duration: 180.766474ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.209479Z","caller":"traceutil/trace.go:171","msg":"trace[1663319837] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"181.050742ms","start":"2026-07-02T15:19:10.028412Z","end":"2026-07-02T15:19:10.209462Z","steps":["trace[1663319837] 'process raft request' (duration: 180.508178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:10.212062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.395897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.181\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:10.212164Z","caller":"traceutil/trace.go:171","msg":"trace[910806386] range","detail":"{range_begin:/registry/masterleases/199.19.213.181; range_end:; response_count:0; response_revision:11; }","duration":"183.523553ms","start":"2026-07-02T15:19:10.028618Z","end":"2026-07-02T15:19:10.212142Z","steps":["trace[910806386] 'agreement among raft nodes before linearized reading' (duration: 182.17903ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.209511Z","caller":"traceutil/trace.go:171","msg":"trace[1032025663] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"181.184165ms","start":"2026-07-02T15:19:10.02832Z","end":"2026-07-02T15:19:10.209504Z","steps":["trace[1032025663] 'process raft request' (duration: 180.549029ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:10.212989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.573902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T15:19:10.213067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.760786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:10.213202Z","caller":"traceutil/trace.go:171","msg":"trace[415605884] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"133.94393ms","start":"2026-07-02T15:19:10.079239Z","end":"2026-07-02T15:19:10.213182Z","steps":["trace[415605884] 'agreement among raft nodes before linearized reading' (duration: 133.592412ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.213197Z","caller":"traceutil/trace.go:171","msg":"trace[1630971065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"258.690575ms","start":"2026-07-02T15:19:09.954394Z","end":"2026-07-02T15:19:10.213085Z","steps":["trace[1630971065] 'agreement among raft nodes before linearized reading' (duration: 255.2132ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.209577Z","caller":"traceutil/trace.go:171","msg":"trace[559097732] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"181.191276ms","start":"2026-07-02T15:19:10.02838Z","end":"2026-07-02T15:19:10.209571Z","steps":["trace[559097732] 'process raft request' (duration: 180.509278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:10.213616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.008833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:10.213717Z","caller":"traceutil/trace.go:171","msg":"trace[1166703620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"259.143266ms","start":"2026-07-02T15:19:09.954551Z","end":"2026-07-02T15:19:10.213695Z","steps":["trace[1166703620] 'agreement among raft nodes before linearized reading' (duration: 256.229905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:10.213667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.977237ms","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":"warn","ts":"2026-07-02T15:19:10.213842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.585911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T15:19:10.213869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.299233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:10.213908Z","caller":"traceutil/trace.go:171","msg":"trace[1527684479] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"185.237083ms","start":"2026-07-02T15:19:10.028644Z","end":"2026-07-02T15:19:10.213881Z","steps":["trace[1527684479] 'agreement among raft nodes before linearized reading' (duration: 184.991687ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.214632Z","caller":"traceutil/trace.go:171","msg":"trace[299775626] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"252.060852ms","start":"2026-07-02T15:19:09.962536Z","end":"2026-07-02T15:19:10.214597Z","steps":["trace[299775626] 'agreement among raft nodes before linearized reading' (duration: 251.267393ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:10.213921Z","caller":"traceutil/trace.go:171","msg":"trace[1084431827] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"212.680453ms","start":"2026-07-02T15:19:10.001206Z","end":"2026-07-02T15:19:10.213887Z","steps":["trace[1084431827] 'agreement among raft nodes before linearized reading' (duration: 212.54928ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:10.213988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.265929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:10.218351Z","caller":"traceutil/trace.go:171","msg":"trace[1659493864] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"190.694717ms","start":"2026-07-02T15:19:10.027631Z","end":"2026-07-02T15:19:10.218326Z","steps":["trace[1659493864] 'agreement among raft nodes before linearized reading' (duration: 186.31179ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:11.163975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.052634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T15:19:11.164031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.941513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:11.164067Z","caller":"traceutil/trace.go:171","msg":"trace[1249633481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:116; }","duration":"144.206788ms","start":"2026-07-02T15:19:11.019841Z","end":"2026-07-02T15:19:11.164048Z","steps":["trace[1249633481] 'range keys from in-memory index tree' (duration: 143.938101ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:11.164099Z","caller":"traceutil/trace.go:171","msg":"trace[153268261] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:116; }","duration":"238.066366ms","start":"2026-07-02T15:19:10.926014Z","end":"2026-07-02T15:19:11.16408Z","steps":["trace[153268261] 'range keys from in-memory index tree' (duration: 237.855961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:11.164237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.994955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:11.164303Z","caller":"traceutil/trace.go:171","msg":"trace[997282901] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:116; }","duration":"238.105767ms","start":"2026-07-02T15:19:10.92618Z","end":"2026-07-02T15:19:11.164286Z","steps":["trace[997282901] 'range keys from in-memory index tree' (duration: 237.873262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:11.669614Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9378076773512539668,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T15:19:12.00454Z","caller":"traceutil/trace.go:171","msg":"trace[1717513667] linearizableReadLoop","detail":"{readStateIndex:122; appliedIndex:121; }","duration":"835.75366ms","start":"2026-07-02T15:19:11.168767Z","end":"2026-07-02T15:19:12.004521Z","steps":["trace[1717513667] 'read index received' (duration: 835.593816ms)","trace[1717513667] 'applied index is now lower than readState.Index' (duration: 159.144µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:19:12.004672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.884643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:12.0047Z","caller":"traceutil/trace.go:171","msg":"trace[1080324459] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:117; }","duration":"835.953134ms","start":"2026-07-02T15:19:11.168738Z","end":"2026-07-02T15:19:12.004691Z","steps":["trace[1080324459] 'agreement among raft nodes before linearized reading' (duration: 835.870102ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:12.004724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:11.168706Z","time spent":"836.013206ms","remote":"127.0.0.1:57564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-07-02T15:19:12.004785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.795404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:12.004853Z","caller":"traceutil/trace.go:171","msg":"trace[916222325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:117; }","duration":"784.908066ms","start":"2026-07-02T15:19:11.219927Z","end":"2026-07-02T15:19:12.004835Z","steps":["trace[916222325] 'agreement among raft nodes before linearized reading' (duration: 784.793824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:12.004902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:11.219906Z","time spent":"784.985478ms","remote":"127.0.0.1:44248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T15:19:12.004984Z","caller":"traceutil/trace.go:171","msg":"trace[96511796] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"837.003179ms","start":"2026-07-02T15:19:11.167791Z","end":"2026-07-02T15:19:12.004794Z","steps":["trace[96511796] 'process raft request' (duration: 836.61714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:12.005676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:11.167777Z","time spent":"837.333278ms","remote":"127.0.0.1:57592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T15:19:12.512182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9378076773512539674,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T15:19:13.012892Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9378076773512539674,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T15:19:13.513647Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9378076773512539674,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T15:19:13.778073Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.767414639s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T15:19:14.120796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000543611s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T15:19:14.120949Z","caller":"traceutil/trace.go:171","msg":"trace[1753766855] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000716805s","start":"2026-07-02T15:19:12.120205Z","end":"2026-07-02T15:19:14.120922Z","steps":["trace[1753766855] 'agreement among raft nodes before linearized reading' (duration: 2.000539551s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:14.121262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:12.120167Z","time spent":"2.001066524s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T15:19:14.719605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.077793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-02T15:19:14.719711Z","caller":"traceutil/trace.go:171","msg":"trace[1569013137] linearizableReadLoop","detail":"{readStateIndex:123; appliedIndex:122; }","duration":"2.708579745s","start":"2026-07-02T15:19:12.011114Z","end":"2026-07-02T15:19:14.719693Z","steps":["trace[1569013137] 'read index received' (duration: 1.767112353s)","trace[1569013137] 'applied index is now lower than readState.Index' (duration: 941.465782ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:19:14.7198Z","caller":"traceutil/trace.go:171","msg":"trace[110702280] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"2.709223281s","start":"2026-07-02T15:19:12.010564Z","end":"2026-07-02T15:19:14.719787Z","steps":["trace[110702280] 'process raft request' (duration: 1.767706307s)","trace[110702280] 'compare' (duration: 940.152951ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:19:14.719853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:12.010547Z","time spent":"2.709280542s","remote":"127.0.0.1:57592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T15:19:14.720064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.708942134s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:14.7201Z","caller":"traceutil/trace.go:171","msg":"trace[178514669] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:118; }","duration":"2.708973954s","start":"2026-07-02T15:19:12.01111Z","end":"2026-07-02T15:19:14.720084Z","steps":["trace[178514669] 'agreement among raft nodes before linearized reading' (duration: 2.708899723s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:14.720132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:12.011079Z","time spent":"2.709045426s","remote":"127.0.0.1:57564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"info","ts":"2026-07-02T15:19:14.800554Z","caller":"traceutil/trace.go:171","msg":"trace[1137244983] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"266.180927ms","start":"2026-07-02T15:19:14.534346Z","end":"2026-07-02T15:19:14.800527Z","steps":["trace[1137244983] 'process raft request' (duration: 266.032783ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:14.800883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.515533548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:430"} {"level":"warn","ts":"2026-07-02T15:19:14.801048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.515848386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-02T15:19:14.801165Z","caller":"traceutil/trace.go:171","msg":"trace[244936725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:119; }","duration":"2.515999779s","start":"2026-07-02T15:19:12.285149Z","end":"2026-07-02T15:19:14.801148Z","steps":["trace[244936725] 'agreement among raft nodes before linearized reading' (duration: 2.515780014s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:14.801215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:12.285132Z","time spent":"2.516073241s","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T15:19:14.800924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.957757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:14.801331Z","caller":"traceutil/trace.go:171","msg":"trace[162743150] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:119; }","duration":"679.450939ms","start":"2026-07-02T15:19:14.121852Z","end":"2026-07-02T15:19:14.801303Z","steps":["trace[162743150] 'agreement among raft nodes before linearized reading' (duration: 678.909256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:14.800952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568798621s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T15:19:14.801442Z","caller":"traceutil/trace.go:171","msg":"trace[1998878227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:119; }","duration":"1.569303932s","start":"2026-07-02T15:19:13.232122Z","end":"2026-07-02T15:19:14.801426Z","steps":["trace[1998878227] 'agreement among raft nodes before linearized reading' (duration: 1.56875138s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:14.801455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:14.121801Z","time spent":"679.606713ms","remote":"127.0.0.1:44248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T15:19:14.801621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:13.232056Z","time spent":"1.569545608s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T15:19:14.801807Z","caller":"traceutil/trace.go:171","msg":"trace[728992442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:119; }","duration":"2.515792585s","start":"2026-07-02T15:19:12.285299Z","end":"2026-07-02T15:19:14.801092Z","steps":["trace[728992442] 'agreement among raft nodes before linearized reading' (duration: 2.515397546s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:14.801882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:12.285289Z","time spent":"2.516577764s","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T15:19:27.415257Z","caller":"traceutil/trace.go:171","msg":"trace[2012823318] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"109.260144ms","start":"2026-07-02T15:19:27.305966Z","end":"2026-07-02T15:19:27.415227Z","steps":["trace[2012823318] 'process raft request' (duration: 109.08356ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:34.887396Z","caller":"traceutil/trace.go:171","msg":"trace[1940958357] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"104.308437ms","start":"2026-07-02T15:19:34.783066Z","end":"2026-07-02T15:19:34.887374Z","steps":["trace[1940958357] 'process raft request' (duration: 104.202975ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:37.121916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.014182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-02T15:19:37.122028Z","caller":"traceutil/trace.go:171","msg":"trace[619786091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:433; }","duration":"114.158155ms","start":"2026-07-02T15:19:37.007847Z","end":"2026-07-02T15:19:37.122005Z","steps":["trace[619786091] 'range keys from in-memory index tree' (duration: 113.92828ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:37.12193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.867147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T15:19:37.122131Z","caller":"traceutil/trace.go:171","msg":"trace[1480108312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:433; }","duration":"124.119582ms","start":"2026-07-02T15:19:36.997992Z","end":"2026-07-02T15:19:37.122112Z","steps":["trace[1480108312] 'range keys from in-memory index tree' (duration: 123.770024ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:38.508755Z","caller":"traceutil/trace.go:171","msg":"trace[318546511] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"153.684647ms","start":"2026-07-02T15:19:38.355044Z","end":"2026-07-02T15:19:38.508728Z","steps":["trace[318546511] 'process raft request' (duration: 153.535964ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:40.683404Z","caller":"traceutil/trace.go:171","msg":"trace[312016112] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"166.316742ms","start":"2026-07-02T15:19:40.517065Z","end":"2026-07-02T15:19:40.683382Z","steps":["trace[312016112] 'process raft request' (duration: 166.1831ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:48.89684Z","caller":"traceutil/trace.go:171","msg":"trace[1054603953] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"146.91871ms","start":"2026-07-02T15:19:48.749894Z","end":"2026-07-02T15:19:48.896813Z","steps":["trace[1054603953] 'process raft request' (duration: 146.765218ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:53.425998Z","caller":"traceutil/trace.go:171","msg":"trace[239802810] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"115.519214ms","start":"2026-07-02T15:19:53.310451Z","end":"2026-07-02T15:19:53.425971Z","steps":["trace[239802810] 'process raft request' (duration: 88.16832ms)","trace[239802810] 'compare' (duration: 27.235741ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:19:57.295582Z","caller":"traceutil/trace.go:171","msg":"trace[691190199] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"174.348873ms","start":"2026-07-02T15:19:57.121217Z","end":"2026-07-02T15:19:57.295566Z","steps":["trace[691190199] 'read index received' (duration: 174.19876ms)","trace[691190199] 'applied index is now lower than readState.Index' (duration: 149.383µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:19:57.295695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.458595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:19:57.295714Z","caller":"traceutil/trace.go:171","msg":"trace[64529744] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:544; }","duration":"174.540137ms","start":"2026-07-02T15:19:57.121169Z","end":"2026-07-02T15:19:57.295709Z","steps":["trace[64529744] 'agreement among raft nodes before linearized reading' (duration: 174.467665ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:57.295648Z","caller":"traceutil/trace.go:171","msg":"trace[896795705] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"270.056546ms","start":"2026-07-02T15:19:57.025562Z","end":"2026-07-02T15:19:57.295618Z","steps":["trace[896795705] 'process raft request' (duration: 269.869163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:58.285375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.583309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T15:19:58.28542Z","caller":"traceutil/trace.go:171","msg":"trace[1942629129] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"418.779534ms","start":"2026-07-02T15:19:57.866596Z","end":"2026-07-02T15:19:58.285375Z","steps":["trace[1942629129] 'process raft request' (duration: 364.466095ms)","trace[1942629129] 'compare' (duration: 54.151066ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:19:58.285478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.710492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T15:19:58.285532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.898199ms","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-07-02T15:19:58.285585Z","caller":"traceutil/trace.go:171","msg":"trace[1376777912] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:545; }","duration":"836.281566ms","start":"2026-07-02T15:19:57.449288Z","end":"2026-07-02T15:19:58.28557Z","steps":["trace[1376777912] 'range keys from in-memory index tree' (duration: 835.769098ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:58.285637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:57.449263Z","time spent":"836.358738ms","remote":"127.0.0.1:44370","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":"info","ts":"2026-07-02T15:19:58.285475Z","caller":"traceutil/trace.go:171","msg":"trace[1385002298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:545; }","duration":"847.739312ms","start":"2026-07-02T15:19:57.437717Z","end":"2026-07-02T15:19:58.285456Z","steps":["trace[1385002298] 'range keys from in-memory index tree' (duration: 847.322815ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:58.285725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:57.437701Z","time spent":"848.013767ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T15:19:58.285812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:57.866572Z","time spent":"418.913167ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T15:19:58.285542Z","caller":"traceutil/trace.go:171","msg":"trace[1228588017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"162.814154ms","start":"2026-07-02T15:19:58.122715Z","end":"2026-07-02T15:19:58.285529Z","steps":["trace[1228588017] 'agreement among raft nodes before linearized reading' (duration: 162.722452ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:19:58.285388Z","caller":"traceutil/trace.go:171","msg":"trace[654928980] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"162.572279ms","start":"2026-07-02T15:19:58.122758Z","end":"2026-07-02T15:19:58.28533Z","steps":["trace[654928980] 'read index received' (duration: 108.292841ms)","trace[654928980] 'applied index is now lower than readState.Index' (duration: 54.278358ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:19:59.224517Z","caller":"traceutil/trace.go:171","msg":"trace[1013499132] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"441.84952ms","start":"2026-07-02T15:19:58.782631Z","end":"2026-07-02T15:19:59.224481Z","steps":["trace[1013499132] 'process raft request' (duration: 420.092813ms)","trace[1013499132] 'compare' (duration: 21.497772ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:19:59.224633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:58.782605Z","time spent":"441.975423ms","remote":"127.0.0.1:44308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T15:19:59.224661Z","caller":"traceutil/trace.go:171","msg":"trace[71134864] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"439.613958ms","start":"2026-07-02T15:19:58.785022Z","end":"2026-07-02T15:19:59.224636Z","steps":["trace[71134864] 'process raft request' (duration: 439.500116ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:59.224844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:58.785001Z","time spent":"439.76124ms","remote":"127.0.0.1:44308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T15:19:59.22508Z","caller":"traceutil/trace.go:171","msg":"trace[1080568670] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:608; }","duration":"291.05983ms","start":"2026-07-02T15:19:58.93399Z","end":"2026-07-02T15:19:59.22505Z","steps":["trace[1080568670] 'read index received' (duration: 268.660562ms)","trace[1080568670] 'applied index is now lower than readState.Index' (duration: 22.397408ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:19:59.225088Z","caller":"traceutil/trace.go:171","msg":"trace[378298798] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"432.099936ms","start":"2026-07-02T15:19:58.792956Z","end":"2026-07-02T15:19:59.225056Z","steps":["trace[378298798] 'process raft request' (duration: 431.978274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:59.225324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:19:58.792942Z","time spent":"432.304451ms","remote":"127.0.0.1:44308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:19:59.225332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.310546ms","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-07-02T15:19:59.22539Z","caller":"traceutil/trace.go:171","msg":"trace[1588959205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"291.439619ms","start":"2026-07-02T15:19:58.933937Z","end":"2026-07-02T15:19:59.225377Z","steps":["trace[1588959205] 'agreement among raft nodes before linearized reading' (duration: 291.254815ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:19:59.225382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.451242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:19:59.225454Z","caller":"traceutil/trace.go:171","msg":"trace[122759795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"103.537053ms","start":"2026-07-02T15:19:59.121894Z","end":"2026-07-02T15:19:59.225431Z","steps":["trace[122759795] 'agreement among raft nodes before linearized reading' (duration: 103.416111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:00.481409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.580853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-07-02T15:20:00.481499Z","caller":"traceutil/trace.go:171","msg":"trace[2094556503] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:622; }","duration":"127.709065ms","start":"2026-07-02T15:20:00.353772Z","end":"2026-07-02T15:20:00.481481Z","steps":["trace[2094556503] 'range keys from in-memory index tree' (duration: 127.40562ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:00.482426Z","caller":"traceutil/trace.go:171","msg":"trace[735932477] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"107.931938ms","start":"2026-07-02T15:20:00.374475Z","end":"2026-07-02T15:20:00.482407Z","steps":["trace[735932477] 'process raft request' (duration: 107.306766ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:00.568602Z","caller":"traceutil/trace.go:171","msg":"trace[1844331633] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"137.11012ms","start":"2026-07-02T15:20:00.431467Z","end":"2026-07-02T15:20:00.568577Z","steps":["trace[1844331633] 'process raft request' (duration: 136.595611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:00.88988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.42692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T15:20:00.890139Z","caller":"traceutil/trace.go:171","msg":"trace[874165254] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"352.547386ms","start":"2026-07-02T15:20:00.537517Z","end":"2026-07-02T15:20:00.890065Z","steps":["trace[874165254] 'process raft request' (duration: 203.82685ms)","trace[874165254] 'compare' (duration: 147.937461ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:00.890206Z","caller":"traceutil/trace.go:171","msg":"trace[747955549] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"310.877211ms","start":"2026-07-02T15:20:00.579289Z","end":"2026-07-02T15:20:00.890166Z","steps":["trace[747955549] 'read index received' (duration: 161.968772ms)","trace[747955549] 'applied index is now lower than readState.Index' (duration: 148.903689ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:00.890372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:00.537482Z","time spent":"352.759001ms","remote":"127.0.0.1:44308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:01.024146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.117662ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-07-02T15:20:01.024382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.934342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:65214"} {"level":"info","ts":"2026-07-02T15:20:01.024528Z","caller":"traceutil/trace.go:171","msg":"trace[2059373386] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:625; }","duration":"445.159587ms","start":"2026-07-02T15:20:00.579285Z","end":"2026-07-02T15:20:01.024445Z","steps":["trace[2059373386] 'agreement among raft nodes before linearized reading' (duration: 311.009303ms)","trace[2059373386] 'range keys from in-memory index tree' (duration: 133.771965ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:01.02474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:00.579249Z","time spent":"445.33733ms","remote":"127.0.0.1:44308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":65237,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-07-02T15:20:02.57619Z","caller":"traceutil/trace.go:171","msg":"trace[1414474968] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"149.567229ms","start":"2026-07-02T15:20:02.426596Z","end":"2026-07-02T15:20:02.576164Z","steps":["trace[1414474968] 'process raft request' (duration: 149.455847ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:04.552786Z","caller":"traceutil/trace.go:171","msg":"trace[356275260] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"334.213606ms","start":"2026-07-02T15:20:04.21849Z","end":"2026-07-02T15:20:04.552704Z","steps":["trace[356275260] 'process raft request' (duration: 329.869456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:04.552919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:04.218457Z","time spent":"334.400881ms","remote":"127.0.0.1:44370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T15:20:04.557596Z","caller":"traceutil/trace.go:171","msg":"trace[1821684560] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"237.968885ms","start":"2026-07-02T15:20:04.319569Z","end":"2026-07-02T15:20:04.557538Z","steps":["trace[1821684560] 'read index received' (duration: 228.665924ms)","trace[1821684560] 'applied index is now lower than readState.Index' (duration: 9.29236ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:04.557761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.176838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T15:20:04.557783Z","caller":"traceutil/trace.go:171","msg":"trace[129457977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"238.24723ms","start":"2026-07-02T15:20:04.319529Z","end":"2026-07-02T15:20:04.557776Z","steps":["trace[129457977] 'agreement among raft nodes before linearized reading' (duration: 238.131828ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:05.451542Z","caller":"traceutil/trace.go:171","msg":"trace[658937177] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"331.004774ms","start":"2026-07-02T15:20:05.120514Z","end":"2026-07-02T15:20:05.451519Z","steps":["trace[658937177] 'read index received' (duration: 328.873575ms)","trace[658937177] 'applied index is now lower than readState.Index' (duration: 2.130208ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:05.451609Z","caller":"traceutil/trace.go:171","msg":"trace[2139637621] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"390.186382ms","start":"2026-07-02T15:20:05.061401Z","end":"2026-07-02T15:20:05.451587Z","steps":["trace[2139637621] 'process raft request' (duration: 388.769436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:05.45169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.170187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:20:05.451725Z","caller":"traceutil/trace.go:171","msg":"trace[1117326337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"331.212958ms","start":"2026-07-02T15:20:05.120501Z","end":"2026-07-02T15:20:05.451714Z","steps":["trace[1117326337] 'agreement among raft nodes before linearized reading' (duration: 331.147827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:05.451732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:05.061372Z","time spent":"390.285475ms","remote":"127.0.0.1:44370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:05.451892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.956801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-02T15:20:05.45196Z","caller":"traceutil/trace.go:171","msg":"trace[299079947] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"197.072133ms","start":"2026-07-02T15:20:05.254871Z","end":"2026-07-02T15:20:05.451943Z","steps":["trace[299079947] 'agreement among raft nodes before linearized reading' (duration: 196.846789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:05.452014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.830659ms","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-07-02T15:20:05.452126Z","caller":"traceutil/trace.go:171","msg":"trace[625172666] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:649; }","duration":"111.987662ms","start":"2026-07-02T15:20:05.340119Z","end":"2026-07-02T15:20:05.452107Z","steps":["trace[625172666] 'agreement among raft nodes before linearized reading' (duration: 111.724677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:05.451764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:05.120445Z","time spent":"331.31247ms","remote":"127.0.0.1:44248","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-07-02T15:20:06.133034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.538122ms","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-07-02T15:20:06.133436Z","caller":"traceutil/trace.go:171","msg":"trace[1456407240] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:649; }","duration":"180.9606ms","start":"2026-07-02T15:20:05.952453Z","end":"2026-07-02T15:20:06.133414Z","steps":["trace[1456407240] 'range keys from in-memory index tree' (duration: 180.518892ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:06.133416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.563199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T15:20:06.133558Z","caller":"traceutil/trace.go:171","msg":"trace[1371416805] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"674.443717ms","start":"2026-07-02T15:20:05.459087Z","end":"2026-07-02T15:20:06.133531Z","steps":["trace[1371416805] 'process raft request' (duration: 254.664283ms)","trace[1371416805] 'compare' (duration: 419.390076ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:06.133664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:05.459071Z","time spent":"674.546618ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:06.798501Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.083431093s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T15:20:07.09353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.786218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T15:20:07.093902Z","caller":"traceutil/trace.go:171","msg":"trace[267147523] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:676; }","duration":"1.569104952s","start":"2026-07-02T15:20:05.524744Z","end":"2026-07-02T15:20:07.093849Z","steps":["trace[267147523] 'read index received' (duration: 189.206089ms)","trace[267147523] 'applied index is now lower than readState.Index' (duration: 1.379897753s)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:07.093995Z","caller":"traceutil/trace.go:171","msg":"trace[1757045027] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"1.57502192s","start":"2026-07-02T15:20:05.518946Z","end":"2026-07-02T15:20:07.093968Z","steps":["trace[1757045027] 'process raft request' (duration: 1.574849126s)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:07.094002Z","caller":"traceutil/trace.go:171","msg":"trace[675647793] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"1.617254151s","start":"2026-07-02T15:20:05.476721Z","end":"2026-07-02T15:20:07.093975Z","steps":["trace[675647793] 'process raft request' (duration: 1.616996865s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:07.094036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.569282696s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.181\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-02T15:20:07.094068Z","caller":"traceutil/trace.go:171","msg":"trace[828852655] range","detail":"{range_begin:/registry/masterleases/199.19.213.181; range_end:; response_count:1; response_revision:654; }","duration":"1.569348016s","start":"2026-07-02T15:20:05.524709Z","end":"2026-07-02T15:20:07.094057Z","steps":["trace[828852655] 'agreement among raft nodes before linearized reading' (duration: 1.569282115s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:07.094092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:05.518923Z","time spent":"1.575129842s","remote":"127.0.0.1:57564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T15:20:07.094121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:05.476701Z","time spent":"1.617353052s","remote":"127.0.0.1:57408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:07.094105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:05.524697Z","time spent":"1.569401288s","remote":"127.0.0.1:44294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.181\" "} {"level":"info","ts":"2026-07-02T15:20:07.094119Z","caller":"traceutil/trace.go:171","msg":"trace[878377224] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"1.634745839s","start":"2026-07-02T15:20:05.459351Z","end":"2026-07-02T15:20:07.094097Z","steps":["trace[878377224] 'process raft request' (duration: 1.63427845s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:07.094226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.797086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T15:20:07.094262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:05.459344Z","time spent":"1.634849141s","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:07.094291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.827199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T15:20:07.094314Z","caller":"traceutil/trace.go:171","msg":"trace[1666285732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"527.885331ms","start":"2026-07-02T15:20:06.566421Z","end":"2026-07-02T15:20:07.094306Z","steps":["trace[1666285732] 'agreement among raft nodes before linearized reading' (duration: 527.785549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:07.094333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:06.566404Z","time spent":"527.926501ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-02T15:20:07.094564Z","caller":"traceutil/trace.go:171","msg":"trace[1477968574] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"1.634483554s","start":"2026-07-02T15:20:05.459298Z","end":"2026-07-02T15:20:07.093782Z","steps":["trace[1477968574] 'process raft request' (duration: 1.33936002s)","trace[1477968574] 'compare' (duration: 294.654235ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:07.09519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:05.45929Z","time spent":"1.635319919s","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T15:20:07.094287Z","caller":"traceutil/trace.go:171","msg":"trace[1026850304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"969.885637ms","start":"2026-07-02T15:20:06.124388Z","end":"2026-07-02T15:20:07.094273Z","steps":["trace[1026850304] 'agreement among raft nodes before linearized reading' (duration: 969.727494ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:07.095787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:06.12437Z","time spent":"971.397264ms","remote":"127.0.0.1:44258","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-07-02T15:20:08.234802Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.082070869s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T15:20:08.362731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.627861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T15:20:08.362851Z","caller":"traceutil/trace.go:171","msg":"trace[1619212090] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"1.247372821s","start":"2026-07-02T15:20:07.115459Z","end":"2026-07-02T15:20:08.362832Z","steps":["trace[1619212090] 'process raft request' (duration: 1.119539867s)","trace[1619212090] 'compare' (duration: 127.452147ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:08.362924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:07.115446Z","time spent":"1.247444472s","remote":"127.0.0.1:44294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:09.85917Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.622852319s","expected-duration":"1s"} {"level":"info","ts":"2026-07-02T15:20:09.866891Z","caller":"traceutil/trace.go:171","msg":"trace[1885547117] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:683; }","duration":"1.745016221s","start":"2026-07-02T15:20:08.121849Z","end":"2026-07-02T15:20:09.866865Z","steps":["trace[1885547117] 'read index received' (duration: 113.249872ms)","trace[1885547117] 'applied index is now lower than readState.Index' (duration: 1.631765359s)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:09.867393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.745529229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:20:09.867354Z","caller":"traceutil/trace.go:171","msg":"trace[1017012438] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"2.320229528s","start":"2026-07-02T15:20:07.547064Z","end":"2026-07-02T15:20:09.867293Z","steps":["trace[1017012438] 'process raft request' (duration: 2.312625272s)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:09.867456Z","caller":"traceutil/trace.go:171","msg":"trace[801407965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"1.745635922s","start":"2026-07-02T15:20:08.121801Z","end":"2026-07-02T15:20:09.867437Z","steps":["trace[801407965] 'agreement among raft nodes before linearized reading' (duration: 1.7455204s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:09.867505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:08.121781Z","time spent":"1.745713683s","remote":"127.0.0.1:44258","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-07-02T15:20:09.867585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:07.547036Z","time spent":"2.320428862s","remote":"127.0.0.1:44370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:09.871837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.119363ms","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-07-02T15:20:09.871882Z","caller":"traceutil/trace.go:171","msg":"trace[1456623256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:658; }","duration":"773.201193ms","start":"2026-07-02T15:20:09.098666Z","end":"2026-07-02T15:20:09.871867Z","steps":["trace[1456623256] 'agreement among raft nodes before linearized reading' (duration: 773.07197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:09.871919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:09.098643Z","time spent":"773.265695ms","remote":"127.0.0.1:57478","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-07-02T15:20:09.871991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.506826059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-07-02T15:20:09.87205Z","caller":"traceutil/trace.go:171","msg":"trace[870025130] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"1.42092315s","start":"2026-07-02T15:20:08.451115Z","end":"2026-07-02T15:20:09.872038Z","steps":["trace[870025130] 'process raft request' (duration: 1.420487362s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:09.87214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:08.451087Z","time spent":"1.420989461s","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:09.87216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.734170716s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-02T15:20:09.872215Z","caller":"traceutil/trace.go:171","msg":"trace[1976987775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:658; }","duration":"1.734270427s","start":"2026-07-02T15:20:08.137933Z","end":"2026-07-02T15:20:09.872204Z","steps":["trace[1976987775] 'agreement among raft nodes before linearized reading' (duration: 1.734135805s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:09.872253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:08.137902Z","time spent":"1.734343349s","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-02T15:20:09.872298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.562368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T15:20:09.872332Z","caller":"traceutil/trace.go:171","msg":"trace[196753345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:658; }","duration":"715.635659ms","start":"2026-07-02T15:20:09.156687Z","end":"2026-07-02T15:20:09.872323Z","steps":["trace[196753345] 'agreement among raft nodes before linearized reading' (duration: 715.550398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:09.872359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:09.15664Z","time spent":"715.713151ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T15:20:09.872528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.713055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-02T15:20:09.872554Z","caller":"traceutil/trace.go:171","msg":"trace[1026549981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:658; }","duration":"772.756365ms","start":"2026-07-02T15:20:09.09979Z","end":"2026-07-02T15:20:09.872547Z","steps":["trace[1026549981] 'agreement among raft nodes before linearized reading' (duration: 772.685244ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:09.872571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:09.099782Z","time spent":"772.784995ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T15:20:09.872047Z","caller":"traceutil/trace.go:171","msg":"trace[1589462193] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:658; }","duration":"1.506940281s","start":"2026-07-02T15:20:08.365094Z","end":"2026-07-02T15:20:09.872034Z","steps":["trace[1589462193] 'agreement among raft nodes before linearized reading' (duration: 1.506846179s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:09.872692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:08.365075Z","time spent":"1.507607902s","remote":"127.0.0.1:57404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-07-02T15:20:12.045578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.197567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:20:12.045654Z","caller":"traceutil/trace.go:171","msg":"trace[1340281108] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:702; }","duration":"218.30775ms","start":"2026-07-02T15:20:11.827328Z","end":"2026-07-02T15:20:12.045636Z","steps":["trace[1340281108] 'range keys from in-memory index tree' (duration: 218.073995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:12.045556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.9794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T15:20:12.045722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.294275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:20:12.045801Z","caller":"traceutil/trace.go:171","msg":"trace[1025071051] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:702; }","duration":"275.394017ms","start":"2026-07-02T15:20:11.770389Z","end":"2026-07-02T15:20:12.045783Z","steps":["trace[1025071051] 'count revisions from in-memory index tree' (duration: 275.210233ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:12.046127Z","caller":"traceutil/trace.go:171","msg":"trace[1533947594] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:732; }","duration":"149.218827ms","start":"2026-07-02T15:20:11.896896Z","end":"2026-07-02T15:20:12.046114Z","steps":["trace[1533947594] 'read index received' (duration: 145.836247ms)","trace[1533947594] 'applied index is now lower than readState.Index' (duration: 3.38166ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:12.046218Z","caller":"traceutil/trace.go:171","msg":"trace[2145640696] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"156.311593ms","start":"2026-07-02T15:20:11.889897Z","end":"2026-07-02T15:20:12.046209Z","steps":["trace[2145640696] 'process raft request' (duration: 152.902673ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:12.046285Z","caller":"traceutil/trace.go:171","msg":"trace[1156041279] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:702; }","duration":"412.271346ms","start":"2026-07-02T15:20:11.633491Z","end":"2026-07-02T15:20:12.045762Z","steps":["trace[1156041279] 'count revisions from in-memory index tree' (duration: 411.900379ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:12.046463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.569543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-02T15:20:12.046509Z","caller":"traceutil/trace.go:171","msg":"trace[231653148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:703; }","duration":"149.649695ms","start":"2026-07-02T15:20:11.896844Z","end":"2026-07-02T15:20:12.046494Z","steps":["trace[231653148] 'agreement among raft nodes before linearized reading' (duration: 149.509623ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:12.046427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:11.63347Z","time spent":"412.935158ms","remote":"127.0.0.1:57616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-07-02T15:20:12.04669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.009936ms","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-07-02T15:20:12.046809Z","caller":"traceutil/trace.go:171","msg":"trace[373257269] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:703; }","duration":"143.176759ms","start":"2026-07-02T15:20:11.903605Z","end":"2026-07-02T15:20:12.046782Z","steps":["trace[373257269] 'agreement among raft nodes before linearized reading' (duration: 142.884644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:12.046884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.61735ms","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-07-02T15:20:12.046926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.883254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-02T15:20:12.046939Z","caller":"traceutil/trace.go:171","msg":"trace[2083065273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:703; }","duration":"142.685971ms","start":"2026-07-02T15:20:11.904237Z","end":"2026-07-02T15:20:12.046923Z","steps":["trace[2083065273] 'agreement among raft nodes before linearized reading' (duration: 142.543148ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:12.046967Z","caller":"traceutil/trace.go:171","msg":"trace[21338145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:703; }","duration":"142.979576ms","start":"2026-07-02T15:20:11.903976Z","end":"2026-07-02T15:20:12.046955Z","steps":["trace[21338145] 'agreement among raft nodes before linearized reading' (duration: 142.847454ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:13.657842Z","caller":"traceutil/trace.go:171","msg":"trace[1505207734] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"193.105617ms","start":"2026-07-02T15:20:13.464718Z","end":"2026-07-02T15:20:13.657824Z","steps":["trace[1505207734] 'process raft request' (duration: 192.962534ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:13.706788Z","caller":"traceutil/trace.go:171","msg":"trace[1480124353] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"230.598541ms","start":"2026-07-02T15:20:13.476141Z","end":"2026-07-02T15:20:13.70674Z","steps":["trace[1480124353] 'process raft request' (duration: 230.350567ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:14.678874Z","caller":"traceutil/trace.go:171","msg":"trace[2070522716] linearizableReadLoop","detail":"{readStateIndex:766; appliedIndex:765; }","duration":"204.405224ms","start":"2026-07-02T15:20:14.474434Z","end":"2026-07-02T15:20:14.678839Z","steps":["trace[2070522716] 'read index received' (duration: 203.993576ms)","trace[2070522716] 'applied index is now lower than readState.Index' (duration: 410.538µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:14.678933Z","caller":"traceutil/trace.go:171","msg":"trace[1758244525] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"219.287938ms","start":"2026-07-02T15:20:14.459616Z","end":"2026-07-02T15:20:14.678904Z","steps":["trace[1758244525] 'process raft request' (duration: 218.953032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:14.679386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.931343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j4fg7\" ","response":"range_response_count:1 size:18067"} {"level":"info","ts":"2026-07-02T15:20:14.679443Z","caller":"traceutil/trace.go:171","msg":"trace[1267348563] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j4fg7; range_end:; response_count:1; response_revision:736; }","duration":"205.022095ms","start":"2026-07-02T15:20:14.474408Z","end":"2026-07-02T15:20:14.67943Z","steps":["trace[1267348563] 'agreement among raft nodes before linearized reading' (duration: 204.537737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:14.898522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.500114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-02T15:20:14.898619Z","caller":"traceutil/trace.go:171","msg":"trace[974515637] linearizableReadLoop","detail":"{readStateIndex:767; appliedIndex:766; }","duration":"219.664504ms","start":"2026-07-02T15:20:14.678939Z","end":"2026-07-02T15:20:14.898603Z","steps":["trace[974515637] 'read index received' (duration: 69.019287ms)","trace[974515637] 'applied index is now lower than readState.Index' (duration: 150.644217ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:14.898677Z","caller":"traceutil/trace.go:171","msg":"trace[158782105] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"423.804894ms","start":"2026-07-02T15:20:14.474863Z","end":"2026-07-02T15:20:14.898668Z","steps":["trace[158782105] 'process raft request' (duration: 273.084496ms)","trace[158782105] 'compare' (duration: 150.371892ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:14.898728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:14.474851Z","time spent":"423.855755ms","remote":"127.0.0.1:44342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T15:20:14.899519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.935505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-07-02T15:20:14.899655Z","caller":"traceutil/trace.go:171","msg":"trace[1878276201] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:737; }","duration":"272.068738ms","start":"2026-07-02T15:20:14.62752Z","end":"2026-07-02T15:20:14.899589Z","steps":["trace[1878276201] 'agreement among raft nodes before linearized reading' (duration: 271.499198ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:15.112798Z","caller":"traceutil/trace.go:171","msg":"trace[1838973606] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"416.578921ms","start":"2026-07-02T15:20:14.696192Z","end":"2026-07-02T15:20:15.112771Z","steps":["trace[1838973606] 'process raft request' (duration: 384.64156ms)","trace[1838973606] 'compare' (duration: 31.801309ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:15.112967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:14.69616Z","time spent":"416.713823ms","remote":"127.0.0.1:57408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18322,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T15:20:15.128458Z","caller":"traceutil/trace.go:171","msg":"trace[1938896922] linearizableReadLoop","detail":"{readStateIndex:770; appliedIndex:767; }","duration":"229.796935ms","start":"2026-07-02T15:20:14.898645Z","end":"2026-07-02T15:20:15.128442Z","steps":["trace[1938896922] 'read index received' (duration: 182.26058ms)","trace[1938896922] 'applied index is now lower than readState.Index' (duration: 47.535605ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:15.128513Z","caller":"traceutil/trace.go:171","msg":"trace[1864017276] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"363.159597ms","start":"2026-07-02T15:20:14.765308Z","end":"2026-07-02T15:20:15.128467Z","steps":["trace[1864017276] 'process raft request' (duration: 362.78042ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:15.128544Z","caller":"traceutil/trace.go:171","msg":"trace[751974874] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"273.385453ms","start":"2026-07-02T15:20:14.855133Z","end":"2026-07-02T15:20:15.128519Z","steps":["trace[751974874] 'process raft request' (duration: 273.233301ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:15.128644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.751612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T15:20:15.12868Z","caller":"traceutil/trace.go:171","msg":"trace[324346182] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:740; }","duration":"361.803413ms","start":"2026-07-02T15:20:14.766868Z","end":"2026-07-02T15:20:15.128672Z","steps":["trace[324346182] 'agreement among raft nodes before linearized reading' (duration: 361.696011ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:15.128712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:14.76684Z","time spent":"361.862114ms","remote":"127.0.0.1:57406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-07-02T15:20:15.128744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:14.76528Z","time spent":"363.324891ms","remote":"127.0.0.1:44308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:15.128743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.800134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T15:20:15.128905Z","caller":"traceutil/trace.go:171","msg":"trace[473405485] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:740; }","duration":"145.991897ms","start":"2026-07-02T15:20:14.982885Z","end":"2026-07-02T15:20:15.128876Z","steps":["trace[473405485] 'agreement among raft nodes before linearized reading' (duration: 145.810864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:15.129051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.275899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-07-02T15:20:15.129152Z","caller":"traceutil/trace.go:171","msg":"trace[921339592] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:740; }","duration":"101.366351ms","start":"2026-07-02T15:20:15.027732Z","end":"2026-07-02T15:20:15.129099Z","steps":["trace[921339592] 'agreement among raft nodes before linearized reading' (duration: 101.195208ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:15.47011Z","caller":"traceutil/trace.go:171","msg":"trace[1328556092] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"124.02025ms","start":"2026-07-02T15:20:15.346066Z","end":"2026-07-02T15:20:15.470086Z","steps":["trace[1328556092] 'process raft request' (duration: 123.724265ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:15.629847Z","caller":"traceutil/trace.go:171","msg":"trace[462546730] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"104.342105ms","start":"2026-07-02T15:20:15.525481Z","end":"2026-07-02T15:20:15.629823Z","steps":["trace[462546730] 'read index received' (duration: 98.808157ms)","trace[462546730] 'applied index is now lower than readState.Index' (duration: 5.533188ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:15.629999Z","caller":"traceutil/trace.go:171","msg":"trace[1584343753] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"128.393407ms","start":"2026-07-02T15:20:15.501509Z","end":"2026-07-02T15:20:15.629903Z","steps":["trace[1584343753] 'process raft request' (duration: 122.765948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:15.630684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.19144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.181\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-02T15:20:15.630759Z","caller":"traceutil/trace.go:171","msg":"trace[1881612224] range","detail":"{range_begin:/registry/masterleases/199.19.213.181; range_end:; response_count:1; response_revision:748; }","duration":"105.315212ms","start":"2026-07-02T15:20:15.525425Z","end":"2026-07-02T15:20:15.63074Z","steps":["trace[1881612224] 'agreement among raft nodes before linearized reading' (duration: 104.542308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:16.187844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.686947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-07-02T15:20:16.187926Z","caller":"traceutil/trace.go:171","msg":"trace[1898757444] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:751; }","duration":"159.81566ms","start":"2026-07-02T15:20:16.028091Z","end":"2026-07-02T15:20:16.187907Z","steps":["trace[1898757444] 'range keys from in-memory index tree' (duration: 159.471282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:16.188158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.32758ms","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-07-02T15:20:16.188233Z","caller":"traceutil/trace.go:171","msg":"trace[706506520] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:751; }","duration":"115.450253ms","start":"2026-07-02T15:20:16.072765Z","end":"2026-07-02T15:20:16.188215Z","steps":["trace[706506520] 'range keys from in-memory index tree' (duration: 115.041536ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:16.336637Z","caller":"traceutil/trace.go:171","msg":"trace[1001916439] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"144.490651ms","start":"2026-07-02T15:20:16.192116Z","end":"2026-07-02T15:20:16.336606Z","steps":["trace[1001916439] 'process raft request' (duration: 111.215608ms)","trace[1001916439] 'compare' (duration: 33.07532ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:16.33705Z","caller":"traceutil/trace.go:171","msg":"trace[751968526] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"144.732025ms","start":"2026-07-02T15:20:16.192303Z","end":"2026-07-02T15:20:16.337035Z","steps":["trace[751968526] 'process raft request' (duration: 144.252117ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:16.337154Z","caller":"traceutil/trace.go:171","msg":"trace[1641742755] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"143.784129ms","start":"2026-07-02T15:20:16.193299Z","end":"2026-07-02T15:20:16.337084Z","steps":["trace[1641742755] 'process raft request' (duration: 143.559605ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:16.875542Z","caller":"traceutil/trace.go:171","msg":"trace[1750369942] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"115.248679ms","start":"2026-07-02T15:20:16.760277Z","end":"2026-07-02T15:20:16.875526Z","steps":["trace[1750369942] 'process raft request' (duration: 115.131917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:16.933855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.447356ms","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-07-02T15:20:16.933947Z","caller":"traceutil/trace.go:171","msg":"trace[282842942] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:758; }","duration":"149.670691ms","start":"2026-07-02T15:20:16.784258Z","end":"2026-07-02T15:20:16.933929Z","steps":["trace[282842942] 'agreement among raft nodes before linearized reading' (duration: 149.464898ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:16.93427Z","caller":"traceutil/trace.go:171","msg":"trace[1819533431] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"137.365185ms","start":"2026-07-02T15:20:16.796883Z","end":"2026-07-02T15:20:16.934248Z","steps":["trace[1819533431] 'process raft request' (duration: 136.682113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:16.93432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.593629ms","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-07-02T15:20:16.934367Z","caller":"traceutil/trace.go:171","msg":"trace[126146605] transaction","detail":"{read_only:false; number_of_response:1; response_revision:758; }","duration":"134.961724ms","start":"2026-07-02T15:20:16.799378Z","end":"2026-07-02T15:20:16.93434Z","steps":["trace[126146605] 'process raft request' (duration: 134.295792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:16.934384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.02057ms","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-07-02T15:20:16.934363Z","caller":"traceutil/trace.go:171","msg":"trace[1932939467] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:758; }","duration":"149.675171ms","start":"2026-07-02T15:20:16.784678Z","end":"2026-07-02T15:20:16.934353Z","steps":["trace[1932939467] 'agreement among raft nodes before linearized reading' (duration: 149.60864ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:16.934537Z","caller":"traceutil/trace.go:171","msg":"trace[1422038660] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:758; }","duration":"121.190653ms","start":"2026-07-02T15:20:16.813292Z","end":"2026-07-02T15:20:16.934483Z","steps":["trace[1422038660] 'agreement among raft nodes before linearized reading' (duration: 121.00199ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:16.934857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.09334ms","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-07-02T15:20:16.934918Z","caller":"traceutil/trace.go:171","msg":"trace[1413327533] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:758; }","duration":"121.183251ms","start":"2026-07-02T15:20:16.813719Z","end":"2026-07-02T15:20:16.934902Z","steps":["trace[1413327533] 'agreement among raft nodes before linearized reading' (duration: 120.428129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:16.934298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.022741ms","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":"info","ts":"2026-07-02T15:20:16.935362Z","caller":"traceutil/trace.go:171","msg":"trace[624053670] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:758; }","duration":"122.132379ms","start":"2026-07-02T15:20:16.813209Z","end":"2026-07-02T15:20:16.935342Z","steps":["trace[624053670] 'agreement among raft nodes before linearized reading' (duration: 120.99313ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:17.191734Z","caller":"traceutil/trace.go:171","msg":"trace[177533776] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:790; }","duration":"219.086217ms","start":"2026-07-02T15:20:16.972623Z","end":"2026-07-02T15:20:17.191709Z","steps":["trace[177533776] 'read index received' (duration: 218.924224ms)","trace[177533776] 'applied index is now lower than readState.Index' (duration: 160.792µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:17.191845Z","caller":"traceutil/trace.go:171","msg":"trace[121387651] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"252.167087ms","start":"2026-07-02T15:20:16.939649Z","end":"2026-07-02T15:20:17.191816Z","steps":["trace[121387651] 'process raft request' (duration: 251.877931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:17.191909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.204629ms","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":"warn","ts":"2026-07-02T15:20:17.191918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.2471ms","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-07-02T15:20:17.192014Z","caller":"traceutil/trace.go:171","msg":"trace[250783968] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:759; }","duration":"219.394702ms","start":"2026-07-02T15:20:16.972597Z","end":"2026-07-02T15:20:17.191991Z","steps":["trace[250783968] 'agreement among raft nodes before linearized reading' (duration: 219.220629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:17.192052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.970875ms","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-07-02T15:20:17.192089Z","caller":"traceutil/trace.go:171","msg":"trace[596505935] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:759; }","duration":"219.039557ms","start":"2026-07-02T15:20:16.973039Z","end":"2026-07-02T15:20:17.192078Z","steps":["trace[596505935] 'agreement among raft nodes before linearized reading' (duration: 218.957015ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:17.191953Z","caller":"traceutil/trace.go:171","msg":"trace[1895649320] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:759; }","duration":"219.30492ms","start":"2026-07-02T15:20:16.972638Z","end":"2026-07-02T15:20:17.191943Z","steps":["trace[1895649320] 'agreement among raft nodes before linearized reading' (duration: 219.209749ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:17.414871Z","caller":"traceutil/trace.go:171","msg":"trace[109067800] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"212.741904ms","start":"2026-07-02T15:20:17.202101Z","end":"2026-07-02T15:20:17.414843Z","steps":["trace[109067800] 'process raft request' (duration: 153.231725ms)","trace[109067800] 'compare' (duration: 59.367187ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:23.808384Z","caller":"traceutil/trace.go:171","msg":"trace[1114736051] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"273.283889ms","start":"2026-07-02T15:20:23.535076Z","end":"2026-07-02T15:20:23.80836Z","steps":["trace[1114736051] 'process raft request' (duration: 273.143517ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:26.735327Z","caller":"traceutil/trace.go:171","msg":"trace[1490371418] linearizableReadLoop","detail":"{readStateIndex:861; appliedIndex:860; }","duration":"355.4395ms","start":"2026-07-02T15:20:26.379863Z","end":"2026-07-02T15:20:26.735303Z","steps":["trace[1490371418] 'read index received' (duration: 355.213176ms)","trace[1490371418] 'applied index is now lower than readState.Index' (duration: 225.394µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:26.73547Z","caller":"traceutil/trace.go:171","msg":"trace[1448565144] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"409.303544ms","start":"2026-07-02T15:20:26.326151Z","end":"2026-07-02T15:20:26.735454Z","steps":["trace[1448565144] 'process raft request' (duration: 408.996459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:26.735603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:26.326139Z","time spent":"409.360785ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:26.735695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.494253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-02T15:20:26.73576Z","caller":"traceutil/trace.go:171","msg":"trace[2014726117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:826; }","duration":"354.600176ms","start":"2026-07-02T15:20:26.381143Z","end":"2026-07-02T15:20:26.735743Z","steps":["trace[2014726117] 'agreement among raft nodes before linearized reading' (duration: 354.423423ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:26.735799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:26.381106Z","time spent":"354.684436ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-02T15:20:26.735957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.0885ms","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-07-02T15:20:26.735984Z","caller":"traceutil/trace.go:171","msg":"trace[371718581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:826; }","duration":"356.161961ms","start":"2026-07-02T15:20:26.379813Z","end":"2026-07-02T15:20:26.735975Z","steps":["trace[371718581] 'agreement among raft nodes before linearized reading' (duration: 356.07398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:26.736008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:26.379791Z","time spent":"356.211482ms","remote":"127.0.0.1:57478","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-07-02T15:20:26.736193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.460512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2pf6d\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-02T15:20:26.736239Z","caller":"traceutil/trace.go:171","msg":"trace[1517746957] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2pf6d; range_end:; response_count:1; response_revision:826; }","duration":"206.542334ms","start":"2026-07-02T15:20:26.529684Z","end":"2026-07-02T15:20:26.736226Z","steps":["trace[1517746957] 'agreement among raft nodes before linearized reading' (duration: 206.403191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:26.736296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.069399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T15:20:26.736337Z","caller":"traceutil/trace.go:171","msg":"trace[1467265741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:826; }","duration":"353.12983ms","start":"2026-07-02T15:20:26.383195Z","end":"2026-07-02T15:20:26.736325Z","steps":["trace[1467265741] 'agreement among raft nodes before linearized reading' (duration: 352.979028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:26.736365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:26.383186Z","time spent":"353.172951ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T15:20:26.737229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.266703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:20:26.737347Z","caller":"traceutil/trace.go:171","msg":"trace[415025709] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:826; }","duration":"185.443995ms","start":"2026-07-02T15:20:26.551865Z","end":"2026-07-02T15:20:26.737309Z","steps":["trace[415025709] 'agreement among raft nodes before linearized reading' (duration: 184.521989ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:26.896999Z","caller":"traceutil/trace.go:171","msg":"trace[1937905368] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"155.035511ms","start":"2026-07-02T15:20:26.741924Z","end":"2026-07-02T15:20:26.896959Z","steps":["trace[1937905368] 'process raft request' (duration: 152.593119ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:26.905493Z","caller":"traceutil/trace.go:171","msg":"trace[2081255194] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"161.287996ms","start":"2026-07-02T15:20:26.744189Z","end":"2026-07-02T15:20:26.905477Z","steps":["trace[2081255194] 'process raft request' (duration: 161.145414ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:26.905765Z","caller":"traceutil/trace.go:171","msg":"trace[245430721] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"161.488129ms","start":"2026-07-02T15:20:26.744254Z","end":"2026-07-02T15:20:26.905742Z","steps":["trace[245430721] 'process raft request' (duration: 161.188325ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:26.905961Z","caller":"traceutil/trace.go:171","msg":"trace[1824487539] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"160.003806ms","start":"2026-07-02T15:20:26.745933Z","end":"2026-07-02T15:20:26.905937Z","steps":["trace[1824487539] 'process raft request' (duration: 159.830482ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:28.143165Z","caller":"traceutil/trace.go:171","msg":"trace[694072871] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"316.74045ms","start":"2026-07-02T15:20:27.8264Z","end":"2026-07-02T15:20:28.14314Z","steps":["trace[694072871] 'process raft request' (duration: 316.562808ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:28.143325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:27.826382Z","time spent":"316.861872ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T15:20:31.177568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.399752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-07-02T15:20:31.177936Z","caller":"traceutil/trace.go:171","msg":"trace[812011930] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:873; }","duration":"111.80935ms","start":"2026-07-02T15:20:31.06611Z","end":"2026-07-02T15:20:31.177919Z","steps":["trace[812011930] 'range keys from in-memory index tree' (duration: 111.25749ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:32.670967Z","caller":"traceutil/trace.go:171","msg":"trace[1718683234] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"104.886319ms","start":"2026-07-02T15:20:32.566057Z","end":"2026-07-02T15:20:32.670944Z","steps":["trace[1718683234] 'process raft request' (duration: 104.741217ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:34.078881Z","caller":"traceutil/trace.go:171","msg":"trace[2076006436] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"175.77706ms","start":"2026-07-02T15:20:33.903075Z","end":"2026-07-02T15:20:34.078852Z","steps":["trace[2076006436] 'process raft request' (duration: 175.610278ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:34.128849Z","caller":"traceutil/trace.go:171","msg":"trace[1896683675] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"138.005598ms","start":"2026-07-02T15:20:33.990827Z","end":"2026-07-02T15:20:34.128833Z","steps":["trace[1896683675] 'process raft request' (duration: 137.866106ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:34.289562Z","caller":"traceutil/trace.go:171","msg":"trace[246955456] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"203.777328ms","start":"2026-07-02T15:20:34.085756Z","end":"2026-07-02T15:20:34.289533Z","steps":["trace[246955456] 'process raft request' (duration: 203.660076ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:34.289583Z","caller":"traceutil/trace.go:171","msg":"trace[1001414498] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"205.13691ms","start":"2026-07-02T15:20:34.084411Z","end":"2026-07-02T15:20:34.289548Z","steps":["trace[1001414498] 'process raft request' (duration: 164.286993ms)","trace[1001414498] 'compare' (duration: 40.543473ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:34.28976Z","caller":"traceutil/trace.go:171","msg":"trace[474819012] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"200.153839ms","start":"2026-07-02T15:20:34.089566Z","end":"2026-07-02T15:20:34.28972Z","steps":["trace[474819012] 'process raft request' (duration: 199.896825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:34.28983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.984878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:20:34.289871Z","caller":"traceutil/trace.go:171","msg":"trace[2079196022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:898; }","duration":"170.078979ms","start":"2026-07-02T15:20:34.119782Z","end":"2026-07-02T15:20:34.289861Z","steps":["trace[2079196022] 'agreement among raft nodes before linearized reading' (duration: 169.967988ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:34.289691Z","caller":"traceutil/trace.go:171","msg":"trace[558621701] linearizableReadLoop","detail":"{readStateIndex:934; appliedIndex:930; }","duration":"169.832696ms","start":"2026-07-02T15:20:34.119813Z","end":"2026-07-02T15:20:34.289645Z","steps":["trace[558621701] 'read index received' (duration: 8.877227ms)","trace[558621701] 'applied index is now lower than readState.Index' (duration: 160.953719ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:34.290308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.188992ms","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-07-02T15:20:34.290333Z","caller":"traceutil/trace.go:171","msg":"trace[349300601] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:898; }","duration":"126.236604ms","start":"2026-07-02T15:20:34.164088Z","end":"2026-07-02T15:20:34.290324Z","steps":["trace[349300601] 'agreement among raft nodes before linearized reading' (duration: 126.154672ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:34.558102Z","caller":"traceutil/trace.go:171","msg":"trace[1329294687] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"255.948784ms","start":"2026-07-02T15:20:34.302117Z","end":"2026-07-02T15:20:34.558066Z","steps":["trace[1329294687] 'process raft request' (duration: 255.871023ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:34.558349Z","caller":"traceutil/trace.go:171","msg":"trace[735393709] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"260.962888ms","start":"2026-07-02T15:20:34.297372Z","end":"2026-07-02T15:20:34.558335Z","steps":["trace[735393709] 'process raft request' (duration: 225.013821ms)","trace[735393709] 'compare' (duration: 35.475009ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:34.728618Z","caller":"traceutil/trace.go:171","msg":"trace[2063544326] linearizableReadLoop","detail":"{readStateIndex:939; appliedIndex:938; }","duration":"132.794882ms","start":"2026-07-02T15:20:34.595798Z","end":"2026-07-02T15:20:34.728593Z","steps":["trace[2063544326] 'read index received' (duration: 131.924667ms)","trace[2063544326] 'applied index is now lower than readState.Index' (duration: 869.375µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:34.728773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.956145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-07-02T15:20:34.728708Z","caller":"traceutil/trace.go:171","msg":"trace[1605175519] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"141.485656ms","start":"2026-07-02T15:20:34.587172Z","end":"2026-07-02T15:20:34.728657Z","steps":["trace[1605175519] 'process raft request' (duration: 140.672352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:34.728864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.733641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-07-02T15:20:34.728895Z","caller":"traceutil/trace.go:171","msg":"trace[229928195] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:903; }","duration":"132.781102ms","start":"2026-07-02T15:20:34.596108Z","end":"2026-07-02T15:20:34.728889Z","steps":["trace[229928195] 'agreement among raft nodes before linearized reading' (duration: 132.728391ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:34.728803Z","caller":"traceutil/trace.go:171","msg":"trace[421888569] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:903; }","duration":"133.021295ms","start":"2026-07-02T15:20:34.595773Z","end":"2026-07-02T15:20:34.728794Z","steps":["trace[421888569] 'agreement among raft nodes before linearized reading' (duration: 132.943114ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:38.559998Z","caller":"traceutil/trace.go:171","msg":"trace[1907210240] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"102.152426ms","start":"2026-07-02T15:20:38.457824Z","end":"2026-07-02T15:20:38.559977Z","steps":["trace[1907210240] 'process raft request' (duration: 101.969673ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:38.560239Z","caller":"traceutil/trace.go:171","msg":"trace[1658664263] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"102.217427ms","start":"2026-07-02T15:20:38.457954Z","end":"2026-07-02T15:20:38.560172Z","steps":["trace[1658664263] 'process raft request' (duration: 101.979913ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:53.303329Z","caller":"traceutil/trace.go:171","msg":"trace[1703375362] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"131.24214ms","start":"2026-07-02T15:20:53.172063Z","end":"2026-07-02T15:20:53.303305Z","steps":["trace[1703375362] 'process raft request' (duration: 123.420976ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:21:07.403722Z","caller":"traceutil/trace.go:171","msg":"trace[1449762119] linearizableReadLoop","detail":"{readStateIndex:1133; appliedIndex:1132; }","duration":"118.805583ms","start":"2026-07-02T15:21:07.284892Z","end":"2026-07-02T15:21:07.403697Z","steps":["trace[1449762119] 'read index received' (duration: 118.039441ms)","trace[1449762119] 'applied index is now lower than readState.Index' (duration: 765.122µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:21:07.403864Z","caller":"traceutil/trace.go:171","msg":"trace[270279507] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"143.651816ms","start":"2026-07-02T15:21:07.260187Z","end":"2026-07-02T15:21:07.403838Z","steps":["trace[270279507] 'process raft request' (duration: 142.796953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:21:07.403977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.070427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-02T15:21:07.40402Z","caller":"traceutil/trace.go:171","msg":"trace[294751673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1090; }","duration":"119.167679ms","start":"2026-07-02T15:21:07.284838Z","end":"2026-07-02T15:21:07.404006Z","steps":["trace[294751673] 'agreement among raft nodes before linearized reading' (duration: 119.001056ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:21:07.657414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.795707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T15:21:07.657511Z","caller":"traceutil/trace.go:171","msg":"trace[128968051] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1092; }","duration":"115.936889ms","start":"2026-07-02T15:21:07.54155Z","end":"2026-07-02T15:21:07.657487Z","steps":["trace[128968051] 'count revisions from in-memory index tree' (duration: 115.713436ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:21:31.768931Z","caller":"traceutil/trace.go:171","msg":"trace[1094929569] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"123.387918ms","start":"2026-07-02T15:21:31.645513Z","end":"2026-07-02T15:21:31.768901Z","steps":["trace[1094929569] 'process raft request' (duration: 94.563798ms)","trace[1094929569] 'compare' (duration: 28.707028ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:21:49.750337Z","caller":"traceutil/trace.go:171","msg":"trace[1616071788] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"115.67262ms","start":"2026-07-02T15:21:49.634636Z","end":"2026-07-02T15:21:49.750309Z","steps":["trace[1616071788] 'process raft request' (duration: 115.558648ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:00.05726Z","caller":"traceutil/trace.go:171","msg":"trace[1680938993] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1314; }","duration":"140.032967ms","start":"2026-07-02T15:21:59.917202Z","end":"2026-07-02T15:22:00.057235Z","steps":["trace[1680938993] 'read index received' (duration: 2.662459ms)","trace[1680938993] 'applied index is now lower than readState.Index' (duration: 137.369638ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:22:00.05733Z","caller":"traceutil/trace.go:171","msg":"trace[1671665692] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"186.286367ms","start":"2026-07-02T15:21:59.871001Z","end":"2026-07-02T15:22:00.057287Z","steps":["trace[1671665692] 'process raft request' (duration: 186.055674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:00.057379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.154239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:22:00.05742Z","caller":"traceutil/trace.go:171","msg":"trace[2042768648] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1263; }","duration":"140.252381ms","start":"2026-07-02T15:21:59.917151Z","end":"2026-07-02T15:22:00.057404Z","steps":["trace[2042768648] 'agreement among raft nodes before linearized reading' (duration: 140.17508ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:09.741636Z","caller":"traceutil/trace.go:171","msg":"trace[1195909870] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"100.972051ms","start":"2026-07-02T15:22:09.640637Z","end":"2026-07-02T15:22:09.741609Z","steps":["trace[1195909870] 'process raft request' (duration: 100.816629ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:15.181907Z","caller":"traceutil/trace.go:171","msg":"trace[1158564800] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"152.902739ms","start":"2026-07-02T15:22:15.028974Z","end":"2026-07-02T15:22:15.181877Z","steps":["trace[1158564800] 'process raft request' (duration: 152.758997ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:20.165515Z","caller":"traceutil/trace.go:171","msg":"trace[1295787633] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"149.807448ms","start":"2026-07-02T15:22:20.015677Z","end":"2026-07-02T15:22:20.165485Z","steps":["trace[1295787633] 'process raft request' (duration: 129.978365ms)","trace[1295787633] 'compare' (duration: 19.421738ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:22:21.035928Z","caller":"traceutil/trace.go:171","msg":"trace[598811104] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"279.801754ms","start":"2026-07-02T15:22:20.756104Z","end":"2026-07-02T15:22:21.035906Z","steps":["trace[598811104] 'process raft request' (duration: 279.6213ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:22.204902Z","caller":"traceutil/trace.go:171","msg":"trace[2074365358] linearizableReadLoop","detail":"{readStateIndex:1434; appliedIndex:1433; }","duration":"103.622718ms","start":"2026-07-02T15:22:22.101255Z","end":"2026-07-02T15:22:22.204878Z","steps":["trace[2074365358] 'read index received' (duration: 103.392715ms)","trace[2074365358] 'applied index is now lower than readState.Index' (duration: 229.143µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:22:22.205043Z","caller":"traceutil/trace.go:171","msg":"trace[1967979467] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"157.971253ms","start":"2026-07-02T15:22:22.047047Z","end":"2026-07-02T15:22:22.205018Z","steps":["trace[1967979467] 'process raft request' (duration: 157.677558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:22.205253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.976934ms","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-07-02T15:22:22.205424Z","caller":"traceutil/trace.go:171","msg":"trace[1638772481] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1375; }","duration":"104.163536ms","start":"2026-07-02T15:22:22.101212Z","end":"2026-07-02T15:22:22.205376Z","steps":["trace[1638772481] 'agreement among raft nodes before linearized reading' (duration: 103.814391ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:23.1072Z","caller":"traceutil/trace.go:171","msg":"trace[1805819055] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"212.944155ms","start":"2026-07-02T15:22:22.894234Z","end":"2026-07-02T15:22:23.107178Z","steps":["trace[1805819055] 'process raft request' (duration: 212.818353ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:23.224432Z","caller":"traceutil/trace.go:171","msg":"trace[1817779695] linearizableReadLoop","detail":"{readStateIndex:1439; appliedIndex:1438; }","duration":"105.532754ms","start":"2026-07-02T15:22:23.118877Z","end":"2026-07-02T15:22:23.22441Z","steps":["trace[1817779695] 'read index received' (duration: 16.376344ms)","trace[1817779695] 'applied index is now lower than readState.Index' (duration: 89.15523ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:22:23.224561Z","caller":"traceutil/trace.go:171","msg":"trace[1263952720] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"183.260541ms","start":"2026-07-02T15:22:23.041288Z","end":"2026-07-02T15:22:23.224548Z","steps":["trace[1263952720] 'process raft request' (duration: 94.0563ms)","trace[1263952720] 'compare' (duration: 88.962978ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:22:23.22471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.824018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:22:23.224749Z","caller":"traceutil/trace.go:171","msg":"trace[1806716268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1380; }","duration":"105.91177ms","start":"2026-07-02T15:22:23.118828Z","end":"2026-07-02T15:22:23.224739Z","steps":["trace[1806716268] 'agreement among raft nodes before linearized reading' (duration: 105.838749ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:36.720675Z","caller":"traceutil/trace.go:171","msg":"trace[593453152] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"380.080229ms","start":"2026-07-02T15:22:36.340569Z","end":"2026-07-02T15:22:36.720649Z","steps":["trace[593453152] 'process raft request' (duration: 300.950589ms)","trace[593453152] 'compare' (duration: 78.530661ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:22:36.720817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:22:36.340558Z","time spent":"380.190511ms","remote":"127.0.0.1:57478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T15:22:36.720835Z","caller":"traceutil/trace.go:171","msg":"trace[1813745673] linearizableReadLoop","detail":"{readStateIndex:1488; appliedIndex:1486; }","duration":"377.885268ms","start":"2026-07-02T15:22:36.34289Z","end":"2026-07-02T15:22:36.720776Z","steps":["trace[1813745673] 'read index received' (duration: 298.644486ms)","trace[1813745673] 'applied index is now lower than readState.Index' (duration: 79.239772ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:22:36.721086Z","caller":"traceutil/trace.go:171","msg":"trace[413803757] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"378.947052ms","start":"2026-07-02T15:22:36.342125Z","end":"2026-07-02T15:22:36.721072Z","steps":["trace[413803757] 'process raft request' (duration: 378.483396ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:36.721221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:22:36.342106Z","time spent":"379.007463ms","remote":"127.0.0.1:57478","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-07-02T15:22:36.721342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.714346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:root-ca-cert-publisher\" ","response":"range_response_count:1 size:763"} {"level":"warn","ts":"2026-07-02T15:22:36.72135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.438645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:resourcequota-controller\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-07-02T15:22:36.721404Z","caller":"traceutil/trace.go:171","msg":"trace[1255627153] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:root-ca-cert-publisher; range_end:; response_count:1; response_revision:1426; }","duration":"365.804276ms","start":"2026-07-02T15:22:36.355583Z","end":"2026-07-02T15:22:36.721387Z","steps":["trace[1255627153] 'agreement among raft nodes before linearized reading' (duration: 365.688595ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:36.721435Z","caller":"traceutil/trace.go:171","msg":"trace[896503761] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:resourcequota-controller; range_end:; response_count:1; response_revision:1426; }","duration":"378.547647ms","start":"2026-07-02T15:22:36.342862Z","end":"2026-07-02T15:22:36.72141Z","steps":["trace[896503761] 'agreement among raft nodes before linearized reading' (duration: 378.395885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:36.721449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:22:36.355567Z","time spent":"365.874267ms","remote":"127.0.0.1:57578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":786,"request content":"key:\"/registry/clusterrolebindings/system:controller:root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-07-02T15:22:36.721493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:22:36.342854Z","time spent":"378.629949ms","remote":"127.0.0.1:57578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":794,"request content":"key:\"/registry/clusterrolebindings/system:controller:resourcequota-controller\" "} {"level":"warn","ts":"2026-07-02T15:22:36.721377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.664734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:22:36.721705Z","caller":"traceutil/trace.go:171","msg":"trace[725739761] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1426; }","duration":"243.022979ms","start":"2026-07-02T15:22:36.478649Z","end":"2026-07-02T15:22:36.721672Z","steps":["trace[725739761] 'agreement among raft nodes before linearized reading' (duration: 242.620043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:36.721479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.42935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T15:22:36.721834Z","caller":"traceutil/trace.go:171","msg":"trace[594464934] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1426; }","duration":"348.814786ms","start":"2026-07-02T15:22:36.373004Z","end":"2026-07-02T15:22:36.721818Z","steps":["trace[594464934] 'agreement among raft nodes before linearized reading' (duration: 348.269728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:36.721881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:22:36.372994Z","time spent":"348.873267ms","remote":"127.0.0.1:57544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":16,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-07-02T15:22:38.302507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.335833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:volume-scheduler\" ","response":"range_response_count:1 size:715"} {"level":"info","ts":"2026-07-02T15:22:38.302592Z","caller":"traceutil/trace.go:171","msg":"trace[1204119230] range","detail":"{range_begin:/registry/clusterrolebindings/system:volume-scheduler; range_end:; response_count:1; response_revision:1429; }","duration":"101.468615ms","start":"2026-07-02T15:22:38.201107Z","end":"2026-07-02T15:22:38.302576Z","steps":["trace[1204119230] 'range keys from in-memory index tree' (duration: 101.271213ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:40.501606Z","caller":"traceutil/trace.go:171","msg":"trace[2037071844] linearizableReadLoop","detail":"{readStateIndex:1498; appliedIndex:1497; }","duration":"105.409279ms","start":"2026-07-02T15:22:40.396175Z","end":"2026-07-02T15:22:40.501584Z","steps":["trace[2037071844] 'read index received' (duration: 105.264247ms)","trace[2037071844] 'applied index is now lower than readState.Index' (duration: 143.852µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:22:40.501731Z","caller":"traceutil/trace.go:171","msg":"trace[993003077] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"150.816569ms","start":"2026-07-02T15:22:40.350903Z","end":"2026-07-02T15:22:40.50172Z","steps":["trace[993003077] 'process raft request' (duration: 150.508605ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:40.501887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.324719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/default/\" range_end:\"/registry/jobs/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:22:40.501941Z","caller":"traceutil/trace.go:171","msg":"trace[86153378] range","detail":"{range_begin:/registry/jobs/default/; range_end:/registry/jobs/default0; response_count:0; response_revision:1436; }","duration":"103.427941ms","start":"2026-07-02T15:22:40.3985Z","end":"2026-07-02T15:22:40.501928Z","steps":["trace[86153378] 'agreement among raft nodes before linearized reading' (duration: 103.33038ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:40.502227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.044748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-07-02T15:22:40.502278Z","caller":"traceutil/trace.go:171","msg":"trace[863322835] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1436; }","duration":"106.128339ms","start":"2026-07-02T15:22:40.396137Z","end":"2026-07-02T15:22:40.502265Z","steps":["trace[863322835] 'agreement among raft nodes before linearized reading' (duration: 106.051298ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:42.62519Z","caller":"traceutil/trace.go:171","msg":"trace[614351809] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"118.044286ms","start":"2026-07-02T15:22:42.507127Z","end":"2026-07-02T15:22:42.625171Z","steps":["trace[614351809] 'process raft request' (duration: 117.62521ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:54.852195Z","caller":"traceutil/trace.go:171","msg":"trace[34826787] linearizableReadLoop","detail":"{readStateIndex:1547; appliedIndex:1546; }","duration":"140.359932ms","start":"2026-07-02T15:22:54.711802Z","end":"2026-07-02T15:22:54.852162Z","steps":["trace[34826787] 'read index received' (duration: 140.121099ms)","trace[34826787] 'applied index is now lower than readState.Index' (duration: 236.883µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:22:54.852235Z","caller":"traceutil/trace.go:171","msg":"trace[1977177633] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"180.908831ms","start":"2026-07-02T15:22:54.671274Z","end":"2026-07-02T15:22:54.852183Z","steps":["trace[1977177633] 'process raft request' (duration: 180.737579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:54.852445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.615345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j4fg7\" ","response":"range_response_count:1 size:18525"} {"level":"warn","ts":"2026-07-02T15:22:54.852445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.604043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T15:22:54.85252Z","caller":"traceutil/trace.go:171","msg":"trace[1057769463] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1482; }","duration":"122.708785ms","start":"2026-07-02T15:22:54.729792Z","end":"2026-07-02T15:22:54.8525Z","steps":["trace[1057769463] 'agreement among raft nodes before linearized reading' (duration: 122.586613ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:54.852774Z","caller":"traceutil/trace.go:171","msg":"trace[1779985169] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j4fg7; range_end:; response_count:1; response_revision:1482; }","duration":"140.696906ms","start":"2026-07-02T15:22:54.711779Z","end":"2026-07-02T15:22:54.852476Z","steps":["trace[1779985169] 'agreement among raft nodes before linearized reading' (duration: 140.535124ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:57.14054Z","caller":"traceutil/trace.go:171","msg":"trace[89505439] linearizableReadLoop","detail":"{readStateIndex:1557; appliedIndex:1556; }","duration":"135.272608ms","start":"2026-07-02T15:22:57.005251Z","end":"2026-07-02T15:22:57.140524Z","steps":["trace[89505439] 'read index received' (duration: 135.058305ms)","trace[89505439] 'applied index is now lower than readState.Index' (duration: 213.193µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:22:57.140724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.45096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-02T15:22:57.140755Z","caller":"traceutil/trace.go:171","msg":"trace[2020580811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1491; }","duration":"135.546252ms","start":"2026-07-02T15:22:57.005201Z","end":"2026-07-02T15:22:57.140747Z","steps":["trace[2020580811] 'agreement among raft nodes before linearized reading' (duration: 135.41597ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:57.140617Z","caller":"traceutil/trace.go:171","msg":"trace[2058218225] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"142.319077ms","start":"2026-07-02T15:22:56.99827Z","end":"2026-07-02T15:22:57.140589Z","steps":["trace[2058218225] 'process raft request' (duration: 142.128014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:57.141024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.195751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-slsgb\" ","response":"range_response_count:1 size:4908"} {"level":"info","ts":"2026-07-02T15:22:57.141235Z","caller":"traceutil/trace.go:171","msg":"trace[1451302315] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-slsgb; range_end:; response_count:1; response_revision:1491; }","duration":"116.464835ms","start":"2026-07-02T15:22:57.02475Z","end":"2026-07-02T15:22:57.141215Z","steps":["trace[1451302315] 'agreement among raft nodes before linearized reading' (duration: 115.977717ms)"],"step_count":1}