{"level":"warn","ts":"2026-08-22T14:35:08.031992Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T14:35:08.032062Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.232:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.232:2380","--initial-cluster=instance=https://199.19.213.232:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.232:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.232: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-08-22T14:35:08.032124Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T14:35:08.032136Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.232:2380"]} {"level":"info","ts":"2026-08-22T14:35:08.032154Z","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-08-22T14:35:08.032757Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"]} {"level":"info","ts":"2026-08-22T14:35:08.032827Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.232:2380"],"listen-peer-urls":["https://199.19.213.232:2380"],"advertise-client-urls":["https://199.19.213.232:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.232: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-08-22T14:35:08.03665Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.631475ms"} {"level":"info","ts":"2026-08-22T14:35:08.04349Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"20a2700e013b1fa5","cluster-id":"b7b35e617ebc7ac7"} {"level":"info","ts":"2026-08-22T14:35:08.043556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T14:35:08.043574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became follower at term 0"} {"level":"info","ts":"2026-08-22T14:35:08.043587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 20a2700e013b1fa5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T14:35:08.0436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became follower at term 1"} {"level":"info","ts":"2026-08-22T14:35:08.043635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=(2351565160893325221)"} {"level":"warn","ts":"2026-08-22T14:35:08.052351Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T14:35:08.053831Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T14:35:08.054945Z","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-08-22T14:35:08.057068Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"20a2700e013b1fa5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T14:35:08.057656Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"20a2700e013b1fa5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T14:35:08.05776Z","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-08-22T14:35:08.057806Z","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-08-22T14:35:08.057826Z","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-08-22T14:35:08.058571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=(2351565160893325221)"} {"level":"info","ts":"2026-08-22T14:35:08.059203Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b7b35e617ebc7ac7","local-member-id":"20a2700e013b1fa5","added-peer-id":"20a2700e013b1fa5","added-peer-peer-urls":["https://199.19.213.232:2380"]} {"level":"info","ts":"2026-08-22T14:35:08.063063Z","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-08-22T14:35:08.063338Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"20a2700e013b1fa5","initial-advertise-peer-urls":["https://199.19.213.232:2380"],"listen-peer-urls":["https://199.19.213.232:2380"],"advertise-client-urls":["https://199.19.213.232:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T14:35:08.063375Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T14:35:08.063439Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.232:2380"} {"level":"info","ts":"2026-08-22T14:35:08.063465Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.232:2380"} {"level":"info","ts":"2026-08-22T14:35:08.444905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T14:35:08.444963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T14:35:08.444986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 received MsgPreVoteResp from 20a2700e013b1fa5 at term 1"} {"level":"info","ts":"2026-08-22T14:35:08.445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became candidate at term 2"} {"level":"info","ts":"2026-08-22T14:35:08.445005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 received MsgVoteResp from 20a2700e013b1fa5 at term 2"} {"level":"info","ts":"2026-08-22T14:35:08.445014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became leader at term 2"} {"level":"info","ts":"2026-08-22T14:35:08.445024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 20a2700e013b1fa5 elected leader 20a2700e013b1fa5 at term 2"} {"level":"info","ts":"2026-08-22T14:35:08.447131Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"20a2700e013b1fa5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.232:2379]}","request-path":"/0/members/20a2700e013b1fa5/attributes","cluster-id":"b7b35e617ebc7ac7","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T14:35:08.447421Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:35:08.447749Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T14:35:08.447951Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T14:35:08.448334Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T14:35:08.448409Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T14:35:08.448499Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b7b35e617ebc7ac7","local-member-id":"20a2700e013b1fa5","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:35:08.448591Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:35:08.448614Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:35:08.450672Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T14:35:08.451833Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.232:2379"} {"level":"info","ts":"2026-08-22T14:35:09.970008Z","caller":"traceutil/trace.go:171","msg":"trace[1081205075] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"287.265577ms","start":"2026-08-22T14:35:09.682695Z","end":"2026-08-22T14:35:09.969961Z","steps":["trace[1081205075] 'read index received' (duration: 84.591729ms)","trace[1081205075] 'applied index is now lower than readState.Index' (duration: 202.673018ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:35:09.970126Z","caller":"traceutil/trace.go:171","msg":"trace[768551743] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"252.673936ms","start":"2026-08-22T14:35:09.717405Z","end":"2026-08-22T14:35:09.970079Z","steps":["trace[768551743] 'process raft request' (duration: 252.363031ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970152Z","caller":"traceutil/trace.go:171","msg":"trace[230904853] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"252.92454ms","start":"2026-08-22T14:35:09.71722Z","end":"2026-08-22T14:35:09.970144Z","steps":["trace[230904853] 'process raft request' (duration: 252.394251ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970314Z","caller":"traceutil/trace.go:171","msg":"trace[1538585616] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"299.65417ms","start":"2026-08-22T14:35:09.670647Z","end":"2026-08-22T14:35:09.970301Z","steps":["trace[1538585616] 'process raft request' (duration: 298.817315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:09.970467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.607933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-22T14:35:09.970501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.395485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.232\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:35:09.970589Z","caller":"traceutil/trace.go:171","msg":"trace[1037554013] range","detail":"{range_begin:/registry/masterleases/199.19.213.232; range_end:; response_count:0; response_revision:11; }","duration":"255.526957ms","start":"2026-08-22T14:35:09.715048Z","end":"2026-08-22T14:35:09.970575Z","steps":["trace[1037554013] 'agreement among raft nodes before linearized reading' (duration: 255.359254ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970565Z","caller":"traceutil/trace.go:171","msg":"trace[2095300977] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"287.878169ms","start":"2026-08-22T14:35:09.682675Z","end":"2026-08-22T14:35:09.970553Z","steps":["trace[2095300977] 'agreement among raft nodes before linearized reading' (duration: 287.508862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:09.970783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.743816ms","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-08-22T14:35:09.970759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.889251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-22T14:35:09.970803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.822815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-22T14:35:09.970815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.268073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:35:09.970848Z","caller":"traceutil/trace.go:171","msg":"trace[320220688] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"254.898336ms","start":"2026-08-22T14:35:09.715938Z","end":"2026-08-22T14:35:09.970836Z","steps":["trace[320220688] 'agreement among raft nodes before linearized reading' (duration: 254.812314ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970853Z","caller":"traceutil/trace.go:171","msg":"trace[1401382818] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"157.353845ms","start":"2026-08-22T14:35:09.813489Z","end":"2026-08-22T14:35:09.970843Z","steps":["trace[1401382818] 'agreement among raft nodes before linearized reading' (duration: 157.282134ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970857Z","caller":"traceutil/trace.go:171","msg":"trace[929125497] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"253.797717ms","start":"2026-08-22T14:35:09.717022Z","end":"2026-08-22T14:35:09.97082Z","steps":["trace[929125497] 'agreement among raft nodes before linearized reading' (duration: 253.712355ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970856Z","caller":"traceutil/trace.go:171","msg":"trace[129975370] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"248.007143ms","start":"2026-08-22T14:35:09.722826Z","end":"2026-08-22T14:35:09.970833Z","steps":["trace[129975370] 'agreement among raft nodes before linearized reading' (duration: 247.85195ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970045Z","caller":"traceutil/trace.go:171","msg":"trace[925609120] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"252.639925ms","start":"2026-08-22T14:35:09.717392Z","end":"2026-08-22T14:35:09.970032Z","steps":["trace[925609120] 'process raft request' (duration: 252.32321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:09.970909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.819739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:35:09.970949Z","caller":"traceutil/trace.go:171","msg":"trace[92787544] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"203.891471ms","start":"2026-08-22T14:35:09.767047Z","end":"2026-08-22T14:35:09.970939Z","steps":["trace[92787544] 'agreement among raft nodes before linearized reading' (duration: 203.82672ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970057Z","caller":"traceutil/trace.go:171","msg":"trace[1013834049] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"214.46543ms","start":"2026-08-22T14:35:09.755555Z","end":"2026-08-22T14:35:09.97002Z","steps":["trace[1013834049] 'process raft request' (duration: 214.313157ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970102Z","caller":"traceutil/trace.go:171","msg":"trace[1269782660] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"252.3329ms","start":"2026-08-22T14:35:09.717754Z","end":"2026-08-22T14:35:09.970087Z","steps":["trace[1269782660] 'process raft request' (duration: 252.041675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:09.971057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.497132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:35:09.971087Z","caller":"traceutil/trace.go:171","msg":"trace[1686827847] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"248.537352ms","start":"2026-08-22T14:35:09.722541Z","end":"2026-08-22T14:35:09.971078Z","steps":["trace[1686827847] 'agreement among raft nodes before linearized reading' (duration: 248.484981ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.969993Z","caller":"traceutil/trace.go:171","msg":"trace[981701544] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"252.642086ms","start":"2026-08-22T14:35:09.717296Z","end":"2026-08-22T14:35:09.969938Z","steps":["trace[981701544] 'process raft request' (duration: 252.389171ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.970007Z","caller":"traceutil/trace.go:171","msg":"trace[74611079] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"252.141027ms","start":"2026-08-22T14:35:09.717844Z","end":"2026-08-22T14:35:09.969985Z","steps":["trace[74611079] 'process raft request' (duration: 251.971324ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:09.971566Z","caller":"traceutil/trace.go:171","msg":"trace[1251741074] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"213.35653ms","start":"2026-08-22T14:35:09.758172Z","end":"2026-08-22T14:35:09.971528Z","steps":["trace[1251741074] 'process raft request' (duration: 211.755842ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.206966Z","caller":"traceutil/trace.go:171","msg":"trace[1420747473] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"231.116272ms","start":"2026-08-22T14:35:09.975823Z","end":"2026-08-22T14:35:10.206939Z","steps":["trace[1420747473] 'read index received' (duration: 1.64719ms)","trace[1420747473] 'applied index is now lower than readState.Index' (duration: 229.467972ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:35:10.207084Z","caller":"traceutil/trace.go:171","msg":"trace[1316612078] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"231.253214ms","start":"2026-08-22T14:35:09.975793Z","end":"2026-08-22T14:35:10.207046Z","steps":["trace[1316612078] 'process raft request' (duration: 227.066419ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:10.207184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.324826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T14:35:10.207311Z","caller":"traceutil/trace.go:171","msg":"trace[636961338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"231.506968ms","start":"2026-08-22T14:35:09.975785Z","end":"2026-08-22T14:35:10.207292Z","steps":["trace[636961338] 'agreement among raft nodes before linearized reading' (duration: 231.290634ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.207703Z","caller":"traceutil/trace.go:171","msg":"trace[1726161506] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"230.493541ms","start":"2026-08-22T14:35:09.977167Z","end":"2026-08-22T14:35:10.207661Z","steps":["trace[1726161506] 'process raft request' (duration: 230.080843ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.207809Z","caller":"traceutil/trace.go:171","msg":"trace[1328331189] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"229.116415ms","start":"2026-08-22T14:35:09.978673Z","end":"2026-08-22T14:35:10.20779Z","steps":["trace[1328331189] 'process raft request' (duration: 228.85554ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:10.207884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.082111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-08-22T14:35:10.207951Z","caller":"traceutil/trace.go:171","msg":"trace[1005947246] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"230.43744ms","start":"2026-08-22T14:35:09.9775Z","end":"2026-08-22T14:35:10.207937Z","steps":["trace[1005947246] 'process raft request' (duration: 229.86462ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.208002Z","caller":"traceutil/trace.go:171","msg":"trace[1701757839] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"229.058905ms","start":"2026-08-22T14:35:09.978932Z","end":"2026-08-22T14:35:10.207991Z","steps":["trace[1701757839] 'process raft request' (duration: 228.711799ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.208049Z","caller":"traceutil/trace.go:171","msg":"trace[409568672] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"230.236675ms","start":"2026-08-22T14:35:09.977791Z","end":"2026-08-22T14:35:10.208027Z","steps":["trace[409568672] 'process raft request' (duration: 229.627664ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.208139Z","caller":"traceutil/trace.go:171","msg":"trace[540622000] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"229.805428ms","start":"2026-08-22T14:35:09.978318Z","end":"2026-08-22T14:35:10.208123Z","steps":["trace[540622000] 'process raft request' (duration: 229.144976ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:10.208186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.047218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-22T14:35:10.208271Z","caller":"traceutil/trace.go:171","msg":"trace[311192145] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"175.106009ms","start":"2026-08-22T14:35:10.033124Z","end":"2026-08-22T14:35:10.20823Z","steps":["trace[311192145] 'agreement among raft nodes before linearized reading' (duration: 175.021537ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.208305Z","caller":"traceutil/trace.go:171","msg":"trace[906372493] transaction","detail":"{read_only:false; number_of_response:0; response_revision:16; }","duration":"229.671425ms","start":"2026-08-22T14:35:09.978618Z","end":"2026-08-22T14:35:10.20829Z","steps":["trace[906372493] 'process raft request' (duration: 228.880031ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.207959Z","caller":"traceutil/trace.go:171","msg":"trace[1012797260] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"231.188523ms","start":"2026-08-22T14:35:09.976752Z","end":"2026-08-22T14:35:10.20794Z","steps":["trace[1012797260] 'agreement among raft nodes before linearized reading' (duration: 231.01002ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:10.208425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.921618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-4b8b2\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-08-22T14:35:10.208488Z","caller":"traceutil/trace.go:171","msg":"trace[1400286646] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-4b8b2; range_end:; response_count:1; response_revision:19; }","duration":"231.001289ms","start":"2026-08-22T14:35:09.977465Z","end":"2026-08-22T14:35:10.208466Z","steps":["trace[1400286646] 'agreement among raft nodes before linearized reading' (duration: 230.917568ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:10.20868Z","caller":"traceutil/trace.go:171","msg":"trace[714022209] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"226.946547ms","start":"2026-08-22T14:35:09.981711Z","end":"2026-08-22T14:35:10.208658Z","steps":["trace[714022209] 'process raft request' (duration: 225.982529ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.361035Z","caller":"traceutil/trace.go:171","msg":"trace[1299963799] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"218.80982ms","start":"2026-08-22T14:35:43.141877Z","end":"2026-08-22T14:35:43.360687Z","steps":["trace[1299963799] 'process raft request' (duration: 218.591817ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.370823Z","caller":"traceutil/trace.go:171","msg":"trace[1078399180] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"223.799609ms","start":"2026-08-22T14:35:43.146992Z","end":"2026-08-22T14:35:43.370791Z","steps":["trace[1078399180] 'process raft request' (duration: 223.635766ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.370857Z","caller":"traceutil/trace.go:171","msg":"trace[220666057] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"221.199218ms","start":"2026-08-22T14:35:43.149624Z","end":"2026-08-22T14:35:43.370824Z","steps":["trace[220666057] 'process raft request' (duration: 221.087246ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.370902Z","caller":"traceutil/trace.go:171","msg":"trace[840661854] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"215.472069ms","start":"2026-08-22T14:35:43.155394Z","end":"2026-08-22T14:35:43.370866Z","steps":["trace[840661854] 'process raft request' (duration: 215.351217ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.370974Z","caller":"traceutil/trace.go:171","msg":"trace[1188628422] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"209.81139ms","start":"2026-08-22T14:35:43.16115Z","end":"2026-08-22T14:35:43.370961Z","steps":["trace[1188628422] 'process raft request' (duration: 209.681968ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.37101Z","caller":"traceutil/trace.go:171","msg":"trace[1282583578] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"214.771058ms","start":"2026-08-22T14:35:43.156231Z","end":"2026-08-22T14:35:43.371002Z","steps":["trace[1282583578] 'process raft request' (duration: 214.550324ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.371043Z","caller":"traceutil/trace.go:171","msg":"trace[1469012381] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"207.501244ms","start":"2026-08-22T14:35:43.163535Z","end":"2026-08-22T14:35:43.371036Z","steps":["trace[1469012381] 'process raft request' (duration: 207.332972ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.37107Z","caller":"traceutil/trace.go:171","msg":"trace[987824881] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"207.039097ms","start":"2026-08-22T14:35:43.164025Z","end":"2026-08-22T14:35:43.371064Z","steps":["trace[987824881] 'process raft request' (duration: 206.879624ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.371103Z","caller":"traceutil/trace.go:171","msg":"trace[130601884] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"183.282835ms","start":"2026-08-22T14:35:43.187816Z","end":"2026-08-22T14:35:43.371098Z","steps":["trace[130601884] 'process raft request' (duration: 183.134693ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.371174Z","caller":"traceutil/trace.go:171","msg":"trace[208433597] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"167.431557ms","start":"2026-08-22T14:35:43.203727Z","end":"2026-08-22T14:35:43.371159Z","steps":["trace[208433597] 'process raft request' (duration: 167.278195ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:43.371248Z","caller":"traceutil/trace.go:171","msg":"trace[1761436285] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:540; }","duration":"207.949961ms","start":"2026-08-22T14:35:43.163283Z","end":"2026-08-22T14:35:43.371233Z","steps":["trace[1761436285] 'read index received' (duration: 197.244604ms)","trace[1761436285] 'applied index is now lower than readState.Index' (duration: 10.704567ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:35:43.371276Z","caller":"traceutil/trace.go:171","msg":"trace[713830734] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"158.6309ms","start":"2026-08-22T14:35:43.212638Z","end":"2026-08-22T14:35:43.371269Z","steps":["trace[713830734] 'process raft request' (duration: 158.422857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:43.371432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.129554ms","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-08-22T14:35:43.37149Z","caller":"traceutil/trace.go:171","msg":"trace[898444159] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:534; }","duration":"208.212135ms","start":"2026-08-22T14:35:43.163257Z","end":"2026-08-22T14:35:43.371469Z","steps":["trace[898444159] 'agreement among raft nodes before linearized reading' (duration: 208.084793ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:47.967489Z","caller":"traceutil/trace.go:171","msg":"trace[584373170] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"284.931067ms","start":"2026-08-22T14:35:47.682527Z","end":"2026-08-22T14:35:47.967458Z","steps":["trace[584373170] 'read index received' (duration: 284.177446ms)","trace[584373170] 'applied index is now lower than readState.Index' (duration: 752.621µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:35:47.967692Z","caller":"traceutil/trace.go:171","msg":"trace[1900081440] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"324.971346ms","start":"2026-08-22T14:35:47.642649Z","end":"2026-08-22T14:35:47.967621Z","steps":["trace[1900081440] 'process raft request' (duration: 324.268755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.967822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.652373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:35:47.967848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.180352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.967881Z","caller":"traceutil/trace.go:171","msg":"trace[1991532204] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:617; }","duration":"133.740594ms","start":"2026-08-22T14:35:47.834127Z","end":"2026-08-22T14:35:47.967867Z","steps":["trace[1991532204] 'agreement among raft nodes before linearized reading' (duration: 133.634132ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:47.967924Z","caller":"traceutil/trace.go:171","msg":"trace[1350007770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:617; }","duration":"285.328703ms","start":"2026-08-22T14:35:47.682573Z","end":"2026-08-22T14:35:47.967902Z","steps":["trace[1350007770] 'agreement among raft nodes before linearized reading' (duration: 285.180011ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.968398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.844441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.969915Z","caller":"traceutil/trace.go:171","msg":"trace[96121509] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:617; }","duration":"287.394155ms","start":"2026-08-22T14:35:47.682498Z","end":"2026-08-22T14:35:47.969892Z","steps":["trace[96121509] 'agreement among raft nodes before linearized reading' (duration: 285.474775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.970056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:47.64263Z","time spent":"325.141528ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:35:47.970683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.289648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.97077Z","caller":"traceutil/trace.go:171","msg":"trace[1047413707] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:617; }","duration":"100.43634ms","start":"2026-08-22T14:35:47.870311Z","end":"2026-08-22T14:35:47.970747Z","steps":["trace[1047413707] 'agreement among raft nodes before linearized reading' (duration: 100.316138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.971139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.913578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.971204Z","caller":"traceutil/trace.go:171","msg":"trace[919885227] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:617; }","duration":"101.010749ms","start":"2026-08-22T14:35:47.870173Z","end":"2026-08-22T14:35:47.971184Z","steps":["trace[919885227] 'agreement among raft nodes before linearized reading' (duration: 100.901787ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.971385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.769086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.971462Z","caller":"traceutil/trace.go:171","msg":"trace[629177258] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:617; }","duration":"148.831297ms","start":"2026-08-22T14:35:47.822599Z","end":"2026-08-22T14:35:47.97143Z","steps":["trace[629177258] 'agreement among raft nodes before linearized reading' (duration: 148.736785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.971506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.064828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.971636Z","caller":"traceutil/trace.go:171","msg":"trace[14278721] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:617; }","duration":"202.20015ms","start":"2026-08-22T14:35:47.76939Z","end":"2026-08-22T14:35:47.97159Z","steps":["trace[14278721] 'agreement among raft nodes before linearized reading' (duration: 202.035308ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.971676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.013199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.971737Z","caller":"traceutil/trace.go:171","msg":"trace[1869163566] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:617; }","duration":"149.07194ms","start":"2026-08-22T14:35:47.822641Z","end":"2026-08-22T14:35:47.971712Z","steps":["trace[1869163566] 'agreement among raft nodes before linearized reading' (duration: 148.993909ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.971827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.890454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:35:47.971872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.177561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.971904Z","caller":"traceutil/trace.go:171","msg":"trace[1909581597] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:617; }","duration":"138.962085ms","start":"2026-08-22T14:35:47.83291Z","end":"2026-08-22T14:35:47.971872Z","steps":["trace[1909581597] 'agreement among raft nodes before linearized reading' (duration: 138.857383ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.97192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.262044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:35:47.971915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.107218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.971959Z","caller":"traceutil/trace.go:171","msg":"trace[2088173638] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:617; }","duration":"149.324905ms","start":"2026-08-22T14:35:47.822622Z","end":"2026-08-22T14:35:47.971946Z","steps":["trace[2088173638] 'agreement among raft nodes before linearized reading' (duration: 149.253494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.971989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.465985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.972035Z","caller":"traceutil/trace.go:171","msg":"trace[360717505] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:617; }","duration":"202.511506ms","start":"2026-08-22T14:35:47.769499Z","end":"2026-08-22T14:35:47.97201Z","steps":["trace[360717505] 'agreement among raft nodes before linearized reading' (duration: 202.448745ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:47.972034Z","caller":"traceutil/trace.go:171","msg":"trace[428389276] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:617; }","duration":"139.211519ms","start":"2026-08-22T14:35:47.832746Z","end":"2026-08-22T14:35:47.971958Z","steps":["trace[428389276] 'agreement among raft nodes before linearized reading' (duration: 139.083817ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.971727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.51561ms","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-08-22T14:35:47.972344Z","caller":"traceutil/trace.go:171","msg":"trace[880217266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"145.11699ms","start":"2026-08-22T14:35:47.827194Z","end":"2026-08-22T14:35:47.972311Z","steps":["trace[880217266] 'agreement among raft nodes before linearized reading' (duration: 144.393878ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:47.971922Z","caller":"traceutil/trace.go:171","msg":"trace[136854396] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:617; }","duration":"202.224491ms","start":"2026-08-22T14:35:47.769672Z","end":"2026-08-22T14:35:47.971897Z","steps":["trace[136854396] 'agreement among raft nodes before linearized reading' (duration: 202.14822ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.97293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.21401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.972987Z","caller":"traceutil/trace.go:171","msg":"trace[300535859] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:617; }","duration":"257.275471ms","start":"2026-08-22T14:35:47.715687Z","end":"2026-08-22T14:35:47.972962Z","steps":["trace[300535859] 'agreement among raft nodes before linearized reading' (duration: 257.194789ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.973277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.491518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.973342Z","caller":"traceutil/trace.go:171","msg":"trace[1196189000] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:617; }","duration":"256.56857ms","start":"2026-08-22T14:35:47.716748Z","end":"2026-08-22T14:35:47.973316Z","steps":["trace[1196189000] 'agreement among raft nodes before linearized reading' (duration: 256.475899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:47.979371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.638488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:35:47.979505Z","caller":"traceutil/trace.go:171","msg":"trace[667018494] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:617; }","duration":"263.834882ms","start":"2026-08-22T14:35:47.715638Z","end":"2026-08-22T14:35:47.979473Z","steps":["trace[667018494] 'agreement among raft nodes before linearized reading' (duration: 263.489607ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:49.644977Z","caller":"traceutil/trace.go:171","msg":"trace[1195024017] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"159.533298ms","start":"2026-08-22T14:35:49.485404Z","end":"2026-08-22T14:35:49.644937Z","steps":["trace[1195024017] 'process raft request' (duration: 159.145022ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:49.836639Z","caller":"traceutil/trace.go:171","msg":"trace[1842591306] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"357.858379ms","start":"2026-08-22T14:35:49.478731Z","end":"2026-08-22T14:35:49.836589Z","steps":["trace[1842591306] 'process raft request' (duration: 351.821407ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:49.836929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:49.478701Z","time spent":"358.077072ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:35:50.475372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.873624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qz6vb\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-22T14:35:50.475301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.707293ms","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-08-22T14:35:50.475506Z","caller":"traceutil/trace.go:171","msg":"trace[1531271755] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qz6vb; range_end:; response_count:1; response_revision:631; }","duration":"434.098757ms","start":"2026-08-22T14:35:50.041363Z","end":"2026-08-22T14:35:50.475462Z","steps":["trace[1531271755] 'range keys from in-memory index tree' (duration: 433.582519ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:50.475525Z","caller":"traceutil/trace.go:171","msg":"trace[1765478923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"439.959517ms","start":"2026-08-22T14:35:50.035537Z","end":"2026-08-22T14:35:50.475496Z","steps":["trace[1765478923] 'range keys from in-memory index tree' (duration: 439.326357ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:50.475589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:50.035426Z","time spent":"440.147609ms","remote":"127.0.0.1:45560","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-08-22T14:35:50.47559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:50.041336Z","time spent":"434.220829ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-qz6vb\" "} {"level":"warn","ts":"2026-08-22T14:35:50.475521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.629861ms","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-08-22T14:35:50.475839Z","caller":"traceutil/trace.go:171","msg":"trace[1489944101] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"488.945367ms","start":"2026-08-22T14:35:49.986803Z","end":"2026-08-22T14:35:50.475748Z","steps":["trace[1489944101] 'range keys from in-memory index tree' (duration: 488.313407ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:50.475957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:49.986779Z","time spent":"489.1599ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-22T14:35:50.757446Z","caller":"traceutil/trace.go:171","msg":"trace[550447187] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"438.211081ms","start":"2026-08-22T14:35:50.319193Z","end":"2026-08-22T14:35:50.757404Z","steps":["trace[550447187] 'process raft request' (duration: 436.693788ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:50.757682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:50.319147Z","time spent":"438.417944ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:35:50.800566Z","caller":"traceutil/trace.go:171","msg":"trace[355341507] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"321.222342ms","start":"2026-08-22T14:35:50.479288Z","end":"2026-08-22T14:35:50.800511Z","steps":["trace[355341507] 'process raft request' (duration: 302.364594ms)","trace[355341507] 'compare' (duration: 18.606724ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:35:50.800554Z","caller":"traceutil/trace.go:171","msg":"trace[1014984435] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"319.857692ms","start":"2026-08-22T14:35:50.480625Z","end":"2026-08-22T14:35:50.800482Z","steps":["trace[1014984435] 'process raft request' (duration: 319.75682ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:50.800789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:50.479263Z","time spent":"321.415976ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:35:50.8008Z","caller":"traceutil/trace.go:171","msg":"trace[755157217] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"309.162638ms","start":"2026-08-22T14:35:50.491595Z","end":"2026-08-22T14:35:50.800757Z","steps":["trace[755157217] 'process raft request' (duration: 308.835943ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:50.801068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:50.491577Z","time spent":"309.389911ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:35:50.800795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:35:50.480602Z","time spent":"320.081575ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:35:52.365908Z","caller":"traceutil/trace.go:171","msg":"trace[849075522] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"167.189181ms","start":"2026-08-22T14:35:52.198693Z","end":"2026-08-22T14:35:52.365883Z","steps":["trace[849075522] 'process raft request' (duration: 166.923447ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:55.382467Z","caller":"traceutil/trace.go:171","msg":"trace[736941514] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"118.226622ms","start":"2026-08-22T14:35:55.264222Z","end":"2026-08-22T14:35:55.382449Z","steps":["trace[736941514] 'process raft request' (duration: 117.799245ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:55.718556Z","caller":"traceutil/trace.go:171","msg":"trace[446377522] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"214.109706ms","start":"2026-08-22T14:35:55.504408Z","end":"2026-08-22T14:35:55.718518Z","steps":["trace[446377522] 'process raft request' (duration: 123.051294ms)","trace[446377522] 'compare' (duration: 90.92783ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:35:55.751745Z","caller":"traceutil/trace.go:171","msg":"trace[797515511] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"158.656001ms","start":"2026-08-22T14:35:55.59306Z","end":"2026-08-22T14:35:55.751716Z","steps":["trace[797515511] 'process raft request' (duration: 158.090412ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:05.881322Z","caller":"traceutil/trace.go:171","msg":"trace[1977329516] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"110.793586ms","start":"2026-08-22T14:36:05.770513Z","end":"2026-08-22T14:36:05.881307Z","steps":["trace[1977329516] 'process raft request' (duration: 110.444201ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:06.011386Z","caller":"traceutil/trace.go:171","msg":"trace[308990110] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"125.234177ms","start":"2026-08-22T14:36:05.886114Z","end":"2026-08-22T14:36:06.011348Z","steps":["trace[308990110] 'process raft request' (duration: 124.978563ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.398199Z","caller":"traceutil/trace.go:171","msg":"trace[1060228951] transaction","detail":"{read_only:false; number_of_response:1; response_revision:843; }","duration":"128.699122ms","start":"2026-08-22T14:36:11.269459Z","end":"2026-08-22T14:36:11.398158Z","steps":["trace[1060228951] 'process raft request' (duration: 125.835021ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.39826Z","caller":"traceutil/trace.go:171","msg":"trace[452348664] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"123.030889ms","start":"2026-08-22T14:36:11.275199Z","end":"2026-08-22T14:36:11.398229Z","steps":["trace[452348664] 'process raft request' (duration: 122.880347ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.482262Z","caller":"traceutil/trace.go:171","msg":"trace[2130823167] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"128.690292ms","start":"2026-08-22T14:36:11.353546Z","end":"2026-08-22T14:36:11.482236Z","steps":["trace[2130823167] 'process raft request' (duration: 128.632591ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.48228Z","caller":"traceutil/trace.go:171","msg":"trace[735398483] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"129.087968ms","start":"2026-08-22T14:36:11.353168Z","end":"2026-08-22T14:36:11.482256Z","steps":["trace[735398483] 'process raft request' (duration: 128.861165ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.557202Z","caller":"traceutil/trace.go:171","msg":"trace[387086322] transaction","detail":"{read_only:false; number_of_response:1; response_revision:846; }","duration":"154.091528ms","start":"2026-08-22T14:36:11.40309Z","end":"2026-08-22T14:36:11.557182Z","steps":["trace[387086322] 'process raft request' (duration: 154.023247ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.731483Z","caller":"traceutil/trace.go:171","msg":"trace[997362523] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"155.000303ms","start":"2026-08-22T14:36:11.576459Z","end":"2026-08-22T14:36:11.731459Z","steps":["trace[997362523] 'process raft request' (duration: 154.945082ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.731537Z","caller":"traceutil/trace.go:171","msg":"trace[1969301349] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"163.050029ms","start":"2026-08-22T14:36:11.568433Z","end":"2026-08-22T14:36:11.731483Z","steps":["trace[1969301349] 'process raft request' (duration: 121.251204ms)","trace[1969301349] 'compare' (duration: 41.588492ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:36:11.737883Z","caller":"traceutil/trace.go:171","msg":"trace[1298901528] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"135.145245ms","start":"2026-08-22T14:36:11.602708Z","end":"2026-08-22T14:36:11.737853Z","steps":["trace[1298901528] 'process raft request' (duration: 134.937012ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.738289Z","caller":"traceutil/trace.go:171","msg":"trace[1906707503] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"132.201542ms","start":"2026-08-22T14:36:11.606068Z","end":"2026-08-22T14:36:11.738269Z","steps":["trace[1906707503] 'process raft request' (duration: 132.07567ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:11.738375Z","caller":"traceutil/trace.go:171","msg":"trace[2136200821] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"135.50804ms","start":"2026-08-22T14:36:11.602852Z","end":"2026-08-22T14:36:11.73836Z","steps":["trace[2136200821] 'process raft request' (duration: 134.940732ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:17.25701Z","caller":"traceutil/trace.go:171","msg":"trace[1805947541] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"193.982799ms","start":"2026-08-22T14:36:17.062996Z","end":"2026-08-22T14:36:17.256978Z","steps":["trace[1805947541] 'process raft request' (duration: 193.745255ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:17.257931Z","caller":"traceutil/trace.go:171","msg":"trace[1804333949] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"152.606329ms","start":"2026-08-22T14:36:17.10531Z","end":"2026-08-22T14:36:17.257917Z","steps":["trace[1804333949] 'process raft request' (duration: 152.514478ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:17.257928Z","caller":"traceutil/trace.go:171","msg":"trace[1693204224] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"192.771072ms","start":"2026-08-22T14:36:17.065137Z","end":"2026-08-22T14:36:17.257909Z","steps":["trace[1693204224] 'process raft request' (duration: 192.445427ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:17.257958Z","caller":"traceutil/trace.go:171","msg":"trace[1286778785] linearizableReadLoop","detail":"{readStateIndex:976; appliedIndex:974; }","duration":"107.900091ms","start":"2026-08-22T14:36:17.149978Z","end":"2026-08-22T14:36:17.257878Z","steps":["trace[1286778785] 'read index received' (duration: 107.026028ms)","trace[1286778785] 'applied index is now lower than readState.Index' (duration: 873.083µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:36:17.25855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.511609ms","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-08-22T14:36:17.258632Z","caller":"traceutil/trace.go:171","msg":"trace[215094154] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:943; }","duration":"108.679161ms","start":"2026-08-22T14:36:17.149937Z","end":"2026-08-22T14:36:17.258616Z","steps":["trace[215094154] 'agreement among raft nodes before linearized reading' (duration: 108.155434ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:18.275038Z","caller":"traceutil/trace.go:171","msg":"trace[1254612815] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"173.118486ms","start":"2026-08-22T14:36:18.101898Z","end":"2026-08-22T14:36:18.275016Z","steps":["trace[1254612815] 'process raft request' (duration: 172.996205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:38.387598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.333611ms","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-08-22T14:36:38.387705Z","caller":"traceutil/trace.go:171","msg":"trace[437930934] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1206; }","duration":"114.478172ms","start":"2026-08-22T14:36:38.273187Z","end":"2026-08-22T14:36:38.387665Z","steps":["trace[437930934] 'count revisions from in-memory index tree' (duration: 114.236189ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:39.394869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.882178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:36:39.394968Z","caller":"traceutil/trace.go:171","msg":"trace[1164683237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"468.021111ms","start":"2026-08-22T14:36:38.926923Z","end":"2026-08-22T14:36:39.394945Z","steps":["trace[1164683237] 'range keys from in-memory index tree' (duration: 467.801247ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:39.394995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.512765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-22T14:36:39.39509Z","caller":"traceutil/trace.go:171","msg":"trace[1296205391] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1207; }","duration":"628.692508ms","start":"2026-08-22T14:36:38.766381Z","end":"2026-08-22T14:36:39.395073Z","steps":["trace[1296205391] 'count revisions from in-memory index tree' (duration: 628.438774ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:39.395139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:38.766358Z","time spent":"628.765048ms","remote":"127.0.0.1:55764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":151,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-08-22T14:36:39.395338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.152922ms","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-08-22T14:36:39.395034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:38.926904Z","time spent":"468.109932ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-22T14:36:39.395366Z","caller":"traceutil/trace.go:171","msg":"trace[943256430] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1207; }","duration":"765.214412ms","start":"2026-08-22T14:36:38.630143Z","end":"2026-08-22T14:36:39.395358Z","steps":["trace[943256430] 'count revisions from in-memory index tree' (duration: 765.091521ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:39.395494Z","caller":"traceutil/trace.go:171","msg":"trace[568010807] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"358.118691ms","start":"2026-08-22T14:36:39.03735Z","end":"2026-08-22T14:36:39.395469Z","steps":["trace[568010807] 'process raft request' (duration: 355.024369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:39.395658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:39.037326Z","time spent":"358.229773ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:36:39.395649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:38.630127Z","time spent":"765.484386ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":12,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-08-22T14:37:28.232102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.642244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-697dd938-b307-49f1-9e67-76f87c2983f7\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-08-22T14:37:28.232176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.999509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:37:28.232422Z","caller":"traceutil/trace.go:171","msg":"trace[300377254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1893; }","duration":"305.281441ms","start":"2026-08-22T14:37:27.927118Z","end":"2026-08-22T14:37:28.2324Z","steps":["trace[300377254] 'range keys from in-memory index tree' (duration: 304.929266ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:37:28.232496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:37:27.927101Z","time spent":"305.383305ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-22T14:37:28.232395Z","caller":"traceutil/trace.go:171","msg":"trace[1265303688] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-697dd938-b307-49f1-9e67-76f87c2983f7; range_end:; response_count:1; response_revision:1893; }","duration":"187.813721ms","start":"2026-08-22T14:37:28.044386Z","end":"2026-08-22T14:37:28.232199Z","steps":["trace[1265303688] 'range keys from in-memory index tree' (duration: 187.433575ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:28.582962Z","caller":"traceutil/trace.go:171","msg":"trace[266852577] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"104.242442ms","start":"2026-08-22T14:37:28.478691Z","end":"2026-08-22T14:37:28.582933Z","steps":["trace[266852577] 'process raft request' (duration: 103.863916ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:28.701185Z","caller":"traceutil/trace.go:171","msg":"trace[645211317] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"110.21489ms","start":"2026-08-22T14:37:28.590946Z","end":"2026-08-22T14:37:28.701161Z","steps":["trace[645211317] 'process raft request' (duration: 109.798512ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:43.963055Z","caller":"traceutil/trace.go:171","msg":"trace[1192718692] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"196.066225ms","start":"2026-08-22T14:37:43.766968Z","end":"2026-08-22T14:37:43.963034Z","steps":["trace[1192718692] 'process raft request' (duration: 195.933679ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:43.965371Z","caller":"traceutil/trace.go:171","msg":"trace[1533871470] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"191.932958ms","start":"2026-08-22T14:37:43.773398Z","end":"2026-08-22T14:37:43.965331Z","steps":["trace[1533871470] 'process raft request' (duration: 191.570364ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:44.568923Z","caller":"traceutil/trace.go:171","msg":"trace[45287171] linearizableReadLoop","detail":"{readStateIndex:2107; appliedIndex:2106; }","duration":"201.126689ms","start":"2026-08-22T14:37:44.367771Z","end":"2026-08-22T14:37:44.568898Z","steps":["trace[45287171] 'read index received' (duration: 200.88526ms)","trace[45287171] 'applied index is now lower than readState.Index' (duration: 240.519µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:37:44.569037Z","caller":"traceutil/trace.go:171","msg":"trace[504257951] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"204.214593ms","start":"2026-08-22T14:37:44.364798Z","end":"2026-08-22T14:37:44.569013Z","steps":["trace[504257951] 'process raft request' (duration: 203.923801ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:37:44.569224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.440792ms","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-08-22T14:37:44.569288Z","caller":"traceutil/trace.go:171","msg":"trace[1494704733] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2028; }","duration":"201.571117ms","start":"2026-08-22T14:37:44.367701Z","end":"2026-08-22T14:37:44.569272Z","steps":["trace[1494704733] 'agreement among raft nodes before linearized reading' (duration: 201.325677ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:38:06.373538Z","caller":"traceutil/trace.go:171","msg":"trace[895374604] linearizableReadLoop","detail":"{readStateIndex:2232; appliedIndex:2231; }","duration":"256.468524ms","start":"2026-08-22T14:38:06.117044Z","end":"2026-08-22T14:38:06.373513Z","steps":["trace[895374604] 'read index received' (duration: 256.201354ms)","trace[895374604] 'applied index is now lower than readState.Index' (duration: 266.31µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:38:06.373732Z","caller":"traceutil/trace.go:171","msg":"trace[2085984518] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"260.670257ms","start":"2026-08-22T14:38:06.113024Z","end":"2026-08-22T14:38:06.373695Z","steps":["trace[2085984518] 'process raft request' (duration: 260.282723ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:06.374049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.959432ms","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-08-22T14:38:06.374166Z","caller":"traceutil/trace.go:171","msg":"trace[660965799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2149; }","duration":"257.148919ms","start":"2026-08-22T14:38:06.116996Z","end":"2026-08-22T14:38:06.374145Z","steps":["trace[660965799] 'agreement among raft nodes before linearized reading' (duration: 256.748714ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:38:06.414861Z","caller":"traceutil/trace.go:171","msg":"trace[1726043294] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"131.852338ms","start":"2026-08-22T14:38:06.28298Z","end":"2026-08-22T14:38:06.414832Z","steps":["trace[1726043294] 'process raft request' (duration: 131.595619ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:06.415012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.627272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ce2771a911d093\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-08-22T14:38:06.415069Z","caller":"traceutil/trace.go:171","msg":"trace[1857092362] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18ce2771a911d093; range_end:; response_count:1; response_revision:2150; }","duration":"180.719755ms","start":"2026-08-22T14:38:06.234333Z","end":"2026-08-22T14:38:06.415053Z","steps":["trace[1857092362] 'agreement among raft nodes before linearized reading' (duration: 180.58064ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:38:07.007323Z","caller":"traceutil/trace.go:171","msg":"trace[968307244] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2237; }","duration":"186.810396ms","start":"2026-08-22T14:38:06.820489Z","end":"2026-08-22T14:38:07.007299Z","steps":["trace[968307244] 'read index received' (duration: 186.590848ms)","trace[968307244] 'applied index is now lower than readState.Index' (duration: 218.558µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:38:07.00743Z","caller":"traceutil/trace.go:171","msg":"trace[1801894564] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"221.428907ms","start":"2026-08-22T14:38:06.785972Z","end":"2026-08-22T14:38:07.007401Z","steps":["trace[1801894564] 'process raft request' (duration: 221.158918ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:07.007636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.800576ms","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-08-22T14:38:07.007642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.127047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-08-22T14:38:07.007695Z","caller":"traceutil/trace.go:171","msg":"trace[2142440141] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2154; }","duration":"113.920989ms","start":"2026-08-22T14:38:06.893761Z","end":"2026-08-22T14:38:07.007682Z","steps":["trace[2142440141] 'agreement among raft nodes before linearized reading' (duration: 113.698221ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:38:07.007708Z","caller":"traceutil/trace.go:171","msg":"trace[882225649] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2154; }","duration":"187.230351ms","start":"2026-08-22T14:38:06.820459Z","end":"2026-08-22T14:38:07.00769Z","steps":["trace[882225649] 'agreement among raft nodes before linearized reading' (duration: 186.966961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:07.652761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.094291ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:38:07.653156Z","caller":"traceutil/trace.go:171","msg":"trace[57613535] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"277.791792ms","start":"2026-08-22T14:38:07.375266Z","end":"2026-08-22T14:38:07.653058Z","steps":["trace[57613535] 'process raft request' (duration: 134.13929ms)","trace[57613535] 'compare' (duration: 142.886714ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:38:08.07033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.813107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:38:08.070408Z","caller":"traceutil/trace.go:171","msg":"trace[982089341] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2157; }","duration":"143.945762ms","start":"2026-08-22T14:38:07.926439Z","end":"2026-08-22T14:38:08.070384Z","steps":["trace[982089341] 'range keys from in-memory index tree' (duration: 143.725884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:08.070462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.282279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-22T14:38:08.07059Z","caller":"traceutil/trace.go:171","msg":"trace[1559741633] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2157; }","duration":"288.500577ms","start":"2026-08-22T14:38:07.782071Z","end":"2026-08-22T14:38:08.070572Z","steps":["trace[1559741633] 'range keys from in-memory index tree' (duration: 288.071301ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:38:58.093468Z","caller":"traceutil/trace.go:171","msg":"trace[60669543] transaction","detail":"{read_only:false; response_revision:2534; number_of_response:1; }","duration":"247.999554ms","start":"2026-08-22T14:38:57.845428Z","end":"2026-08-22T14:38:58.093428Z","steps":["trace[60669543] 'process raft request' (duration: 247.824359ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:39:30.938393Z","caller":"traceutil/trace.go:171","msg":"trace[1484937022] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"100.828611ms","start":"2026-08-22T14:39:30.837517Z","end":"2026-08-22T14:39:30.938346Z","steps":["trace[1484937022] 'process raft request' (duration: 100.553644ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:07.426928Z","caller":"traceutil/trace.go:171","msg":"trace[1385680483] linearizableReadLoop","detail":"{readStateIndex:4209; appliedIndex:4208; }","duration":"292.208893ms","start":"2026-08-22T14:43:07.134668Z","end":"2026-08-22T14:43:07.426877Z","steps":["trace[1385680483] 'read index received' (duration: 290.534903ms)","trace[1385680483] 'applied index is now lower than readState.Index' (duration: 1.67156ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:07.427257Z","caller":"traceutil/trace.go:171","msg":"trace[636935397] transaction","detail":"{read_only:false; response_revision:4042; number_of_response:1; }","duration":"326.25115ms","start":"2026-08-22T14:43:07.100966Z","end":"2026-08-22T14:43:07.427217Z","steps":["trace[636935397] 'process raft request' (duration: 324.054891ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:07.427467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:07.100931Z","time spent":"326.430793ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:07.427924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.18769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-create-bcvwq\" ","response":"range_response_count:1 size:4357"} {"level":"info","ts":"2026-08-22T14:43:07.428008Z","caller":"traceutil/trace.go:171","msg":"trace[1364847537] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-create-bcvwq; range_end:; response_count:1; response_revision:4042; }","duration":"293.331412ms","start":"2026-08-22T14:43:07.134652Z","end":"2026-08-22T14:43:07.427983Z","steps":["trace[1364847537] 'agreement among raft nodes before linearized reading' (duration: 292.546268ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:07.430674Z","caller":"traceutil/trace.go:171","msg":"trace[2139952685] transaction","detail":"{read_only:false; response_revision:4044; number_of_response:1; }","duration":"256.720289ms","start":"2026-08-22T14:43:07.173931Z","end":"2026-08-22T14:43:07.430651Z","steps":["trace[2139952685] 'process raft request' (duration: 256.632228ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:07.430872Z","caller":"traceutil/trace.go:171","msg":"trace[532681615] transaction","detail":"{read_only:false; response_revision:4043; number_of_response:1; }","duration":"256.941354ms","start":"2026-08-22T14:43:07.17391Z","end":"2026-08-22T14:43:07.430851Z","steps":["trace[532681615] 'process raft request' (duration: 256.502216ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:07.430972Z","caller":"traceutil/trace.go:171","msg":"trace[241079049] transaction","detail":"{read_only:false; response_revision:4045; number_of_response:1; }","duration":"256.102929ms","start":"2026-08-22T14:43:07.174861Z","end":"2026-08-22T14:43:07.430964Z","steps":["trace[241079049] 'process raft request' (duration: 255.740432ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:13.036461Z","caller":"traceutil/trace.go:171","msg":"trace[33456058] transaction","detail":"{read_only:false; response_revision:4391; number_of_response:1; }","duration":"104.502136ms","start":"2026-08-22T14:43:12.93193Z","end":"2026-08-22T14:43:13.036432Z","steps":["trace[33456058] 'process raft request' (duration: 102.286647ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:14.192189Z","caller":"traceutil/trace.go:171","msg":"trace[1057800067] transaction","detail":"{read_only:false; response_revision:4431; number_of_response:1; }","duration":"271.487587ms","start":"2026-08-22T14:43:13.920675Z","end":"2026-08-22T14:43:14.192163Z","steps":["trace[1057800067] 'process raft request' (duration: 271.335484ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:14.192505Z","caller":"traceutil/trace.go:171","msg":"trace[1224393565] linearizableReadLoop","detail":"{readStateIndex:4606; appliedIndex:4606; }","duration":"261.816205ms","start":"2026-08-22T14:43:13.930624Z","end":"2026-08-22T14:43:14.19244Z","steps":["trace[1224393565] 'read index received' (duration: 261.804725ms)","trace[1224393565] 'applied index is now lower than readState.Index' (duration: 8.98µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:14.192868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.187711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:43:14.192935Z","caller":"traceutil/trace.go:171","msg":"trace[707268129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4431; }","duration":"262.317424ms","start":"2026-08-22T14:43:13.93058Z","end":"2026-08-22T14:43:14.192898Z","steps":["trace[707268129] 'agreement among raft nodes before linearized reading' (duration: 262.146151ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:14.197803Z","caller":"traceutil/trace.go:171","msg":"trace[200979331] transaction","detail":"{read_only:false; response_revision:4432; number_of_response:1; }","duration":"236.977134ms","start":"2026-08-22T14:43:13.960799Z","end":"2026-08-22T14:43:14.197777Z","steps":["trace[200979331] 'process raft request' (duration: 236.697879ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:14.198147Z","caller":"traceutil/trace.go:171","msg":"trace[545260624] transaction","detail":"{read_only:false; response_revision:4433; number_of_response:1; }","duration":"149.646855ms","start":"2026-08-22T14:43:14.048491Z","end":"2026-08-22T14:43:14.198138Z","steps":["trace[545260624] 'process raft request' (duration: 149.126596ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:14.198539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.832758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:43:14.198589Z","caller":"traceutil/trace.go:171","msg":"trace[1891467827] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:4433; }","duration":"162.954241ms","start":"2026-08-22T14:43:14.035622Z","end":"2026-08-22T14:43:14.198576Z","steps":["trace[1891467827] 'agreement among raft nodes before linearized reading' (duration: 162.629515ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:14.198892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.948566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T14:43:14.198923Z","caller":"traceutil/trace.go:171","msg":"trace[1468769972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4433; }","duration":"165.013887ms","start":"2026-08-22T14:43:14.033902Z","end":"2026-08-22T14:43:14.198916Z","steps":["trace[1468769972] 'agreement among raft nodes before linearized reading' (duration: 164.865814ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:18.710421Z","caller":"traceutil/trace.go:171","msg":"trace[976773963] transaction","detail":"{read_only:false; response_revision:4571; number_of_response:1; }","duration":"253.322669ms","start":"2026-08-22T14:43:18.457065Z","end":"2026-08-22T14:43:18.710387Z","steps":["trace[976773963] 'process raft request' (duration: 252.934172ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:20.724093Z","caller":"traceutil/trace.go:171","msg":"trace[729665305] linearizableReadLoop","detail":"{readStateIndex:4793; appliedIndex:4792; }","duration":"222.265364ms","start":"2026-08-22T14:43:20.50181Z","end":"2026-08-22T14:43:20.724075Z","steps":["trace[729665305] 'read index received' (duration: 222.157802ms)","trace[729665305] 'applied index is now lower than readState.Index' (duration: 106.572µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:20.724314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.497028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-08-22T14:43:20.724344Z","caller":"traceutil/trace.go:171","msg":"trace[94873647] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4614; }","duration":"222.561509ms","start":"2026-08-22T14:43:20.501773Z","end":"2026-08-22T14:43:20.724334Z","steps":["trace[94873647] 'agreement among raft nodes before linearized reading' (duration: 222.416916ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:20.724271Z","caller":"traceutil/trace.go:171","msg":"trace[115453721] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"224.800338ms","start":"2026-08-22T14:43:20.499334Z","end":"2026-08-22T14:43:20.724134Z","steps":["trace[115453721] 'process raft request' (duration: 224.626875ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:20.724553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.199335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-rzttx-tls\" ","response":"range_response_count:1 size:2130"} {"level":"info","ts":"2026-08-22T14:43:20.724617Z","caller":"traceutil/trace.go:171","msg":"trace[34565517] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-rzttx-tls; range_end:; response_count:1; response_revision:4614; }","duration":"221.324297ms","start":"2026-08-22T14:43:20.503279Z","end":"2026-08-22T14:43:20.724603Z","steps":["trace[34565517] 'agreement among raft nodes before linearized reading' (duration: 220.93023ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:20.860825Z","caller":"traceutil/trace.go:171","msg":"trace[1658538520] linearizableReadLoop","detail":"{readStateIndex:4795; appliedIndex:4794; }","duration":"119.568671ms","start":"2026-08-22T14:43:20.741236Z","end":"2026-08-22T14:43:20.860805Z","steps":["trace[1658538520] 'read index received' (duration: 76.247626ms)","trace[1658538520] 'applied index is now lower than readState.Index' (duration: 43.319605ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:20.860902Z","caller":"traceutil/trace.go:171","msg":"trace[474936866] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"122.611874ms","start":"2026-08-22T14:43:20.738212Z","end":"2026-08-22T14:43:20.860824Z","steps":["trace[474936866] 'process raft request' (duration: 79.252699ms)","trace[474936866] 'compare' (duration: 43.137201ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:20.861602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.345804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-08-22T14:43:20.8618Z","caller":"traceutil/trace.go:171","msg":"trace[1405908392] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4617; }","duration":"120.570128ms","start":"2026-08-22T14:43:20.741201Z","end":"2026-08-22T14:43:20.861771Z","steps":["trace[1405908392] 'agreement among raft nodes before linearized reading' (duration: 119.765194ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.187825Z","caller":"traceutil/trace.go:171","msg":"trace[1900830461] transaction","detail":"{read_only:false; response_revision:4618; number_of_response:1; }","duration":"320.397192ms","start":"2026-08-22T14:43:20.86738Z","end":"2026-08-22T14:43:21.187777Z","steps":["trace[1900830461] 'process raft request' (duration: 293.729612ms)","trace[1900830461] 'compare' (duration: 26.470317ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:21.188054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:20.867357Z","time spent":"320.576525ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:21.218474Z","caller":"traceutil/trace.go:171","msg":"trace[1702439971] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"350.758318ms","start":"2026-08-22T14:43:20.867691Z","end":"2026-08-22T14:43:21.21845Z","steps":["trace[1702439971] 'process raft request' (duration: 350.474243ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.2185Z","caller":"traceutil/trace.go:171","msg":"trace[1798149832] linearizableReadLoop","detail":"{readStateIndex:4798; appliedIndex:4796; }","duration":"350.007145ms","start":"2026-08-22T14:43:20.868467Z","end":"2026-08-22T14:43:21.218474Z","steps":["trace[1798149832] 'read index received' (duration: 292.674663ms)","trace[1798149832] 'applied index is now lower than readState.Index' (duration: 57.331672ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:21.218575Z","caller":"traceutil/trace.go:171","msg":"trace[1574026799] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"344.1108ms","start":"2026-08-22T14:43:20.874437Z","end":"2026-08-22T14:43:21.218548Z","steps":["trace[1574026799] 'process raft request' (duration: 343.888366ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.218615Z","caller":"traceutil/trace.go:171","msg":"trace[800056941] transaction","detail":"{read_only:false; response_revision:4621; number_of_response:1; }","duration":"195.710571ms","start":"2026-08-22T14:43:21.022893Z","end":"2026-08-22T14:43:21.218604Z","steps":["trace[800056941] 'process raft request' (duration: 195.503288ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:21.218618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:20.867658Z","time spent":"350.88123ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:21.218688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:20.874427Z","time spent":"344.213142ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3387,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:43:21.218845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.528557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:43:21.218947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.768436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:43:21.219009Z","caller":"traceutil/trace.go:171","msg":"trace[714642403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4621; }","duration":"291.860788ms","start":"2026-08-22T14:43:20.927124Z","end":"2026-08-22T14:43:21.218985Z","steps":["trace[714642403] 'agreement among raft nodes before linearized reading' (duration: 291.792977ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:21.218869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.880313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-08-22T14:43:21.219093Z","caller":"traceutil/trace.go:171","msg":"trace[1925702944] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4621; }","duration":"324.155109ms","start":"2026-08-22T14:43:20.894929Z","end":"2026-08-22T14:43:21.219084Z","steps":["trace[1925702944] 'agreement among raft nodes before linearized reading' (duration: 323.730621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:21.219123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:20.894889Z","time spent":"324.222839ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1840,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-08-22T14:43:21.218868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.378981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-08-22T14:43:21.219211Z","caller":"traceutil/trace.go:171","msg":"trace[1293446305] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4621; }","duration":"350.764818ms","start":"2026-08-22T14:43:20.868433Z","end":"2026-08-22T14:43:21.219198Z","steps":["trace[1293446305] 'agreement among raft nodes before linearized reading' (duration: 350.355901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:21.219269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:20.868412Z","time spent":"350.84557ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":1,"response size":673,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" "} {"level":"info","ts":"2026-08-22T14:43:21.218966Z","caller":"traceutil/trace.go:171","msg":"trace[1864311654] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:4621; }","duration":"285.691109ms","start":"2026-08-22T14:43:20.933259Z","end":"2026-08-22T14:43:21.21895Z","steps":["trace[1864311654] 'agreement among raft nodes before linearized reading' (duration: 285.504746ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.345433Z","caller":"traceutil/trace.go:171","msg":"trace[990209956] transaction","detail":"{read_only:false; response_revision:4622; number_of_response:1; }","duration":"113.581163ms","start":"2026-08-22T14:43:21.231782Z","end":"2026-08-22T14:43:21.345363Z","steps":["trace[990209956] 'process raft request' (duration: 55.432058ms)","trace[990209956] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-rzttx-kqbvd.18ce27be7e4c620d; req_size:928; } (duration: 57.801639ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:21.375574Z","caller":"traceutil/trace.go:171","msg":"trace[780150858] transaction","detail":"{read_only:false; response_revision:4623; number_of_response:1; }","duration":"143.000823ms","start":"2026-08-22T14:43:21.232539Z","end":"2026-08-22T14:43:21.37554Z","steps":["trace[780150858] 'process raft request' (duration: 142.751598ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.375658Z","caller":"traceutil/trace.go:171","msg":"trace[353826733] transaction","detail":"{read_only:false; response_revision:4624; number_of_response:1; }","duration":"141.864623ms","start":"2026-08-22T14:43:21.233737Z","end":"2026-08-22T14:43:21.375601Z","steps":["trace[353826733] 'process raft request' (duration: 141.69879ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.375695Z","caller":"traceutil/trace.go:171","msg":"trace[23876588] linearizableReadLoop","detail":"{readStateIndex:4803; appliedIndex:4800; }","duration":"141.70114ms","start":"2026-08-22T14:43:21.233964Z","end":"2026-08-22T14:43:21.375665Z","steps":["trace[23876588] 'read index received' (duration: 53.221949ms)","trace[23876588] 'applied index is now lower than readState.Index' (duration: 88.478041ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:21.375897Z","caller":"traceutil/trace.go:171","msg":"trace[753503788] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"141.346863ms","start":"2026-08-22T14:43:21.234529Z","end":"2026-08-22T14:43:21.375876Z","steps":["trace[753503788] 'process raft request' (duration: 140.971647ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.376Z","caller":"traceutil/trace.go:171","msg":"trace[748603053] transaction","detail":"{read_only:false; response_revision:4627; number_of_response:1; }","duration":"141.237991ms","start":"2026-08-22T14:43:21.234739Z","end":"2026-08-22T14:43:21.375977Z","steps":["trace[748603053] 'process raft request' (duration: 140.791353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:21.376146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.153678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14496"} {"level":"info","ts":"2026-08-22T14:43:21.375921Z","caller":"traceutil/trace.go:171","msg":"trace[308953918] transaction","detail":"{read_only:false; response_revision:4629; number_of_response:1; }","duration":"125.580605ms","start":"2026-08-22T14:43:21.250317Z","end":"2026-08-22T14:43:21.375898Z","steps":["trace[308953918] 'process raft request' (duration: 125.273109ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.37619Z","caller":"traceutil/trace.go:171","msg":"trace[878956611] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4629; }","duration":"142.240989ms","start":"2026-08-22T14:43:21.233939Z","end":"2026-08-22T14:43:21.37618Z","steps":["trace[878956611] 'agreement among raft nodes before linearized reading' (duration: 142.058836ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.376572Z","caller":"traceutil/trace.go:171","msg":"trace[1381887007] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"142.27928ms","start":"2026-08-22T14:43:21.234262Z","end":"2026-08-22T14:43:21.376542Z","steps":["trace[1381887007] 'process raft request' (duration: 141.210231ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.376593Z","caller":"traceutil/trace.go:171","msg":"trace[905084347] transaction","detail":"{read_only:false; response_revision:4628; number_of_response:1; }","duration":"139.42696ms","start":"2026-08-22T14:43:21.236405Z","end":"2026-08-22T14:43:21.375832Z","steps":["trace[905084347] 'process raft request' (duration: 139.148265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:21.410813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.043878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-22T14:43:21.410901Z","caller":"traceutil/trace.go:171","msg":"trace[977387480] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4630; }","duration":"162.14264ms","start":"2026-08-22T14:43:21.248729Z","end":"2026-08-22T14:43:21.410872Z","steps":["trace[977387480] 'agreement among raft nodes before linearized reading' (duration: 161.947676ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:21.410888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.095264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"warn","ts":"2026-08-22T14:43:21.410825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.362227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-08-22T14:43:21.410974Z","caller":"traceutil/trace.go:171","msg":"trace[1764285049] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4630; }","duration":"173.223525ms","start":"2026-08-22T14:43:21.23773Z","end":"2026-08-22T14:43:21.410953Z","steps":["trace[1764285049] 'agreement among raft nodes before linearized reading' (duration: 172.92467ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:21.41105Z","caller":"traceutil/trace.go:171","msg":"trace[140439512] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4630; }","duration":"148.580911ms","start":"2026-08-22T14:43:21.262446Z","end":"2026-08-22T14:43:21.411026Z","steps":["trace[140439512] 'agreement among raft nodes before linearized reading' (duration: 148.219934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:21.411347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.585467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.232\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-22T14:43:21.411423Z","caller":"traceutil/trace.go:171","msg":"trace[648586449] range","detail":"{range_begin:/registry/masterleases/199.19.213.232; range_end:; response_count:1; response_revision:4630; }","duration":"171.676078ms","start":"2026-08-22T14:43:21.23973Z","end":"2026-08-22T14:43:21.411406Z","steps":["trace[648586449] 'agreement among raft nodes before linearized reading' (duration: 171.358413ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:22.276104Z","caller":"traceutil/trace.go:171","msg":"trace[816843036] linearizableReadLoop","detail":"{readStateIndex:4834; appliedIndex:4833; }","duration":"167.620405ms","start":"2026-08-22T14:43:22.108465Z","end":"2026-08-22T14:43:22.276085Z","steps":["trace[816843036] 'read index received' (duration: 167.34461ms)","trace[816843036] 'applied index is now lower than readState.Index' (duration: 275.155µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:22.276156Z","caller":"traceutil/trace.go:171","msg":"trace[86902699] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"216.201211ms","start":"2026-08-22T14:43:22.059929Z","end":"2026-08-22T14:43:22.276131Z","steps":["trace[86902699] 'process raft request' (duration: 216.010737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:22.276274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.790878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:43:22.276304Z","caller":"traceutil/trace.go:171","msg":"trace[1992115159] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:4652; }","duration":"167.88464ms","start":"2026-08-22T14:43:22.108409Z","end":"2026-08-22T14:43:22.276294Z","steps":["trace[1992115159] 'agreement among raft nodes before linearized reading' (duration: 167.780348ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:27.938475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.157926ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:43:27.938601Z","caller":"traceutil/trace.go:171","msg":"trace[482923221] linearizableReadLoop","detail":"{readStateIndex:4932; appliedIndex:4931; }","duration":"283.00428ms","start":"2026-08-22T14:43:27.655579Z","end":"2026-08-22T14:43:27.938583Z","steps":["trace[482923221] 'read index received' (duration: 25.546539ms)","trace[482923221] 'applied index is now lower than readState.Index' (duration: 257.456181ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:27.9388Z","caller":"traceutil/trace.go:171","msg":"trace[60199597] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"293.681228ms","start":"2026-08-22T14:43:27.645102Z","end":"2026-08-22T14:43:27.938783Z","steps":["trace[60199597] 'process raft request' (duration: 36.103354ms)","trace[60199597] 'compare' (duration: 256.977923ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:27.939023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.935813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-08-22T14:43:27.939108Z","caller":"traceutil/trace.go:171","msg":"trace[152775102] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4748; }","duration":"265.069835ms","start":"2026-08-22T14:43:27.674017Z","end":"2026-08-22T14:43:27.939087Z","steps":["trace[152775102] 'agreement among raft nodes before linearized reading' (duration: 264.846951ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:27.939266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.127023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"warn","ts":"2026-08-22T14:43:27.93931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.704612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-08-22T14:43:27.939355Z","caller":"traceutil/trace.go:171","msg":"trace[517926502] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4748; }","duration":"262.253446ms","start":"2026-08-22T14:43:27.677081Z","end":"2026-08-22T14:43:27.939334Z","steps":["trace[517926502] 'agreement among raft nodes before linearized reading' (duration: 261.970511ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:27.939422Z","caller":"traceutil/trace.go:171","msg":"trace[468101346] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4748; }","duration":"283.865705ms","start":"2026-08-22T14:43:27.655528Z","end":"2026-08-22T14:43:27.939394Z","steps":["trace[468101346] 'agreement among raft nodes before linearized reading' (duration: 283.504219ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:28.157368Z","caller":"traceutil/trace.go:171","msg":"trace[230932255] linearizableReadLoop","detail":"{readStateIndex:4933; appliedIndex:4932; }","duration":"213.301194ms","start":"2026-08-22T14:43:27.944039Z","end":"2026-08-22T14:43:28.15734Z","steps":["trace[230932255] 'read index received' (duration: 213.113781ms)","trace[230932255] 'applied index is now lower than readState.Index' (duration: 186.473µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:28.158011Z","caller":"traceutil/trace.go:171","msg":"trace[935005526] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"214.055007ms","start":"2026-08-22T14:43:27.94394Z","end":"2026-08-22T14:43:28.157995Z","steps":["trace[935005526] 'process raft request' (duration: 213.241983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:28.158377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.315601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18ce27bff68cdc90\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-08-22T14:43:28.158433Z","caller":"traceutil/trace.go:171","msg":"trace[1242675895] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18ce27bff68cdc90; range_end:; response_count:1; response_revision:4749; }","duration":"214.412424ms","start":"2026-08-22T14:43:27.944006Z","end":"2026-08-22T14:43:28.158418Z","steps":["trace[1242675895] 'agreement among raft nodes before linearized reading' (duration: 214.231401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:28.158657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.11618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-08-22T14:43:28.158689Z","caller":"traceutil/trace.go:171","msg":"trace[1382079416] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4749; }","duration":"193.197241ms","start":"2026-08-22T14:43:27.965482Z","end":"2026-08-22T14:43:28.15868Z","steps":["trace[1382079416] 'agreement among raft nodes before linearized reading' (duration: 193.1039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:28.664645Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280404888139183271,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-22T14:43:28.73862Z","caller":"traceutil/trace.go:171","msg":"trace[1347461149] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"577.353681ms","start":"2026-08-22T14:43:28.161172Z","end":"2026-08-22T14:43:28.738525Z","steps":["trace[1347461149] 'process raft request' (duration: 541.847678ms)","trace[1347461149] 'compare' (duration: 35.000164ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:28.738851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:28.16114Z","time spent":"577.583705ms","remote":"127.0.0.1:45386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:28.751846Z","caller":"traceutil/trace.go:171","msg":"trace[733843041] linearizableReadLoop","detail":"{readStateIndex:4935; appliedIndex:4933; }","duration":"587.284066ms","start":"2026-08-22T14:43:28.164542Z","end":"2026-08-22T14:43:28.751826Z","steps":["trace[733843041] 'read index received' (duration: 538.51527ms)","trace[733843041] 'applied index is now lower than readState.Index' (duration: 48.765896ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:28.752124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.433854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:43:28.752158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.55295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:43:28.752215Z","caller":"traceutil/trace.go:171","msg":"trace[1318923871] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:4751; }","duration":"181.605207ms","start":"2026-08-22T14:43:28.57059Z","end":"2026-08-22T14:43:28.752195Z","steps":["trace[1318923871] 'agreement among raft nodes before linearized reading' (duration: 181.386703ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:28.752296Z","caller":"traceutil/trace.go:171","msg":"trace[1337924588] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:4751; }","duration":"587.752043ms","start":"2026-08-22T14:43:28.164516Z","end":"2026-08-22T14:43:28.752268Z","steps":["trace[1337924588] 'agreement among raft nodes before linearized reading' (duration: 587.423358ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:28.752273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.359897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9fd580b7-1080-4fa4-8437-7f5ad4e2d0e8\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-08-22T14:43:28.752216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.164956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"warn","ts":"2026-08-22T14:43:28.752359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:28.164508Z","time spent":"587.839425ms","remote":"127.0.0.1:47166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-08-22T14:43:28.752368Z","caller":"traceutil/trace.go:171","msg":"trace[1902509355] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9fd580b7-1080-4fa4-8437-7f5ad4e2d0e8; range_end:; response_count:1; response_revision:4751; }","duration":"269.49705ms","start":"2026-08-22T14:43:28.482848Z","end":"2026-08-22T14:43:28.752345Z","steps":["trace[1902509355] 'agreement among raft nodes before linearized reading' (duration: 269.181534ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:28.752385Z","caller":"traceutil/trace.go:171","msg":"trace[685947504] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4751; }","duration":"586.358659ms","start":"2026-08-22T14:43:28.166013Z","end":"2026-08-22T14:43:28.752371Z","steps":["trace[685947504] 'agreement among raft nodes before linearized reading' (duration: 585.928452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:28.752358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.733637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-22T14:43:28.752457Z","caller":"traceutil/trace.go:171","msg":"trace[592859962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4751; }","duration":"439.9043ms","start":"2026-08-22T14:43:28.312538Z","end":"2026-08-22T14:43:28.752442Z","steps":["trace[592859962] 'agreement among raft nodes before linearized reading' (duration: 439.578525ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:28.752525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:28.312516Z","time spent":"439.999482ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-22T14:43:28.752116Z","caller":"traceutil/trace.go:171","msg":"trace[22456100] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"590.068144ms","start":"2026-08-22T14:43:28.161799Z","end":"2026-08-22T14:43:28.751867Z","steps":["trace[22456100] 'process raft request' (duration: 589.920452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:28.752655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:28.166007Z","time spent":"586.610313ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3529,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-08-22T14:43:28.752937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:28.161773Z","time spent":"590.925049ms","remote":"127.0.0.1:45386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T14:43:29.233734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.777433ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:43:29.233854Z","caller":"traceutil/trace.go:171","msg":"trace[1583068383] linearizableReadLoop","detail":"{readStateIndex:4946; appliedIndex:4945; }","duration":"215.011271ms","start":"2026-08-22T14:43:29.018825Z","end":"2026-08-22T14:43:29.233836Z","steps":["trace[1583068383] 'read index received' (duration: 103.887762ms)","trace[1583068383] 'applied index is now lower than readState.Index' (duration: 111.122489ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:29.233891Z","caller":"traceutil/trace.go:171","msg":"trace[882428389] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"278.564686ms","start":"2026-08-22T14:43:28.955296Z","end":"2026-08-22T14:43:29.23386Z","steps":["trace[882428389] 'process raft request' (duration: 167.5694ms)","trace[882428389] 'compare' (duration: 110.618309ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:29.233989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.281008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-08-22T14:43:29.234023Z","caller":"traceutil/trace.go:171","msg":"trace[504781884] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4762; }","duration":"279.324169ms","start":"2026-08-22T14:43:28.95469Z","end":"2026-08-22T14:43:29.234014Z","steps":["trace[504781884] 'agreement among raft nodes before linearized reading' (duration: 279.192226ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:29.593495Z","caller":"traceutil/trace.go:171","msg":"trace[436264477] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"351.408672ms","start":"2026-08-22T14:43:29.242055Z","end":"2026-08-22T14:43:29.593464Z","steps":["trace[436264477] 'process raft request' (duration: 316.544881ms)","trace[436264477] 'compare' (duration: 34.727719ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:29.593698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:29.242043Z","time spent":"351.543525ms","remote":"127.0.0.1:45566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1392,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:29.609907Z","caller":"traceutil/trace.go:171","msg":"trace[351661267] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"367.608117ms","start":"2026-08-22T14:43:29.242273Z","end":"2026-08-22T14:43:29.609881Z","steps":["trace[351661267] 'process raft request' (duration: 367.350972ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:29.609955Z","caller":"traceutil/trace.go:171","msg":"trace[1656135319] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"367.523745ms","start":"2026-08-22T14:43:29.242386Z","end":"2026-08-22T14:43:29.609909Z","steps":["trace[1656135319] 'process raft request' (duration: 367.387293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:29.61007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:29.242263Z","time spent":"367.719819ms","remote":"127.0.0.1:45472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:29.610175Z","caller":"traceutil/trace.go:171","msg":"trace[1358501437] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"367.623947ms","start":"2026-08-22T14:43:29.242531Z","end":"2026-08-22T14:43:29.610155Z","steps":["trace[1358501437] 'process raft request' (duration: 367.288351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:29.610326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:29.242503Z","time spent":"367.742249ms","remote":"127.0.0.1:45566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1852,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:29.610889Z","caller":"traceutil/trace.go:171","msg":"trace[801210588] linearizableReadLoop","detail":"{readStateIndex:4950; appliedIndex:4946; }","duration":"366.780212ms","start":"2026-08-22T14:43:29.244087Z","end":"2026-08-22T14:43:29.610868Z","steps":["trace[801210588] 'read index received' (duration: 314.527796ms)","trace[801210588] 'applied index is now lower than readState.Index' (duration: 52.250706ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:29.611133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.330829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-22T14:43:29.611194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.917334ms","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-08-22T14:43:29.611221Z","caller":"traceutil/trace.go:171","msg":"trace[444009651] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4770; }","duration":"287.453131ms","start":"2026-08-22T14:43:29.323757Z","end":"2026-08-22T14:43:29.61121Z","steps":["trace[444009651] 'agreement among raft nodes before linearized reading' (duration: 287.333499ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:29.611247Z","caller":"traceutil/trace.go:171","msg":"trace[525377969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4770; }","duration":"359.033357ms","start":"2026-08-22T14:43:29.252199Z","end":"2026-08-22T14:43:29.611232Z","steps":["trace[525377969] 'agreement among raft nodes before linearized reading' (duration: 358.825653ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:29.611254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.169009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61909"} {"level":"warn","ts":"2026-08-22T14:43:29.611291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:29.252187Z","time spent":"359.092257ms","remote":"127.0.0.1:45560","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-08-22T14:43:29.61131Z","caller":"traceutil/trace.go:171","msg":"trace[351982454] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4770; }","duration":"367.258851ms","start":"2026-08-22T14:43:29.244039Z","end":"2026-08-22T14:43:29.611297Z","steps":["trace[351982454] 'agreement among raft nodes before linearized reading' (duration: 366.941535ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:29.611349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:29.244022Z","time spent":"367.316161ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":6,"response size":61932,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"warn","ts":"2026-08-22T14:43:29.612389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.766525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:43:29.612521Z","caller":"traceutil/trace.go:171","msg":"trace[1331444539] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:4770; }","duration":"292.925867ms","start":"2026-08-22T14:43:29.319574Z","end":"2026-08-22T14:43:29.612499Z","steps":["trace[1331444539] 'agreement among raft nodes before linearized reading' (duration: 292.651432ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:29.613274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.60547ms","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-08-22T14:43:29.613391Z","caller":"traceutil/trace.go:171","msg":"trace[1959913523] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4770; }","duration":"337.736432ms","start":"2026-08-22T14:43:29.275639Z","end":"2026-08-22T14:43:29.613376Z","steps":["trace[1959913523] 'agreement among raft nodes before linearized reading' (duration: 337.532249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:29.613532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:29.275632Z","time spent":"337.884256ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-22T14:43:29.610159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:29.242354Z","time spent":"367.679908ms","remote":"127.0.0.1:45472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1272,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:29.61631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.906222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-22T14:43:29.616469Z","caller":"traceutil/trace.go:171","msg":"trace[581542780] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4770; }","duration":"119.951893ms","start":"2026-08-22T14:43:29.49639Z","end":"2026-08-22T14:43:29.616342Z","steps":["trace[581542780] 'agreement among raft nodes before linearized reading' (duration: 115.504755ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:29.744974Z","caller":"traceutil/trace.go:171","msg":"trace[173316087] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"126.352786ms","start":"2026-08-22T14:43:29.618594Z","end":"2026-08-22T14:43:29.744947Z","steps":["trace[173316087] 'process raft request' (duration: 122.568179ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:29.751972Z","caller":"traceutil/trace.go:171","msg":"trace[1071874153] linearizableReadLoop","detail":"{readStateIndex:4957; appliedIndex:4954; }","duration":"105.901827ms","start":"2026-08-22T14:43:29.646047Z","end":"2026-08-22T14:43:29.751949Z","steps":["trace[1071874153] 'read index received' (duration: 95.085638ms)","trace[1071874153] 'applied index is now lower than readState.Index' (duration: 10.814299ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:29.752592Z","caller":"traceutil/trace.go:171","msg":"trace[776790416] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"132.201209ms","start":"2026-08-22T14:43:29.620176Z","end":"2026-08-22T14:43:29.752378Z","steps":["trace[776790416] 'process raft request' (duration: 131.488636ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:29.753185Z","caller":"traceutil/trace.go:171","msg":"trace[2109008485] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"124.746128ms","start":"2026-08-22T14:43:29.628424Z","end":"2026-08-22T14:43:29.75317Z","steps":["trace[2109008485] 'process raft request' (duration: 123.406734ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:29.753333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.265971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-08-22T14:43:29.753398Z","caller":"traceutil/trace.go:171","msg":"trace[1422073117] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4773; }","duration":"107.392824ms","start":"2026-08-22T14:43:29.645989Z","end":"2026-08-22T14:43:29.753382Z","steps":["trace[1422073117] 'agreement among raft nodes before linearized reading' (duration: 107.263681ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.191052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.210143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-22T14:43:32.191126Z","caller":"traceutil/trace.go:171","msg":"trace[168391690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4798; }","duration":"441.332996ms","start":"2026-08-22T14:43:31.749774Z","end":"2026-08-22T14:43:32.191107Z","steps":["trace[168391690] 'range keys from in-memory index tree' (duration: 441.06937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.191161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:31.749751Z","time spent":"441.401476ms","remote":"127.0.0.1:45560","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-08-22T14:43:32.191327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.364143ms","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-08-22T14:43:32.191365Z","caller":"traceutil/trace.go:171","msg":"trace[270970302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4798; }","duration":"434.417964ms","start":"2026-08-22T14:43:31.756933Z","end":"2026-08-22T14:43:32.191351Z","steps":["trace[270970302] 'range keys from in-memory index tree' (duration: 434.284982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.1914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:31.756923Z","time spent":"434.466684ms","remote":"127.0.0.1:45560","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-08-22T14:43:32.191615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.606149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-8c6vp\" ","response":"range_response_count:1 size:5148"} {"level":"info","ts":"2026-08-22T14:43:32.191649Z","caller":"traceutil/trace.go:171","msg":"trace[1062652672] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-8c6vp; range_end:; response_count:1; response_revision:4798; }","duration":"417.661071ms","start":"2026-08-22T14:43:31.773977Z","end":"2026-08-22T14:43:32.191638Z","steps":["trace[1062652672] 'range keys from in-memory index tree' (duration: 417.454097ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.191676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:31.773963Z","time spent":"417.706691ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":5171,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-8c6vp\" "} {"level":"warn","ts":"2026-08-22T14:43:32.19185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.335805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9fd580b7-1080-4fa4-8437-7f5ad4e2d0e8\" ","response":"range_response_count:1 size:3939"} {"level":"info","ts":"2026-08-22T14:43:32.19188Z","caller":"traceutil/trace.go:171","msg":"trace[382460370] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9fd580b7-1080-4fa4-8437-7f5ad4e2d0e8; range_end:; response_count:1; response_revision:4798; }","duration":"417.380626ms","start":"2026-08-22T14:43:31.77449Z","end":"2026-08-22T14:43:32.191871Z","steps":["trace[382460370] 'range keys from in-memory index tree' (duration: 417.255584ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.191909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:31.774483Z","time spent":"417.419786ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3962,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9fd580b7-1080-4fa4-8437-7f5ad4e2d0e8\" "} {"level":"warn","ts":"2026-08-22T14:43:32.192092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.589385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6868f5db79-rh9sb.18ce27bfb23449e3\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-08-22T14:43:32.192121Z","caller":"traceutil/trace.go:171","msg":"trace[2050784298] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-6868f5db79-rh9sb.18ce27bfb23449e3; range_end:; response_count:1; response_revision:4798; }","duration":"379.638396ms","start":"2026-08-22T14:43:31.812474Z","end":"2026-08-22T14:43:32.192113Z","steps":["trace[2050784298] 'range keys from in-memory index tree' (duration: 379.472623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.192148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:31.812464Z","time spent":"379.678107ms","remote":"127.0.0.1:45386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":919,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6868f5db79-rh9sb.18ce27bfb23449e3\" "} {"level":"warn","ts":"2026-08-22T14:43:32.192737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.740482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-22T14:43:32.192785Z","caller":"traceutil/trace.go:171","msg":"trace[1286936657] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4798; }","duration":"289.868934ms","start":"2026-08-22T14:43:31.902904Z","end":"2026-08-22T14:43:32.192773Z","steps":["trace[1286936657] 'range keys from in-memory index tree' (duration: 289.519798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.19388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.97925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:43:32.193984Z","caller":"traceutil/trace.go:171","msg":"trace[275084096] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4798; }","duration":"268.165424ms","start":"2026-08-22T14:43:31.925804Z","end":"2026-08-22T14:43:32.19397Z","steps":["trace[275084096] 'range keys from in-memory index tree' (duration: 267.879329ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.876128Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280404888139183393,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-22T14:43:32.99931Z","caller":"traceutil/trace.go:171","msg":"trace[2132160223] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"801.389464ms","start":"2026-08-22T14:43:32.197895Z","end":"2026-08-22T14:43:32.999285Z","steps":["trace[2132160223] 'process raft request' (duration: 801.19484ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:32.99946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:32.197882Z","time spent":"801.497005ms","remote":"127.0.0.1:45386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":881,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:33.012914Z","caller":"traceutil/trace.go:171","msg":"trace[535656288] linearizableReadLoop","detail":"{readStateIndex:4988; appliedIndex:4983; }","duration":"636.867895ms","start":"2026-08-22T14:43:32.376023Z","end":"2026-08-22T14:43:33.012891Z","steps":["trace[535656288] 'read index received' (duration: 623.056513ms)","trace[535656288] 'applied index is now lower than readState.Index' (duration: 13.810172ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:33.013218Z","caller":"traceutil/trace.go:171","msg":"trace[1658573533] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"814.92817ms","start":"2026-08-22T14:43:32.198277Z","end":"2026-08-22T14:43:33.013205Z","steps":["trace[1658573533] 'process raft request' (duration: 814.33041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:33.013342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:32.198252Z","time spent":"815.007072ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:33.01348Z","caller":"traceutil/trace.go:171","msg":"trace[1844435848] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"810.408411ms","start":"2026-08-22T14:43:32.20306Z","end":"2026-08-22T14:43:33.013468Z","steps":["trace[1844435848] 'process raft request' (duration: 809.77499ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:33.013547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:32.203054Z","time spent":"810.458203ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4933,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:33.013584Z","caller":"traceutil/trace.go:171","msg":"trace[4258198] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"813.686448ms","start":"2026-08-22T14:43:32.199869Z","end":"2026-08-22T14:43:33.013556Z","steps":["trace[4258198] 'process raft request' (duration: 812.928815ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:33.013675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.231979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:43:33.013779Z","caller":"traceutil/trace.go:171","msg":"trace[1281191191] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:4803; }","duration":"626.392351ms","start":"2026-08-22T14:43:32.387368Z","end":"2026-08-22T14:43:33.01376Z","steps":["trace[1281191191] 'agreement among raft nodes before linearized reading' (duration: 626.172547ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:33.013767Z","caller":"traceutil/trace.go:171","msg":"trace[1096295668] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"814.175417ms","start":"2026-08-22T14:43:32.199574Z","end":"2026-08-22T14:43:33.01375Z","steps":["trace[1096295668] 'process raft request' (duration: 813.174959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:33.013796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.165397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-22T14:43:33.013721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:32.19986Z","time spent":"813.783551ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:33.013806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.76763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18ce27bff1750886\" ","response":"range_response_count:1 size:1012"} {"level":"warn","ts":"2026-08-22T14:43:33.013835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:32.387358Z","time spent":"626.464612ms","remote":"127.0.0.1:45666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-08-22T14:43:33.013848Z","caller":"traceutil/trace.go:171","msg":"trace[1311922519] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4803; }","duration":"218.258799ms","start":"2026-08-22T14:43:32.795576Z","end":"2026-08-22T14:43:33.013834Z","steps":["trace[1311922519] 'agreement among raft nodes before linearized reading' (duration: 218.099337ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:33.013874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:32.199559Z","time spent":"814.256989ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:33.013889Z","caller":"traceutil/trace.go:171","msg":"trace[470537515] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18ce27bff1750886; range_end:; response_count:1; response_revision:4803; }","duration":"637.848652ms","start":"2026-08-22T14:43:32.376006Z","end":"2026-08-22T14:43:33.013855Z","steps":["trace[470537515] 'agreement among raft nodes before linearized reading' (duration: 637.625108ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:33.013927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:32.375945Z","time spent":"637.975174ms","remote":"127.0.0.1:45386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":1035,"request content":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18ce27bff1750886\" "} {"level":"warn","ts":"2026-08-22T14:43:33.238328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.686365ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:43:33.23843Z","caller":"traceutil/trace.go:171","msg":"trace[287628438] linearizableReadLoop","detail":"{readStateIndex:4995; appliedIndex:4994; }","duration":"106.975311ms","start":"2026-08-22T14:43:33.131438Z","end":"2026-08-22T14:43:33.238414Z","steps":["trace[287628438] 'read index received' (duration: 4.045591ms)","trace[287628438] 'applied index is now lower than readState.Index' (duration: 102.92834ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:33.238531Z","caller":"traceutil/trace.go:171","msg":"trace[767934501] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"163.748463ms","start":"2026-08-22T14:43:33.074755Z","end":"2026-08-22T14:43:33.238503Z","steps":["trace[767934501] 'process raft request' (duration: 60.800063ms)","trace[767934501] 'compare' (duration: 102.576394ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:33.238745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.302736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-9fd580b7-1080-4fa4-8437-7f5ad4e2d0e8\" ","response":"range_response_count:1 size:2244"} {"level":"info","ts":"2026-08-22T14:43:33.238786Z","caller":"traceutil/trace.go:171","msg":"trace[1031650716] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-9fd580b7-1080-4fa4-8437-7f5ad4e2d0e8; range_end:; response_count:1; response_revision:4810; }","duration":"107.390058ms","start":"2026-08-22T14:43:33.131384Z","end":"2026-08-22T14:43:33.238775Z","steps":["trace[1031650716] 'agreement among raft nodes before linearized reading' (duration: 107.269026ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:38.119262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.313726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-08-22T14:43:38.119327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.698754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:43:38.119371Z","caller":"traceutil/trace.go:171","msg":"trace[149754903] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4889; }","duration":"171.447819ms","start":"2026-08-22T14:43:37.947897Z","end":"2026-08-22T14:43:38.119345Z","steps":["trace[149754903] 'range keys from in-memory index tree' (duration: 171.068892ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:38.119424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.832987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-rzttx.18ce27be469dbec2\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-08-22T14:43:38.119473Z","caller":"traceutil/trace.go:171","msg":"trace[1337340788] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-rzttx.18ce27be469dbec2; range_end:; response_count:1; response_revision:4889; }","duration":"174.940219ms","start":"2026-08-22T14:43:37.94452Z","end":"2026-08-22T14:43:38.11946Z","steps":["trace[1337340788] 'range keys from in-memory index tree' (duration: 174.599714ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:38.119425Z","caller":"traceutil/trace.go:171","msg":"trace[823367063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4889; }","duration":"194.833136ms","start":"2026-08-22T14:43:37.924571Z","end":"2026-08-22T14:43:38.119404Z","steps":["trace[823367063] 'range keys from in-memory index tree' (duration: 194.612313ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:38.120074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.249614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13290"} {"level":"info","ts":"2026-08-22T14:43:38.120159Z","caller":"traceutil/trace.go:171","msg":"trace[2025207034] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4889; }","duration":"226.380337ms","start":"2026-08-22T14:43:37.893755Z","end":"2026-08-22T14:43:38.120136Z","steps":["trace[2025207034] 'range keys from in-memory index tree' (duration: 226.03235ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:43.508496Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280404888139183733,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T14:43:44.008768Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280404888139183733,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T14:43:44.026493Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.062671078s","expected-duration":"1s"} {"level":"info","ts":"2026-08-22T14:43:44.027003Z","caller":"traceutil/trace.go:171","msg":"trace[136550100] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"1.063338379s","start":"2026-08-22T14:43:42.963639Z","end":"2026-08-22T14:43:44.026978Z","steps":["trace[136550100] 'process raft request' (duration: 1.063088215s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.027201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:42.963603Z","time spent":"1.063460602s","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10667,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:44.216262Z","caller":"traceutil/trace.go:171","msg":"trace[1047048619] linearizableReadLoop","detail":"{readStateIndex:5139; appliedIndex:5134; }","duration":"1.208382906s","start":"2026-08-22T14:43:43.007813Z","end":"2026-08-22T14:43:44.216196Z","steps":["trace[1047048619] 'read index received' (duration: 1.019169671s)","trace[1047048619] 'applied index is now lower than readState.Index' (duration: 189.212275ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:44.216402Z","caller":"traceutil/trace.go:171","msg":"trace[1521244797] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"529.467134ms","start":"2026-08-22T14:43:43.686922Z","end":"2026-08-22T14:43:44.216389Z","steps":["trace[1521244797] 'process raft request' (duration: 529.154009ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:44.216397Z","caller":"traceutil/trace.go:171","msg":"trace[1544775040] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"532.747671ms","start":"2026-08-22T14:43:43.683603Z","end":"2026-08-22T14:43:44.216351Z","steps":["trace[1544775040] 'process raft request' (duration: 532.427086ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.216514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.686895Z","time spent":"529.534685ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:44.216562Z","caller":"traceutil/trace.go:171","msg":"trace[1038751893] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"403.72057ms","start":"2026-08-22T14:43:43.81282Z","end":"2026-08-22T14:43:44.216541Z","steps":["trace[1038751893] 'process raft request' (duration: 403.335443ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.216607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.68358Z","time spent":"532.907354ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:44.21663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.812795Z","time spent":"403.801292ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:43:44.216643Z","caller":"traceutil/trace.go:171","msg":"trace[63828839] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"537.032146ms","start":"2026-08-22T14:43:43.679566Z","end":"2026-08-22T14:43:44.216598Z","steps":["trace[63828839] 'process raft request' (duration: 527.263536ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:44.216771Z","caller":"traceutil/trace.go:171","msg":"trace[289610029] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"529.368153ms","start":"2026-08-22T14:43:43.687393Z","end":"2026-08-22T14:43:44.216761Z","steps":["trace[289610029] 'process raft request' (duration: 528.725941ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.216883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.687385Z","time spent":"529.468724ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:44.216805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.208982756s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-22T14:43:44.217001Z","caller":"traceutil/trace.go:171","msg":"trace[2002767770] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4948; }","duration":"1.20918156s","start":"2026-08-22T14:43:43.0078Z","end":"2026-08-22T14:43:44.216981Z","steps":["trace[2002767770] 'agreement among raft nodes before linearized reading' (duration: 1.208894045s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.217041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.679538Z","time spent":"537.212088ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:44.217055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.007792Z","time spent":"1.209251712s","remote":"127.0.0.1:45470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-08-22T14:43:44.469791Z","caller":"traceutil/trace.go:171","msg":"trace[94668781] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"434.200897ms","start":"2026-08-22T14:43:44.035552Z","end":"2026-08-22T14:43:44.469753Z","steps":["trace[94668781] 'process raft request' (duration: 400.087885ms)","trace[94668781] 'compare' (duration: 33.827697ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:44.47016Z","caller":"traceutil/trace.go:171","msg":"trace[384925351] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"434.497871ms","start":"2026-08-22T14:43:44.035621Z","end":"2026-08-22T14:43:44.470119Z","steps":["trace[384925351] 'process raft request' (duration: 434.060474ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:44.470413Z","caller":"traceutil/trace.go:171","msg":"trace[20229474] linearizableReadLoop","detail":"{readStateIndex:5143; appliedIndex:5139; }","duration":"254.03201ms","start":"2026-08-22T14:43:44.216348Z","end":"2026-08-22T14:43:44.47038Z","steps":["trace[20229474] 'read index received' (duration: 219.197085ms)","trace[20229474] 'applied index is now lower than readState.Index' (duration: 34.831995ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:44.470464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:44.035616Z","time spent":"434.678835ms","remote":"127.0.0.1:45472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:44.470621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.363003329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T14:43:44.470685Z","caller":"traceutil/trace.go:171","msg":"trace[248913872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4952; }","duration":"1.363164622s","start":"2026-08-22T14:43:43.107505Z","end":"2026-08-22T14:43:44.47067Z","steps":["trace[248913872] 'agreement among raft nodes before linearized reading' (duration: 1.362926338s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.470662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.013241604s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-22T14:43:44.470748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.107465Z","time spent":"1.363273794s","remote":"127.0.0.1:45560","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":"info","ts":"2026-08-22T14:43:44.470778Z","caller":"traceutil/trace.go:171","msg":"trace[171949890] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:4952; }","duration":"1.013456557s","start":"2026-08-22T14:43:43.457297Z","end":"2026-08-22T14:43:44.470754Z","steps":["trace[171949890] 'agreement among raft nodes before linearized reading' (duration: 1.013108261s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.470799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.381929998s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-22T14:43:44.470817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.802337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:43:44.470856Z","caller":"traceutil/trace.go:171","msg":"trace[161836133] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:4952; }","duration":"237.861079ms","start":"2026-08-22T14:43:44.23298Z","end":"2026-08-22T14:43:44.470841Z","steps":["trace[161836133] 'agreement among raft nodes before linearized reading' (duration: 237.804728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.470687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392232247s","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-08-22T14:43:44.470907Z","caller":"traceutil/trace.go:171","msg":"trace[824616423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4952; }","duration":"1.392501252s","start":"2026-08-22T14:43:43.078395Z","end":"2026-08-22T14:43:44.470896Z","steps":["trace[824616423] 'agreement among raft nodes before linearized reading' (duration: 1.392127685s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:44.470931Z","caller":"traceutil/trace.go:171","msg":"trace[175121414] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"434.622914ms","start":"2026-08-22T14:43:44.036296Z","end":"2026-08-22T14:43:44.470919Z","steps":["trace[175121414] 'process raft request' (duration: 433.989933ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.47095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.078379Z","time spent":"1.392560583s","remote":"127.0.0.1:45560","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-08-22T14:43:44.471025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:44.036286Z","time spent":"434.675355ms","remote":"127.0.0.1:45566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:44.470753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.713484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c755fe1d-dc16-41cf-aa95-25ffe80a6872\" ","response":"range_response_count:1 size:1435"} {"level":"warn","ts":"2026-08-22T14:43:44.471023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.36018879s","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-08-22T14:43:44.471097Z","caller":"traceutil/trace.go:171","msg":"trace[1287828819] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c755fe1d-dc16-41cf-aa95-25ffe80a6872; range_end:; response_count:1; response_revision:4952; }","duration":"250.081071ms","start":"2026-08-22T14:43:44.221003Z","end":"2026-08-22T14:43:44.471084Z","steps":["trace[1287828819] 'agreement among raft nodes before linearized reading' (duration: 249.664254ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:44.471122Z","caller":"traceutil/trace.go:171","msg":"trace[1323448388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4952; }","duration":"1.360358203s","start":"2026-08-22T14:43:43.110739Z","end":"2026-08-22T14:43:44.471097Z","steps":["trace[1323448388] 'agreement among raft nodes before linearized reading' (duration: 1.360091029s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:44.47113Z","caller":"traceutil/trace.go:171","msg":"trace[2055612071] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"435.319897ms","start":"2026-08-22T14:43:44.035788Z","end":"2026-08-22T14:43:44.471108Z","steps":["trace[2055612071] 'process raft request' (duration: 434.264798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.471182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.110713Z","time spent":"1.360455825s","remote":"127.0.0.1:45560","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-08-22T14:43:44.471223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:44.03576Z","time spent":"435.411988ms","remote":"127.0.0.1:45566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1505,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:44.470854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.457278Z","time spent":"1.01356318s","remote":"127.0.0.1:45506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":69,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-08-22T14:43:44.470637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.395048096s","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-08-22T14:43:44.471325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.763473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:43:44.471346Z","caller":"traceutil/trace.go:171","msg":"trace[802387989] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4952; }","duration":"1.395818018s","start":"2026-08-22T14:43:43.075516Z","end":"2026-08-22T14:43:44.471334Z","steps":["trace[802387989] 'agreement among raft nodes before linearized reading' (duration: 1.395027045s)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:44.471376Z","caller":"traceutil/trace.go:171","msg":"trace[407028882] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:4952; }","duration":"728.853734ms","start":"2026-08-22T14:43:43.742508Z","end":"2026-08-22T14:43:44.471362Z","steps":["trace[407028882] 'agreement among raft nodes before linearized reading' (duration: 728.723112ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.471384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.075486Z","time spent":"1.39588728s","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-22T14:43:44.471424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.742458Z","time spent":"728.955356ms","remote":"127.0.0.1:45656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":72,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-08-22T14:43:44.47086Z","caller":"traceutil/trace.go:171","msg":"trace[1898082108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4952; }","duration":"1.38203454s","start":"2026-08-22T14:43:43.088804Z","end":"2026-08-22T14:43:44.470839Z","steps":["trace[1898082108] 'agreement among raft nodes before linearized reading' (duration: 1.381938388s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.471483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:43.088779Z","time spent":"1.382692561s","remote":"127.0.0.1:45560","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-08-22T14:43:44.471589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.704505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16548"} {"level":"info","ts":"2026-08-22T14:43:44.471636Z","caller":"traceutil/trace.go:171","msg":"trace[1240158273] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4952; }","duration":"438.789266ms","start":"2026-08-22T14:43:44.032834Z","end":"2026-08-22T14:43:44.471623Z","steps":["trace[1240158273] 'agreement among raft nodes before linearized reading' (duration: 438.676084ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:44.471669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:44.032811Z","time spent":"438.851727ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16571,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-08-22T14:43:44.470261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:44.03554Z","time spent":"434.483952ms","remote":"127.0.0.1:45472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:43:45.36581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.338691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-22T14:43:45.36592Z","caller":"traceutil/trace.go:171","msg":"trace[294995686] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4960; }","duration":"311.523224ms","start":"2026-08-22T14:43:45.054375Z","end":"2026-08-22T14:43:45.365898Z","steps":["trace[294995686] 'range keys from in-memory index tree' (duration: 311.108867ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:45.365973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:45.054345Z","time spent":"311.616926ms","remote":"127.0.0.1:45470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-08-22T14:43:45.367488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.223249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-22T14:43:45.367575Z","caller":"traceutil/trace.go:171","msg":"trace[1117104060] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4960; }","duration":"288.373092ms","start":"2026-08-22T14:43:45.079183Z","end":"2026-08-22T14:43:45.367556Z","steps":["trace[1117104060] 'range keys from in-memory index tree' (duration: 286.607862ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:47.457099Z","caller":"traceutil/trace.go:171","msg":"trace[341678364] linearizableReadLoop","detail":"{readStateIndex:5161; appliedIndex:5160; }","duration":"536.555497ms","start":"2026-08-22T14:43:46.920507Z","end":"2026-08-22T14:43:47.457062Z","steps":["trace[341678364] 'read index received' (duration: 454.324412ms)","trace[341678364] 'applied index is now lower than readState.Index' (duration: 82.229195ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:43:47.457299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.75105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T14:43:47.457363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.737648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:43:47.457408Z","caller":"traceutil/trace.go:171","msg":"trace[898690988] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:4969; }","duration":"536.914722ms","start":"2026-08-22T14:43:46.92047Z","end":"2026-08-22T14:43:47.457384Z","steps":["trace[898690988] 'agreement among raft nodes before linearized reading' (duration: 536.714999ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:47.457413Z","caller":"traceutil/trace.go:171","msg":"trace[75060441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4969; }","duration":"533.83301ms","start":"2026-08-22T14:43:46.923565Z","end":"2026-08-22T14:43:47.457398Z","steps":["trace[75060441] 'agreement among raft nodes before linearized reading' (duration: 533.697917ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:47.457463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:46.920452Z","time spent":"536.998355ms","remote":"127.0.0.1:50564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-22T14:43:47.457495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:46.92356Z","time spent":"533.896921ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-22T14:43:47.457505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.643477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-22T14:43:47.457588Z","caller":"traceutil/trace.go:171","msg":"trace[371530375] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4969; }","duration":"237.79941ms","start":"2026-08-22T14:43:47.219767Z","end":"2026-08-22T14:43:47.457566Z","steps":["trace[371530375] 'agreement among raft nodes before linearized reading' (duration: 237.526115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:47.457505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.876822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-22T14:43:47.457685Z","caller":"traceutil/trace.go:171","msg":"trace[753607807] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4969; }","duration":"462.116696ms","start":"2026-08-22T14:43:46.995548Z","end":"2026-08-22T14:43:47.457665Z","steps":["trace[753607807] 'agreement among raft nodes before linearized reading' (duration: 461.801681ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:47.45774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:43:46.99552Z","time spent":"462.203247ms","remote":"127.0.0.1:45470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-08-22T14:43:51.975467Z","caller":"traceutil/trace.go:171","msg":"trace[393936597] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"115.505946ms","start":"2026-08-22T14:43:51.859927Z","end":"2026-08-22T14:43:51.975433Z","steps":["trace[393936597] 'process raft request' (duration: 115.15855ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:52.310627Z","caller":"traceutil/trace.go:171","msg":"trace[2066841539] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"120.401529ms","start":"2026-08-22T14:43:52.190203Z","end":"2026-08-22T14:43:52.310604Z","steps":["trace[2066841539] 'process raft request' (duration: 79.94222ms)","trace[2066841539] 'compare' (duration: 40.100103ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:52.310949Z","caller":"traceutil/trace.go:171","msg":"trace[1569027006] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"113.518901ms","start":"2026-08-22T14:43:52.197417Z","end":"2026-08-22T14:43:52.310936Z","steps":["trace[1569027006] 'process raft request' (duration: 113.316887ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:52.310993Z","caller":"traceutil/trace.go:171","msg":"trace[114460263] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"119.31598ms","start":"2026-08-22T14:43:52.191647Z","end":"2026-08-22T14:43:52.310963Z","steps":["trace[114460263] 'process raft request' (duration: 118.901193ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:52.311152Z","caller":"traceutil/trace.go:171","msg":"trace[344268484] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"120.848157ms","start":"2026-08-22T14:43:52.190266Z","end":"2026-08-22T14:43:52.311114Z","steps":["trace[344268484] 'process raft request' (duration: 120.201926ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:52.311287Z","caller":"traceutil/trace.go:171","msg":"trace[1759392313] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"118.089489ms","start":"2026-08-22T14:43:52.193171Z","end":"2026-08-22T14:43:52.31126Z","steps":["trace[1759392313] 'process raft request' (duration: 117.488449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:52.84608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.033116ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:43:52.846194Z","caller":"traceutil/trace.go:171","msg":"trace[1105372287] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"214.104028ms","start":"2026-08-22T14:43:52.63207Z","end":"2026-08-22T14:43:52.846174Z","steps":["trace[1105372287] 'process raft request' (duration: 105.884909ms)","trace[1105372287] 'compare' (duration: 107.906574ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:43:52.902054Z","caller":"traceutil/trace.go:171","msg":"trace[522806154] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"269.521114ms","start":"2026-08-22T14:43:52.632503Z","end":"2026-08-22T14:43:52.902024Z","steps":["trace[522806154] 'process raft request' (duration: 268.524727ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:52.902392Z","caller":"traceutil/trace.go:171","msg":"trace[490866576] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"269.23084ms","start":"2026-08-22T14:43:52.633149Z","end":"2026-08-22T14:43:52.90238Z","steps":["trace[490866576] 'process raft request' (duration: 269.193129ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:52.902545Z","caller":"traceutil/trace.go:171","msg":"trace[1103640732] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"269.80917ms","start":"2026-08-22T14:43:52.632664Z","end":"2026-08-22T14:43:52.902473Z","steps":["trace[1103640732] 'process raft request' (duration: 268.546748ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:44:09.101183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.760687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:44:09.101566Z","caller":"traceutil/trace.go:171","msg":"trace[52386443] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"107.407457ms","start":"2026-08-22T14:44:08.994122Z","end":"2026-08-22T14:44:09.10153Z","steps":["trace[52386443] 'process raft request' (duration: 107.149093ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:44:09.101728Z","caller":"traceutil/trace.go:171","msg":"trace[1938957076] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"108.092169ms","start":"2026-08-22T14:44:08.993588Z","end":"2026-08-22T14:44:09.10168Z","steps":["trace[1938957076] 'compare' (duration: 102.631495ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:44:21.147689Z","caller":"traceutil/trace.go:171","msg":"trace[1340736876] linearizableReadLoop","detail":"{readStateIndex:5466; appliedIndex:5465; }","duration":"128.790699ms","start":"2026-08-22T14:44:21.018872Z","end":"2026-08-22T14:44:21.147662Z","steps":["trace[1340736876] 'read index received' (duration: 79.99724ms)","trace[1340736876] 'applied index is now lower than readState.Index' (duration: 48.792469ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:44:21.147853Z","caller":"traceutil/trace.go:171","msg":"trace[1945829545] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"150.00316ms","start":"2026-08-22T14:44:20.997835Z","end":"2026-08-22T14:44:21.147838Z","steps":["trace[1945829545] 'process raft request' (duration: 101.110339ms)","trace[1945829545] 'compare' (duration: 48.591056ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:44:21.148172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.294175ms","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-08-22T14:44:21.148311Z","caller":"traceutil/trace.go:171","msg":"trace[1227759585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5267; }","duration":"103.483499ms","start":"2026-08-22T14:44:21.044807Z","end":"2026-08-22T14:44:21.148291Z","steps":["trace[1227759585] 'agreement among raft nodes before linearized reading' (duration: 103.232175ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:44:21.148424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.531302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-22T14:44:21.148545Z","caller":"traceutil/trace.go:171","msg":"trace[105363909] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5267; }","duration":"129.686855ms","start":"2026-08-22T14:44:21.018832Z","end":"2026-08-22T14:44:21.148519Z","steps":["trace[105363909] 'agreement among raft nodes before linearized reading' (duration: 129.356109ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:44:32.04163Z","caller":"traceutil/trace.go:171","msg":"trace[871218413] linearizableReadLoop","detail":"{readStateIndex:5533; appliedIndex:5532; }","duration":"114.584368ms","start":"2026-08-22T14:44:31.926993Z","end":"2026-08-22T14:44:32.041578Z","steps":["trace[871218413] 'read index received' (duration: 114.397115ms)","trace[871218413] 'applied index is now lower than readState.Index' (duration: 186.413µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:44:32.041729Z","caller":"traceutil/trace.go:171","msg":"trace[1060194995] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"277.707498ms","start":"2026-08-22T14:44:31.763983Z","end":"2026-08-22T14:44:32.041691Z","steps":["trace[1060194995] 'process raft request' (duration: 277.427333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:44:32.041768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.757641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:44:32.041814Z","caller":"traceutil/trace.go:171","msg":"trace[1234086204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5330; }","duration":"114.864073ms","start":"2026-08-22T14:44:31.926938Z","end":"2026-08-22T14:44:32.041802Z","steps":["trace[1234086204] 'agreement among raft nodes before linearized reading' (duration: 114.774571ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:44:38.646652Z","caller":"traceutil/trace.go:171","msg":"trace[363155431] transaction","detail":"{read_only:false; response_revision:5383; number_of_response:1; }","duration":"110.203949ms","start":"2026-08-22T14:44:38.536416Z","end":"2026-08-22T14:44:38.64662Z","steps":["trace[363155431] 'process raft request' (duration: 70.992837ms)","trace[363155431] 'compare' (duration: 38.994428ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:44:38.647025Z","caller":"traceutil/trace.go:171","msg":"trace[2050080373] transaction","detail":"{read_only:false; response_revision:5384; number_of_response:1; }","duration":"109.762781ms","start":"2026-08-22T14:44:38.537231Z","end":"2026-08-22T14:44:38.646994Z","steps":["trace[2050080373] 'process raft request' (duration: 109.317263ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:44:41.335203Z","caller":"traceutil/trace.go:171","msg":"trace[537824306] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"115.441264ms","start":"2026-08-22T14:44:41.219735Z","end":"2026-08-22T14:44:41.335176Z","steps":["trace[537824306] 'process raft request' (duration: 115.129119ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:45:08.485535Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2911} {"level":"info","ts":"2026-08-22T14:45:08.571728Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2911,"took":"84.673442ms","hash":159691726,"current-db-size-bytes":53510144,"current-db-size":"54 MB","current-db-size-in-use-bytes":29368320,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-22T14:45:08.571794Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":159691726,"revision":2911,"compact-revision":-1} {"level":"info","ts":"2026-08-22T14:46:45.39269Z","caller":"traceutil/trace.go:171","msg":"trace[1805768959] transaction","detail":"{read_only:false; response_revision:6156; number_of_response:1; }","duration":"193.812356ms","start":"2026-08-22T14:46:45.198838Z","end":"2026-08-22T14:46:45.39265Z","steps":["trace[1805768959] 'process raft request' (duration: 136.88582ms)","trace[1805768959] 'compare' (duration: 56.405677ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:46:45.392924Z","caller":"traceutil/trace.go:171","msg":"trace[1136933280] transaction","detail":"{read_only:false; response_revision:6157; number_of_response:1; }","duration":"193.39015ms","start":"2026-08-22T14:46:45.199492Z","end":"2026-08-22T14:46:45.392882Z","steps":["trace[1136933280] 'process raft request' (duration: 193.097949ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:46:45.393315Z","caller":"traceutil/trace.go:171","msg":"trace[275422966] transaction","detail":"{read_only:false; response_revision:6158; number_of_response:1; }","duration":"190.803022ms","start":"2026-08-22T14:46:45.202467Z","end":"2026-08-22T14:46:45.39327Z","steps":["trace[275422966] 'process raft request' (duration: 190.324864ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:46:45.393442Z","caller":"traceutil/trace.go:171","msg":"trace[1699031718] linearizableReadLoop","detail":"{readStateIndex:6389; appliedIndex:6386; }","duration":"179.680068ms","start":"2026-08-22T14:46:45.213721Z","end":"2026-08-22T14:46:45.393401Z","steps":["trace[1699031718] 'read index received' (duration: 122.015483ms)","trace[1699031718] 'applied index is now lower than readState.Index' (duration: 57.663185ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:46:45.393556Z","caller":"traceutil/trace.go:171","msg":"trace[229963074] transaction","detail":"{read_only:false; response_revision:6159; number_of_response:1; }","duration":"138.137687ms","start":"2026-08-22T14:46:45.255375Z","end":"2026-08-22T14:46:45.393512Z","steps":["trace[229963074] 'process raft request' (duration: 137.897668ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:46:45.393838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.080884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-domain-manage-v2slv\" ","response":"range_response_count:1 size:8277"} {"level":"info","ts":"2026-08-22T14:46:45.394025Z","caller":"traceutil/trace.go:171","msg":"trace[723440243] range","detail":"{range_begin:/registry/pods/openstack/keystone-domain-manage-v2slv; range_end:; response_count:1; response_revision:6159; }","duration":"180.185947ms","start":"2026-08-22T14:46:45.213693Z","end":"2026-08-22T14:46:45.393879Z","steps":["trace[723440243] 'agreement among raft nodes before linearized reading' (duration: 179.891506ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:18.685824Z","caller":"traceutil/trace.go:171","msg":"trace[221666573] transaction","detail":"{read_only:false; response_revision:6488; number_of_response:1; }","duration":"215.7843ms","start":"2026-08-22T14:47:18.470019Z","end":"2026-08-22T14:47:18.685804Z","steps":["trace[221666573] 'process raft request' (duration: 215.637715ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:18.693735Z","caller":"traceutil/trace.go:171","msg":"trace[1370276196] linearizableReadLoop","detail":"{readStateIndex:6731; appliedIndex:6729; }","duration":"212.98598ms","start":"2026-08-22T14:47:18.480728Z","end":"2026-08-22T14:47:18.693714Z","steps":["trace[1370276196] 'read index received' (duration: 204.909382ms)","trace[1370276196] 'applied index is now lower than readState.Index' (duration: 8.075578ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:47:18.693826Z","caller":"traceutil/trace.go:171","msg":"trace[377327640] transaction","detail":"{read_only:false; response_revision:6489; number_of_response:1; }","duration":"222.586713ms","start":"2026-08-22T14:47:18.471217Z","end":"2026-08-22T14:47:18.693804Z","steps":["trace[377327640] 'process raft request' (duration: 222.375396ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:18.694013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.25692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-db-init-p6drg\" ","response":"range_response_count:1 size:6405"} {"level":"info","ts":"2026-08-22T14:47:18.694085Z","caller":"traceutil/trace.go:171","msg":"trace[606375143] range","detail":"{range_begin:/registry/pods/openstack/horizon-db-init-p6drg; range_end:; response_count:1; response_revision:6489; }","duration":"213.416186ms","start":"2026-08-22T14:47:18.480657Z","end":"2026-08-22T14:47:18.694074Z","steps":["trace[606375143] 'agreement among raft nodes before linearized reading' (duration: 213.192048ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:26.70509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.584781ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-22T14:47:26.705486Z","caller":"traceutil/trace.go:171","msg":"trace[20529841] linearizableReadLoop","detail":"{readStateIndex:6795; appliedIndex:6794; }","duration":"210.094198ms","start":"2026-08-22T14:47:26.495368Z","end":"2026-08-22T14:47:26.705463Z","steps":["trace[20529841] 'read index received' (duration: 90.069382ms)","trace[20529841] 'applied index is now lower than readState.Index' (duration: 120.022066ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:47:26.705841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.473671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-22T14:47:26.705973Z","caller":"traceutil/trace.go:171","msg":"trace[1616293068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6551; }","duration":"210.571514ms","start":"2026-08-22T14:47:26.495303Z","end":"2026-08-22T14:47:26.705874Z","steps":["trace[1616293068] 'agreement among raft nodes before linearized reading' (duration: 210.230742ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:26.927273Z","caller":"traceutil/trace.go:171","msg":"trace[2135242933] linearizableReadLoop","detail":"{readStateIndex:6796; appliedIndex:6795; }","duration":"211.548488ms","start":"2026-08-22T14:47:26.715685Z","end":"2026-08-22T14:47:26.927234Z","steps":["trace[2135242933] 'read index received' (duration: 211.219247ms)","trace[2135242933] 'applied index is now lower than readState.Index' (duration: 328.001µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:47:26.927451Z","caller":"traceutil/trace.go:171","msg":"trace[27069317] transaction","detail":"{read_only:false; response_revision:6552; number_of_response:1; }","duration":"216.159031ms","start":"2026-08-22T14:47:26.711276Z","end":"2026-08-22T14:47:26.927435Z","steps":["trace[27069317] 'process raft request' (duration: 215.710356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:26.927636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.66175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-22T14:47:26.927676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.828293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-22T14:47:26.927721Z","caller":"traceutil/trace.go:171","msg":"trace[155407063] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6552; }","duration":"103.785725ms","start":"2026-08-22T14:47:26.823915Z","end":"2026-08-22T14:47:26.9277Z","steps":["trace[155407063] 'agreement among raft nodes before linearized reading' (duration: 103.631149ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:26.927697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.992855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-22T14:47:26.927755Z","caller":"traceutil/trace.go:171","msg":"trace[1618101497] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6552; }","duration":"206.935636ms","start":"2026-08-22T14:47:26.7208Z","end":"2026-08-22T14:47:26.927736Z","steps":["trace[1618101497] 'agreement among raft nodes before linearized reading' (duration: 206.715568ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:26.927808Z","caller":"traceutil/trace.go:171","msg":"trace[825222587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6552; }","duration":"212.16017ms","start":"2026-08-22T14:47:26.71563Z","end":"2026-08-22T14:47:26.92779Z","steps":["trace[825222587] 'agreement among raft nodes before linearized reading' (duration: 211.87285ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:34.849254Z","caller":"traceutil/trace.go:171","msg":"trace[1430402327] transaction","detail":"{read_only:false; response_revision:6597; number_of_response:1; }","duration":"209.429288ms","start":"2026-08-22T14:47:34.639779Z","end":"2026-08-22T14:47:34.849209Z","steps":["trace[1430402327] 'process raft request' (duration: 209.014704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:35.032155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.551662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:47:35.03283Z","caller":"traceutil/trace.go:171","msg":"trace[1122232814] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:6597; }","duration":"104.272227ms","start":"2026-08-22T14:47:34.928533Z","end":"2026-08-22T14:47:35.032805Z","steps":["trace[1122232814] 'count revisions from in-memory index tree' (duration: 103.48243ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:35.032427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.738179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:47:35.033068Z","caller":"traceutil/trace.go:171","msg":"trace[483263884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6597; }","duration":"104.430892ms","start":"2026-08-22T14:47:34.928615Z","end":"2026-08-22T14:47:35.033046Z","steps":["trace[483263884] 'range keys from in-memory index tree' (duration: 103.628204ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:35.157822Z","caller":"traceutil/trace.go:171","msg":"trace[2072919899] linearizableReadLoop","detail":"{readStateIndex:6845; appliedIndex:6843; }","duration":"119.300953ms","start":"2026-08-22T14:47:35.038492Z","end":"2026-08-22T14:47:35.157793Z","steps":["trace[2072919899] 'read index received' (duration: 58.772796ms)","trace[2072919899] 'applied index is now lower than readState.Index' (duration: 60.526687ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:47:35.157968Z","caller":"traceutil/trace.go:171","msg":"trace[632251806] transaction","detail":"{read_only:false; response_revision:6599; number_of_response:1; }","duration":"119.708537ms","start":"2026-08-22T14:47:35.038245Z","end":"2026-08-22T14:47:35.157953Z","steps":["trace[632251806] 'process raft request' (duration: 99.038021ms)","trace[632251806] 'compare' (duration: 20.407836ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:47:35.158196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.679306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:12170"} {"level":"info","ts":"2026-08-22T14:47:35.158246Z","caller":"traceutil/trace.go:171","msg":"trace[1174764980] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:6599; }","duration":"119.768509ms","start":"2026-08-22T14:47:35.038462Z","end":"2026-08-22T14:47:35.158231Z","steps":["trace[1174764980] 'agreement among raft nodes before linearized reading' (duration: 119.654515ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:35.158287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.380733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T14:47:35.158423Z","caller":"traceutil/trace.go:171","msg":"trace[568778065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6599; }","duration":"112.537469ms","start":"2026-08-22T14:47:35.045865Z","end":"2026-08-22T14:47:35.158403Z","steps":["trace[568778065] 'agreement among raft nodes before linearized reading' (duration: 112.199697ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:39.419181Z","caller":"traceutil/trace.go:171","msg":"trace[333958259] transaction","detail":"{read_only:false; response_revision:6618; number_of_response:1; }","duration":"241.791597ms","start":"2026-08-22T14:47:39.177353Z","end":"2026-08-22T14:47:39.419144Z","steps":["trace[333958259] 'process raft request' (duration: 198.650263ms)","trace[333958259] 'compare' (duration: 42.971538ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:47:39.4192Z","caller":"traceutil/trace.go:171","msg":"trace[550891405] linearizableReadLoop","detail":"{readStateIndex:6865; appliedIndex:6864; }","duration":"233.977538ms","start":"2026-08-22T14:47:39.185199Z","end":"2026-08-22T14:47:39.419177Z","steps":["trace[550891405] 'read index received' (duration: 190.940768ms)","trace[550891405] 'applied index is now lower than readState.Index' (duration: 43.03526ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:47:39.419447Z","caller":"traceutil/trace.go:171","msg":"trace[252563925] transaction","detail":"{read_only:false; response_revision:6619; number_of_response:1; }","duration":"124.806663ms","start":"2026-08-22T14:47:39.294624Z","end":"2026-08-22T14:47:39.41943Z","steps":["trace[252563925] 'process raft request' (duration: 124.508473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:39.419774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.551319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T14:47:39.41983Z","caller":"traceutil/trace.go:171","msg":"trace[369126727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6619; }","duration":"234.666522ms","start":"2026-08-22T14:47:39.185151Z","end":"2026-08-22T14:47:39.419818Z","steps":["trace[369126727] 'agreement among raft nodes before linearized reading' (duration: 234.153705ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:39.473303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.963856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-22T14:47:39.47352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.954168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-08-22T14:47:39.473651Z","caller":"traceutil/trace.go:171","msg":"trace[495299399] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6620; }","duration":"266.145255ms","start":"2026-08-22T14:47:39.20748Z","end":"2026-08-22T14:47:39.473626Z","steps":["trace[495299399] 'agreement among raft nodes before linearized reading' (duration: 265.630738ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:39.473567Z","caller":"traceutil/trace.go:171","msg":"trace[1269141192] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:6620; }","duration":"288.293167ms","start":"2026-08-22T14:47:39.185241Z","end":"2026-08-22T14:47:39.473534Z","steps":["trace[1269141192] 'agreement among raft nodes before linearized reading' (duration: 287.839571ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:39.58993Z","caller":"traceutil/trace.go:171","msg":"trace[1109911657] linearizableReadLoop","detail":"{readStateIndex:6868; appliedIndex:6867; }","duration":"109.841828ms","start":"2026-08-22T14:47:39.480064Z","end":"2026-08-22T14:47:39.589905Z","steps":["trace[1109911657] 'read index received' (duration: 76.484701ms)","trace[1109911657] 'applied index is now lower than readState.Index' (duration: 33.356367ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:47:39.590136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.070716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-08-22T14:47:39.590167Z","caller":"traceutil/trace.go:171","msg":"trace[1416188866] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6621; }","duration":"110.17141ms","start":"2026-08-22T14:47:39.479989Z","end":"2026-08-22T14:47:39.590161Z","steps":["trace[1416188866] 'agreement among raft nodes before linearized reading' (duration: 110.035515ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:39.590002Z","caller":"traceutil/trace.go:171","msg":"trace[1837199567] transaction","detail":"{read_only:false; response_revision:6621; number_of_response:1; }","duration":"164.557391ms","start":"2026-08-22T14:47:39.425419Z","end":"2026-08-22T14:47:39.589977Z","steps":["trace[1837199567] 'process raft request' (duration: 131.248785ms)","trace[1837199567] 'compare' (duration: 33.065707ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:47:40.133639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.264701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-22T14:47:40.133726Z","caller":"traceutil/trace.go:171","msg":"trace[877452772] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6624; }","duration":"209.411846ms","start":"2026-08-22T14:47:39.924294Z","end":"2026-08-22T14:47:40.133706Z","steps":["trace[877452772] 'range keys from in-memory index tree' (duration: 209.121226ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:40.260645Z","caller":"traceutil/trace.go:171","msg":"trace[267036007] transaction","detail":"{read_only:false; response_revision:6625; number_of_response:1; }","duration":"122.418064ms","start":"2026-08-22T14:47:40.138204Z","end":"2026-08-22T14:47:40.260622Z","steps":["trace[267036007] 'process raft request' (duration: 122.223817ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:47:57.550099Z","caller":"traceutil/trace.go:171","msg":"trace[2078519422] transaction","detail":"{read_only:false; response_revision:6765; number_of_response:1; }","duration":"311.63925ms","start":"2026-08-22T14:47:57.238445Z","end":"2026-08-22T14:47:57.550084Z","steps":["trace[2078519422] 'process raft request' (duration: 311.549007ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:47:57.550228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:47:57.238421Z","time spent":"311.751974ms","remote":"127.0.0.1:45560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:47:57.660573Z","caller":"traceutil/trace.go:171","msg":"trace[1774997962] transaction","detail":"{read_only:false; response_revision:6766; number_of_response:1; }","duration":"123.188647ms","start":"2026-08-22T14:47:57.537357Z","end":"2026-08-22T14:47:57.660546Z","steps":["trace[1774997962] 'process raft request' (duration: 86.103141ms)","trace[1774997962] 'compare' (duration: 36.983963ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:47:57.673178Z","caller":"traceutil/trace.go:171","msg":"trace[602568726] transaction","detail":"{read_only:false; response_revision:6767; number_of_response:1; }","duration":"119.575707ms","start":"2026-08-22T14:47:57.553579Z","end":"2026-08-22T14:47:57.673154Z","steps":["trace[602568726] 'process raft request' (duration: 118.860723ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:50:08.491955Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5599} {"level":"info","ts":"2026-08-22T14:50:08.589383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5599,"took":"94.614145ms","hash":580539067,"current-db-size-bytes":53510144,"current-db-size":"54 MB","current-db-size-in-use-bytes":18345984,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-22T14:50:08.589564Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":580539067,"revision":5599,"compact-revision":2911}