{"level":"warn","ts":"2026-06-24T22:19:24.135099Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T22:19:24.135235Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-24T22:19:24.135326Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T22:19:24.135366Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-06-24T22:19:24.135403Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-24T22:19:24.136222Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-06-24T22:19:24.13635Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-24T22:19:24.158634Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"22.009372ms"} {"level":"info","ts":"2026-06-24T22:19:24.254934Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-06-24T22:19:24.25507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T22:19:24.255106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-06-24T22:19:24.255122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T22:19:24.25514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-06-24T22:19:24.255241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-06-24T22:19:24.298739Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T22:19:24.329482Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T22:19:24.347085Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-24T22:19:24.351122Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T22:19:24.351328Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T22:19:24.351517Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T22:19:24.351603Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T22:19:24.351613Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T22:19:24.35327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-06-24T22:19:24.353704Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-06-24T22:19:24.355401Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-24T22:19:24.355489Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-06-24T22:19:24.355522Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-06-24T22:19:24.356309Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T22:19:24.356348Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T22:19:24.456091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T22:19:24.456174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T22:19:24.456215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-06-24T22:19:24.456238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-06-24T22:19:24.45625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-06-24T22:19:24.456274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-06-24T22:19:24.456288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-06-24T22:19:24.457666Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T22:19:24.457715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T22:19:24.457872Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T22:19:24.458191Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T22:19:24.458356Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T22:19:24.458549Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T22:19:24.460234Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T22:19:24.460498Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T22:19:24.460687Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T22:19:24.461734Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-06-24T22:19:24.462769Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T22:19:25.997336Z","caller":"traceutil/trace.go:171","msg":"trace[2085575061] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"101.574446ms","start":"2026-06-24T22:19:25.895739Z","end":"2026-06-24T22:19:25.997313Z","steps":["trace[2085575061] 'read index received' (duration: 101.499764ms)","trace[2085575061] 'applied index is now lower than readState.Index' (duration: 73.592µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:25.997377Z","caller":"traceutil/trace.go:171","msg":"trace[216097848] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"102.114542ms","start":"2026-06-24T22:19:25.895228Z","end":"2026-06-24T22:19:25.997343Z","steps":["trace[216097848] 'process raft request' (duration: 101.911196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:25.997501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.741011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T22:19:25.99763Z","caller":"traceutil/trace.go:171","msg":"trace[578968752] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"101.896056ms","start":"2026-06-24T22:19:25.895726Z","end":"2026-06-24T22:19:25.997622Z","steps":["trace[578968752] 'agreement among raft nodes before linearized reading' (duration: 101.693409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.497492Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375521660,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T22:19:26.871826Z","caller":"traceutil/trace.go:171","msg":"trace[181029474] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"896.466813ms","start":"2026-06-24T22:19:25.975322Z","end":"2026-06-24T22:19:26.871789Z","steps":["trace[181029474] 'process raft request' (duration: 896.423802ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:26.871891Z","caller":"traceutil/trace.go:171","msg":"trace[2056588365] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"896.768352ms","start":"2026-06-24T22:19:25.975068Z","end":"2026-06-24T22:19:26.871837Z","steps":["trace[2056588365] 'process raft request' (duration: 896.654709ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:26.872008Z","caller":"traceutil/trace.go:171","msg":"trace[513994916] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"897.428411ms","start":"2026-06-24T22:19:25.974569Z","end":"2026-06-24T22:19:26.871998Z","steps":["trace[513994916] 'process raft request' (duration: 897.104452ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:26.872042Z","caller":"traceutil/trace.go:171","msg":"trace[667888167] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"897.137153ms","start":"2026-06-24T22:19:25.974898Z","end":"2026-06-24T22:19:26.872035Z","steps":["trace[667888167] 'process raft request' (duration: 896.799033ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:26.872062Z","caller":"traceutil/trace.go:171","msg":"trace[1688153353] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"974.25617ms","start":"2026-06-24T22:19:25.897762Z","end":"2026-06-24T22:19:26.872018Z","steps":["trace[1688153353] 'process raft request' (duration: 973.657701ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:26.872191Z","caller":"traceutil/trace.go:171","msg":"trace[1181490262] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"897.621417ms","start":"2026-06-24T22:19:25.97456Z","end":"2026-06-24T22:19:26.872181Z","steps":["trace[1181490262] 'process raft request' (duration: 897.05504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.872355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.975306Z","time spent":"896.593346ms","remote":"127.0.0.1:37258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:19:26.872412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.974551Z","time spent":"897.475643ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:19:26.872482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.974523Z","time spent":"897.694009ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:19:26.872592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.97504Z","time spent":"896.940288ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:19:26.872952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.897745Z","time spent":"974.383363ms","remote":"127.0.0.1:36956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:19:26.872959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.974888Z","time spent":"897.169084ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:19:26.87331Z","caller":"traceutil/trace.go:171","msg":"trace[1142310350] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"898.514663ms","start":"2026-06-24T22:19:25.974771Z","end":"2026-06-24T22:19:26.873286Z","steps":["trace[1142310350] 'process raft request' (duration: 896.876545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.873366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.974586Z","time spent":"898.75359ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:19:26.87629Z","caller":"traceutil/trace.go:171","msg":"trace[914072932] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"878.859675ms","start":"2026-06-24T22:19:25.9974Z","end":"2026-06-24T22:19:26.87626Z","steps":["trace[914072932] 'read index received' (duration: 873.992573ms)","trace[914072932] 'applied index is now lower than readState.Index' (duration: 4.866152ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:26.876447Z","caller":"traceutil/trace.go:171","msg":"trace[1424659350] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"877.393251ms","start":"2026-06-24T22:19:25.999041Z","end":"2026-06-24T22:19:26.876434Z","steps":["trace[1424659350] 'process raft request' (duration: 877.091922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.876655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.069504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-24T22:19:26.876805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.999026Z","time spent":"877.491233ms","remote":"127.0.0.1:36812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:19:26.876915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.85704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T22:19:26.876977Z","caller":"traceutil/trace.go:171","msg":"trace[2088175801] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"901.938172ms","start":"2026-06-24T22:19:25.975028Z","end":"2026-06-24T22:19:26.876966Z","steps":["trace[2088175801] 'agreement among raft nodes before linearized reading' (duration: 901.817629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.877042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.975017Z","time spent":"902.016355ms","remote":"127.0.0.1:36884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-24T22:19:26.876815Z","caller":"traceutil/trace.go:171","msg":"trace[1893651453] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:0; response_revision:10; }","duration":"904.2621ms","start":"2026-06-24T22:19:25.972477Z","end":"2026-06-24T22:19:26.876739Z","steps":["trace[1893651453] 'agreement among raft nodes before linearized reading' (duration: 903.991832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.877269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.381055ms","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-06-24T22:19:26.877282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.400462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T22:19:26.877305Z","caller":"traceutil/trace.go:171","msg":"trace[1734747900] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"902.466129ms","start":"2026-06-24T22:19:25.974827Z","end":"2026-06-24T22:19:26.877293Z","steps":["trace[1734747900] 'agreement among raft nodes before linearized reading' (duration: 902.383745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.877341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.974817Z","time spent":"902.51498ms","remote":"127.0.0.1:36840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-06-24T22:19:26.877341Z","caller":"traceutil/trace.go:171","msg":"trace[67937843] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"927.485605ms","start":"2026-06-24T22:19:25.949838Z","end":"2026-06-24T22:19:26.877324Z","steps":["trace[67937843] 'agreement among raft nodes before linearized reading' (duration: 927.396101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.877369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.500891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-06-24T22:19:26.877383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.949821Z","time spent":"927.553456ms","remote":"127.0.0.1:36884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-24T22:19:26.87741Z","caller":"traceutil/trace.go:171","msg":"trace[1833216439] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"981.548004ms","start":"2026-06-24T22:19:25.895848Z","end":"2026-06-24T22:19:26.877396Z","steps":["trace[1833216439] 'agreement among raft nodes before linearized reading' (duration: 981.462111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.877434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.895844Z","time spent":"981.584375ms","remote":"127.0.0.1:36956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3195,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-24T22:19:26.877433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.972386Z","time spent":"905.024174ms","remote":"127.0.0.1:36794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.250\" "} {"level":"warn","ts":"2026-06-24T22:19:26.878774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"982.716877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T22:19:26.878838Z","caller":"traceutil/trace.go:171","msg":"trace[1510125254] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"982.880022ms","start":"2026-06-24T22:19:25.895943Z","end":"2026-06-24T22:19:26.878823Z","steps":["trace[1510125254] 'agreement among raft nodes before linearized reading' (duration: 980.716228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.878873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:25.895939Z","time spent":"982.928053ms","remote":"127.0.0.1:37192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-24T22:19:26.879902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.08164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T22:19:26.879932Z","caller":"traceutil/trace.go:171","msg":"trace[348094441] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"853.113201ms","start":"2026-06-24T22:19:26.026812Z","end":"2026-06-24T22:19:26.879925Z","steps":["trace[348094441] 'agreement among raft nodes before linearized reading' (duration: 853.029038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:26.879973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:26.026793Z","time spent":"853.159402ms","remote":"127.0.0.1:36884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-24T22:19:27.399588Z","caller":"traceutil/trace.go:171","msg":"trace[1258737844] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:73; }","duration":"103.966371ms","start":"2026-06-24T22:19:27.2956Z","end":"2026-06-24T22:19:27.399567Z","steps":["trace[1258737844] 'read index received' (duration: 13.268915ms)","trace[1258737844] 'applied index is now lower than readState.Index' (duration: 90.695696ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:27.39975Z","caller":"traceutil/trace.go:171","msg":"trace[1863328857] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"104.910538ms","start":"2026-06-24T22:19:27.2948Z","end":"2026-06-24T22:19:27.399711Z","steps":["trace[1863328857] 'process raft request' (duration: 75.026962ms)","trace[1863328857] 'compare' (duration: 29.505255ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:27.399796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.172237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T22:19:27.400129Z","caller":"traceutil/trace.go:171","msg":"trace[1386526089] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:72; }","duration":"104.544438ms","start":"2026-06-24T22:19:27.29557Z","end":"2026-06-24T22:19:27.400115Z","steps":["trace[1386526089] 'agreement among raft nodes before linearized reading' (duration: 104.169397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:28.710871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.36177ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-24T22:19:28.711031Z","caller":"traceutil/trace.go:171","msg":"trace[1651867195] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"536.939465ms","start":"2026-06-24T22:19:28.174021Z","end":"2026-06-24T22:19:28.710961Z","steps":["trace[1651867195] 'process raft request' (duration: 57.284717ms)","trace[1651867195] 'compare' (duration: 479.217696ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:28.711165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:28.174012Z","time spent":"537.058958ms","remote":"127.0.0.1:37126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":900,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:19:29.197477Z","caller":"traceutil/trace.go:171","msg":"trace[1552955505] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"113.618543ms","start":"2026-06-24T22:19:29.08382Z","end":"2026-06-24T22:19:29.197438Z","steps":["trace[1552955505] 'process raft request' (duration: 67.771654ms)","trace[1552955505] 'compare' (duration: 45.563321ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:30.929286Z","caller":"traceutil/trace.go:171","msg":"trace[745643645] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"157.904382ms","start":"2026-06-24T22:19:30.771355Z","end":"2026-06-24T22:19:30.929259Z","steps":["trace[745643645] 'process raft request' (duration: 157.781459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:31.238601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.152504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:19:31.238703Z","caller":"traceutil/trace.go:171","msg":"trace[707778215] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"214.873263ms","start":"2026-06-24T22:19:31.023811Z","end":"2026-06-24T22:19:31.238684Z","steps":["trace[707778215] 'process raft request' (duration: 33.567185ms)","trace[707778215] 'compare' (duration: 181.044781ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:31.533112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.151635ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:19:31.533223Z","caller":"traceutil/trace.go:171","msg":"trace[2018031098] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"195.978022ms","start":"2026-06-24T22:19:31.337225Z","end":"2026-06-24T22:19:31.533203Z","steps":["trace[2018031098] 'process raft request' (duration: 57.670441ms)","trace[2018031098] 'compare' (duration: 138.006211ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:31.958358Z","caller":"traceutil/trace.go:171","msg":"trace[1315453400] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"107.869054ms","start":"2026-06-24T22:19:31.850446Z","end":"2026-06-24T22:19:31.958315Z","steps":["trace[1315453400] 'process raft request' (duration: 59.147594ms)","trace[1315453400] 'compare' (duration: 48.515864ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:31.959385Z","caller":"traceutil/trace.go:171","msg":"trace[736520129] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"106.457594ms","start":"2026-06-24T22:19:31.852749Z","end":"2026-06-24T22:19:31.959206Z","steps":["trace[736520129] 'process raft request' (duration: 105.495907ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:34.626414Z","caller":"traceutil/trace.go:171","msg":"trace[1366714019] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:334; }","duration":"138.414401ms","start":"2026-06-24T22:19:34.487974Z","end":"2026-06-24T22:19:34.626388Z","steps":["trace[1366714019] 'read index received' (duration: 90.547713ms)","trace[1366714019] 'applied index is now lower than readState.Index' (duration: 47.865788ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:34.626619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.622997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T22:19:34.626661Z","caller":"traceutil/trace.go:171","msg":"trace[815722995] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:324; }","duration":"138.768461ms","start":"2026-06-24T22:19:34.48788Z","end":"2026-06-24T22:19:34.626649Z","steps":["trace[815722995] 'agreement among raft nodes before linearized reading' (duration: 138.620107ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:34.626746Z","caller":"traceutil/trace.go:171","msg":"trace[1348092963] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"138.73382ms","start":"2026-06-24T22:19:34.48791Z","end":"2026-06-24T22:19:34.626643Z","steps":["trace[1348092963] 'process raft request' (duration: 90.589885ms)","trace[1348092963] 'compare' (duration: 47.773345ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:35.783432Z","caller":"traceutil/trace.go:171","msg":"trace[1190159285] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"106.528012ms","start":"2026-06-24T22:19:35.676869Z","end":"2026-06-24T22:19:35.783397Z","steps":["trace[1190159285] 'process raft request' (duration: 92.771676ms)","trace[1190159285] 'compare' (duration: 13.52187ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:38.235827Z","caller":"traceutil/trace.go:171","msg":"trace[909694976] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:373; }","duration":"184.863062ms","start":"2026-06-24T22:19:38.050935Z","end":"2026-06-24T22:19:38.235798Z","steps":["trace[909694976] 'read index received' (duration: 39.713224ms)","trace[909694976] 'applied index is now lower than readState.Index' (duration: 145.148688ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:38.235974Z","caller":"traceutil/trace.go:171","msg":"trace[1338393603] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"198.99621ms","start":"2026-06-24T22:19:38.036965Z","end":"2026-06-24T22:19:38.235961Z","steps":["trace[1338393603] 'process raft request' (duration: 143.71924ms)","trace[1338393603] 'compare' (duration: 54.962652ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:38.236153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.313088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-24T22:19:38.23621Z","caller":"traceutil/trace.go:171","msg":"trace[1067902017] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:364; }","duration":"159.409711ms","start":"2026-06-24T22:19:38.076787Z","end":"2026-06-24T22:19:38.236197Z","steps":["trace[1067902017] 'agreement among raft nodes before linearized reading' (duration: 159.261557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:38.23637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.261967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-06-24T22:19:38.236374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.058621ms","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-06-24T22:19:38.236393Z","caller":"traceutil/trace.go:171","msg":"trace[484107753] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:364; }","duration":"109.322419ms","start":"2026-06-24T22:19:38.127062Z","end":"2026-06-24T22:19:38.236384Z","steps":["trace[484107753] 'agreement among raft nodes before linearized reading' (duration: 109.285488ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.236406Z","caller":"traceutil/trace.go:171","msg":"trace[511846818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:364; }","duration":"109.104423ms","start":"2026-06-24T22:19:38.127291Z","end":"2026-06-24T22:19:38.236395Z","steps":["trace[511846818] 'agreement among raft nodes before linearized reading' (duration: 109.031811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:38.23647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.338375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:19:38.236488Z","caller":"traceutil/trace.go:171","msg":"trace[1946400677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:364; }","duration":"138.389776ms","start":"2026-06-24T22:19:38.098092Z","end":"2026-06-24T22:19:38.236482Z","steps":["trace[1946400677] 'agreement among raft nodes before linearized reading' (duration: 138.357975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:38.236562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.617722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T22:19:38.236605Z","caller":"traceutil/trace.go:171","msg":"trace[1379837259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:364; }","duration":"185.705014ms","start":"2026-06-24T22:19:38.050887Z","end":"2026-06-24T22:19:38.236592Z","steps":["trace[1379837259] 'agreement among raft nodes before linearized reading' (duration: 185.624622ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.411372Z","caller":"traceutil/trace.go:171","msg":"trace[299617435] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"156.194594ms","start":"2026-06-24T22:19:38.255151Z","end":"2026-06-24T22:19:38.411346Z","steps":["trace[299617435] 'process raft request' (duration: 149.587506ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.411433Z","caller":"traceutil/trace.go:171","msg":"trace[1103479151] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"156.240795ms","start":"2026-06-24T22:19:38.255152Z","end":"2026-06-24T22:19:38.411393Z","steps":["trace[1103479151] 'process raft request' (duration: 156.113741ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.411589Z","caller":"traceutil/trace.go:171","msg":"trace[390854692] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"156.321708ms","start":"2026-06-24T22:19:38.255257Z","end":"2026-06-24T22:19:38.411579Z","steps":["trace[390854692] 'process raft request' (duration: 156.079771ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.411701Z","caller":"traceutil/trace.go:171","msg":"trace[395210105] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"156.379189ms","start":"2026-06-24T22:19:38.255312Z","end":"2026-06-24T22:19:38.411691Z","steps":["trace[395210105] 'process raft request' (duration: 156.073801ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.411763Z","caller":"traceutil/trace.go:171","msg":"trace[32159100] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"156.395219ms","start":"2026-06-24T22:19:38.255358Z","end":"2026-06-24T22:19:38.411753Z","steps":["trace[32159100] 'process raft request' (duration: 156.216875ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.411792Z","caller":"traceutil/trace.go:171","msg":"trace[109613562] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"156.480621ms","start":"2026-06-24T22:19:38.255304Z","end":"2026-06-24T22:19:38.411784Z","steps":["trace[109613562] 'process raft request' (duration: 156.117802ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.457231Z","caller":"traceutil/trace.go:171","msg":"trace[2114775961] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"143.562496ms","start":"2026-06-24T22:19:38.313633Z","end":"2026-06-24T22:19:38.457196Z","steps":["trace[2114775961] 'process raft request' (duration: 143.35359ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.457288Z","caller":"traceutil/trace.go:171","msg":"trace[665479646] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"141.248234ms","start":"2026-06-24T22:19:38.316024Z","end":"2026-06-24T22:19:38.457272Z","steps":["trace[665479646] 'process raft request' (duration: 141.070919ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.457206Z","caller":"traceutil/trace.go:171","msg":"trace[665065303] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:378; }","duration":"143.439082ms","start":"2026-06-24T22:19:38.313718Z","end":"2026-06-24T22:19:38.457157Z","steps":["trace[665065303] 'read index received' (duration: 91.06951ms)","trace[665065303] 'applied index is now lower than readState.Index' (duration: 52.368412ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:38.457815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.096649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T22:19:38.457861Z","caller":"traceutil/trace.go:171","msg":"trace[151137985] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:375; }","duration":"144.193782ms","start":"2026-06-24T22:19:38.313654Z","end":"2026-06-24T22:19:38.457848Z","steps":["trace[151137985] 'agreement among raft nodes before linearized reading' (duration: 143.703509ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.614259Z","caller":"traceutil/trace.go:171","msg":"trace[1407269261] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"103.298957ms","start":"2026-06-24T22:19:38.510938Z","end":"2026-06-24T22:19:38.614237Z","steps":["trace[1407269261] 'process raft request' (duration: 102.967968ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.614392Z","caller":"traceutil/trace.go:171","msg":"trace[1583436638] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"102.259529ms","start":"2026-06-24T22:19:38.512112Z","end":"2026-06-24T22:19:38.614371Z","steps":["trace[1583436638] 'process raft request' (duration: 101.970021ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.614191Z","caller":"traceutil/trace.go:171","msg":"trace[758861971] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"102.118365ms","start":"2026-06-24T22:19:38.512028Z","end":"2026-06-24T22:19:38.614146Z","steps":["trace[758861971] 'process raft request' (duration: 102.013152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:38.61484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.78275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-06-24T22:19:38.61491Z","caller":"traceutil/trace.go:171","msg":"trace[441841933] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:392; }","duration":"103.895084ms","start":"2026-06-24T22:19:38.510997Z","end":"2026-06-24T22:19:38.614892Z","steps":["trace[441841933] 'agreement among raft nodes before linearized reading' (duration: 103.74895ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.61443Z","caller":"traceutil/trace.go:171","msg":"trace[625527427] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:398; }","duration":"103.360649ms","start":"2026-06-24T22:19:38.51104Z","end":"2026-06-24T22:19:38.614401Z","steps":["trace[625527427] 'read index received' (duration: 39.310682ms)","trace[625527427] 'applied index is now lower than readState.Index' (duration: 64.049047ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:38.745988Z","caller":"traceutil/trace.go:171","msg":"trace[389140950] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"125.875671ms","start":"2026-06-24T22:19:38.620085Z","end":"2026-06-24T22:19:38.745961Z","steps":["trace[389140950] 'process raft request' (duration: 63.250604ms)","trace[389140950] 'compare' (duration: 62.35647ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:38.746042Z","caller":"traceutil/trace.go:171","msg":"trace[1492911247] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"124.051053ms","start":"2026-06-24T22:19:38.621965Z","end":"2026-06-24T22:19:38.746016Z","steps":["trace[1492911247] 'process raft request' (duration: 123.918689ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.746216Z","caller":"traceutil/trace.go:171","msg":"trace[1367464691] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"124.202557ms","start":"2026-06-24T22:19:38.621997Z","end":"2026-06-24T22:19:38.7462Z","steps":["trace[1367464691] 'process raft request' (duration: 123.96222ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.746595Z","caller":"traceutil/trace.go:171","msg":"trace[996802846] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:403; }","duration":"115.041382ms","start":"2026-06-24T22:19:38.631543Z","end":"2026-06-24T22:19:38.746585Z","steps":["trace[996802846] 'read index received' (duration: 11.035136ms)","trace[996802846] 'applied index is now lower than readState.Index' (duration: 104.005566ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:38.746671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.112784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-06-24T22:19:38.746694Z","caller":"traceutil/trace.go:171","msg":"trace[647694200] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:397; }","duration":"115.168125ms","start":"2026-06-24T22:19:38.631519Z","end":"2026-06-24T22:19:38.746687Z","steps":["trace[647694200] 'agreement among raft nodes before linearized reading' (duration: 115.101523ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:38.746687Z","caller":"traceutil/trace.go:171","msg":"trace[1518375235] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"123.753155ms","start":"2026-06-24T22:19:38.622917Z","end":"2026-06-24T22:19:38.74667Z","steps":["trace[1518375235] 'process raft request' (duration: 123.217561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:39.091401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.584031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:19:39.091616Z","caller":"traceutil/trace.go:171","msg":"trace[1790850997] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"333.235781ms","start":"2026-06-24T22:19:38.758359Z","end":"2026-06-24T22:19:39.091595Z","steps":["trace[1790850997] 'process raft request' (duration: 99.361421ms)","trace[1790850997] 'compare' (duration: 233.440318ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:39.091787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:38.75834Z","time spent":"333.355624ms","remote":"127.0.0.1:36958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4451,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:19:39.115196Z","caller":"traceutil/trace.go:171","msg":"trace[416947145] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"297.12941ms","start":"2026-06-24T22:19:38.818038Z","end":"2026-06-24T22:19:39.115168Z","steps":["trace[416947145] 'process raft request' (duration: 296.854233ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:39.975816Z","caller":"traceutil/trace.go:171","msg":"trace[1584372606] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"105.684611ms","start":"2026-06-24T22:19:39.870097Z","end":"2026-06-24T22:19:39.975781Z","steps":["trace[1584372606] 'process raft request' (duration: 105.525497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:40.41984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.796787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:19:40.419944Z","caller":"traceutil/trace.go:171","msg":"trace[514257310] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"159.196357ms","start":"2026-06-24T22:19:40.260729Z","end":"2026-06-24T22:19:40.419925Z","steps":["trace[514257310] 'process raft request' (duration: 39.232066ms)","trace[514257310] 'compare' (duration: 119.53292ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:47.865767Z","caller":"traceutil/trace.go:171","msg":"trace[1576876972] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"702.393878ms","start":"2026-06-24T22:19:47.16334Z","end":"2026-06-24T22:19:47.865734Z","steps":["trace[1576876972] 'process raft request' (duration: 702.241335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:47.866247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:47.163321Z","time spent":"702.532531ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:19:47.909479Z","caller":"traceutil/trace.go:171","msg":"trace[1913932729] linearizableReadLoop","detail":"{readStateIndex:446; appliedIndex:444; }","duration":"149.446376ms","start":"2026-06-24T22:19:47.760009Z","end":"2026-06-24T22:19:47.909455Z","steps":["trace[1913932729] 'read index received' (duration: 105.601178ms)","trace[1913932729] 'applied index is now lower than readState.Index' (duration: 43.844268ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:47.909595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.572009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T22:19:47.909623Z","caller":"traceutil/trace.go:171","msg":"trace[424564128] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:432; }","duration":"149.656751ms","start":"2026-06-24T22:19:47.759958Z","end":"2026-06-24T22:19:47.909615Z","steps":["trace[424564128] 'agreement among raft nodes before linearized reading' (duration: 149.570199ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:47.909656Z","caller":"traceutil/trace.go:171","msg":"trace[342174426] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"548.753385ms","start":"2026-06-24T22:19:47.360845Z","end":"2026-06-24T22:19:47.909599Z","steps":["trace[342174426] 'process raft request' (duration: 547.028602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:47.909827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:47.360824Z","time spent":"548.92471ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:19:53.524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.77314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:19:53.524147Z","caller":"traceutil/trace.go:171","msg":"trace[1563539193] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"518.893326ms","start":"2026-06-24T22:19:53.00523Z","end":"2026-06-24T22:19:53.524123Z","steps":["trace[1563539193] 'process raft request' (duration: 288.87211ms)","trace[1563539193] 'compare' (duration: 229.628525ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:53.524231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.005206Z","time spent":"518.980518ms","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:19:53.551533Z","caller":"traceutil/trace.go:171","msg":"trace[1874701570] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"545.246787ms","start":"2026-06-24T22:19:53.006244Z","end":"2026-06-24T22:19:53.551491Z","steps":["trace[1874701570] 'process raft request' (duration: 545.094013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:53.551755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.006228Z","time spent":"545.40526ms","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:19:53.769007Z","caller":"traceutil/trace.go:171","msg":"trace[2076067796] transaction","detail":"{read_only:false; number_of_response:1; response_revision:461; }","duration":"166.536788ms","start":"2026-06-24T22:19:53.602077Z","end":"2026-06-24T22:19:53.768614Z","steps":["trace[2076067796] 'process raft request' (duration: 87.489853ms)","trace[2076067796] 'compare' (duration: 78.861571ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:53.77483Z","caller":"traceutil/trace.go:171","msg":"trace[1304215788] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"164.237922ms","start":"2026-06-24T22:19:53.610575Z","end":"2026-06-24T22:19:53.774813Z","steps":["trace[1304215788] 'process raft request' (duration: 164.197571ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:53.774968Z","caller":"traceutil/trace.go:171","msg":"trace[1660713296] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"164.754505ms","start":"2026-06-24T22:19:53.610059Z","end":"2026-06-24T22:19:53.774814Z","steps":["trace[1660713296] 'process raft request' (duration: 164.679104ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:53.774915Z","caller":"traceutil/trace.go:171","msg":"trace[1430362203] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"170.071215ms","start":"2026-06-24T22:19:53.604834Z","end":"2026-06-24T22:19:53.774905Z","steps":["trace[1430362203] 'process raft request' (duration: 169.791118ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:53.774864Z","caller":"traceutil/trace.go:171","msg":"trace[1552698119] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"168.031875ms","start":"2026-06-24T22:19:53.606777Z","end":"2026-06-24T22:19:53.774809Z","steps":["trace[1552698119] 'process raft request' (duration: 167.929373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:54.027909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.867721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:19:54.028027Z","caller":"traceutil/trace.go:171","msg":"trace[371671744] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"252.060439ms","start":"2026-06-24T22:19:53.775949Z","end":"2026-06-24T22:19:54.02801Z","steps":["trace[371671744] 'process raft request' (duration: 137.982173ms)","trace[371671744] 'compare' (duration: 113.696397ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:54.089126Z","caller":"traceutil/trace.go:171","msg":"trace[259628135] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"309.236734ms","start":"2026-06-24T22:19:53.779861Z","end":"2026-06-24T22:19:54.089098Z","steps":["trace[259628135] 'process raft request' (duration: 309.095481ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:54.08912Z","caller":"traceutil/trace.go:171","msg":"trace[2033480031] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"309.459659ms","start":"2026-06-24T22:19:53.779606Z","end":"2026-06-24T22:19:54.089066Z","steps":["trace[2033480031] 'process raft request' (duration: 309.226864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:54.089171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.863556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-06-24T22:19:54.089227Z","caller":"traceutil/trace.go:171","msg":"trace[2058116121] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:471; }","duration":"306.953258ms","start":"2026-06-24T22:19:53.78226Z","end":"2026-06-24T22:19:54.089213Z","steps":["trace[2058116121] 'agreement among raft nodes before linearized reading' (duration: 306.843865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:54.089269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.78225Z","time spent":"307.010809ms","remote":"127.0.0.1:37266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4219,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-06-24T22:19:54.089259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.779836Z","time spent":"309.354396ms","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:19:54.089337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.779591Z","time spent":"309.637093ms","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:19:54.089489Z","caller":"traceutil/trace.go:171","msg":"trace[1430676124] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:481; }","duration":"306.808674ms","start":"2026-06-24T22:19:53.782291Z","end":"2026-06-24T22:19:54.0891Z","steps":["trace[1430676124] 'read index received' (duration: 131.687499ms)","trace[1430676124] 'applied index is now lower than readState.Index' (duration: 175.119995ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:19:54.089281Z","caller":"traceutil/trace.go:171","msg":"trace[419091249] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"306.834366ms","start":"2026-06-24T22:19:53.782366Z","end":"2026-06-24T22:19:54.0892Z","steps":["trace[419091249] 'process raft request' (duration: 306.686392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:54.08972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.782358Z","time spent":"307.290046ms","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:19:54.08987Z","caller":"traceutil/trace.go:171","msg":"trace[612475770] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"309.50006ms","start":"2026-06-24T22:19:53.780352Z","end":"2026-06-24T22:19:54.089852Z","steps":["trace[612475770] 'process raft request' (duration: 308.6624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:54.090049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.780289Z","time spent":"309.683935ms","remote":"127.0.0.1:36958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:19:54.260031Z","caller":"traceutil/trace.go:171","msg":"trace[1052994204] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"170.44305ms","start":"2026-06-24T22:19:54.089569Z","end":"2026-06-24T22:19:54.260012Z","steps":["trace[1052994204] 'read index received' (duration: 92.842471ms)","trace[1052994204] 'applied index is now lower than readState.Index' (duration: 77.598109ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:54.26021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.098001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T22:19:54.260238Z","caller":"traceutil/trace.go:171","msg":"trace[179435088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:472; }","duration":"324.192853ms","start":"2026-06-24T22:19:53.936038Z","end":"2026-06-24T22:19:54.260231Z","steps":["trace[179435088] 'agreement among raft nodes before linearized reading' (duration: 324.07945ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:54.260144Z","caller":"traceutil/trace.go:171","msg":"trace[225659602] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"226.321353ms","start":"2026-06-24T22:19:54.033785Z","end":"2026-06-24T22:19:54.260107Z","steps":["trace[225659602] 'process raft request' (duration: 148.676873ms)","trace[225659602] 'compare' (duration: 77.455306ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:19:54.26026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.936012Z","time spent":"324.244245ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T22:19:54.260354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.883033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T22:19:54.260391Z","caller":"traceutil/trace.go:171","msg":"trace[1889428169] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:472; }","duration":"361.960275ms","start":"2026-06-24T22:19:53.898421Z","end":"2026-06-24T22:19:54.260381Z","steps":["trace[1889428169] 'agreement among raft nodes before linearized reading' (duration: 361.713759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:54.260416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:19:53.898398Z","time spent":"362.011425ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T22:19:54.296676Z","caller":"traceutil/trace.go:171","msg":"trace[173654365] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"198.771966ms","start":"2026-06-24T22:19:54.09788Z","end":"2026-06-24T22:19:54.296651Z","steps":["trace[173654365] 'process raft request' (duration: 198.571861ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:19:54.296827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.625687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:19:54.296857Z","caller":"traceutil/trace.go:171","msg":"trace[2071781851] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"195.802184ms","start":"2026-06-24T22:19:54.101042Z","end":"2026-06-24T22:19:54.296844Z","steps":["trace[2071781851] 'process raft request' (duration: 195.550538ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:19:54.296921Z","caller":"traceutil/trace.go:171","msg":"trace[797912239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:474; }","duration":"197.749001ms","start":"2026-06-24T22:19:54.099156Z","end":"2026-06-24T22:19:54.296905Z","steps":["trace[797912239] 'agreement among raft nodes before linearized reading' (duration: 197.598647ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:02.476847Z","caller":"traceutil/trace.go:171","msg":"trace[522509064] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:510; }","duration":"122.706663ms","start":"2026-06-24T22:20:02.35412Z","end":"2026-06-24T22:20:02.476826Z","steps":["trace[522509064] 'read index received' (duration: 122.609391ms)","trace[522509064] 'applied index is now lower than readState.Index' (duration: 96.172µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:02.47699Z","caller":"traceutil/trace.go:171","msg":"trace[1363746138] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"123.857389ms","start":"2026-06-24T22:20:02.353074Z","end":"2026-06-24T22:20:02.476931Z","steps":["trace[1363746138] 'process raft request' (duration: 123.632014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:02.477267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.058171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T22:20:02.477359Z","caller":"traceutil/trace.go:171","msg":"trace[1262174520] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:494; }","duration":"123.265527ms","start":"2026-06-24T22:20:02.354075Z","end":"2026-06-24T22:20:02.477341Z","steps":["trace[1262174520] 'agreement among raft nodes before linearized reading' (duration: 122.873697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:02.743613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.406157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T22:20:02.743692Z","caller":"traceutil/trace.go:171","msg":"trace[1643163200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:496; }","duration":"163.490468ms","start":"2026-06-24T22:20:02.580181Z","end":"2026-06-24T22:20:02.743672Z","steps":["trace[1643163200] 'range keys from in-memory index tree' (duration: 163.268123ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:02.917544Z","caller":"traceutil/trace.go:171","msg":"trace[1768347700] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"126.662035ms","start":"2026-06-24T22:20:02.790852Z","end":"2026-06-24T22:20:02.917514Z","steps":["trace[1768347700] 'process raft request' (duration: 76.267498ms)","trace[1768347700] 'compare' (duration: 50.279445ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:04.265106Z","caller":"traceutil/trace.go:171","msg":"trace[810921679] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"171.033451ms","start":"2026-06-24T22:20:04.094042Z","end":"2026-06-24T22:20:04.265075Z","steps":["trace[810921679] 'process raft request' (duration: 170.612551ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:04.41606Z","caller":"traceutil/trace.go:171","msg":"trace[1712910263] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"126.797978ms","start":"2026-06-24T22:20:04.28923Z","end":"2026-06-24T22:20:04.416028Z","steps":["trace[1712910263] 'process raft request' (duration: 83.698589ms)","trace[1712910263] 'compare' (duration: 42.939585ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:04.797828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.185981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:20:04.798039Z","caller":"traceutil/trace.go:171","msg":"trace[187991405] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:518; }","duration":"316.957736ms","start":"2026-06-24T22:20:04.48106Z","end":"2026-06-24T22:20:04.798018Z","steps":["trace[187991405] 'read index received' (duration: 160.510169ms)","trace[187991405] 'applied index is now lower than readState.Index' (duration: 156.445217ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:04.798071Z","caller":"traceutil/trace.go:171","msg":"trace[916044612] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"376.8693ms","start":"2026-06-24T22:20:04.421171Z","end":"2026-06-24T22:20:04.79804Z","steps":["trace[916044612] 'process raft request' (duration: 220.391493ms)","trace[916044612] 'compare' (duration: 156.027057ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:04.798279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:04.421148Z","time spent":"377.005604ms","remote":"127.0.0.1:36870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6516,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:20:04.798314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.148886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T22:20:04.798371Z","caller":"traceutil/trace.go:171","msg":"trace[1384107759] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:502; }","duration":"278.243148ms","start":"2026-06-24T22:20:04.52011Z","end":"2026-06-24T22:20:04.798353Z","steps":["trace[1384107759] 'agreement among raft nodes before linearized reading' (duration: 278.138436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:04.798596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.576051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T22:20:04.798758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.697733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T22:20:04.798688Z","caller":"traceutil/trace.go:171","msg":"trace[1410068524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:502; }","duration":"235.701414ms","start":"2026-06-24T22:20:04.562966Z","end":"2026-06-24T22:20:04.798667Z","steps":["trace[1410068524] 'agreement among raft nodes before linearized reading' (duration: 235.317965ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:04.798804Z","caller":"traceutil/trace.go:171","msg":"trace[1305897212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:502; }","duration":"317.774664ms","start":"2026-06-24T22:20:04.481019Z","end":"2026-06-24T22:20:04.798793Z","steps":["trace[1305897212] 'agreement among raft nodes before linearized reading' (duration: 317.103879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:04.798834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:04.481006Z","time spent":"317.821096ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T22:20:05.11165Z","caller":"traceutil/trace.go:171","msg":"trace[845981465] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"308.815947ms","start":"2026-06-24T22:20:04.802807Z","end":"2026-06-24T22:20:05.111623Z","steps":["trace[845981465] 'process raft request' (duration: 230.687755ms)","trace[845981465] 'compare' (duration: 77.909137ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:05.111796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:04.802791Z","time spent":"308.925439ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:20:05.11192Z","caller":"traceutil/trace.go:171","msg":"trace[2018208162] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"307.971627ms","start":"2026-06-24T22:20:04.803938Z","end":"2026-06-24T22:20:05.11191Z","steps":["trace[2018208162] 'process raft request' (duration: 307.696341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:05.111976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:04.803931Z","time spent":"308.017469ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:20:05.111968Z","caller":"traceutil/trace.go:171","msg":"trace[1157446266] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"307.1965ms","start":"2026-06-24T22:20:04.804749Z","end":"2026-06-24T22:20:05.111946Z","steps":["trace[1157446266] 'process raft request' (duration: 306.931994ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.112047Z","caller":"traceutil/trace.go:171","msg":"trace[932039704] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"308.335896ms","start":"2026-06-24T22:20:04.80367Z","end":"2026-06-24T22:20:05.112006Z","steps":["trace[932039704] 'process raft request' (duration: 307.928477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:05.112172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:04.804743Z","time spent":"307.317912ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:20:05.112185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:04.803658Z","time spent":"308.466969ms","remote":"127.0.0.1:37126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1639,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:20:05.112578Z","caller":"traceutil/trace.go:171","msg":"trace[358656978] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"309.375539ms","start":"2026-06-24T22:20:04.803165Z","end":"2026-06-24T22:20:05.112541Z","steps":["trace[358656978] 'process raft request' (duration: 308.386247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:05.112736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:04.803159Z","time spent":"309.489132ms","remote":"127.0.0.1:37126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2364,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:20:05.247536Z","caller":"traceutil/trace.go:171","msg":"trace[1178779606] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"131.248902ms","start":"2026-06-24T22:20:05.116261Z","end":"2026-06-24T22:20:05.24751Z","steps":["trace[1178779606] 'process raft request' (duration: 104.709237ms)","trace[1178779606] 'compare' (duration: 26.443293ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:05.273892Z","caller":"traceutil/trace.go:171","msg":"trace[139147858] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"156.579581ms","start":"2026-06-24T22:20:05.117243Z","end":"2026-06-24T22:20:05.273822Z","steps":["trace[139147858] 'process raft request' (duration: 156.414687ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.638724Z","caller":"traceutil/trace.go:171","msg":"trace[1601184357] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"196.496671ms","start":"2026-06-24T22:20:05.442194Z","end":"2026-06-24T22:20:05.638691Z","steps":["trace[1601184357] 'process raft request' (duration: 137.991607ms)","trace[1601184357] 'compare' (duration: 57.996253ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:05.638927Z","caller":"traceutil/trace.go:171","msg":"trace[905582234] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"171.040221ms","start":"2026-06-24T22:20:05.467852Z","end":"2026-06-24T22:20:05.638892Z","steps":["trace[905582234] 'process raft request' (duration: 170.55657ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.639763Z","caller":"traceutil/trace.go:171","msg":"trace[1862751805] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"154.423352ms","start":"2026-06-24T22:20:05.485325Z","end":"2026-06-24T22:20:05.639748Z","steps":["trace[1862751805] 'process raft request' (duration: 154.194227ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.639809Z","caller":"traceutil/trace.go:171","msg":"trace[1896154896] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"152.378875ms","start":"2026-06-24T22:20:05.487401Z","end":"2026-06-24T22:20:05.639779Z","steps":["trace[1896154896] 'process raft request' (duration: 152.308713ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.639921Z","caller":"traceutil/trace.go:171","msg":"trace[930603564] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"153.269715ms","start":"2026-06-24T22:20:05.486602Z","end":"2026-06-24T22:20:05.639872Z","steps":["trace[930603564] 'process raft request' (duration: 153.04919ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.948009Z","caller":"traceutil/trace.go:171","msg":"trace[1840322425] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:539; }","duration":"292.552382ms","start":"2026-06-24T22:20:05.655433Z","end":"2026-06-24T22:20:05.947986Z","steps":["trace[1840322425] 'read index received' (duration: 31.57538ms)","trace[1840322425] 'applied index is now lower than readState.Index' (duration: 260.976122ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:05.948086Z","caller":"traceutil/trace.go:171","msg":"trace[2121388159] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"298.100248ms","start":"2026-06-24T22:20:05.649953Z","end":"2026-06-24T22:20:05.948053Z","steps":["trace[2121388159] 'process raft request' (duration: 297.827242ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.948144Z","caller":"traceutil/trace.go:171","msg":"trace[806404124] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"293.824591ms","start":"2026-06-24T22:20:05.654289Z","end":"2026-06-24T22:20:05.948113Z","steps":["trace[806404124] 'process raft request' (duration: 293.612576ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.948131Z","caller":"traceutil/trace.go:171","msg":"trace[34322493] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"292.841399ms","start":"2026-06-24T22:20:05.655279Z","end":"2026-06-24T22:20:05.94812Z","steps":["trace[34322493] 'process raft request' (duration: 292.660994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:05.94827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.822689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-06-24T22:20:05.94804Z","caller":"traceutil/trace.go:171","msg":"trace[1196350327] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"293.867171ms","start":"2026-06-24T22:20:05.654143Z","end":"2026-06-24T22:20:05.948011Z","steps":["trace[1196350327] 'process raft request' (duration: 293.719298ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:05.948427Z","caller":"traceutil/trace.go:171","msg":"trace[294935534] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"300.029922ms","start":"2026-06-24T22:20:05.648368Z","end":"2026-06-24T22:20:05.948397Z","steps":["trace[294935534] 'process raft request' (duration: 250.367049ms)","trace[294935534] 'compare' (duration: 48.890315ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:05.948713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.60237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-06-24T22:20:05.948758Z","caller":"traceutil/trace.go:171","msg":"trace[2123477874] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:527; }","duration":"223.643411ms","start":"2026-06-24T22:20:05.7251Z","end":"2026-06-24T22:20:05.948744Z","steps":["trace[2123477874] 'agreement among raft nodes before linearized reading' (duration: 223.199281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:05.948753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:05.648356Z","time spent":"300.32082ms","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:20:05.949545Z","caller":"traceutil/trace.go:171","msg":"trace[1914772381] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:527; }","duration":"292.932221ms","start":"2026-06-24T22:20:05.655424Z","end":"2026-06-24T22:20:05.948356Z","steps":["trace[1914772381] 'agreement among raft nodes before linearized reading' (duration: 292.727287ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:06.133314Z","caller":"traceutil/trace.go:171","msg":"trace[1809907936] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"173.085503ms","start":"2026-06-24T22:20:05.960213Z","end":"2026-06-24T22:20:06.133299Z","steps":["trace[1809907936] 'process raft request' (duration: 172.023568ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:06.133383Z","caller":"traceutil/trace.go:171","msg":"trace[1673247509] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:546; }","duration":"173.028691ms","start":"2026-06-24T22:20:05.960319Z","end":"2026-06-24T22:20:06.133348Z","steps":["trace[1673247509] 'read index received' (duration: 27.737843ms)","trace[1673247509] 'applied index is now lower than readState.Index' (duration: 145.289788ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:06.133586Z","caller":"traceutil/trace.go:171","msg":"trace[558928255] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"173.303547ms","start":"2026-06-24T22:20:05.960276Z","end":"2026-06-24T22:20:06.13358Z","steps":["trace[558928255] 'process raft request' (duration: 172.942989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:06.133743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.414019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-xnwbl\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-24T22:20:06.13376Z","caller":"traceutil/trace.go:171","msg":"trace[1335496530] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-xnwbl; range_end:; response_count:1; response_revision:531; }","duration":"173.469641ms","start":"2026-06-24T22:20:05.960285Z","end":"2026-06-24T22:20:06.133755Z","steps":["trace[1335496530] 'agreement among raft nodes before linearized reading' (duration: 173.398599ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:06.133863Z","caller":"traceutil/trace.go:171","msg":"trace[660650196] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"168.087288ms","start":"2026-06-24T22:20:05.965771Z","end":"2026-06-24T22:20:06.133859Z","steps":["trace[660650196] 'process raft request' (duration: 167.513625ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:06.135764Z","caller":"traceutil/trace.go:171","msg":"trace[300441874] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"144.288585ms","start":"2026-06-24T22:20:05.991468Z","end":"2026-06-24T22:20:06.135757Z","steps":["trace[300441874] 'process raft request' (duration: 143.891056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:06.391019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.820228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:20:06.39113Z","caller":"traceutil/trace.go:171","msg":"trace[988185909] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:550; }","duration":"245.379198ms","start":"2026-06-24T22:20:06.145734Z","end":"2026-06-24T22:20:06.391113Z","steps":["trace[988185909] 'read index received' (duration: 144.386997ms)","trace[988185909] 'applied index is now lower than readState.Index' (duration: 100.991051ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:06.391163Z","caller":"traceutil/trace.go:171","msg":"trace[1184222251] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"246.179506ms","start":"2026-06-24T22:20:06.144961Z","end":"2026-06-24T22:20:06.391141Z","steps":["trace[1184222251] 'process raft request' (duration: 145.149054ms)","trace[1184222251] 'compare' (duration: 100.697475ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:06.391279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.556272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" ","response":"range_response_count:1 size:4354"} {"level":"info","ts":"2026-06-24T22:20:06.391317Z","caller":"traceutil/trace.go:171","msg":"trace[1111239625] range","detail":"{range_begin:/registry/replicasets/kube-system/cilium-operator-869df985b8; range_end:; response_count:1; response_revision:533; }","duration":"245.628034ms","start":"2026-06-24T22:20:06.145675Z","end":"2026-06-24T22:20:06.391303Z","steps":["trace[1111239625] 'agreement among raft nodes before linearized reading' (duration: 245.501121ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:06.421039Z","caller":"traceutil/trace.go:171","msg":"trace[2096188861] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"271.311006ms","start":"2026-06-24T22:20:06.149704Z","end":"2026-06-24T22:20:06.421015Z","steps":["trace[2096188861] 'process raft request' (duration: 271.093381ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:06.5525Z","caller":"traceutil/trace.go:171","msg":"trace[1503972111] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"114.270423ms","start":"2026-06-24T22:20:06.438203Z","end":"2026-06-24T22:20:06.552474Z","steps":["trace[1503972111] 'process raft request' (duration: 112.620316ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:08.206374Z","caller":"traceutil/trace.go:171","msg":"trace[401561190] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"286.529916ms","start":"2026-06-24T22:20:07.919818Z","end":"2026-06-24T22:20:08.206348Z","steps":["trace[401561190] 'process raft request' (duration: 284.865698ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:08.221268Z","caller":"traceutil/trace.go:171","msg":"trace[914280870] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:610; }","duration":"121.260453ms","start":"2026-06-24T22:20:08.099987Z","end":"2026-06-24T22:20:08.221248Z","steps":["trace[914280870] 'read index received' (duration: 104.710152ms)","trace[914280870] 'applied index is now lower than readState.Index' (duration: 16.549791ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:08.221373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.366916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:08.221394Z","caller":"traceutil/trace.go:171","msg":"trace[822538729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"121.443708ms","start":"2026-06-24T22:20:08.099944Z","end":"2026-06-24T22:20:08.221388Z","steps":["trace[822538729] 'agreement among raft nodes before linearized reading' (duration: 121.374936ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:08.221699Z","caller":"traceutil/trace.go:171","msg":"trace[1375877851] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"279.7561ms","start":"2026-06-24T22:20:07.941936Z","end":"2026-06-24T22:20:08.221692Z","steps":["trace[1375877851] 'process raft request' (duration: 279.092386ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:08.221766Z","caller":"traceutil/trace.go:171","msg":"trace[982924243] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"277.193622ms","start":"2026-06-24T22:20:07.944568Z","end":"2026-06-24T22:20:08.221762Z","steps":["trace[982924243] 'process raft request' (duration: 276.592229ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:08.468942Z","caller":"traceutil/trace.go:171","msg":"trace[87650112] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"171.472841ms","start":"2026-06-24T22:20:08.297395Z","end":"2026-06-24T22:20:08.468868Z","steps":["trace[87650112] 'process raft request' (duration: 154.247964ms)","trace[87650112] 'compare' (duration: 17.077003ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:09.340097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375522777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:20:09.841308Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375522777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:20:10.041961Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.440744587s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T22:20:10.044684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.443273984s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:20:10.04549Z","caller":"traceutil/trace.go:171","msg":"trace[1178272189] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.744014228s","start":"2026-06-24T22:20:08.301442Z","end":"2026-06-24T22:20:10.045456Z","steps":["trace[1178272189] 'process raft request' (duration: 299.875265ms)","trace[1178272189] 'compare' (duration: 1.44310779s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:10.045639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:08.301413Z","time spent":"1.744150751s","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:20:10.045924Z","caller":"traceutil/trace.go:171","msg":"trace[1241017493] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:617; }","duration":"1.205995104s","start":"2026-06-24T22:20:08.839904Z","end":"2026-06-24T22:20:10.045899Z","steps":["trace[1241017493] 'read index received' (duration: 1.20222144s)","trace[1241017493] 'applied index is now lower than readState.Index' (duration: 3.772724ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:10.045995Z","caller":"traceutil/trace.go:171","msg":"trace[481967057] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.656705417s","start":"2026-06-24T22:20:08.389269Z","end":"2026-06-24T22:20:10.045974Z","steps":["trace[481967057] 'process raft request' (duration: 1.656489892s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:10.046089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:08.38925Z","time spent":"1.656793829s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:20:10.046167Z","caller":"traceutil/trace.go:171","msg":"trace[1272465291] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.548409124s","start":"2026-06-24T22:20:08.497698Z","end":"2026-06-24T22:20:10.046107Z","steps":["trace[1272465291] 'process raft request' (duration: 1.548157139s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:10.046291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:08.4976Z","time spent":"1.548626319s","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:20:10.046366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.764041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:10.046413Z","caller":"traceutil/trace.go:171","msg":"trace[440309728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"945.845153ms","start":"2026-06-24T22:20:09.100556Z","end":"2026-06-24T22:20:10.046402Z","steps":["trace[440309728] 'agreement among raft nodes before linearized reading' (duration: 945.779401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:10.046443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:09.100536Z","time spent":"945.900103ms","remote":"127.0.0.1:36780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T22:20:10.046613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.503261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-24T22:20:10.046635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.302129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T22:20:10.046659Z","caller":"traceutil/trace.go:171","msg":"trace[2090746256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"858.574993ms","start":"2026-06-24T22:20:09.188073Z","end":"2026-06-24T22:20:10.046648Z","steps":["trace[2090746256] 'agreement among raft nodes before linearized reading' (duration: 858.463651ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:10.046667Z","caller":"traceutil/trace.go:171","msg":"trace[1181081518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"859.37078ms","start":"2026-06-24T22:20:09.187287Z","end":"2026-06-24T22:20:10.046658Z","steps":["trace[1181081518] 'agreement among raft nodes before linearized reading' (duration: 859.273718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:10.046684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:09.188064Z","time spent":"858.613034ms","remote":"127.0.0.1:37038","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-06-24T22:20:10.046696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:09.187272Z","time spent":"859.417061ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T22:20:10.046186Z","caller":"traceutil/trace.go:171","msg":"trace[1797906660] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.709132785s","start":"2026-06-24T22:20:08.337041Z","end":"2026-06-24T22:20:10.046174Z","steps":["trace[1797906660] 'process raft request' (duration: 1.707772465s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:10.046812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.930929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T22:20:10.046838Z","caller":"traceutil/trace.go:171","msg":"trace[1118293864] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"866.997231ms","start":"2026-06-24T22:20:09.179833Z","end":"2026-06-24T22:20:10.046831Z","steps":["trace[1118293864] 'agreement among raft nodes before linearized reading' (duration: 866.920509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:10.046874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:09.179804Z","time spent":"867.063492ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T22:20:10.046843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206937495s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T22:20:10.046998Z","caller":"traceutil/trace.go:171","msg":"trace[1308746536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"1.207127499s","start":"2026-06-24T22:20:08.839862Z","end":"2026-06-24T22:20:10.046989Z","steps":["trace[1308746536] 'agreement among raft nodes before linearized reading' (duration: 1.206937855s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:10.047037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:08.839841Z","time spent":"1.207184501s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T22:20:10.047305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:08.337018Z","time spent":"1.709804731s","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:20:12.311558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.705963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:20:12.311724Z","caller":"traceutil/trace.go:171","msg":"trace[2080702018] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"104.246225ms","start":"2026-06-24T22:20:12.207459Z","end":"2026-06-24T22:20:12.311706Z","steps":["trace[2080702018] 'process raft request' (duration: 104.198884ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:12.311726Z","caller":"traceutil/trace.go:171","msg":"trace[701487800] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"104.880779ms","start":"2026-06-24T22:20:12.206824Z","end":"2026-06-24T22:20:12.311705Z","steps":["trace[701487800] 'compare' (duration: 103.56312ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:12.782566Z","caller":"traceutil/trace.go:171","msg":"trace[1740770949] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"242.347216ms","start":"2026-06-24T22:20:12.540196Z","end":"2026-06-24T22:20:12.782544Z","steps":["trace[1740770949] 'process raft request' (duration: 242.010519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:18.682399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.703412782s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:20:18.682504Z","caller":"traceutil/trace.go:171","msg":"trace[1819325175] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"2.148754616s","start":"2026-06-24T22:20:16.533732Z","end":"2026-06-24T22:20:18.682487Z","steps":["trace[1819325175] 'read index received' (duration: 445.216852ms)","trace[1819325175] 'applied index is now lower than readState.Index' (duration: 1.703536434s)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:18.682574Z","caller":"traceutil/trace.go:171","msg":"trace[1193183203] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"2.333094951s","start":"2026-06-24T22:20:16.349436Z","end":"2026-06-24T22:20:18.682531Z","steps":["trace[1193183203] 'process raft request' (duration: 629.471215ms)","trace[1193183203] 'compare' (duration: 1.703056684s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:18.6827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.148970441s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-m6pv4\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-24T22:20:18.682699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:16.349413Z","time spent":"2.333226143s","remote":"127.0.0.1:37010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:20:18.68273Z","caller":"traceutil/trace.go:171","msg":"trace[1858707042] range","detail":"{range_begin:/registry/pods/kube-system/cilium-m6pv4; range_end:; response_count:1; response_revision:656; }","duration":"2.149040032s","start":"2026-06-24T22:20:16.533682Z","end":"2026-06-24T22:20:18.682722Z","steps":["trace[1858707042] 'agreement among raft nodes before linearized reading' (duration: 2.148887019s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:18.682763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:16.53366Z","time spent":"2.149095404s","remote":"127.0.0.1:36958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-m6pv4\" "} {"level":"warn","ts":"2026-06-24T22:20:18.682954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.589187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:18.68298Z","caller":"traceutil/trace.go:171","msg":"trace[1748287909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"582.634188ms","start":"2026-06-24T22:20:18.100338Z","end":"2026-06-24T22:20:18.682972Z","steps":["trace[1748287909] 'agreement among raft nodes before linearized reading' (duration: 582.593728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:18.683004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:18.100323Z","time spent":"582.676219ms","remote":"127.0.0.1:36780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T22:20:18.683065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.597242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T22:20:18.683103Z","caller":"traceutil/trace.go:171","msg":"trace[1309448092] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:656; }","duration":"572.655724ms","start":"2026-06-24T22:20:18.110434Z","end":"2026-06-24T22:20:18.68309Z","steps":["trace[1309448092] 'agreement among raft nodes before linearized reading' (duration: 572.512011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:18.683145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:18.110424Z","time spent":"572.714335ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T22:20:18.683222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.21218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T22:20:18.683253Z","caller":"traceutil/trace.go:171","msg":"trace[1872469866] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"576.266191ms","start":"2026-06-24T22:20:18.106979Z","end":"2026-06-24T22:20:18.683245Z","steps":["trace[1872469866] 'agreement among raft nodes before linearized reading' (duration: 576.167558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:18.68328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:18.106972Z","time spent":"576.301853ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T22:20:18.683497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.071723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-24T22:20:18.683519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.787522ms","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-06-24T22:20:18.683594Z","caller":"traceutil/trace.go:171","msg":"trace[42217312] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:656; }","duration":"580.200666ms","start":"2026-06-24T22:20:18.103364Z","end":"2026-06-24T22:20:18.683564Z","steps":["trace[42217312] 'agreement among raft nodes before linearized reading' (duration: 579.952331ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:18.68361Z","caller":"traceutil/trace.go:171","msg":"trace[438227415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:656; }","duration":"576.918005ms","start":"2026-06-24T22:20:18.106669Z","end":"2026-06-24T22:20:18.683587Z","steps":["trace[438227415] 'agreement among raft nodes before linearized reading' (duration: 576.66238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:18.683651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:18.10335Z","time spent":"580.287137ms","remote":"127.0.0.1:37038","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-06-24T22:20:18.683664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:18.106631Z","time spent":"577.020428ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T22:20:18.834679Z","caller":"traceutil/trace.go:171","msg":"trace[850937717] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"146.11978ms","start":"2026-06-24T22:20:18.688524Z","end":"2026-06-24T22:20:18.834643Z","steps":["trace[850937717] 'process raft request' (duration: 127.132673ms)","trace[850937717] 'compare' (duration: 18.669669ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:18.83471Z","caller":"traceutil/trace.go:171","msg":"trace[1760783327] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"145.21835ms","start":"2026-06-24T22:20:18.689462Z","end":"2026-06-24T22:20:18.83468Z","steps":["trace[1760783327] 'process raft request' (duration: 145.087558ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:18.834965Z","caller":"traceutil/trace.go:171","msg":"trace[1933038252] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"143.733459ms","start":"2026-06-24T22:20:18.69122Z","end":"2026-06-24T22:20:18.834953Z","steps":["trace[1933038252] 'process raft request' (duration: 143.412722ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:18.835006Z","caller":"traceutil/trace.go:171","msg":"trace[458741859] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:678; }","duration":"144.596687ms","start":"2026-06-24T22:20:18.690386Z","end":"2026-06-24T22:20:18.834983Z","steps":["trace[458741859] 'read index received' (duration: 42.544781ms)","trace[458741859] 'applied index is now lower than readState.Index' (duration: 102.050906ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:18.835133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.73378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-24T22:20:18.835152Z","caller":"traceutil/trace.go:171","msg":"trace[1637486097] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"137.723179ms","start":"2026-06-24T22:20:18.697417Z","end":"2026-06-24T22:20:18.83514Z","steps":["trace[1637486097] 'process raft request' (duration: 137.358531ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:18.835175Z","caller":"traceutil/trace.go:171","msg":"trace[1677286200] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:661; }","duration":"144.804941ms","start":"2026-06-24T22:20:18.690357Z","end":"2026-06-24T22:20:18.835162Z","steps":["trace[1677286200] 'agreement among raft nodes before linearized reading' (duration: 144.72082ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:19.122632Z","caller":"traceutil/trace.go:171","msg":"trace[1296841212] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"277.061062ms","start":"2026-06-24T22:20:18.845531Z","end":"2026-06-24T22:20:19.122592Z","steps":["trace[1296841212] 'process raft request' (duration: 276.801147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:20.546378Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375522924,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:20:21.04712Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375522924,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:20:21.547703Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375522924,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:20:21.768427Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.640553292s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T22:20:22.100985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001008074s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-24T22:20:22.101074Z","caller":"traceutil/trace.go:171","msg":"trace[677968104] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001160627s","start":"2026-06-24T22:20:20.099895Z","end":"2026-06-24T22:20:22.101056Z","steps":["trace[677968104] 'agreement among raft nodes before linearized reading' (duration: 2.001017475s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.101125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:20.099887Z","time spent":"2.001228739s","remote":"127.0.0.1:36784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/24 22:20:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T22:20:22.318242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.511144ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:20:22.318349Z","caller":"traceutil/trace.go:171","msg":"trace[705561596] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"3.190554456s","start":"2026-06-24T22:20:19.127776Z","end":"2026-06-24T22:20:22.31833Z","steps":["trace[705561596] 'process raft request' (duration: 2.640877188s)","trace[705561596] 'compare' (duration: 549.350691ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:22.318406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:19.127756Z","time spent":"3.190627547s","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:20:22.319152Z","caller":"traceutil/trace.go:171","msg":"trace[2043006260] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"3.190945414s","start":"2026-06-24T22:20:19.128183Z","end":"2026-06-24T22:20:22.319128Z","steps":["trace[2043006260] 'process raft request' (duration: 3.19079777s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:22.319258Z","caller":"traceutil/trace.go:171","msg":"trace[148488628] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"3.189582764s","start":"2026-06-24T22:20:19.129655Z","end":"2026-06-24T22:20:22.319238Z","steps":["trace[148488628] 'process raft request' (duration: 3.18938419s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.319322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:19.128122Z","time spent":"3.191115917s","remote":"127.0.0.1:37010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:20:22.319365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:19.129646Z","time spent":"3.189651605s","remote":"127.0.0.1:36958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:20:22.31917Z","caller":"traceutil/trace.go:171","msg":"trace[390118810] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"3.191016955s","start":"2026-06-24T22:20:19.128128Z","end":"2026-06-24T22:20:22.319145Z","steps":["trace[390118810] 'process raft request' (duration: 3.190740389s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.31946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:19.128098Z","time spent":"3.191338033s","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:20:22.319506Z","caller":"traceutil/trace.go:171","msg":"trace[1727649979] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:684; }","duration":"2.274010548s","start":"2026-06-24T22:20:20.045387Z","end":"2026-06-24T22:20:22.319397Z","steps":["trace[1727649979] 'read index received' (duration: 1.723256477s)","trace[1727649979] 'applied index is now lower than readState.Index' (duration: 550.752801ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:22.319613Z","caller":"traceutil/trace.go:171","msg":"trace[2009768166] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"1.959085794s","start":"2026-06-24T22:20:20.360503Z","end":"2026-06-24T22:20:22.319589Z","steps":["trace[2009768166] 'process raft request' (duration: 1.958572092s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.319934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:20.360481Z","time spent":"1.9594074s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:20:22.319782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.274385466s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T22:20:22.320187Z","caller":"traceutil/trace.go:171","msg":"trace[498864527] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:667; }","duration":"2.274885496s","start":"2026-06-24T22:20:20.045291Z","end":"2026-06-24T22:20:22.320176Z","steps":["trace[498864527] 'agreement among raft nodes before linearized reading' (duration: 2.274360295s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.320257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:20.045271Z","time spent":"2.274952108s","remote":"127.0.0.1:36794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" "} {"level":"info","ts":"2026-06-24T22:20:22.324051Z","caller":"traceutil/trace.go:171","msg":"trace[1522478518] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"219.640792ms","start":"2026-06-24T22:20:22.1044Z","end":"2026-06-24T22:20:22.32404Z","steps":["trace[1522478518] 'process raft request' (duration: 219.587261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.324262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.430594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:22.324349Z","caller":"traceutil/trace.go:171","msg":"trace[253533543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"216.541586ms","start":"2026-06-24T22:20:22.107796Z","end":"2026-06-24T22:20:22.324338Z","steps":["trace[253533543] 'agreement among raft nodes before linearized reading' (duration: 216.426044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.324278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.484348186s","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-06-24T22:20:22.324462Z","caller":"traceutil/trace.go:171","msg":"trace[1892180954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:668; }","duration":"1.484590241s","start":"2026-06-24T22:20:20.839863Z","end":"2026-06-24T22:20:22.324454Z","steps":["trace[1892180954] 'agreement among raft nodes before linearized reading' (duration: 1.484341665s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.324492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:20.839832Z","time spent":"1.484653402s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T22:20:22.324295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.484479958s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T22:20:22.324595Z","caller":"traceutil/trace.go:171","msg":"trace[559470489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:668; }","duration":"1.484802515s","start":"2026-06-24T22:20:20.839785Z","end":"2026-06-24T22:20:22.324588Z","steps":["trace[559470489] 'agreement among raft nodes before linearized reading' (duration: 1.484432258s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.324621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:20.839777Z","time spent":"1.484836756s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T22:20:22.324257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.587120676s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-24T22:20:22.324763Z","caller":"traceutil/trace.go:171","msg":"trace[47199922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:668; }","duration":"1.587643517s","start":"2026-06-24T22:20:20.737078Z","end":"2026-06-24T22:20:22.324721Z","steps":["trace[47199922] 'agreement among raft nodes before linearized reading' (duration: 1.587015964s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.324354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.484697702s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-24T22:20:22.324826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:20.737057Z","time spent":"1.58775137s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T22:20:22.324865Z","caller":"traceutil/trace.go:171","msg":"trace[289108180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:668; }","duration":"1.485233154s","start":"2026-06-24T22:20:20.839619Z","end":"2026-06-24T22:20:22.324852Z","steps":["trace[289108180] 'agreement among raft nodes before linearized reading' (duration: 1.484672042s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:22.324935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:20.839595Z","time spent":"1.485319395s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T22:20:23.662246Z","caller":"traceutil/trace.go:171","msg":"trace[1737385300] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"187.783614ms","start":"2026-06-24T22:20:23.474416Z","end":"2026-06-24T22:20:23.6622Z","steps":["trace[1737385300] 'process raft request' (duration: 187.457818ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:25.231017Z","caller":"traceutil/trace.go:171","msg":"trace[981913947] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:713; }","duration":"521.776616ms","start":"2026-06-24T22:20:24.709202Z","end":"2026-06-24T22:20:25.230979Z","steps":["trace[981913947] 'read index received' (duration: 444.032341ms)","trace[981913947] 'applied index is now lower than readState.Index' (duration: 77.742765ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:25.231234Z","caller":"traceutil/trace.go:171","msg":"trace[424326675] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"526.954374ms","start":"2026-06-24T22:20:24.704266Z","end":"2026-06-24T22:20:25.23122Z","steps":["trace[424326675] 'process raft request' (duration: 449.030795ms)","trace[424326675] 'compare' (duration: 77.268846ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:25.23133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.704255Z","time spent":"527.008405ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:20:25.231599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.374268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:25.232313Z","caller":"traceutil/trace.go:171","msg":"trace[1704962767] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:691; }","duration":"523.097923ms","start":"2026-06-24T22:20:24.709198Z","end":"2026-06-24T22:20:25.232296Z","steps":["trace[1704962767] 'agreement among raft nodes before linearized reading' (duration: 522.219665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:25.232405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.709159Z","time spent":"523.220956ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:25.241184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.357144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:20:25.241245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.519978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:20:25.241224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.219061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:25.241293Z","caller":"traceutil/trace.go:171","msg":"trace[2062060903] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"531.503149ms","start":"2026-06-24T22:20:24.709761Z","end":"2026-06-24T22:20:25.241264Z","steps":["trace[2062060903] 'agreement among raft nodes before linearized reading' (duration: 531.301954ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:25.241302Z","caller":"traceutil/trace.go:171","msg":"trace[1748684557] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"137.602809ms","start":"2026-06-24T22:20:25.103674Z","end":"2026-06-24T22:20:25.241277Z","steps":["trace[1748684557] 'agreement among raft nodes before linearized reading' (duration: 137.532948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:25.241321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.415705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:25.24134Z","caller":"traceutil/trace.go:171","msg":"trace[2011228033] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"471.377244ms","start":"2026-06-24T22:20:24.769933Z","end":"2026-06-24T22:20:25.24131Z","steps":["trace[2011228033] 'agreement among raft nodes before linearized reading' (duration: 471.161259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:25.241351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.709755Z","time spent":"531.584321ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-06-24T22:20:25.241359Z","caller":"traceutil/trace.go:171","msg":"trace[7817338] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"471.447366ms","start":"2026-06-24T22:20:24.769899Z","end":"2026-06-24T22:20:25.241346Z","steps":["trace[7817338] 'agreement among raft nodes before linearized reading' (duration: 471.404125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:25.241399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.769907Z","time spent":"471.481267ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:25.24141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.769868Z","time spent":"471.533738ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-06-24T22:20:25.241455Z","caller":"traceutil/trace.go:171","msg":"trace[2020778540] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"475.238135ms","start":"2026-06-24T22:20:24.766207Z","end":"2026-06-24T22:20:25.241445Z","steps":["trace[2020778540] 'process raft request' (duration: 474.663182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:25.241519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.176403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:20:25.241519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.766177Z","time spent":"475.297625ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:20:25.241549Z","caller":"traceutil/trace.go:171","msg":"trace[1578818246] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"475.225385ms","start":"2026-06-24T22:20:24.766315Z","end":"2026-06-24T22:20:25.24154Z","steps":["trace[1578818246] 'agreement among raft nodes before linearized reading' (duration: 475.177014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:25.241579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.766306Z","time spent":"475.266185ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:25.241557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.945145ms","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-06-24T22:20:25.241624Z","caller":"traceutil/trace.go:171","msg":"trace[1566526073] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"471.031016ms","start":"2026-06-24T22:20:24.770577Z","end":"2026-06-24T22:20:25.241608Z","steps":["trace[1566526073] 'agreement among raft nodes before linearized reading' (duration: 470.914534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:25.241618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.073093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:20:25.241656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.77057Z","time spent":"471.079967ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:25.241676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.184202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:20:25.241268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.898028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:25.241677Z","caller":"traceutil/trace.go:171","msg":"trace[631918857] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"338.172014ms","start":"2026-06-24T22:20:24.903487Z","end":"2026-06-24T22:20:25.241659Z","steps":["trace[631918857] 'agreement among raft nodes before linearized reading' (duration: 338.087892ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:25.241708Z","caller":"traceutil/trace.go:171","msg":"trace[826180680] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"531.218213ms","start":"2026-06-24T22:20:24.710476Z","end":"2026-06-24T22:20:25.241695Z","steps":["trace[826180680] 'agreement among raft nodes before linearized reading' (duration: 531.179532ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:25.241716Z","caller":"traceutil/trace.go:171","msg":"trace[1463963617] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"475.349327ms","start":"2026-06-24T22:20:24.766354Z","end":"2026-06-24T22:20:25.241704Z","steps":["trace[1463963617] 'agreement among raft nodes before linearized reading' (duration: 474.849517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:25.241736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.710471Z","time spent":"531.258064ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:25.241753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.76628Z","time spent":"475.463229ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:25.241794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:24.903465Z","time spent":"338.249306ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-06-24T22:20:27.118698Z","caller":"traceutil/trace.go:171","msg":"trace[43306862] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"187.708824ms","start":"2026-06-24T22:20:26.930953Z","end":"2026-06-24T22:20:27.118662Z","steps":["trace[43306862] 'process raft request' (duration: 187.450599ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:27.457036Z","caller":"traceutil/trace.go:171","msg":"trace[336312832] linearizableReadLoop","detail":"{readStateIndex:762; appliedIndex:761; }","duration":"221.067675ms","start":"2026-06-24T22:20:27.235937Z","end":"2026-06-24T22:20:27.457005Z","steps":["trace[336312832] 'read index received' (duration: 190.119357ms)","trace[336312832] 'applied index is now lower than readState.Index' (duration: 30.947308ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:27.457163Z","caller":"traceutil/trace.go:171","msg":"trace[420843975] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"259.274574ms","start":"2026-06-24T22:20:27.197877Z","end":"2026-06-24T22:20:27.457151Z","steps":["trace[420843975] 'process raft request' (duration: 228.298324ms)","trace[420843975] 'compare' (duration: 30.637272ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:27.457545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.586666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T22:20:27.457557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.998213ms","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-06-24T22:20:27.45759Z","caller":"traceutil/trace.go:171","msg":"trace[1394519083] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:738; }","duration":"221.669738ms","start":"2026-06-24T22:20:27.235909Z","end":"2026-06-24T22:20:27.457579Z","steps":["trace[1394519083] 'agreement among raft nodes before linearized reading' (duration: 221.477294ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:27.457627Z","caller":"traceutil/trace.go:171","msg":"trace[2032811300] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:738; }","duration":"154.113636ms","start":"2026-06-24T22:20:27.303494Z","end":"2026-06-24T22:20:27.457608Z","steps":["trace[2032811300] 'agreement among raft nodes before linearized reading' (duration: 153.898911ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:27.889476Z","caller":"traceutil/trace.go:171","msg":"trace[1789312660] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"354.100438ms","start":"2026-06-24T22:20:27.535345Z","end":"2026-06-24T22:20:27.889446Z","steps":["trace[1789312660] 'process raft request' (duration: 283.574705ms)","trace[1789312660] 'compare' (duration: 70.3668ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:27.889635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:27.535305Z","time spent":"354.243361ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188471,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:20:28.081692Z","caller":"traceutil/trace.go:171","msg":"trace[1385748427] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"542.953342ms","start":"2026-06-24T22:20:27.538714Z","end":"2026-06-24T22:20:28.081667Z","steps":["trace[1385748427] 'process raft request' (duration: 455.711501ms)","trace[1385748427] 'compare' (duration: 87.028267ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:28.081858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:27.538687Z","time spent":"543.092706ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:20:28.08199Z","caller":"traceutil/trace.go:171","msg":"trace[383087721] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:763; }","duration":"486.0276ms","start":"2026-06-24T22:20:27.595938Z","end":"2026-06-24T22:20:28.081966Z","steps":["trace[383087721] 'read index received' (duration: 222.948325ms)","trace[383087721] 'applied index is now lower than readState.Index' (duration: 263.078195ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:28.082139Z","caller":"traceutil/trace.go:171","msg":"trace[34137592] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"484.542539ms","start":"2026-06-24T22:20:27.597549Z","end":"2026-06-24T22:20:28.082091Z","steps":["trace[34137592] 'process raft request' (duration: 484.056548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.082215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.265265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-m6pv4\" ","response":"range_response_count:1 size:18067"} {"level":"info","ts":"2026-06-24T22:20:28.082247Z","caller":"traceutil/trace.go:171","msg":"trace[1085561881] range","detail":"{range_begin:/registry/pods/kube-system/cilium-m6pv4; range_end:; response_count:1; response_revision:742; }","duration":"486.339297ms","start":"2026-06-24T22:20:27.595898Z","end":"2026-06-24T22:20:28.082238Z","steps":["trace[1085561881] 'agreement among raft nodes before linearized reading' (duration: 486.187244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.082286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:27.595884Z","time spent":"486.393368ms","remote":"127.0.0.1:36958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18091,"request content":"key:\"/registry/pods/kube-system/cilium-m6pv4\" "} {"level":"warn","ts":"2026-06-24T22:20:28.082298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:27.597521Z","time spent":"484.704382ms","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:20:28.082406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.602356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-06-24T22:20:28.082506Z","caller":"traceutil/trace.go:171","msg":"trace[2122322460] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:742; }","duration":"378.735658ms","start":"2026-06-24T22:20:27.703753Z","end":"2026-06-24T22:20:28.082488Z","steps":["trace[2122322460] 'agreement among raft nodes before linearized reading' (duration: 378.417671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.082641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:27.703738Z","time spent":"378.890882ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4204,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:28.083053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.827289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-06-24T22:20:28.083109Z","caller":"traceutil/trace.go:171","msg":"trace[287214248] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:742; }","duration":"178.926021ms","start":"2026-06-24T22:20:27.904166Z","end":"2026-06-24T22:20:28.083092Z","steps":["trace[287214248] 'agreement among raft nodes before linearized reading' (duration: 178.799178ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:28.301389Z","caller":"traceutil/trace.go:171","msg":"trace[792009460] linearizableReadLoop","detail":"{readStateIndex:767; appliedIndex:766; }","duration":"198.620367ms","start":"2026-06-24T22:20:28.102732Z","end":"2026-06-24T22:20:28.301352Z","steps":["trace[792009460] 'read index received' (duration: 198.390562ms)","trace[792009460] 'applied index is now lower than readState.Index' (duration: 228.125µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:28.301643Z","caller":"traceutil/trace.go:171","msg":"trace[1221481742] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"205.454476ms","start":"2026-06-24T22:20:28.09613Z","end":"2026-06-24T22:20:28.301584Z","steps":["trace[1221481742] 'process raft request' (duration: 204.997497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.301938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.168978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-06-24T22:20:28.302179Z","caller":"traceutil/trace.go:171","msg":"trace[2115288181] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:743; }","duration":"199.472404ms","start":"2026-06-24T22:20:28.102688Z","end":"2026-06-24T22:20:28.30216Z","steps":["trace[2115288181] 'agreement among raft nodes before linearized reading' (duration: 198.894022ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:28.607165Z","caller":"traceutil/trace.go:171","msg":"trace[851821053] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:767; }","duration":"302.975099ms","start":"2026-06-24T22:20:28.304165Z","end":"2026-06-24T22:20:28.60714Z","steps":["trace[851821053] 'read index received' (duration: 302.51011ms)","trace[851821053] 'applied index is now lower than readState.Index' (duration: 463.959µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:28.607332Z","caller":"traceutil/trace.go:171","msg":"trace[887459137] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"436.605751ms","start":"2026-06-24T22:20:28.170693Z","end":"2026-06-24T22:20:28.607299Z","steps":["trace[887459137] 'process raft request' (duration: 436.023969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.607664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.038954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T22:20:28.607779Z","caller":"traceutil/trace.go:171","msg":"trace[2080525612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"216.203957ms","start":"2026-06-24T22:20:28.391557Z","end":"2026-06-24T22:20:28.607761Z","steps":["trace[2080525612] 'agreement among raft nodes before linearized reading' (duration: 215.952612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.607806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:28.170666Z","time spent":"437.061511ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:20:28.607516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.324506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-06-24T22:20:28.608009Z","caller":"traceutil/trace.go:171","msg":"trace[833622926] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:744; }","duration":"303.858786ms","start":"2026-06-24T22:20:28.304135Z","end":"2026-06-24T22:20:28.607994Z","steps":["trace[833622926] 'agreement among raft nodes before linearized reading' (duration: 303.210623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.608046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:28.304115Z","time spent":"303.918138ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24268,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:28.607575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.026564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T22:20:28.608182Z","caller":"traceutil/trace.go:171","msg":"trace[1398422199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"216.683237ms","start":"2026-06-24T22:20:28.39149Z","end":"2026-06-24T22:20:28.608173Z","steps":["trace[1398422199] 'agreement among raft nodes before linearized reading' (duration: 215.927722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.607616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.046055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-06-24T22:20:28.608298Z","caller":"traceutil/trace.go:171","msg":"trace[1357224933] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:744; }","duration":"104.798171ms","start":"2026-06-24T22:20:28.503489Z","end":"2026-06-24T22:20:28.608287Z","steps":["trace[1357224933] 'agreement among raft nodes before linearized reading' (duration: 103.995645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.607661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.085125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T22:20:28.608419Z","caller":"traceutil/trace.go:171","msg":"trace[2109796536] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:744; }","duration":"216.850951ms","start":"2026-06-24T22:20:28.391557Z","end":"2026-06-24T22:20:28.608408Z","steps":["trace[2109796536] 'agreement among raft nodes before linearized reading' (duration: 215.998693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:28.607656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.293439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T22:20:28.608535Z","caller":"traceutil/trace.go:171","msg":"trace[2065721061] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:744; }","duration":"216.208028ms","start":"2026-06-24T22:20:28.392294Z","end":"2026-06-24T22:20:28.608502Z","steps":["trace[2065721061] 'agreement among raft nodes before linearized reading' (duration: 215.153786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:29.296803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.806015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:20:29.29712Z","caller":"traceutil/trace.go:171","msg":"trace[482985225] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"531.144107ms","start":"2026-06-24T22:20:28.765935Z","end":"2026-06-24T22:20:29.297079Z","steps":["trace[482985225] 'process raft request' (duration: 86.001015ms)","trace[482985225] 'compare' (duration: 444.672023ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:29.297203Z","caller":"traceutil/trace.go:171","msg":"trace[269624955] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:773; }","duration":"411.769027ms","start":"2026-06-24T22:20:28.885168Z","end":"2026-06-24T22:20:29.296937Z","steps":["trace[269624955] 'read index received' (duration: 42.711µs)","trace[269624955] 'applied index is now lower than readState.Index' (duration: 411.725066ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:29.297272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:28.765899Z","time spent":"531.29938ms","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:20:29.297409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.231406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T22:20:29.297471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.061729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:29.297513Z","caller":"traceutil/trace.go:171","msg":"trace[1802083456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"196.13984ms","start":"2026-06-24T22:20:29.101359Z","end":"2026-06-24T22:20:29.297499Z","steps":["trace[1802083456] 'agreement among raft nodes before linearized reading' (duration: 196.073068ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:29.297487Z","caller":"traceutil/trace.go:171","msg":"trace[739681151] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:750; }","duration":"412.360709ms","start":"2026-06-24T22:20:28.885112Z","end":"2026-06-24T22:20:29.297473Z","steps":["trace[739681151] 'agreement among raft nodes before linearized reading' (duration: 412.166185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:29.297617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:28.885087Z","time spent":"412.515094ms","remote":"127.0.0.1:36854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":5,"response size":31,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:20:29.297818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.714717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-06-24T22:20:29.297915Z","caller":"traceutil/trace.go:171","msg":"trace[653314806] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:750; }","duration":"393.86224ms","start":"2026-06-24T22:20:28.90403Z","end":"2026-06-24T22:20:29.297892Z","steps":["trace[653314806] 'agreement among raft nodes before linearized reading' (duration: 393.347139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:29.298075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:28.90402Z","time spent":"393.986133ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13253,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-06-24T22:20:29.298185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.257682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-06-24T22:20:29.298248Z","caller":"traceutil/trace.go:171","msg":"trace[123344218] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:750; }","duration":"194.326063ms","start":"2026-06-24T22:20:29.103907Z","end":"2026-06-24T22:20:29.298233Z","steps":["trace[123344218] 'agreement among raft nodes before linearized reading' (duration: 193.508816ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:29.776638Z","caller":"traceutil/trace.go:171","msg":"trace[453394661] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"150.716152ms","start":"2026-06-24T22:20:29.625893Z","end":"2026-06-24T22:20:29.77661Z","steps":["trace[453394661] 'process raft request' (duration: 96.774618ms)","trace[453394661] 'compare' (duration: 53.80008ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:41.19898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375523305,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:20:41.699966Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375523305,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:20:41.835927Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.788330108s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T22:20:41.836226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:40.047444Z","time spent":"1.788778427s","remote":"127.0.0.1:36794","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-24T22:20:41.841255Z","caller":"traceutil/trace.go:171","msg":"trace[1068077727] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"1.170181307s","start":"2026-06-24T22:20:40.671061Z","end":"2026-06-24T22:20:41.841243Z","steps":["trace[1068077727] 'process raft request' (duration: 1.170010774s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:41.841363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:40.671037Z","time spent":"1.170255009s","remote":"127.0.0.1:37010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:20:41.841211Z","caller":"traceutil/trace.go:171","msg":"trace[1855918081] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:858; }","duration":"1.142929912s","start":"2026-06-24T22:20:40.698262Z","end":"2026-06-24T22:20:41.841192Z","steps":["trace[1855918081] 'read index received' (duration: 1.137813102s)","trace[1855918081] 'applied index is now lower than readState.Index' (duration: 5.11603ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:41.8416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1433125s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T22:20:41.841666Z","caller":"traceutil/trace.go:171","msg":"trace[549976116] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:831; }","duration":"1.143442412s","start":"2026-06-24T22:20:40.698211Z","end":"2026-06-24T22:20:41.841654Z","steps":["trace[549976116] 'agreement among raft nodes before linearized reading' (duration: 1.143233538s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:41.841693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:40.698194Z","time spent":"1.143493864s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T22:20:41.851016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.211473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:20:41.851068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.941306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:41.851097Z","caller":"traceutil/trace.go:171","msg":"trace[1413761221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:832; }","duration":"751.000916ms","start":"2026-06-24T22:20:41.100085Z","end":"2026-06-24T22:20:41.851086Z","steps":["trace[1413761221] 'agreement among raft nodes before linearized reading' (duration: 750.968476ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:41.851087Z","caller":"traceutil/trace.go:171","msg":"trace[1341417960] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:832; }","duration":"498.327005ms","start":"2026-06-24T22:20:41.352745Z","end":"2026-06-24T22:20:41.851072Z","steps":["trace[1341417960] 'agreement among raft nodes before linearized reading' (duration: 498.198103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:41.851124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:41.100068Z","time spent":"751.052368ms","remote":"127.0.0.1:36780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T22:20:41.851146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:41.352724Z","time spent":"498.411687ms","remote":"127.0.0.1:37000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:20:41.851206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106825003s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T22:20:41.851243Z","caller":"traceutil/trace.go:171","msg":"trace[814737416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:832; }","duration":"1.106921505s","start":"2026-06-24T22:20:40.744313Z","end":"2026-06-24T22:20:41.851235Z","steps":["trace[814737416] 'agreement among raft nodes before linearized reading' (duration: 1.106820363s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:41.851279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.107013387s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-24T22:20:41.851287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:40.744275Z","time spent":"1.107004047s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T22:20:41.851024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110762461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T22:20:41.851408Z","caller":"traceutil/trace.go:171","msg":"trace[1611823538] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:832; }","duration":"1.111213569s","start":"2026-06-24T22:20:40.740189Z","end":"2026-06-24T22:20:41.851403Z","steps":["trace[1611823538] 'agreement among raft nodes before linearized reading' (duration: 1.11072344s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:41.851431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:40.740172Z","time spent":"1.111252691s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T22:20:41.851451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.422774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T22:20:41.851493Z","caller":"traceutil/trace.go:171","msg":"trace[795971934] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:832; }","duration":"280.490425ms","start":"2026-06-24T22:20:41.570991Z","end":"2026-06-24T22:20:41.851482Z","steps":["trace[795971934] 'agreement among raft nodes before linearized reading' (duration: 280.360972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:41.851548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.905022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:20:41.851303Z","caller":"traceutil/trace.go:171","msg":"trace[718890909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:832; }","duration":"1.107068327s","start":"2026-06-24T22:20:40.744229Z","end":"2026-06-24T22:20:41.851297Z","steps":["trace[718890909] 'agreement among raft nodes before linearized reading' (duration: 1.107007516s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:41.851593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:40.744217Z","time spent":"1.107368064s","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T22:20:41.851584Z","caller":"traceutil/trace.go:171","msg":"trace[446309901] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:832; }","duration":"351.981634ms","start":"2026-06-24T22:20:41.499593Z","end":"2026-06-24T22:20:41.851575Z","steps":["trace[446309901] 'agreement among raft nodes before linearized reading' (duration: 351.888582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:20:41.851662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:20:41.499574Z","time spent":"352.076255ms","remote":"127.0.0.1:36978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"info","ts":"2026-06-24T22:20:44.057277Z","caller":"traceutil/trace.go:171","msg":"trace[1128900481] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"180.649524ms","start":"2026-06-24T22:20:43.8766Z","end":"2026-06-24T22:20:44.05725Z","steps":["trace[1128900481] 'process raft request' (duration: 120.934227ms)","trace[1128900481] 'compare' (duration: 59.599205ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:20:44.058038Z","caller":"traceutil/trace.go:171","msg":"trace[1087299535] linearizableReadLoop","detail":"{readStateIndex:875; appliedIndex:871; }","duration":"161.692538ms","start":"2026-06-24T22:20:43.896327Z","end":"2026-06-24T22:20:44.05802Z","steps":["trace[1087299535] 'read index received' (duration: 101.283337ms)","trace[1087299535] 'applied index is now lower than readState.Index' (duration: 60.408321ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:20:44.058158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.80864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T22:20:44.058205Z","caller":"traceutil/trace.go:171","msg":"trace[1067296199] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:846; }","duration":"161.911501ms","start":"2026-06-24T22:20:43.896284Z","end":"2026-06-24T22:20:44.058195Z","steps":["trace[1067296199] 'agreement among raft nodes before linearized reading' (duration: 161.811649ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:44.058491Z","caller":"traceutil/trace.go:171","msg":"trace[634509303] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"181.059813ms","start":"2026-06-24T22:20:43.877412Z","end":"2026-06-24T22:20:44.058472Z","steps":["trace[634509303] 'process raft request' (duration: 180.574374ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:44.058511Z","caller":"traceutil/trace.go:171","msg":"trace[283166286] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"181.181986ms","start":"2026-06-24T22:20:43.87731Z","end":"2026-06-24T22:20:44.058492Z","steps":["trace[283166286] 'process raft request' (duration: 180.644745ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:44.058466Z","caller":"traceutil/trace.go:171","msg":"trace[657269109] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"181.183856ms","start":"2026-06-24T22:20:43.877272Z","end":"2026-06-24T22:20:44.058456Z","steps":["trace[657269109] 'process raft request' (duration: 180.537173ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:20:56.910689Z","caller":"traceutil/trace.go:171","msg":"trace[158825862] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"168.19142ms","start":"2026-06-24T22:20:56.742472Z","end":"2026-06-24T22:20:56.910664Z","steps":["trace[158825862] 'process raft request' (duration: 168.029906ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:08.247913Z","caller":"traceutil/trace.go:171","msg":"trace[1033177502] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1079; }","duration":"148.827242ms","start":"2026-06-24T22:21:08.099065Z","end":"2026-06-24T22:21:08.247892Z","steps":["trace[1033177502] 'read index received' (duration: 148.653779ms)","trace[1033177502] 'applied index is now lower than readState.Index' (duration: 172.613µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:08.248305Z","caller":"traceutil/trace.go:171","msg":"trace[1235594862] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"239.765316ms","start":"2026-06-24T22:21:08.008509Z","end":"2026-06-24T22:21:08.248274Z","steps":["trace[1235594862] 'process raft request' (duration: 239.263767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:08.248363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.29481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:21:08.248428Z","caller":"traceutil/trace.go:171","msg":"trace[2032538964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1046; }","duration":"149.402422ms","start":"2026-06-24T22:21:08.09901Z","end":"2026-06-24T22:21:08.248413Z","steps":["trace[2032538964] 'agreement among raft nodes before linearized reading' (duration: 149.28702ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:13.352085Z","caller":"traceutil/trace.go:171","msg":"trace[730114814] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1098; }","duration":"251.330592ms","start":"2026-06-24T22:21:13.100738Z","end":"2026-06-24T22:21:13.352068Z","steps":["trace[730114814] 'read index received' (duration: 251.165009ms)","trace[730114814] 'applied index is now lower than readState.Index' (duration: 164.873µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:21:13.352222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.474354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:21:13.352247Z","caller":"traceutil/trace.go:171","msg":"trace[584196470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1064; }","duration":"251.552806ms","start":"2026-06-24T22:21:13.100685Z","end":"2026-06-24T22:21:13.352238Z","steps":["trace[584196470] 'agreement among raft nodes before linearized reading' (duration: 251.459094ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:13.352441Z","caller":"traceutil/trace.go:171","msg":"trace[282202267] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"306.05618ms","start":"2026-06-24T22:21:13.046356Z","end":"2026-06-24T22:21:13.352413Z","steps":["trace[282202267] 'process raft request' (duration: 305.603522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:13.352585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:13.046339Z","time spent":"306.170752ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:21:13.560212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.025862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T22:21:13.560306Z","caller":"traceutil/trace.go:171","msg":"trace[294182171] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1065; }","duration":"112.181584ms","start":"2026-06-24T22:21:13.448107Z","end":"2026-06-24T22:21:13.560288Z","steps":["trace[294182171] 'count revisions from in-memory index tree' (duration: 111.90571ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:14.480295Z","caller":"traceutil/trace.go:171","msg":"trace[840411163] linearizableReadLoop","detail":"{readStateIndex:1102; appliedIndex:1101; }","duration":"125.021978ms","start":"2026-06-24T22:21:14.355243Z","end":"2026-06-24T22:21:14.480265Z","steps":["trace[840411163] 'read index received' (duration: 30.354201ms)","trace[840411163] 'applied index is now lower than readState.Index' (duration: 94.666077ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:14.480377Z","caller":"traceutil/trace.go:171","msg":"trace[1134724623] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"132.035044ms","start":"2026-06-24T22:21:14.348307Z","end":"2026-06-24T22:21:14.480342Z","steps":["trace[1134724623] 'process raft request' (duration: 37.342027ms)","trace[1134724623] 'compare' (duration: 94.453483ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:21:14.481202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.916796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T22:21:14.481274Z","caller":"traceutil/trace.go:171","msg":"trace[596423649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1067; }","duration":"126.043577ms","start":"2026-06-24T22:21:14.355212Z","end":"2026-06-24T22:21:14.481255Z","steps":["trace[596423649] 'agreement among raft nodes before linearized reading' (duration: 125.251403ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:15.221593Z","caller":"traceutil/trace.go:171","msg":"trace[1290889455] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"115.135208ms","start":"2026-06-24T22:21:15.106428Z","end":"2026-06-24T22:21:15.221564Z","steps":["trace[1290889455] 'process raft request' (duration: 75.153667ms)","trace[1290889455] 'compare' (duration: 39.844789ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:21:16.585445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.026606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T22:21:16.585638Z","caller":"traceutil/trace.go:171","msg":"trace[1869888174] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1077; }","duration":"100.233429ms","start":"2026-06-24T22:21:16.485387Z","end":"2026-06-24T22:21:16.58562Z","steps":["trace[1869888174] 'range keys from in-memory index tree' (duration: 99.829222ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:16.876448Z","caller":"traceutil/trace.go:171","msg":"trace[146600617] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"286.269622ms","start":"2026-06-24T22:21:16.590117Z","end":"2026-06-24T22:21:16.876386Z","steps":["trace[146600617] 'process raft request' (duration: 254.417736ms)","trace[146600617] 'compare' (duration: 31.664263ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:16.876657Z","caller":"traceutil/trace.go:171","msg":"trace[1164587854] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"286.201021ms","start":"2026-06-24T22:21:16.59044Z","end":"2026-06-24T22:21:16.876641Z","steps":["trace[1164587854] 'process raft request' (duration: 286.103349ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:16.876649Z","caller":"traceutil/trace.go:171","msg":"trace[666465983] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"286.517406ms","start":"2026-06-24T22:21:16.590113Z","end":"2026-06-24T22:21:16.87663Z","steps":["trace[666465983] 'process raft request' (duration: 286.230031ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:17.479093Z","caller":"traceutil/trace.go:171","msg":"trace[1518515443] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"109.676913ms","start":"2026-06-24T22:21:17.369386Z","end":"2026-06-24T22:21:17.479063Z","steps":["trace[1518515443] 'process raft request' (duration: 109.52124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:18.949832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.573119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:21:18.949923Z","caller":"traceutil/trace.go:171","msg":"trace[2038653658] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1083; }","duration":"104.723532ms","start":"2026-06-24T22:21:18.845178Z","end":"2026-06-24T22:21:18.949902Z","steps":["trace[2038653658] 'count revisions from in-memory index tree' (duration: 104.424606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:18.949941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.780277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T22:21:18.949985Z","caller":"traceutil/trace.go:171","msg":"trace[1719871391] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1083; }","duration":"330.857978ms","start":"2026-06-24T22:21:18.619117Z","end":"2026-06-24T22:21:18.949975Z","steps":["trace[1719871391] 'range keys from in-memory index tree' (duration: 330.649724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:18.950011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:18.619102Z","time spent":"330.903798ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-24T22:21:19.343106Z","caller":"traceutil/trace.go:171","msg":"trace[971404079] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"388.966393ms","start":"2026-06-24T22:21:18.954116Z","end":"2026-06-24T22:21:19.343082Z","steps":["trace[971404079] 'process raft request' (duration: 388.893491ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:19.343186Z","caller":"traceutil/trace.go:171","msg":"trace[1251364237] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"389.028064ms","start":"2026-06-24T22:21:18.954112Z","end":"2026-06-24T22:21:19.34314Z","steps":["trace[1251364237] 'process raft request' (duration: 388.744289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:19.343415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:18.9541Z","time spent":"389.186966ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:21:19.343529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:18.954099Z","time spent":"389.346719ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:21:19.574043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.519308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:21:19.574271Z","caller":"traceutil/trace.go:171","msg":"trace[1484453756] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"619.924706ms","start":"2026-06-24T22:21:18.954322Z","end":"2026-06-24T22:21:19.574247Z","steps":["trace[1484453756] 'process raft request' (duration: 619.850515ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:19.574291Z","caller":"traceutil/trace.go:171","msg":"trace[701801570] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"620.08759ms","start":"2026-06-24T22:21:18.954173Z","end":"2026-06-24T22:21:19.574261Z","steps":["trace[701801570] 'process raft request' (duration: 432.209236ms)","trace[701801570] 'compare' (duration: 187.346414ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:21:19.574356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:18.954314Z","time spent":"620.006048ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:21:19.574444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:18.954165Z","time spent":"620.187351ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:21:19.775038Z","caller":"traceutil/trace.go:171","msg":"trace[839345128] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"290.327039ms","start":"2026-06-24T22:21:19.484675Z","end":"2026-06-24T22:21:19.775002Z","steps":["trace[839345128] 'process raft request' (duration: 200.996975ms)","trace[839345128] 'compare' (duration: 89.160391ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:20.210842Z","caller":"traceutil/trace.go:171","msg":"trace[689190758] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"110.549065ms","start":"2026-06-24T22:21:20.10027Z","end":"2026-06-24T22:21:20.210819Z","steps":["trace[689190758] 'read index received' (duration: 110.488404ms)","trace[689190758] 'applied index is now lower than readState.Index' (duration: 59.431µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:21:20.210957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.677477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:21:20.210985Z","caller":"traceutil/trace.go:171","msg":"trace[610207381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1088; }","duration":"110.75192ms","start":"2026-06-24T22:21:20.100224Z","end":"2026-06-24T22:21:20.210976Z","steps":["trace[610207381] 'agreement among raft nodes before linearized reading' (duration: 110.687039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:20.397816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.238511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:21:20.397939Z","caller":"traceutil/trace.go:171","msg":"trace[1534333859] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"185.630947ms","start":"2026-06-24T22:21:20.212284Z","end":"2026-06-24T22:21:20.397915Z","steps":["trace[1534333859] 'process raft request' (duration: 84.202632ms)","trace[1534333859] 'compare' (duration: 101.101159ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:20.596094Z","caller":"traceutil/trace.go:171","msg":"trace[1267727481] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"143.534656ms","start":"2026-06-24T22:21:20.452508Z","end":"2026-06-24T22:21:20.596043Z","steps":["trace[1267727481] 'process raft request' (duration: 54.827016ms)","trace[1267727481] 'compare' (duration: 88.548078ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:21:22.079528Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375523842,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T22:21:22.207286Z","caller":"traceutil/trace.go:171","msg":"trace[264352768] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"855.579452ms","start":"2026-06-24T22:21:21.351684Z","end":"2026-06-24T22:21:22.207263Z","steps":["trace[264352768] 'process raft request' (duration: 855.45645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:22.20758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:21.351664Z","time spent":"855.861127ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:21:22.295225Z","caller":"traceutil/trace.go:171","msg":"trace[778728076] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1128; }","duration":"715.790422ms","start":"2026-06-24T22:21:21.579408Z","end":"2026-06-24T22:21:22.295199Z","steps":["trace[778728076] 'read index received' (duration: 627.729859ms)","trace[778728076] 'applied index is now lower than readState.Index' (duration: 88.059053ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:22.295276Z","caller":"traceutil/trace.go:171","msg":"trace[1221038229] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"513.708492ms","start":"2026-06-24T22:21:21.781548Z","end":"2026-06-24T22:21:22.295256Z","steps":["trace[1221038229] 'process raft request' (duration: 513.58434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:22.29541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.464657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:21:22.295411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.980886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T22:21:22.295466Z","caller":"traceutil/trace.go:171","msg":"trace[1339930995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1093; }","duration":"195.553959ms","start":"2026-06-24T22:21:22.0999Z","end":"2026-06-24T22:21:22.295454Z","steps":["trace[1339930995] 'agreement among raft nodes before linearized reading' (duration: 195.488778ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:22.295475Z","caller":"traceutil/trace.go:171","msg":"trace[64850125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1093; }","duration":"716.093718ms","start":"2026-06-24T22:21:21.579368Z","end":"2026-06-24T22:21:22.295461Z","steps":["trace[64850125] 'agreement among raft nodes before linearized reading' (duration: 715.913975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:22.295511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:21.579347Z","time spent":"716.155449ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T22:21:22.295515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.084847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T22:21:22.29557Z","caller":"traceutil/trace.go:171","msg":"trace[1369770460] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1093; }","duration":"716.18668ms","start":"2026-06-24T22:21:21.579368Z","end":"2026-06-24T22:21:22.295555Z","steps":["trace[1369770460] 'agreement among raft nodes before linearized reading' (duration: 715.969286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:22.295576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:21.781524Z","time spent":"513.890876ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:21:22.295666Z","caller":"traceutil/trace.go:171","msg":"trace[1800576107] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"942.347082ms","start":"2026-06-24T22:21:21.353311Z","end":"2026-06-24T22:21:22.295658Z","steps":["trace[1800576107] 'process raft request' (duration: 940.814166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:22.295624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:21.579347Z","time spent":"716.26504ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T22:21:22.295733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:21.353284Z","time spent":"942.406743ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:21:23.751159Z","caller":"traceutil/trace.go:171","msg":"trace[115660351] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"171.582171ms","start":"2026-06-24T22:21:23.579547Z","end":"2026-06-24T22:21:23.751129Z","steps":["trace[115660351] 'process raft request' (duration: 171.395038ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:28.457239Z","caller":"traceutil/trace.go:171","msg":"trace[1055994994] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"219.205269ms","start":"2026-06-24T22:21:28.238005Z","end":"2026-06-24T22:21:28.457211Z","steps":["trace[1055994994] 'process raft request' (duration: 219.061287ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:32.57187Z","caller":"traceutil/trace.go:171","msg":"trace[546370164] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"103.925268ms","start":"2026-06-24T22:21:32.46792Z","end":"2026-06-24T22:21:32.571846Z","steps":["trace[546370164] 'process raft request' (duration: 103.777005ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:32.728992Z","caller":"traceutil/trace.go:171","msg":"trace[1020111821] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1163; }","duration":"188.84411ms","start":"2026-06-24T22:21:32.540125Z","end":"2026-06-24T22:21:32.72897Z","steps":["trace[1020111821] 'read index received' (duration: 31.553903ms)","trace[1020111821] 'applied index is now lower than readState.Index' (duration: 157.289147ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:32.729111Z","caller":"traceutil/trace.go:171","msg":"trace[898010440] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"257.760705ms","start":"2026-06-24T22:21:32.471337Z","end":"2026-06-24T22:21:32.729098Z","steps":["trace[898010440] 'process raft request' (duration: 240.733282ms)","trace[898010440] 'compare' (duration: 16.642106ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:21:32.729252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.631235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T22:21:32.729319Z","caller":"traceutil/trace.go:171","msg":"trace[1950144307] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1125; }","duration":"181.727587ms","start":"2026-06-24T22:21:32.547572Z","end":"2026-06-24T22:21:32.729299Z","steps":["trace[1950144307] 'agreement among raft nodes before linearized reading' (duration: 181.558424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:32.729418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.274667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T22:21:32.729465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.590417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T22:21:32.729481Z","caller":"traceutil/trace.go:171","msg":"trace[1866577267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1125; }","duration":"189.370968ms","start":"2026-06-24T22:21:32.540093Z","end":"2026-06-24T22:21:32.729464Z","steps":["trace[1866577267] 'agreement among raft nodes before linearized reading' (duration: 189.193355ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:32.729503Z","caller":"traceutil/trace.go:171","msg":"trace[73087318] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1125; }","duration":"180.664499ms","start":"2026-06-24T22:21:32.54883Z","end":"2026-06-24T22:21:32.729495Z","steps":["trace[73087318] 'agreement among raft nodes before linearized reading' (duration: 180.572527ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:34.885928Z","caller":"traceutil/trace.go:171","msg":"trace[1981507817] linearizableReadLoop","detail":"{readStateIndex:1171; appliedIndex:1170; }","duration":"149.464923ms","start":"2026-06-24T22:21:34.736439Z","end":"2026-06-24T22:21:34.885904Z","steps":["trace[1981507817] 'read index received' (duration: 149.241048ms)","trace[1981507817] 'applied index is now lower than readState.Index' (duration: 222.995µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:34.88606Z","caller":"traceutil/trace.go:171","msg":"trace[773221299] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"308.394798ms","start":"2026-06-24T22:21:34.577645Z","end":"2026-06-24T22:21:34.88604Z","steps":["trace[773221299] 'process raft request' (duration: 308.099542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:21:34.886152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.709727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-24T22:21:34.886174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.989097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-24T22:21:34.886195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:21:34.577629Z","time spent":"308.47845ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:21:34.886219Z","caller":"traceutil/trace.go:171","msg":"trace[678680682] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1131; }","duration":"120.068089ms","start":"2026-06-24T22:21:34.766138Z","end":"2026-06-24T22:21:34.886206Z","steps":["trace[678680682] 'agreement among raft nodes before linearized reading' (duration: 119.931067ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:34.886195Z","caller":"traceutil/trace.go:171","msg":"trace[1764847722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1131; }","duration":"149.794929ms","start":"2026-06-24T22:21:34.736388Z","end":"2026-06-24T22:21:34.886183Z","steps":["trace[1764847722] 'agreement among raft nodes before linearized reading' (duration: 149.648356ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:35.38571Z","caller":"traceutil/trace.go:171","msg":"trace[1759417811] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"165.733626ms","start":"2026-06-24T22:21:35.219956Z","end":"2026-06-24T22:21:35.38569Z","steps":["trace[1759417811] 'process raft request' (duration: 165.601094ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:39.033005Z","caller":"traceutil/trace.go:171","msg":"trace[1517229926] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"102.524896ms","start":"2026-06-24T22:21:38.930432Z","end":"2026-06-24T22:21:39.032957Z","steps":["trace[1517229926] 'process raft request' (duration: 102.18336ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:39.258543Z","caller":"traceutil/trace.go:171","msg":"trace[502840652] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"221.69942ms","start":"2026-06-24T22:21:39.036811Z","end":"2026-06-24T22:21:39.25851Z","steps":["trace[502840652] 'process raft request' (duration: 150.875896ms)","trace[502840652] 'compare' (duration: 70.321845ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:39.258879Z","caller":"traceutil/trace.go:171","msg":"trace[1317744760] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"220.703483ms","start":"2026-06-24T22:21:39.038149Z","end":"2026-06-24T22:21:39.258852Z","steps":["trace[1317744760] 'process raft request' (duration: 220.246545ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:39.258926Z","caller":"traceutil/trace.go:171","msg":"trace[129499997] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"220.467519ms","start":"2026-06-24T22:21:39.038448Z","end":"2026-06-24T22:21:39.258916Z","steps":["trace[129499997] 'process raft request' (duration: 220.245565ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:39.259001Z","caller":"traceutil/trace.go:171","msg":"trace[769292942] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"220.233116ms","start":"2026-06-24T22:21:39.03876Z","end":"2026-06-24T22:21:39.258993Z","steps":["trace[769292942] 'process raft request' (duration: 219.95197ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:41.443474Z","caller":"traceutil/trace.go:171","msg":"trace[1266971907] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"176.437701ms","start":"2026-06-24T22:21:41.266996Z","end":"2026-06-24T22:21:41.443434Z","steps":["trace[1266971907] 'process raft request' (duration: 175.114849ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:41.443485Z","caller":"traceutil/trace.go:171","msg":"trace[578971016] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"176.42523ms","start":"2026-06-24T22:21:41.267028Z","end":"2026-06-24T22:21:41.443453Z","steps":["trace[578971016] 'process raft request' (duration: 176.297208ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:41.443449Z","caller":"traceutil/trace.go:171","msg":"trace[2067798550] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"176.36374ms","start":"2026-06-24T22:21:41.26706Z","end":"2026-06-24T22:21:41.443424Z","steps":["trace[2067798550] 'process raft request' (duration: 176.318619ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:43.608498Z","caller":"traceutil/trace.go:171","msg":"trace[1822720887] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"154.262357ms","start":"2026-06-24T22:21:43.454197Z","end":"2026-06-24T22:21:43.608459Z","steps":["trace[1822720887] 'process raft request' (duration: 154.185666ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:21:43.60862Z","caller":"traceutil/trace.go:171","msg":"trace[1350930893] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"155.396496ms","start":"2026-06-24T22:21:43.453186Z","end":"2026-06-24T22:21:43.608582Z","steps":["trace[1350930893] 'process raft request' (duration: 94.541168ms)","trace[1350930893] 'compare' (duration: 60.37543ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:21:55.811537Z","caller":"traceutil/trace.go:171","msg":"trace[1223188343] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"137.382684ms","start":"2026-06-24T22:21:55.674121Z","end":"2026-06-24T22:21:55.811503Z","steps":["trace[1223188343] 'process raft request' (duration: 84.192519ms)","trace[1223188343] 'compare' (duration: 53.008962ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:13.552015Z","caller":"traceutil/trace.go:171","msg":"trace[268650835] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1303; }","duration":"104.125677ms","start":"2026-06-24T22:22:13.447866Z","end":"2026-06-24T22:22:13.551991Z","steps":["trace[268650835] 'read index received' (duration: 103.995965ms)","trace[268650835] 'applied index is now lower than readState.Index' (duration: 128.822µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:13.552124Z","caller":"traceutil/trace.go:171","msg":"trace[301648468] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"116.937495ms","start":"2026-06-24T22:22:13.435148Z","end":"2026-06-24T22:22:13.552085Z","steps":["trace[301648468] 'process raft request' (duration: 116.688041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:22:13.552463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.576884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T22:22:13.552595Z","caller":"traceutil/trace.go:171","msg":"trace[1912883911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1256; }","duration":"104.668635ms","start":"2026-06-24T22:22:13.447851Z","end":"2026-06-24T22:22:13.55252Z","steps":["trace[1912883911] 'agreement among raft nodes before linearized reading' (duration: 104.245159ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:22:22.275623Z","caller":"traceutil/trace.go:171","msg":"trace[1101211449] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"128.387756ms","start":"2026-06-24T22:22:22.147216Z","end":"2026-06-24T22:22:22.275604Z","steps":["trace[1101211449] 'process raft request' (duration: 53.76706ms)","trace[1101211449] 'compare' (duration: 74.514664ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:25.169147Z","caller":"traceutil/trace.go:171","msg":"trace[1880557771] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"115.921418ms","start":"2026-06-24T22:22:25.05316Z","end":"2026-06-24T22:22:25.169081Z","steps":["trace[1880557771] 'process raft request' (duration: 115.703545ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:22:29.975514Z","caller":"traceutil/trace.go:171","msg":"trace[699710838] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"160.481149ms","start":"2026-06-24T22:22:29.814999Z","end":"2026-06-24T22:22:29.975481Z","steps":["trace[699710838] 'process raft request' (duration: 84.916135ms)","trace[699710838] 'compare' (duration: 75.429142ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:30.35462Z","caller":"traceutil/trace.go:171","msg":"trace[581716028] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"213.153284ms","start":"2026-06-24T22:22:30.141437Z","end":"2026-06-24T22:22:30.35459Z","steps":["trace[581716028] 'process raft request' (duration: 195.49461ms)","trace[581716028] 'compare' (duration: 17.543272ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:32.35576Z","caller":"traceutil/trace.go:171","msg":"trace[171037967] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"113.524682ms","start":"2026-06-24T22:22:32.242211Z","end":"2026-06-24T22:22:32.355735Z","steps":["trace[171037967] 'process raft request' (duration: 113.368428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:22:32.858765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208187203375524518,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:22:32.984363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.451902ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:22:32.984447Z","caller":"traceutil/trace.go:171","msg":"trace[545105556] linearizableReadLoop","detail":"{readStateIndex:1406; appliedIndex:1405; }","duration":"625.914278ms","start":"2026-06-24T22:22:32.358517Z","end":"2026-06-24T22:22:32.984431Z","steps":["trace[545105556] 'read index received' (duration: 500.344354ms)","trace[545105556] 'applied index is now lower than readState.Index' (duration: 125.568464ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:32.984449Z","caller":"traceutil/trace.go:171","msg":"trace[216867631] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"741.688785ms","start":"2026-06-24T22:22:32.242746Z","end":"2026-06-24T22:22:32.984435Z","steps":["trace[216867631] 'process raft request' (duration: 616.05767ms)","trace[216867631] 'compare' (duration: 125.245799ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:22:32.984517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:22:32.242728Z","time spent":"741.761637ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:22:32.984483Z","caller":"etcdserver/v3_server.go:874","msg":"ignored out-of-date read index response; local node read indexes queueing up and waiting to be in sync with leader","sent-request-id":14208187203375524521,"received-request-id":14208187203375524518} {"level":"warn","ts":"2026-06-24T22:22:32.984665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.150002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T22:22:32.98469Z","caller":"traceutil/trace.go:171","msg":"trace[389798507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1352; }","duration":"626.233833ms","start":"2026-06-24T22:22:32.358448Z","end":"2026-06-24T22:22:32.984681Z","steps":["trace[389798507] 'agreement among raft nodes before linearized reading' (duration: 626.130532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:22:32.984719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:22:32.358431Z","time spent":"626.281184ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T22:22:32.984728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.194205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T22:22:32.984748Z","caller":"traceutil/trace.go:171","msg":"trace[1942550101] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1352; }","duration":"522.252195ms","start":"2026-06-24T22:22:32.462489Z","end":"2026-06-24T22:22:32.984742Z","steps":["trace[1942550101] 'agreement among raft nodes before linearized reading' (duration: 522.208864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:22:32.984771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:22:32.462465Z","time spent":"522.300186ms","remote":"127.0.0.1:36870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":16,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:22:32.984962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.386265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:22:32.984983Z","caller":"traceutil/trace.go:171","msg":"trace[1325282639] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1352; }","duration":"404.450187ms","start":"2026-06-24T22:22:32.580527Z","end":"2026-06-24T22:22:32.984977Z","steps":["trace[1325282639] 'agreement among raft nodes before linearized reading' (duration: 404.416786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:22:32.985002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:22:32.580506Z","time spent":"404.490447ms","remote":"127.0.0.1:35086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-24T22:22:33.178829Z","caller":"traceutil/trace.go:171","msg":"trace[708747581] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"190.356151ms","start":"2026-06-24T22:22:32.988432Z","end":"2026-06-24T22:22:33.178789Z","steps":["trace[708747581] 'process raft request' (duration: 108.220025ms)","trace[708747581] 'compare' (duration: 81.74746ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:34.070963Z","caller":"traceutil/trace.go:171","msg":"trace[194040086] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"178.391809ms","start":"2026-06-24T22:22:33.892548Z","end":"2026-06-24T22:22:34.07094Z","steps":["trace[194040086] 'process raft request' (duration: 178.174315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:22:50.445187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.443231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-envoy-gateway-rolebinding\" ","response":"range_response_count:1 size:842"} {"level":"info","ts":"2026-06-24T22:22:50.445262Z","caller":"traceutil/trace.go:171","msg":"trace[690956782] linearizableReadLoop","detail":"{readStateIndex:1479; appliedIndex:1478; }","duration":"102.7253ms","start":"2026-06-24T22:22:50.342514Z","end":"2026-06-24T22:22:50.44524Z","steps":["trace[690956782] 'read index received' (duration: 4.124606ms)","trace[690956782] 'applied index is now lower than readState.Index' (duration: 98.598874ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:50.445296Z","caller":"traceutil/trace.go:171","msg":"trace[1935748793] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-envoy-gateway-rolebinding; range_end:; response_count:1; response_revision:1420; }","duration":"103.601593ms","start":"2026-06-24T22:22:50.341672Z","end":"2026-06-24T22:22:50.445274Z","steps":["trace[1935748793] 'range keys from in-memory index tree' (duration: 103.225617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:22:50.445459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.931873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ephemeral-volume-controller\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-06-24T22:22:50.445453Z","caller":"traceutil/trace.go:171","msg":"trace[91577232] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"103.558802ms","start":"2026-06-24T22:22:50.341856Z","end":"2026-06-24T22:22:50.445414Z","steps":["trace[91577232] 'compare' (duration: 98.38821ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:22:50.445528Z","caller":"traceutil/trace.go:171","msg":"trace[1692103364] range","detail":"{range_begin:/registry/clusterroles/system:controller:ephemeral-volume-controller; range_end:; response_count:1; response_revision:1421; }","duration":"103.021104ms","start":"2026-06-24T22:22:50.34249Z","end":"2026-06-24T22:22:50.445511Z","steps":["trace[1692103364] 'agreement among raft nodes before linearized reading' (duration: 102.821091ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:22:52.496857Z","caller":"traceutil/trace.go:171","msg":"trace[1359526237] linearizableReadLoop","detail":"{readStateIndex:1484; appliedIndex:1483; }","duration":"105.907306ms","start":"2026-06-24T22:22:52.390929Z","end":"2026-06-24T22:22:52.496836Z","steps":["trace[1359526237] 'read index received' (duration: 105.716743ms)","trace[1359526237] 'applied index is now lower than readState.Index' (duration: 189.803µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:22:52.496945Z","caller":"traceutil/trace.go:171","msg":"trace[400110049] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"152.620207ms","start":"2026-06-24T22:22:52.344294Z","end":"2026-06-24T22:22:52.496915Z","steps":["trace[400110049] 'process raft request' (duration: 152.412294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:22:52.497094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.12963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:deployment-controller\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-06-24T22:22:52.497192Z","caller":"traceutil/trace.go:171","msg":"trace[187133318] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:deployment-controller; range_end:; response_count:1; response_revision:1426; }","duration":"106.287973ms","start":"2026-06-24T22:22:52.390883Z","end":"2026-06-24T22:22:52.497171Z","steps":["trace[187133318] 'agreement among raft nodes before linearized reading' (duration: 106.07155ms)"],"step_count":1}