{"level":"warn","ts":"2026-08-11T15:33:33.743052Z","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-11T15:33:33.743387Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-11T15:33:33.74361Z","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-11T15:33:33.743643Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-08-11T15:33:33.743692Z","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-11T15:33:33.744837Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-08-11T15:33:33.74502Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-11T15:33:33.75001Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.711049ms"} {"level":"info","ts":"2026-08-11T15:33:33.756006Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-08-11T15:33:33.75607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T15:33:33.756091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-08-11T15:33:33.756099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T15:33:33.75611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-08-11T15:33:33.756172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-08-11T15:33:33.762949Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T15:33:33.764457Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T15:33:33.76602Z","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-11T15:33:33.767998Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T15:33:33.768485Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T15:33:33.76859Z","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-11T15:33:33.768748Z","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-11T15:33:33.768786Z","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-11T15:33:33.770707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-08-11T15:33:33.771731Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-08-11T15:33:33.773134Z","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-11T15:33:33.773268Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-08-11T15:33:33.773323Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-08-11T15:33:33.773454Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T15:33:33.773498Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T15:33:34.657228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T15:33:34.657294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T15:33:34.657331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-08-11T15:33:34.657352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-08-11T15:33:34.65737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-08-11T15:33:34.657393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-08-11T15:33:34.657412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-08-11T15:33:34.65842Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T15:33:34.659566Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T15:33:34.659631Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T15:33:34.66028Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T15:33:34.66046Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T15:33:34.660504Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T15:33:34.661579Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T15:33:34.661713Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T15:33:34.661982Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T15:33:34.662635Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-08-11T15:33:34.659555Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T15:34:09.932574Z","caller":"traceutil/trace.go:171","msg":"trace[971924066] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:553; }","duration":"208.417813ms","start":"2026-08-11T15:34:09.724128Z","end":"2026-08-11T15:34:09.932546Z","steps":["trace[971924066] 'read index received' (duration: 208.196181ms)","trace[971924066] 'applied index is now lower than readState.Index' (duration: 220.372µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:34:09.932625Z","caller":"traceutil/trace.go:171","msg":"trace[124692388] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"212.281362ms","start":"2026-08-11T15:34:09.720322Z","end":"2026-08-11T15:34:09.932603Z","steps":["trace[124692388] 'process raft request' (duration: 212.05403ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:09.93282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.616135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:34:09.933067Z","caller":"traceutil/trace.go:171","msg":"trace[1594295823] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:532; }","duration":"208.950229ms","start":"2026-08-11T15:34:09.724099Z","end":"2026-08-11T15:34:09.933049Z","steps":["trace[1594295823] 'agreement among raft nodes before linearized reading' (duration: 208.567145ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:34:10.915697Z","caller":"traceutil/trace.go:171","msg":"trace[614646360] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"516.223569ms","start":"2026-08-11T15:34:10.399455Z","end":"2026-08-11T15:34:10.915678Z","steps":["trace[614646360] 'process raft request' (duration: 509.477044ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:34:10.915985Z","caller":"traceutil/trace.go:171","msg":"trace[706454657] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"515.102129ms","start":"2026-08-11T15:34:10.400859Z","end":"2026-08-11T15:34:10.915961Z","steps":["trace[706454657] 'process raft request' (duration: 514.767866ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:34:10.916073Z","caller":"traceutil/trace.go:171","msg":"trace[1194896293] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"457.528735ms","start":"2026-08-11T15:34:10.458526Z","end":"2026-08-11T15:34:10.916054Z","steps":["trace[1194896293] 'process raft request' (duration: 457.330803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:10.917771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:10.399433Z","time spent":"516.33217ms","remote":"127.0.0.1:33732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:34:10.917938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:10.400831Z","time spent":"515.22563ms","remote":"127.0.0.1:33732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:34:10.918077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:10.458499Z","time spent":"457.626946ms","remote":"127.0.0.1:33732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T15:34:17.52254Z","caller":"traceutil/trace.go:171","msg":"trace[927171379] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"510.141886ms","start":"2026-08-11T15:34:17.012358Z","end":"2026-08-11T15:34:17.522499Z","steps":["trace[927171379] 'process raft request' (duration: 506.337401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:17.522752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:17.01232Z","time spent":"510.347099ms","remote":"127.0.0.1:33776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:34:17.528362Z","caller":"traceutil/trace.go:171","msg":"trace[1098408314] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"264.348191ms","start":"2026-08-11T15:34:17.263958Z","end":"2026-08-11T15:34:17.528306Z","steps":["trace[1098408314] 'read index received' (duration: 254.475978ms)","trace[1098408314] 'applied index is now lower than readState.Index' (duration: 9.871373ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:34:17.528422Z","caller":"traceutil/trace.go:171","msg":"trace[755859857] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"288.032181ms","start":"2026-08-11T15:34:17.240368Z","end":"2026-08-11T15:34:17.5284Z","steps":["trace[755859857] 'process raft request' (duration: 287.82226ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:17.52853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.556162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:34:17.528592Z","caller":"traceutil/trace.go:171","msg":"trace[866614060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"264.689344ms","start":"2026-08-11T15:34:17.26389Z","end":"2026-08-11T15:34:17.528579Z","steps":["trace[866614060] 'agreement among raft nodes before linearized reading' (duration: 264.588253ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:17.528716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.807359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nzk94\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-11T15:34:17.528801Z","caller":"traceutil/trace.go:171","msg":"trace[595213279] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nzk94; range_end:; response_count:1; response_revision:644; }","duration":"182.92427ms","start":"2026-08-11T15:34:17.345858Z","end":"2026-08-11T15:34:17.528783Z","steps":["trace[595213279] 'agreement among raft nodes before linearized reading' (duration: 182.664138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:18.083049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.598611ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:34:18.083347Z","caller":"traceutil/trace.go:171","msg":"trace[572598150] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:669; }","duration":"409.635434ms","start":"2026-08-11T15:34:17.673695Z","end":"2026-08-11T15:34:18.083331Z","steps":["trace[572598150] 'read index received' (duration: 196.285825ms)","trace[572598150] 'applied index is now lower than readState.Index' (duration: 213.348579ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:34:18.083441Z","caller":"traceutil/trace.go:171","msg":"trace[82711737] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"498.163721ms","start":"2026-08-11T15:34:17.585268Z","end":"2026-08-11T15:34:18.083432Z","steps":["trace[82711737] 'process raft request' (duration: 497.998529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:18.08359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:17.585234Z","time spent":"498.325272ms","remote":"127.0.0.1:33916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T15:34:18.083567Z","caller":"traceutil/trace.go:171","msg":"trace[809201840] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"541.483815ms","start":"2026-08-11T15:34:17.54201Z","end":"2026-08-11T15:34:18.083494Z","steps":["trace[809201840] 'process raft request' (duration: 327.994755ms)","trace[809201840] 'compare' (duration: 212.46613ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:34:18.083798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:17.541964Z","time spent":"541.730398ms","remote":"127.0.0.1:33854","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-11T15:34:18.084362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.668403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-11T15:34:18.084418Z","caller":"traceutil/trace.go:171","msg":"trace[621928624] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:646; }","duration":"410.769414ms","start":"2026-08-11T15:34:17.673634Z","end":"2026-08-11T15:34:18.084403Z","steps":["trace[621928624] 'agreement among raft nodes before linearized reading' (duration: 410.672823ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:18.084489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:17.67361Z","time spent":"410.868575ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" "} {"level":"warn","ts":"2026-08-11T15:34:18.086755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.409813ms","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-11T15:34:18.086907Z","caller":"traceutil/trace.go:171","msg":"trace[942323578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"116.623095ms","start":"2026-08-11T15:34:17.970261Z","end":"2026-08-11T15:34:18.086884Z","steps":["trace[942323578] 'agreement among raft nodes before linearized reading' (duration: 113.400696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:18.64552Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334369640644329873,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T15:34:19.107633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.954055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:34:19.107779Z","caller":"traceutil/trace.go:171","msg":"trace[1099807575] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.016219643s","start":"2026-08-11T15:34:18.091539Z","end":"2026-08-11T15:34:19.107758Z","steps":["trace[1099807575] 'process raft request' (duration: 1.016160352s)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:34:19.107808Z","caller":"traceutil/trace.go:171","msg":"trace[505002610] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.016514995s","start":"2026-08-11T15:34:18.091264Z","end":"2026-08-11T15:34:19.107779Z","steps":["trace[505002610] 'process raft request' (duration: 681.333548ms)","trace[505002610] 'compare' (duration: 334.666652ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:34:19.107841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:18.091527Z","time spent":"1.016284853s","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:34:19.107946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:18.091231Z","time spent":"1.016639037s","remote":"127.0.0.1:33948","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-11T15:34:19.164424Z","caller":"traceutil/trace.go:171","msg":"trace[436262115] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:672; }","duration":"1.01934729s","start":"2026-08-11T15:34:18.145065Z","end":"2026-08-11T15:34:19.164412Z","steps":["trace[436262115] 'read index received' (duration: 627.514079ms)","trace[436262115] 'applied index is now lower than readState.Index' (duration: 391.832441ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:34:19.164464Z","caller":"traceutil/trace.go:171","msg":"trace[815783712] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.01822315s","start":"2026-08-11T15:34:18.146217Z","end":"2026-08-11T15:34:19.16444Z","steps":["trace[815783712] 'process raft request' (duration: 1.018138059s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:19.164583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:18.146191Z","time spent":"1.018326151s","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:34:19.164596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.071642225s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-11T15:34:19.164578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015910818s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-11T15:34:19.16462Z","caller":"traceutil/trace.go:171","msg":"trace[1138533022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"1.071703956s","start":"2026-08-11T15:34:18.092909Z","end":"2026-08-11T15:34:19.164612Z","steps":["trace[1138533022] 'agreement among raft nodes before linearized reading' (duration: 1.071577405s)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:34:19.164629Z","caller":"traceutil/trace.go:171","msg":"trace[463995306] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:649; }","duration":"1.016014999s","start":"2026-08-11T15:34:18.148605Z","end":"2026-08-11T15:34:19.16462Z","steps":["trace[463995306] 'agreement among raft nodes before linearized reading' (duration: 1.015917198s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:19.164648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:18.0929Z","time spent":"1.071743027s","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T15:34:19.164655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:18.148585Z","time spent":"1.016063719s","remote":"127.0.0.1:33870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-08-11T15:34:19.16471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.234296ms","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-11T15:34:19.164769Z","caller":"traceutil/trace.go:171","msg":"trace[911049654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"855.331257ms","start":"2026-08-11T15:34:18.309424Z","end":"2026-08-11T15:34:19.164755Z","steps":["trace[911049654] 'agreement among raft nodes before linearized reading' (duration: 855.139135ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:19.164815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:18.309409Z","time spent":"855.400267ms","remote":"127.0.0.1:33948","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-11T15:34:30.755787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.618955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:34:30.755904Z","caller":"traceutil/trace.go:171","msg":"trace[1918182611] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"296.051889ms","start":"2026-08-11T15:34:30.459834Z","end":"2026-08-11T15:34:30.755886Z","steps":["trace[1918182611] 'process raft request' (duration: 79.262963ms)","trace[1918182611] 'compare' (duration: 216.522764ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:34:33.850544Z","caller":"traceutil/trace.go:171","msg":"trace[162724605] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"542.782211ms","start":"2026-08-11T15:34:33.307734Z","end":"2026-08-11T15:34:33.850516Z","steps":["trace[162724605] 'process raft request' (duration: 542.599879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:33.850722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:33.307722Z","time spent":"542.911942ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:34:33.983049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.327936ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T15:34:33.983176Z","caller":"traceutil/trace.go:171","msg":"trace[941701272] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"533.150898ms","start":"2026-08-11T15:34:33.450004Z","end":"2026-08-11T15:34:33.983155Z","steps":["trace[941701272] 'read index received' (duration: 400.519562ms)","trace[941701272] 'applied index is now lower than readState.Index' (duration: 132.629646ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:34:33.983539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.526102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jz98q\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-11T15:34:33.983614Z","caller":"traceutil/trace.go:171","msg":"trace[307153227] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jz98q; range_end:; response_count:1; response_revision:808; }","duration":"533.676772ms","start":"2026-08-11T15:34:33.449921Z","end":"2026-08-11T15:34:33.983597Z","steps":["trace[307153227] 'agreement among raft nodes before linearized reading' (duration: 533.298029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:34:33.983704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:34:33.449878Z","time spent":"533.786544ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jz98q\" "} {"level":"warn","ts":"2026-08-11T15:35:21.391602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.598664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:35:21.391745Z","caller":"traceutil/trace.go:171","msg":"trace[985279598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1351; }","duration":"124.814094ms","start":"2026-08-11T15:35:21.266908Z","end":"2026-08-11T15:35:21.391722Z","steps":["trace[985279598] 'range keys from in-memory index tree' (duration: 124.50286ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:26.686598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.003231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/ingress-nginx-admission\" ","response":"range_response_count:1 size:1659"} {"level":"info","ts":"2026-08-11T15:35:26.686697Z","caller":"traceutil/trace.go:171","msg":"trace[1818112075] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/ingress-nginx-admission; range_end:; response_count:1; response_revision:1463; }","duration":"301.119335ms","start":"2026-08-11T15:35:26.385541Z","end":"2026-08-11T15:35:26.686661Z","steps":["trace[1818112075] 'range keys from in-memory index tree' (duration: 300.76471ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:26.686733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:26.385528Z","time spent":"301.196268ms","remote":"127.0.0.1:34176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":1682,"request content":"key:\"/registry/validatingwebhookconfigurations/ingress-nginx-admission\" "} {"level":"info","ts":"2026-08-11T15:35:29.181102Z","caller":"traceutil/trace.go:171","msg":"trace[1595144722] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"331.63167ms","start":"2026-08-11T15:35:28.849425Z","end":"2026-08-11T15:35:29.181057Z","steps":["trace[1595144722] 'process raft request' (duration: 324.692096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:29.181331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:28.849409Z","time spent":"331.797957ms","remote":"127.0.0.1:33948","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-11T15:35:29.371449Z","caller":"traceutil/trace.go:171","msg":"trace[298789311] linearizableReadLoop","detail":"{readStateIndex:1522; appliedIndex:1521; }","duration":"122.912248ms","start":"2026-08-11T15:35:29.248501Z","end":"2026-08-11T15:35:29.371413Z","steps":["trace[298789311] 'read index received' (duration: 119.272584ms)","trace[298789311] 'applied index is now lower than readState.Index' (duration: 3.637894ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:35:29.371632Z","caller":"traceutil/trace.go:171","msg":"trace[1986563570] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"511.382604ms","start":"2026-08-11T15:35:28.860236Z","end":"2026-08-11T15:35:29.371619Z","steps":["trace[1986563570] 'process raft request' (duration: 507.520551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:29.371761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:28.860195Z","time spent":"511.465487ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:35:29.372091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.557104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-d6b77\" ","response":"range_response_count:1 size:4504"} {"level":"info","ts":"2026-08-11T15:35:29.372249Z","caller":"traceutil/trace.go:171","msg":"trace[255539199] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-d6b77; range_end:; response_count:1; response_revision:1476; }","duration":"123.786963ms","start":"2026-08-11T15:35:29.248436Z","end":"2026-08-11T15:35:29.372223Z","steps":["trace[255539199] 'agreement among raft nodes before linearized reading' (duration: 123.501282ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:35:29.627328Z","caller":"traceutil/trace.go:171","msg":"trace[1805588483] transaction","detail":"{read_only:false; response_revision:1477; number_of_response:1; }","duration":"214.555547ms","start":"2026-08-11T15:35:29.412738Z","end":"2026-08-11T15:35:29.627293Z","steps":["trace[1805588483] 'process raft request' (duration: 153.76514ms)","trace[1805588483] 'compare' (duration: 60.437763ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:35:55.006175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.618037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b57d362-d549-46ff-b2eb-a59d40981b35\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-11T15:35:55.00629Z","caller":"traceutil/trace.go:171","msg":"trace[1018121038] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6b57d362-d549-46ff-b2eb-a59d40981b35; range_end:; response_count:1; response_revision:1898; }","duration":"825.786692ms","start":"2026-08-11T15:35:54.180482Z","end":"2026-08-11T15:35:55.006269Z","steps":["trace[1018121038] 'range keys from in-memory index tree' (duration: 825.39492ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.006336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:54.180451Z","time spent":"825.875285ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b57d362-d549-46ff-b2eb-a59d40981b35\" "} {"level":"warn","ts":"2026-08-11T15:35:55.006683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.450957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:35:55.006813Z","caller":"traceutil/trace.go:171","msg":"trace[2101243259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1898; }","duration":"743.623272ms","start":"2026-08-11T15:35:54.26316Z","end":"2026-08-11T15:35:55.006783Z","steps":["trace[2101243259] 'range keys from in-memory index tree' (duration: 743.341973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.006877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:54.263145Z","time spent":"743.713804ms","remote":"127.0.0.1:33694","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-11T15:35:55.008229Z","caller":"traceutil/trace.go:171","msg":"trace[787884494] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"518.741916ms","start":"2026-08-11T15:35:54.48946Z","end":"2026-08-11T15:35:55.008202Z","steps":["trace[787884494] 'process raft request' (duration: 518.593461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.008391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:54.489434Z","time spent":"518.877539ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:35:55.038651Z","caller":"traceutil/trace.go:171","msg":"trace[1022673316] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1972; }","duration":"526.130144ms","start":"2026-08-11T15:35:54.512495Z","end":"2026-08-11T15:35:55.038625Z","steps":["trace[1022673316] 'read index received' (duration: 496.004149ms)","trace[1022673316] 'applied index is now lower than readState.Index' (duration: 30.124995ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:35:55.03888Z","caller":"traceutil/trace.go:171","msg":"trace[1612144997] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"528.248679ms","start":"2026-08-11T15:35:54.510618Z","end":"2026-08-11T15:35:55.038867Z","steps":["trace[1612144997] 'process raft request' (duration: 526.833775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.039097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:54.510594Z","time spent":"528.353632ms","remote":"127.0.0.1:33948","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-11T15:35:55.039184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.691841ms","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-11T15:35:55.039254Z","caller":"traceutil/trace.go:171","msg":"trace[1490913090] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1901; }","duration":"526.807495ms","start":"2026-08-11T15:35:54.512427Z","end":"2026-08-11T15:35:55.039235Z","steps":["trace[1490913090] 'agreement among raft nodes before linearized reading' (duration: 526.566557ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.039289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:54.512415Z","time spent":"526.866196ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-11T15:35:55.046175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.433512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:35:55.046274Z","caller":"traceutil/trace.go:171","msg":"trace[1078475343] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1901; }","duration":"467.626637ms","start":"2026-08-11T15:35:54.578621Z","end":"2026-08-11T15:35:55.046248Z","steps":["trace[1078475343] 'agreement among raft nodes before linearized reading' (duration: 467.39726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.04632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:54.578602Z","time spent":"467.70769ms","remote":"127.0.0.1:53874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-08-11T15:35:55.043714Z","caller":"traceutil/trace.go:171","msg":"trace[789126582] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"326.339945ms","start":"2026-08-11T15:35:54.717354Z","end":"2026-08-11T15:35:55.043694Z","steps":["trace[789126582] 'process raft request' (duration: 321.210159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.046483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:54.717334Z","time spent":"329.110509ms","remote":"127.0.0.1:33948","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-11T15:35:55.04675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.313179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b57d362-d549-46ff-b2eb-a59d40981b35\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-11T15:35:55.046793Z","caller":"traceutil/trace.go:171","msg":"trace[773596604] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6b57d362-d549-46ff-b2eb-a59d40981b35; range_end:; response_count:1; response_revision:1901; }","duration":"153.398181ms","start":"2026-08-11T15:35:54.893384Z","end":"2026-08-11T15:35:55.046782Z","steps":["trace[773596604] 'agreement among raft nodes before linearized reading' (duration: 153.239025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.52593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.151949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:35:55.526033Z","caller":"traceutil/trace.go:171","msg":"trace[179744533] linearizableReadLoop","detail":"{readStateIndex:1975; appliedIndex:1974; }","duration":"158.364731ms","start":"2026-08-11T15:35:55.367651Z","end":"2026-08-11T15:35:55.526016Z","steps":["trace[179744533] 'read index received' (duration: 69.403µs)","trace[179744533] 'applied index is now lower than readState.Index' (duration: 158.294008ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:35:55.526161Z","caller":"traceutil/trace.go:171","msg":"trace[776298794] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"473.207475ms","start":"2026-08-11T15:35:55.05292Z","end":"2026-08-11T15:35:55.526128Z","steps":["trace[776298794] 'process raft request' (duration: 196.738866ms)","trace[776298794] 'compare' (duration: 276.014364ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:35:55.526322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.68162ms","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-11T15:35:55.526361Z","caller":"traceutil/trace.go:171","msg":"trace[1722897694] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1902; }","duration":"158.777103ms","start":"2026-08-11T15:35:55.367573Z","end":"2026-08-11T15:35:55.52635Z","steps":["trace[1722897694] 'agreement among raft nodes before linearized reading' (duration: 158.631629ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.526819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:55.052894Z","time spent":"473.347609ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:35:55.621779Z","caller":"traceutil/trace.go:171","msg":"trace[158449345] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"157.660629ms","start":"2026-08-11T15:35:55.464098Z","end":"2026-08-11T15:35:55.621759Z","steps":["trace[158449345] 'process raft request' (duration: 157.543685ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:35:55.919485Z","caller":"traceutil/trace.go:171","msg":"trace[1614501468] linearizableReadLoop","detail":"{readStateIndex:1978; appliedIndex:1976; }","duration":"393.41205ms","start":"2026-08-11T15:35:55.526059Z","end":"2026-08-11T15:35:55.919471Z","steps":["trace[1614501468] 'read index received' (duration: 95.728237ms)","trace[1614501468] 'applied index is now lower than readState.Index' (duration: 297.682863ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:35:55.919475Z","caller":"traceutil/trace.go:171","msg":"trace[176874110] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"427.00453ms","start":"2026-08-11T15:35:55.492448Z","end":"2026-08-11T15:35:55.919452Z","steps":["trace[176874110] 'process raft request' (duration: 426.929058ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:35:55.919568Z","caller":"traceutil/trace.go:171","msg":"trace[1278249080] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"384.455528ms","start":"2026-08-11T15:35:55.535087Z","end":"2026-08-11T15:35:55.919542Z","steps":["trace[1278249080] 'process raft request' (duration: 384.331824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.9196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.201539ms","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-11T15:35:55.919634Z","caller":"traceutil/trace.go:171","msg":"trace[950383939] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1906; }","duration":"512.284892ms","start":"2026-08-11T15:35:55.407341Z","end":"2026-08-11T15:35:55.919626Z","steps":["trace[950383939] 'agreement among raft nodes before linearized reading' (duration: 512.205909ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.91963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:55.492421Z","time spent":"427.133074ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:35:55.919652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:55.407319Z","time spent":"512.328013ms","remote":"127.0.0.1:45232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-11T15:35:55.919703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:55.535068Z","time spent":"384.552991ms","remote":"127.0.0.1:33948","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-11T15:35:55.919523Z","caller":"traceutil/trace.go:171","msg":"trace[1241583623] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"437.698816ms","start":"2026-08-11T15:35:55.481811Z","end":"2026-08-11T15:35:55.91951Z","steps":["trace[1241583623] 'process raft request' (duration: 436.893142ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:35:55.920064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:35:55.481796Z","time spent":"438.244652ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:36:01.783792Z","caller":"traceutil/trace.go:171","msg":"trace[1012684990] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"143.215475ms","start":"2026-08-11T15:36:01.64055Z","end":"2026-08-11T15:36:01.783765Z","steps":["trace[1012684990] 'process raft request' (duration: 143.063921ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:03.260354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.712749ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T15:36:03.260984Z","caller":"traceutil/trace.go:171","msg":"trace[935968042] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"188.205302ms","start":"2026-08-11T15:36:03.072576Z","end":"2026-08-11T15:36:03.260781Z","steps":["trace[935968042] 'process raft request' (duration: 187.880852ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:03.337521Z","caller":"traceutil/trace.go:171","msg":"trace[177248538] linearizableReadLoop","detail":"{readStateIndex:2051; appliedIndex:2048; }","duration":"213.852954ms","start":"2026-08-11T15:36:03.123646Z","end":"2026-08-11T15:36:03.337499Z","steps":["trace[177248538] 'read index received' (duration: 73.093002ms)","trace[177248538] 'applied index is now lower than readState.Index' (duration: 140.758732ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:36:03.337584Z","caller":"traceutil/trace.go:171","msg":"trace[1118534171] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"263.793093ms","start":"2026-08-11T15:36:03.073756Z","end":"2026-08-11T15:36:03.337549Z","steps":["trace[1118534171] 'process raft request' (duration: 263.627889ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:03.337704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.05953ms","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-11T15:36:03.337731Z","caller":"traceutil/trace.go:171","msg":"trace[1970231998] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1976; }","duration":"214.153903ms","start":"2026-08-11T15:36:03.123569Z","end":"2026-08-11T15:36:03.337723Z","steps":["trace[1970231998] 'agreement among raft nodes before linearized reading' (duration: 214.03615ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:07.871314Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334369640644332515,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T15:36:08.2694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:07.464534Z","time spent":"804.85856ms","remote":"127.0.0.1:40266","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-11T15:36:08.272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.836021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:36:08.272362Z","caller":"traceutil/trace.go:171","msg":"trace[376024667] linearizableReadLoop","detail":"{readStateIndex:2076; appliedIndex:2074; }","duration":"902.010024ms","start":"2026-08-11T15:36:07.370334Z","end":"2026-08-11T15:36:08.272344Z","steps":["trace[376024667] 'read index received' (duration: 653.759271ms)","trace[376024667] 'applied index is now lower than readState.Index' (duration: 248.249633ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:36:08.272699Z","caller":"traceutil/trace.go:171","msg":"trace[2039433171] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"915.618105ms","start":"2026-08-11T15:36:07.357067Z","end":"2026-08-11T15:36:08.272685Z","steps":["trace[2039433171] 'process raft request' (duration: 667.017243ms)","trace[2039433171] 'compare' (duration: 247.723438ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:36:08.272761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:07.357046Z","time spent":"915.681976ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:36:08.273075Z","caller":"traceutil/trace.go:171","msg":"trace[957841676] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"457.63107ms","start":"2026-08-11T15:36:07.815429Z","end":"2026-08-11T15:36:08.27306Z","steps":["trace[957841676] 'process raft request' (duration: 456.829069ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.273152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:07.815374Z","time spent":"457.737743ms","remote":"127.0.0.1:33948","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-11T15:36:08.27329Z","caller":"traceutil/trace.go:171","msg":"trace[1309343043] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"304.262284ms","start":"2026-08-11T15:36:07.969017Z","end":"2026-08-11T15:36:08.27328Z","steps":["trace[1309343043] 'process raft request' (duration: 303.291018ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.273341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:07.968979Z","time spent":"304.332676ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:36:08.273569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.248107ms","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-11T15:36:08.273601Z","caller":"traceutil/trace.go:171","msg":"trace[1488909231] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2002; }","duration":"903.33797ms","start":"2026-08-11T15:36:07.370252Z","end":"2026-08-11T15:36:08.27359Z","steps":["trace[1488909231] 'agreement among raft nodes before linearized reading' (duration: 903.208307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.27363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:07.370209Z","time spent":"903.414742ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-11T15:36:08.273854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.696098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-11T15:36:08.27427Z","caller":"traceutil/trace.go:171","msg":"trace[2120591368] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:2002; }","duration":"593.146091ms","start":"2026-08-11T15:36:07.681112Z","end":"2026-08-11T15:36:08.274258Z","steps":["trace[2120591368] 'agreement among raft nodes before linearized reading' (duration: 592.677218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.274308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:07.681092Z","time spent":"593.202052ms","remote":"127.0.0.1:33718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" "} {"level":"warn","ts":"2026-08-11T15:36:08.274521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.084904ms","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-11T15:36:08.274547Z","caller":"traceutil/trace.go:171","msg":"trace[271854458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2002; }","duration":"236.119774ms","start":"2026-08-11T15:36:08.038419Z","end":"2026-08-11T15:36:08.274538Z","steps":["trace[271854458] 'agreement among raft nodes before linearized reading' (duration: 236.034792ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.27471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.450381ms","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-11T15:36:08.274736Z","caller":"traceutil/trace.go:171","msg":"trace[754053465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2002; }","duration":"247.486712ms","start":"2026-08-11T15:36:08.027242Z","end":"2026-08-11T15:36:08.274728Z","steps":["trace[754053465] 'agreement among raft nodes before linearized reading' (duration: 247.41225ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.274843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.617735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-11T15:36:08.274866Z","caller":"traceutil/trace.go:171","msg":"trace[1028214450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2002; }","duration":"247.651407ms","start":"2026-08-11T15:36:08.027206Z","end":"2026-08-11T15:36:08.274858Z","steps":["trace[1028214450] 'agreement among raft nodes before linearized reading' (duration: 247.586964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.27504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.601618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-11T15:36:08.275067Z","caller":"traceutil/trace.go:171","msg":"trace[1722674820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2002; }","duration":"253.662169ms","start":"2026-08-11T15:36:08.021394Z","end":"2026-08-11T15:36:08.275056Z","steps":["trace[1722674820] 'agreement among raft nodes before linearized reading' (duration: 253.587587ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.27517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.972046ms","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-11T15:36:08.275238Z","caller":"traceutil/trace.go:171","msg":"trace[1891746272] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2002; }","duration":"268.097579ms","start":"2026-08-11T15:36:08.007122Z","end":"2026-08-11T15:36:08.275219Z","steps":["trace[1891746272] 'agreement among raft nodes before linearized reading' (duration: 267.915314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.275332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.746641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11988"} {"level":"info","ts":"2026-08-11T15:36:08.275423Z","caller":"traceutil/trace.go:171","msg":"trace[898883807] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2002; }","duration":"317.885074ms","start":"2026-08-11T15:36:07.957515Z","end":"2026-08-11T15:36:08.2754Z","steps":["trace[898883807] 'agreement among raft nodes before linearized reading' (duration: 317.624028ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:08.275472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:07.957493Z","time spent":"317.970456ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12011,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-11T15:36:30.722977Z","caller":"traceutil/trace.go:171","msg":"trace[78615024] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"297.408337ms","start":"2026-08-11T15:36:30.425541Z","end":"2026-08-11T15:36:30.722949Z","steps":["trace[78615024] 'process raft request' (duration: 297.233963ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:30.805641Z","caller":"traceutil/trace.go:171","msg":"trace[1900411604] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"379.863023ms","start":"2026-08-11T15:36:30.425749Z","end":"2026-08-11T15:36:30.805612Z","steps":["trace[1900411604] 'process raft request' (duration: 379.770361ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.805819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.425742Z","time spent":"379.979356ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:36:30.805651Z","caller":"traceutil/trace.go:171","msg":"trace[65202054] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"380.040377ms","start":"2026-08-11T15:36:30.425575Z","end":"2026-08-11T15:36:30.805615Z","steps":["trace[65202054] 'process raft request' (duration: 379.785202ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.806112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.425555Z","time spent":"380.413275ms","remote":"127.0.0.1:33948","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-11T15:36:30.806653Z","caller":"traceutil/trace.go:171","msg":"trace[424614564] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2218; }","duration":"375.383722ms","start":"2026-08-11T15:36:30.431256Z","end":"2026-08-11T15:36:30.80664Z","steps":["trace[424614564] 'read index received' (duration: 291.488042ms)","trace[424614564] 'applied index is now lower than readState.Index' (duration: 83.88922ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:36:30.807011Z","caller":"traceutil/trace.go:171","msg":"trace[239553901] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"193.773349ms","start":"2026-08-11T15:36:30.613229Z","end":"2026-08-11T15:36:30.807002Z","steps":["trace[239553901] 'process raft request' (duration: 192.342206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.80833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.453363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:36:30.809525Z","caller":"traceutil/trace.go:171","msg":"trace[792280892] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2142; }","duration":"240.659261ms","start":"2026-08-11T15:36:30.568816Z","end":"2026-08-11T15:36:30.809476Z","steps":["trace[792280892] 'agreement among raft nodes before linearized reading' (duration: 239.470454ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.808378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.107231ms","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-11T15:36:30.809739Z","caller":"traceutil/trace.go:171","msg":"trace[1943014410] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2142; }","duration":"378.525624ms","start":"2026-08-11T15:36:30.431199Z","end":"2026-08-11T15:36:30.809724Z","steps":["trace[1943014410] 'agreement among raft nodes before linearized reading' (duration: 377.026009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.808429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.836638ms","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-11T15:36:30.809899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.43118Z","time spent":"378.628596ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-11T15:36:30.809863Z","caller":"traceutil/trace.go:171","msg":"trace[977326168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2142; }","duration":"364.24601ms","start":"2026-08-11T15:36:30.445575Z","end":"2026-08-11T15:36:30.809821Z","steps":["trace[977326168] 'agreement among raft nodes before linearized reading' (duration: 362.683004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.810062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.44556Z","time spent":"364.482245ms","remote":"127.0.0.1:33948","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-11T15:36:30.808507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.220494ms","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-11T15:36:30.810176Z","caller":"traceutil/trace.go:171","msg":"trace[608032222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2142; }","duration":"374.924432ms","start":"2026-08-11T15:36:30.435239Z","end":"2026-08-11T15:36:30.810163Z","steps":["trace[608032222] 'agreement among raft nodes before linearized reading' (duration: 373.201812ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.810269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.435217Z","time spent":"375.035505ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T15:36:30.808541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.593191ms","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-11T15:36:30.810408Z","caller":"traceutil/trace.go:171","msg":"trace[1492628545] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2142; }","duration":"356.465044ms","start":"2026-08-11T15:36:30.453917Z","end":"2026-08-11T15:36:30.810382Z","steps":["trace[1492628545] 'agreement among raft nodes before linearized reading' (duration: 354.54559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.810499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.45388Z","time spent":"356.603347ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-11T15:36:30.808618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.463469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-11T15:36:30.80847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.803586ms","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-11T15:36:30.810679Z","caller":"traceutil/trace.go:171","msg":"trace[2091136919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2142; }","duration":"375.541946ms","start":"2026-08-11T15:36:30.435124Z","end":"2026-08-11T15:36:30.810666Z","steps":["trace[2091136919] 'agreement among raft nodes before linearized reading' (duration: 373.394467ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:30.810799Z","caller":"traceutil/trace.go:171","msg":"trace[1622373666] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2142; }","duration":"376.16906ms","start":"2026-08-11T15:36:30.434607Z","end":"2026-08-11T15:36:30.810776Z","steps":["trace[1622373666] 'agreement among raft nodes before linearized reading' (duration: 373.631173ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:30.810828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.435115Z","time spent":"375.698729ms","remote":"127.0.0.1:33948","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-11T15:36:30.810867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.434602Z","time spent":"376.250382ms","remote":"127.0.0.1:33948","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-11T15:36:30.968458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.706487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:36:30.968589Z","caller":"traceutil/trace.go:171","msg":"trace[329010702] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"153.907246ms","start":"2026-08-11T15:36:30.814661Z","end":"2026-08-11T15:36:30.968569Z","steps":["trace[329010702] 'compare' (duration: 143.781906ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:31.232853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.780797ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:36:31.233186Z","caller":"traceutil/trace.go:171","msg":"trace[1091335705] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"414.059761ms","start":"2026-08-11T15:36:30.819085Z","end":"2026-08-11T15:36:31.233145Z","steps":["trace[1091335705] 'process raft request' (duration: 280.902346ms)","trace[1091335705] 'compare' (duration: 132.573562ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:36:31.233216Z","caller":"traceutil/trace.go:171","msg":"trace[1392374104] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"413.958269ms","start":"2026-08-11T15:36:30.819232Z","end":"2026-08-11T15:36:31.23319Z","steps":["trace[1392374104] 'process raft request' (duration: 413.764724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:31.233327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.819225Z","time spent":"414.04668ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:36:31.233382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.819067Z","time spent":"414.200254ms","remote":"127.0.0.1:33948","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-11T15:36:31.233443Z","caller":"traceutil/trace.go:171","msg":"trace[883480175] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"414.158143ms","start":"2026-08-11T15:36:30.819268Z","end":"2026-08-11T15:36:31.233426Z","steps":["trace[883480175] 'process raft request' (duration: 413.842256ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:31.233538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.819249Z","time spent":"414.241635ms","remote":"127.0.0.1:33948","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-11T15:36:31.23359Z","caller":"traceutil/trace.go:171","msg":"trace[1029018812] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"414.218724ms","start":"2026-08-11T15:36:30.819327Z","end":"2026-08-11T15:36:31.233546Z","steps":["trace[1029018812] 'process raft request' (duration: 414.04238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:31.233809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:30.819302Z","time spent":"414.395609ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:36:32.063648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.372133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:36:32.063766Z","caller":"traceutil/trace.go:171","msg":"trace[928844084] linearizableReadLoop","detail":"{readStateIndex:2228; appliedIndex:2227; }","duration":"242.263347ms","start":"2026-08-11T15:36:31.821485Z","end":"2026-08-11T15:36:32.063748Z","steps":["trace[928844084] 'read index received' (duration: 69.431µs)","trace[928844084] 'applied index is now lower than readState.Index' (duration: 242.192546ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:36:32.063825Z","caller":"traceutil/trace.go:171","msg":"trace[664635636] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"657.704229ms","start":"2026-08-11T15:36:31.406101Z","end":"2026-08-11T15:36:32.063805Z","steps":["trace[664635636] 'process raft request' (duration: 366.080521ms)","trace[664635636] 'compare' (duration: 290.680387ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:36:32.063905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:31.406072Z","time spent":"657.793591ms","remote":"127.0.0.1:33948","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-11T15:36:32.06394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.452281ms","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-11T15:36:32.063971Z","caller":"traceutil/trace.go:171","msg":"trace[1685728837] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2148; }","duration":"242.521443ms","start":"2026-08-11T15:36:31.821439Z","end":"2026-08-11T15:36:32.06396Z","steps":["trace[1685728837] 'agreement among raft nodes before linearized reading' (duration: 242.39054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:32.064197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.198383ms","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-11T15:36:32.064252Z","caller":"traceutil/trace.go:171","msg":"trace[2010844311] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2148; }","duration":"128.225824ms","start":"2026-08-11T15:36:31.935991Z","end":"2026-08-11T15:36:32.064216Z","steps":["trace[2010844311] 'agreement among raft nodes before linearized reading' (duration: 128.136882ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:32.629237Z","caller":"traceutil/trace.go:171","msg":"trace[1070573457] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"295.347613ms","start":"2026-08-11T15:36:32.333863Z","end":"2026-08-11T15:36:32.629211Z","steps":["trace[1070573457] 'process raft request' (duration: 295.20215ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:32.630039Z","caller":"traceutil/trace.go:171","msg":"trace[1328211347] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2229; }","duration":"250.456251ms","start":"2026-08-11T15:36:32.379365Z","end":"2026-08-11T15:36:32.629821Z","steps":["trace[1328211347] 'read index received' (duration: 250.43825ms)","trace[1328211347] 'applied index is now lower than readState.Index' (duration: 15.541µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:36:32.630149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.719298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18caca40eba7c284\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-08-11T15:36:32.630344Z","caller":"traceutil/trace.go:171","msg":"trace[488473358] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18caca40eba7c284; range_end:; response_count:1; response_revision:2149; }","duration":"250.868951ms","start":"2026-08-11T15:36:32.379311Z","end":"2026-08-11T15:36:32.63018Z","steps":["trace[488473358] 'agreement among raft nodes before linearized reading' (duration: 250.620295ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:33.369454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.071774ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:36:33.369598Z","caller":"traceutil/trace.go:171","msg":"trace[83774862] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"801.652829ms","start":"2026-08-11T15:36:32.567922Z","end":"2026-08-11T15:36:33.369575Z","steps":["trace[83774862] 'process raft request' (duration: 472.318209ms)","trace[83774862] 'compare' (duration: 328.706355ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:36:33.369852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:32.567894Z","time spent":"801.901034ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:36:33.501175Z","caller":"traceutil/trace.go:171","msg":"trace[453651670] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"687.739534ms","start":"2026-08-11T15:36:32.813401Z","end":"2026-08-11T15:36:33.50114Z","steps":["trace[453651670] 'process raft request' (duration: 687.678272ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:33.501204Z","caller":"traceutil/trace.go:171","msg":"trace[1862622930] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"766.019941ms","start":"2026-08-11T15:36:32.735136Z","end":"2026-08-11T15:36:33.501156Z","steps":["trace[1862622930] 'process raft request' (duration: 765.831737ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:33.501476Z","caller":"traceutil/trace.go:171","msg":"trace[273947712] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"868.397857ms","start":"2026-08-11T15:36:32.633048Z","end":"2026-08-11T15:36:33.501446Z","steps":["trace[273947712] 'process raft request' (duration: 862.863705ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:33.501538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:32.73492Z","time spent":"766.412351ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:36:33.501699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:32.633016Z","time spent":"868.56012ms","remote":"127.0.0.1:33760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:36:33.501187Z","caller":"traceutil/trace.go:171","msg":"trace[875146525] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"689.285798ms","start":"2026-08-11T15:36:32.811877Z","end":"2026-08-11T15:36:33.501162Z","steps":["trace[875146525] 'process raft request' (duration: 689.167426ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:33.502055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:32.813378Z","time spent":"687.904878ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:36:33.502264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:32.811856Z","time spent":"690.306362ms","remote":"127.0.0.1:33948","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-11T15:36:33.761433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.285529ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T15:36:33.761582Z","caller":"traceutil/trace.go:171","msg":"trace[1781054121] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2229; }","duration":"781.496986ms","start":"2026-08-11T15:36:32.980053Z","end":"2026-08-11T15:36:33.76155Z","steps":["trace[1781054121] 'read index received' (duration: 60.275491ms)","trace[1781054121] 'applied index is now lower than readState.Index' (duration: 721.219125ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:36:33.761792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.734771ms","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-11T15:36:33.761908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.117248ms","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-11T15:36:33.761866Z","caller":"traceutil/trace.go:171","msg":"trace[1069453262] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2154; }","duration":"781.874985ms","start":"2026-08-11T15:36:32.97997Z","end":"2026-08-11T15:36:33.761845Z","steps":["trace[1069453262] 'agreement among raft nodes before linearized reading' (duration: 781.642279ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:33.76194Z","caller":"traceutil/trace.go:171","msg":"trace[56053089] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2154; }","duration":"677.255242ms","start":"2026-08-11T15:36:33.084673Z","end":"2026-08-11T15:36:33.761929Z","steps":["trace[56053089] 'agreement among raft nodes before linearized reading' (duration: 677.016376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:33.761931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.659262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T15:36:33.761967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:32.979939Z","time spent":"782.018778ms","remote":"127.0.0.1:33948","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-11T15:36:33.761956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.49992ms","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-11T15:36:33.762007Z","caller":"traceutil/trace.go:171","msg":"trace[1640926366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"498.820836ms","start":"2026-08-11T15:36:33.263163Z","end":"2026-08-11T15:36:33.761984Z","steps":["trace[1640926366] 'agreement among raft nodes before linearized reading' (duration: 498.656942ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:33.761975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.084647Z","time spent":"677.320063ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-11T15:36:33.762003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.82272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-11T15:36:33.762049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.931072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-11T15:36:33.762051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.263152Z","time spent":"498.891477ms","remote":"127.0.0.1:33694","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-11T15:36:33.762063Z","caller":"traceutil/trace.go:171","msg":"trace[1377409614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2154; }","duration":"523.906712ms","start":"2026-08-11T15:36:33.238141Z","end":"2026-08-11T15:36:33.762048Z","steps":["trace[1377409614] 'agreement among raft nodes before linearized reading' (duration: 523.78668ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:33.762073Z","caller":"traceutil/trace.go:171","msg":"trace[474904479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2154; }","duration":"524.017205ms","start":"2026-08-11T15:36:33.238048Z","end":"2026-08-11T15:36:33.762066Z","steps":["trace[474904479] 'agreement among raft nodes before linearized reading' (duration: 523.946743ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:33.762016Z","caller":"traceutil/trace.go:171","msg":"trace[238454626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2154; }","duration":"521.618922ms","start":"2026-08-11T15:36:33.240381Z","end":"2026-08-11T15:36:33.762Z","steps":["trace[238454626] 'agreement among raft nodes before linearized reading' (duration: 521.389367ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:33.762094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.238017Z","time spent":"524.071985ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T15:36:33.762079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.862418ms","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-11T15:36:33.762108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.240357Z","time spent":"521.742785ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-11T15:36:33.762133Z","caller":"traceutil/trace.go:171","msg":"trace[431180184] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2154; }","duration":"521.936049ms","start":"2026-08-11T15:36:33.240183Z","end":"2026-08-11T15:36:33.762119Z","steps":["trace[431180184] 'agreement among raft nodes before linearized reading' (duration: 521.790226ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:33.762141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.752851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"warn","ts":"2026-08-11T15:36:33.762172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.240173Z","time spent":"521.99045ms","remote":"127.0.0.1:33948","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":"info","ts":"2026-08-11T15:36:33.762169Z","caller":"traceutil/trace.go:171","msg":"trace[1703392182] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2154; }","duration":"344.834363ms","start":"2026-08-11T15:36:33.417327Z","end":"2026-08-11T15:36:33.762162Z","steps":["trace[1703392182] 'agreement among raft nodes before linearized reading' (duration: 344.446634ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:33.762203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.417297Z","time spent":"344.900585ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12408,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-11T15:36:33.762094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.238135Z","time spent":"523.953913ms","remote":"127.0.0.1:33948","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-11T15:36:34.164228Z","caller":"traceutil/trace.go:171","msg":"trace[638284804] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"395.658085ms","start":"2026-08-11T15:36:33.768544Z","end":"2026-08-11T15:36:34.164202Z","steps":["trace[638284804] 'process raft request' (duration: 395.42923ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:34.164449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.768519Z","time spent":"395.804668ms","remote":"127.0.0.1:33948","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-11T15:36:34.172958Z","caller":"traceutil/trace.go:171","msg":"trace[699269635] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"403.003097ms","start":"2026-08-11T15:36:33.769931Z","end":"2026-08-11T15:36:34.172934Z","steps":["trace[699269635] 'process raft request' (duration: 402.766892ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:34.173032Z","caller":"traceutil/trace.go:171","msg":"trace[1303716917] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"402.912885ms","start":"2026-08-11T15:36:33.770084Z","end":"2026-08-11T15:36:34.172997Z","steps":["trace[1303716917] 'process raft request' (duration: 402.748971ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:34.173075Z","caller":"traceutil/trace.go:171","msg":"trace[1653825027] linearizableReadLoop","detail":"{readStateIndex:2240; appliedIndex:2235; }","duration":"392.966044ms","start":"2026-08-11T15:36:33.780089Z","end":"2026-08-11T15:36:34.173055Z","steps":["trace[1653825027] 'read index received' (duration: 383.925425ms)","trace[1653825027] 'applied index is now lower than readState.Index' (duration: 9.039449ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:36:34.173088Z","caller":"traceutil/trace.go:171","msg":"trace[1801289765] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"402.666368ms","start":"2026-08-11T15:36:33.770395Z","end":"2026-08-11T15:36:34.173061Z","steps":["trace[1801289765] 'process raft request' (duration: 402.477834ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:34.173218Z","caller":"traceutil/trace.go:171","msg":"trace[206584800] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"101.35484ms","start":"2026-08-11T15:36:34.07185Z","end":"2026-08-11T15:36:34.173205Z","steps":["trace[206584800] 'process raft request' (duration: 101.152106ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:36:34.173187Z","caller":"traceutil/trace.go:171","msg":"trace[613143077] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"401.091655ms","start":"2026-08-11T15:36:33.772079Z","end":"2026-08-11T15:36:34.173171Z","steps":["trace[613143077] 'process raft request' (duration: 400.86929ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:34.173257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.158938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T15:36:34.173272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.770075Z","time spent":"403.038257ms","remote":"127.0.0.1:33948","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-11T15:36:34.173304Z","caller":"traceutil/trace.go:171","msg":"trace[397634794] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2160; }","duration":"393.216849ms","start":"2026-08-11T15:36:33.780075Z","end":"2026-08-11T15:36:34.173292Z","steps":["trace[397634794] 'agreement among raft nodes before linearized reading' (duration: 393.131957ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:36:34.173348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.78006Z","time spent":"393.272011ms","remote":"127.0.0.1:34136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-08-11T15:36:34.173062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.769912Z","time spent":"403.096579ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:36:34.173335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.772065Z","time spent":"401.203677ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:36:34.173417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:36:33.770387Z","time spent":"402.892764ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:37:28.02584Z","caller":"traceutil/trace.go:171","msg":"trace[72197618] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"278.489772ms","start":"2026-08-11T15:37:27.747312Z","end":"2026-08-11T15:37:28.025802Z","steps":["trace[72197618] 'process raft request' (duration: 213.74574ms)","trace[72197618] 'compare' (duration: 64.482498ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:37:28.028685Z","caller":"traceutil/trace.go:171","msg":"trace[439014541] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"275.656246ms","start":"2026-08-11T15:37:27.753004Z","end":"2026-08-11T15:37:28.02866Z","steps":["trace[439014541] 'process raft request' (duration: 275.529524ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:37:36.96205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.982493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:37:36.962178Z","caller":"traceutil/trace.go:171","msg":"trace[1514442907] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:2597; }","duration":"195.186846ms","start":"2026-08-11T15:37:36.766972Z","end":"2026-08-11T15:37:36.962158Z","steps":["trace[1514442907] 'count revisions from in-memory index tree' (duration: 194.817669ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:38:04.206427Z","caller":"traceutil/trace.go:171","msg":"trace[38544981] transaction","detail":"{read_only:false; response_revision:2745; number_of_response:1; }","duration":"271.753362ms","start":"2026-08-11T15:38:03.934615Z","end":"2026-08-11T15:38:04.206368Z","steps":["trace[38544981] 'process raft request' (duration: 271.58205ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:38:04.32573Z","caller":"traceutil/trace.go:171","msg":"trace[1175008865] transaction","detail":"{read_only:false; response_revision:2746; number_of_response:1; }","duration":"156.657466ms","start":"2026-08-11T15:38:04.169037Z","end":"2026-08-11T15:38:04.325694Z","steps":["trace[1175008865] 'process raft request' (duration: 124.608201ms)","trace[1175008865] 'compare' (duration: 31.825972ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:38:04.325935Z","caller":"traceutil/trace.go:171","msg":"trace[1281184091] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"148.527379ms","start":"2026-08-11T15:38:04.177336Z","end":"2026-08-11T15:38:04.325863Z","steps":["trace[1281184091] 'process raft request' (duration: 148.306546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.028524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.743765ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:38:11.028682Z","caller":"traceutil/trace.go:171","msg":"trace[1604586106] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2776; }","duration":"652.918007ms","start":"2026-08-11T15:38:10.375744Z","end":"2026-08-11T15:38:11.028662Z","steps":["trace[1604586106] 'range keys from in-memory index tree' (duration: 652.724015ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.029021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.165616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:38:11.029651Z","caller":"traceutil/trace.go:171","msg":"trace[917257826] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"682.151485ms","start":"2026-08-11T15:38:10.34746Z","end":"2026-08-11T15:38:11.029612Z","steps":["trace[917257826] 'process raft request' (duration: 263.002706ms)","trace[917257826] 'compare' (duration: 417.831301ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:38:11.029853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.347437Z","time spent":"682.308017ms","remote":"127.0.0.1:33948","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-11T15:38:11.029675Z","caller":"traceutil/trace.go:171","msg":"trace[1177797514] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"680.34188ms","start":"2026-08-11T15:38:10.349306Z","end":"2026-08-11T15:38:11.029648Z","steps":["trace[1177797514] 'process raft request' (duration: 680.197668ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.030184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.349287Z","time spent":"680.856787ms","remote":"127.0.0.1:33948","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-11T15:38:11.484542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.934288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:38:11.485462Z","caller":"traceutil/trace.go:171","msg":"trace[1684457165] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"492.423534ms","start":"2026-08-11T15:38:10.993016Z","end":"2026-08-11T15:38:11.48544Z","steps":["trace[1684457165] 'process raft request' (duration: 492.373374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.485649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.993008Z","time spent":"492.567716ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:38:11.486133Z","caller":"traceutil/trace.go:171","msg":"trace[277565579] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"841.364519ms","start":"2026-08-11T15:38:10.644615Z","end":"2026-08-11T15:38:11.485979Z","steps":["trace[277565579] 'process raft request' (duration: 531.872689ms)","trace[277565579] 'compare' (duration: 307.752635ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:38:11.486265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.644587Z","time spent":"841.639102ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:38:11.486541Z","caller":"traceutil/trace.go:171","msg":"trace[622786194] linearizableReadLoop","detail":"{readStateIndex:2882; appliedIndex:2881; }","duration":"669.925175ms","start":"2026-08-11T15:38:10.816603Z","end":"2026-08-11T15:38:11.486529Z","steps":["trace[622786194] 'read index received' (duration: 359.994018ms)","trace[622786194] 'applied index is now lower than readState.Index' (duration: 309.929997ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:38:11.486886Z","caller":"traceutil/trace.go:171","msg":"trace[1969481493] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"512.311807ms","start":"2026-08-11T15:38:10.974562Z","end":"2026-08-11T15:38:11.486874Z","steps":["trace[1969481493] 'process raft request' (duration: 510.757736ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.487007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.974523Z","time spent":"512.445529ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:38:11.487416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.789698ms","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-11T15:38:11.487507Z","caller":"traceutil/trace.go:171","msg":"trace[2022867323] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2781; }","duration":"670.94521ms","start":"2026-08-11T15:38:10.816541Z","end":"2026-08-11T15:38:11.487486Z","steps":["trace[2022867323] 'agreement among raft nodes before linearized reading' (duration: 670.675076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.487453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.518302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-11T15:38:11.48763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.625286ms","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-11T15:38:11.487668Z","caller":"traceutil/trace.go:171","msg":"trace[858629419] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2781; }","duration":"661.679987ms","start":"2026-08-11T15:38:10.825979Z","end":"2026-08-11T15:38:11.487659Z","steps":["trace[858629419] 'agreement among raft nodes before linearized reading' (duration: 661.591016ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.487688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.825964Z","time spent":"661.719188ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T15:38:11.487846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.57409ms","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-11T15:38:11.488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.00239ms","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-11T15:38:11.488036Z","caller":"traceutil/trace.go:171","msg":"trace[99079752] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2781; }","duration":"664.087931ms","start":"2026-08-11T15:38:10.823939Z","end":"2026-08-11T15:38:11.488027Z","steps":["trace[99079752] 'agreement among raft nodes before linearized reading' (duration: 664.00322ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.488059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.823916Z","time spent":"664.136172ms","remote":"127.0.0.1:33948","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":"info","ts":"2026-08-11T15:38:11.487981Z","caller":"traceutil/trace.go:171","msg":"trace[650086572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2781; }","duration":"662.728792ms","start":"2026-08-11T15:38:10.82524Z","end":"2026-08-11T15:38:11.487969Z","steps":["trace[650086572] 'agreement among raft nodes before linearized reading' (duration: 662.496599ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.488188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.825229Z","time spent":"662.946805ms","remote":"127.0.0.1:33948","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-11T15:38:11.487602Z","caller":"traceutil/trace.go:171","msg":"trace[671842334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2781; }","duration":"665.734995ms","start":"2026-08-11T15:38:10.821851Z","end":"2026-08-11T15:38:11.487586Z","steps":["trace[671842334] 'agreement among raft nodes before linearized reading' (duration: 665.414861ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.488435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.821811Z","time spent":"666.612688ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T15:38:11.488125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.964958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-08-11T15:38:11.488633Z","caller":"traceutil/trace.go:171","msg":"trace[1925127388] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2781; }","duration":"527.532485ms","start":"2026-08-11T15:38:10.961083Z","end":"2026-08-11T15:38:11.488615Z","steps":["trace[1925127388] 'agreement among raft nodes before linearized reading' (duration: 526.780865ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.488728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.961072Z","time spent":"527.641208ms","remote":"127.0.0.1:33858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-08-11T15:38:11.487893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.43942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:38:11.489146Z","caller":"traceutil/trace.go:171","msg":"trace[686126044] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:2781; }","duration":"324.687567ms","start":"2026-08-11T15:38:11.164438Z","end":"2026-08-11T15:38:11.489126Z","steps":["trace[686126044] 'agreement among raft nodes before linearized reading' (duration: 323.353429ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:38:11.489256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:11.164412Z","time spent":"324.820689ms","remote":"127.0.0.1:33732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":54,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-08-11T15:38:11.487547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:38:10.816516Z","time spent":"671.022812ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-11T15:42:06.148086Z","caller":"traceutil/trace.go:171","msg":"trace[293294654] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"238.479358ms","start":"2026-08-11T15:42:05.909565Z","end":"2026-08-11T15:42:06.148045Z","steps":["trace[293294654] 'process raft request' (duration: 237.205431ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:06.148347Z","caller":"traceutil/trace.go:171","msg":"trace[1260726779] transaction","detail":"{read_only:false; response_revision:4583; number_of_response:1; }","duration":"105.86629ms","start":"2026-08-11T15:42:06.042455Z","end":"2026-08-11T15:42:06.148322Z","steps":["trace[1260726779] 'process raft request' (duration: 105.432791ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:07.090507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.950991ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:42:07.091602Z","caller":"traceutil/trace.go:171","msg":"trace[458936265] linearizableReadLoop","detail":"{readStateIndex:4792; appliedIndex:4789; }","duration":"125.271482ms","start":"2026-08-11T15:42:06.96631Z","end":"2026-08-11T15:42:07.091581Z","steps":["trace[458936265] 'read index received' (duration: 9.245018ms)","trace[458936265] 'applied index is now lower than readState.Index' (duration: 116.021554ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:07.091896Z","caller":"traceutil/trace.go:171","msg":"trace[1934680002] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"130.480564ms","start":"2026-08-11T15:42:06.961403Z","end":"2026-08-11T15:42:07.091883Z","steps":["trace[1934680002] 'process raft request' (duration: 13.99948ms)","trace[1934680002] 'compare' (duration: 114.574773ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:07.092117Z","caller":"traceutil/trace.go:171","msg":"trace[1925832105] transaction","detail":"{read_only:false; response_revision:4617; number_of_response:1; }","duration":"125.834354ms","start":"2026-08-11T15:42:06.966273Z","end":"2026-08-11T15:42:07.092108Z","steps":["trace[1925832105] 'process raft request' (duration: 125.211711ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:07.092242Z","caller":"traceutil/trace.go:171","msg":"trace[2110975978] transaction","detail":"{read_only:false; response_revision:4618; number_of_response:1; }","duration":"125.950886ms","start":"2026-08-11T15:42:06.966282Z","end":"2026-08-11T15:42:07.092233Z","steps":["trace[2110975978] 'process raft request' (duration: 125.257612ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:07.092483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.164371ms","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-11T15:42:07.092513Z","caller":"traceutil/trace.go:171","msg":"trace[1128563138] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4618; }","duration":"126.203752ms","start":"2026-08-11T15:42:06.966299Z","end":"2026-08-11T15:42:07.092503Z","steps":["trace[1128563138] 'agreement among raft nodes before linearized reading' (duration: 126.078399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:07.092692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.820082ms","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-11T15:42:07.092717Z","caller":"traceutil/trace.go:171","msg":"trace[2063864723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4618; }","duration":"124.887804ms","start":"2026-08-11T15:42:06.967822Z","end":"2026-08-11T15:42:07.092709Z","steps":["trace[2063864723] 'agreement among raft nodes before linearized reading' (duration: 124.812493ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:08.060607Z","caller":"traceutil/trace.go:171","msg":"trace[1258219390] transaction","detail":"{read_only:false; response_revision:4631; number_of_response:1; }","duration":"180.422687ms","start":"2026-08-11T15:42:07.880163Z","end":"2026-08-11T15:42:08.060586Z","steps":["trace[1258219390] 'process raft request' (duration: 180.288335ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:08.065477Z","caller":"traceutil/trace.go:171","msg":"trace[1677550872] transaction","detail":"{read_only:false; response_revision:4632; number_of_response:1; }","duration":"173.682263ms","start":"2026-08-11T15:42:07.891741Z","end":"2026-08-11T15:42:08.065423Z","steps":["trace[1677550872] 'process raft request' (duration: 173.423227ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:09.270894Z","caller":"traceutil/trace.go:171","msg":"trace[1539499694] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"108.783087ms","start":"2026-08-11T15:42:09.162066Z","end":"2026-08-11T15:42:09.270849Z","steps":["trace[1539499694] 'process raft request' (duration: 108.640974ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:09.28638Z","caller":"traceutil/trace.go:171","msg":"trace[1880319801] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"124.053811ms","start":"2026-08-11T15:42:09.162299Z","end":"2026-08-11T15:42:09.286353Z","steps":["trace[1880319801] 'process raft request' (duration: 123.652583ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:10.550124Z","caller":"traceutil/trace.go:171","msg":"trace[1121314411] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"156.29281ms","start":"2026-08-11T15:42:10.393788Z","end":"2026-08-11T15:42:10.55008Z","steps":["trace[1121314411] 'process raft request' (duration: 83.393382ms)","trace[1121314411] 'compare' (duration: 72.622903ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:10.550192Z","caller":"traceutil/trace.go:171","msg":"trace[2145960854] linearizableReadLoop","detail":"{readStateIndex:4863; appliedIndex:4862; }","duration":"140.577406ms","start":"2026-08-11T15:42:10.409566Z","end":"2026-08-11T15:42:10.550143Z","steps":["trace[2145960854] 'read index received' (duration: 67.546475ms)","trace[2145960854] 'applied index is now lower than readState.Index' (duration: 73.02175ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:42:10.550509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.901072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-78fc2bfa-e0e6-4b14-8e41-da41d0014c9a\" ","response":"range_response_count:1 size:4065"} {"level":"info","ts":"2026-08-11T15:42:10.550563Z","caller":"traceutil/trace.go:171","msg":"trace[836018601] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-78fc2bfa-e0e6-4b14-8e41-da41d0014c9a; range_end:; response_count:1; response_revision:4688; }","duration":"141.028635ms","start":"2026-08-11T15:42:10.409515Z","end":"2026-08-11T15:42:10.550543Z","steps":["trace[836018601] 'agreement among raft nodes before linearized reading' (duration: 140.76685ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:11.469193Z","caller":"traceutil/trace.go:171","msg":"trace[761338607] linearizableReadLoop","detail":"{readStateIndex:4893; appliedIndex:4890; }","duration":"260.328877ms","start":"2026-08-11T15:42:11.20884Z","end":"2026-08-11T15:42:11.469168Z","steps":["trace[761338607] 'read index received' (duration: 13.923325ms)","trace[761338607] 'applied index is now lower than readState.Index' (duration: 246.403862ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:11.469307Z","caller":"traceutil/trace.go:171","msg":"trace[1282638031] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"291.163321ms","start":"2026-08-11T15:42:11.178108Z","end":"2026-08-11T15:42:11.469271Z","steps":["trace[1282638031] 'process raft request' (duration: 290.837865ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:11.469373Z","caller":"traceutil/trace.go:171","msg":"trace[1678927708] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"291.077329ms","start":"2026-08-11T15:42:11.178221Z","end":"2026-08-11T15:42:11.469298Z","steps":["trace[1678927708] 'process raft request' (duration: 290.897585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:11.469705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.8525ms","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-11T15:42:11.469749Z","caller":"traceutil/trace.go:171","msg":"trace[967888943] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4715; }","duration":"260.943111ms","start":"2026-08-11T15:42:11.208793Z","end":"2026-08-11T15:42:11.469736Z","steps":["trace[967888943] 'agreement among raft nodes before linearized reading' (duration: 260.738556ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:11.517042Z","caller":"traceutil/trace.go:171","msg":"trace[199683061] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"176.95137ms","start":"2026-08-11T15:42:11.340064Z","end":"2026-08-11T15:42:11.517016Z","steps":["trace[199683061] 'process raft request' (duration: 176.694185ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:11.517322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.979982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:42:11.517381Z","caller":"traceutil/trace.go:171","msg":"trace[1541800942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4717; }","duration":"253.124156ms","start":"2026-08-11T15:42:11.264243Z","end":"2026-08-11T15:42:11.517367Z","steps":["trace[1541800942] 'agreement among raft nodes before linearized reading' (duration: 252.965671ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:11.517458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.175256ms","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-11T15:42:11.517588Z","caller":"traceutil/trace.go:171","msg":"trace[152251822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4717; }","duration":"227.35102ms","start":"2026-08-11T15:42:11.290216Z","end":"2026-08-11T15:42:11.517567Z","steps":["trace[152251822] 'agreement among raft nodes before linearized reading' (duration: 226.978541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:11.517726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.844057ms","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-11T15:42:11.517772Z","caller":"traceutil/trace.go:171","msg":"trace[1448185646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4717; }","duration":"242.934489ms","start":"2026-08-11T15:42:11.274827Z","end":"2026-08-11T15:42:11.517761Z","steps":["trace[1448185646] 'agreement among raft nodes before linearized reading' (duration: 242.797156ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:11.517201Z","caller":"traceutil/trace.go:171","msg":"trace[977448989] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"159.101321ms","start":"2026-08-11T15:42:11.358088Z","end":"2026-08-11T15:42:11.517189Z","steps":["trace[977448989] 'process raft request' (duration: 158.843045ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:15.284807Z","caller":"traceutil/trace.go:171","msg":"trace[776576739] linearizableReadLoop","detail":"{readStateIndex:4960; appliedIndex:4959; }","duration":"245.2043ms","start":"2026-08-11T15:42:15.039576Z","end":"2026-08-11T15:42:15.28478Z","steps":["trace[776576739] 'read index received' (duration: 244.994555ms)","trace[776576739] 'applied index is now lower than readState.Index' (duration: 208.704µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:15.284907Z","caller":"traceutil/trace.go:171","msg":"trace[781376954] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"245.395403ms","start":"2026-08-11T15:42:15.039471Z","end":"2026-08-11T15:42:15.284866Z","steps":["trace[781376954] 'process raft request' (duration: 245.180379ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:15.285096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.571311ms","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-11T15:42:15.285137Z","caller":"traceutil/trace.go:171","msg":"trace[943368267] 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:4780; }","duration":"220.661495ms","start":"2026-08-11T15:42:15.064462Z","end":"2026-08-11T15:42:15.285123Z","steps":["trace[943368267] 'agreement among raft nodes before linearized reading' (duration: 220.453369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:15.285391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.892582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:42:15.285498Z","caller":"traceutil/trace.go:171","msg":"trace[1901709680] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:4780; }","duration":"133.047595ms","start":"2026-08-11T15:42:15.152427Z","end":"2026-08-11T15:42:15.285474Z","steps":["trace[1901709680] 'agreement among raft nodes before linearized reading' (duration: 132.82151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:15.285432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.788122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13293"} {"level":"info","ts":"2026-08-11T15:42:15.285609Z","caller":"traceutil/trace.go:171","msg":"trace[268909853] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4780; }","duration":"245.999886ms","start":"2026-08-11T15:42:15.039546Z","end":"2026-08-11T15:42:15.285546Z","steps":["trace[268909853] 'agreement among raft nodes before linearized reading' (duration: 245.345212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.077248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.443406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:42:19.077313Z","caller":"traceutil/trace.go:171","msg":"trace[460335867] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:4861; }","duration":"639.540658ms","start":"2026-08-11T15:42:18.43776Z","end":"2026-08-11T15:42:19.0773Z","steps":["trace[460335867] 'count revisions from in-memory index tree' (duration: 639.332334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.077568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:18.437693Z","time spent":"639.864734ms","remote":"127.0.0.1:53864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":22,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-08-11T15:42:19.077754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.374063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:42:19.077827Z","caller":"traceutil/trace.go:171","msg":"trace[1635871862] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:4861; }","duration":"684.508066ms","start":"2026-08-11T15:42:18.393298Z","end":"2026-08-11T15:42:19.077806Z","steps":["trace[1635871862] 'count revisions from in-memory index tree' (duration: 684.273272ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.077858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:18.393275Z","time spent":"684.575198ms","remote":"127.0.0.1:33830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":4,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-08-11T15:42:19.077863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.136939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b0054ddb-4f71-40e2-91ef-8c3a0d455ac7\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-11T15:42:19.077885Z","caller":"traceutil/trace.go:171","msg":"trace[1666491455] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b0054ddb-4f71-40e2-91ef-8c3a0d455ac7; range_end:; response_count:1; response_revision:4861; }","duration":"651.181611ms","start":"2026-08-11T15:42:18.426696Z","end":"2026-08-11T15:42:19.077878Z","steps":["trace[1666491455] 'range keys from in-memory index tree' (duration: 651.005117ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.077914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:18.426644Z","time spent":"651.265742ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b0054ddb-4f71-40e2-91ef-8c3a0d455ac7\" "} {"level":"warn","ts":"2026-08-11T15:42:19.078061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.787298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-11T15:42:19.078183Z","caller":"traceutil/trace.go:171","msg":"trace[256651381] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4861; }","duration":"738.960013ms","start":"2026-08-11T15:42:18.339192Z","end":"2026-08-11T15:42:19.078152Z","steps":["trace[256651381] 'range keys from in-memory index tree' (duration: 738.456752ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.078241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:18.339174Z","time spent":"739.051825ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-11T15:42:19.079602Z","caller":"traceutil/trace.go:171","msg":"trace[1124165567] linearizableReadLoop","detail":"{readStateIndex:5043; appliedIndex:5042; }","duration":"419.128371ms","start":"2026-08-11T15:42:18.660462Z","end":"2026-08-11T15:42:19.07959Z","steps":["trace[1124165567] 'read index received' (duration: 410.805988ms)","trace[1124165567] 'applied index is now lower than readState.Index' (duration: 8.321863ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:19.079826Z","caller":"traceutil/trace.go:171","msg":"trace[2048264642] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"501.374196ms","start":"2026-08-11T15:42:18.578413Z","end":"2026-08-11T15:42:19.079787Z","steps":["trace[2048264642] 'process raft request' (duration: 492.784617ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.079862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.407466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:42:19.079883Z","caller":"traceutil/trace.go:171","msg":"trace[1268206652] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:4862; }","duration":"419.456287ms","start":"2026-08-11T15:42:18.66042Z","end":"2026-08-11T15:42:19.079876Z","steps":["trace[1268206652] 'agreement among raft nodes before linearized reading' (duration: 419.395196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.0799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:18.660404Z","time spent":"419.491308ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":33,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-08-11T15:42:19.079923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:18.578393Z","time spent":"501.470218ms","remote":"127.0.0.1:33948","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-11T15:42:19.080635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.254252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:42:19.080665Z","caller":"traceutil/trace.go:171","msg":"trace[310731293] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4863; }","duration":"407.302613ms","start":"2026-08-11T15:42:18.673354Z","end":"2026-08-11T15:42:19.080657Z","steps":["trace[310731293] 'agreement among raft nodes before linearized reading' (duration: 407.238982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.08068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:18.673344Z","time spent":"407.331494ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-08-11T15:42:19.781134Z","caller":"traceutil/trace.go:171","msg":"trace[626018417] linearizableReadLoop","detail":"{readStateIndex:5047; appliedIndex:5046; }","duration":"333.010163ms","start":"2026-08-11T15:42:19.448098Z","end":"2026-08-11T15:42:19.781109Z","steps":["trace[626018417] 'read index received' (duration: 332.251267ms)","trace[626018417] 'applied index is now lower than readState.Index' (duration: 757.816µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:19.781237Z","caller":"traceutil/trace.go:171","msg":"trace[2135250453] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"413.851834ms","start":"2026-08-11T15:42:19.367337Z","end":"2026-08-11T15:42:19.781189Z","steps":["trace[2135250453] 'process raft request' (duration: 412.860013ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.7814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.273969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-08-11T15:42:19.781411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:19.367312Z","time spent":"414.000748ms","remote":"127.0.0.1:33948","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-11T15:42:19.781443Z","caller":"traceutil/trace.go:171","msg":"trace[2049965204] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4866; }","duration":"333.346601ms","start":"2026-08-11T15:42:19.44808Z","end":"2026-08-11T15:42:19.781427Z","steps":["trace[2049965204] 'agreement among raft nodes before linearized reading' (duration: 333.163107ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.781481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:19.448072Z","time spent":"333.400492ms","remote":"127.0.0.1:45764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-08-11T15:42:19.955277Z","caller":"traceutil/trace.go:171","msg":"trace[607483878] linearizableReadLoop","detail":"{readStateIndex:5048; appliedIndex:5047; }","duration":"174.039524ms","start":"2026-08-11T15:42:19.781214Z","end":"2026-08-11T15:42:19.955253Z","steps":["trace[607483878] 'read index received' (duration: 173.779359ms)","trace[607483878] 'applied index is now lower than readState.Index' (duration: 258.845µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:42:19.95556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.88012ms","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":"warn","ts":"2026-08-11T15:42:19.955619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.447445ms","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-11T15:42:19.955667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.940607ms","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-11T15:42:19.955725Z","caller":"traceutil/trace.go:171","msg":"trace[315250518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4867; }","duration":"448.589799ms","start":"2026-08-11T15:42:19.507122Z","end":"2026-08-11T15:42:19.955712Z","steps":["trace[315250518] 'agreement among raft nodes before linearized reading' (duration: 448.357214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.955766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.241663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-08-11T15:42:19.955856Z","caller":"traceutil/trace.go:171","msg":"trace[1969380352] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4867; }","duration":"168.403446ms","start":"2026-08-11T15:42:19.787436Z","end":"2026-08-11T15:42:19.95584Z","steps":["trace[1969380352] 'agreement among raft nodes before linearized reading' (duration: 168.08889ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:19.955751Z","caller":"traceutil/trace.go:171","msg":"trace[1440361798] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4867; }","duration":"450.06426ms","start":"2026-08-11T15:42:19.505668Z","end":"2026-08-11T15:42:19.955732Z","steps":["trace[1440361798] 'agreement among raft nodes before linearized reading' (duration: 449.876186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.955958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:19.505644Z","time spent":"450.305185ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T15:42:19.955988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:19.507113Z","time spent":"448.852464ms","remote":"127.0.0.1:33948","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-11T15:42:19.95572Z","caller":"traceutil/trace.go:171","msg":"trace[1510281056] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"396.454244ms","start":"2026-08-11T15:42:19.558953Z","end":"2026-08-11T15:42:19.955408Z","steps":["trace[1510281056] 'process raft request' (duration: 396.143218ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:19.955682Z","caller":"traceutil/trace.go:171","msg":"trace[2143363853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4867; }","duration":"271.036373ms","start":"2026-08-11T15:42:19.684613Z","end":"2026-08-11T15:42:19.955649Z","steps":["trace[2143363853] 'agreement among raft nodes before linearized reading' (duration: 270.692546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.95559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.075971ms","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-11T15:42:19.956364Z","caller":"traceutil/trace.go:171","msg":"trace[1164276897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4867; }","duration":"304.906138ms","start":"2026-08-11T15:42:19.651445Z","end":"2026-08-11T15:42:19.956351Z","steps":["trace[1164276897] 'agreement among raft nodes before linearized reading' (duration: 303.931738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:19.956445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:19.651377Z","time spent":"305.052411ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T15:42:19.956502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:19.558925Z","time spent":"397.232531ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:42:20.086291Z","caller":"traceutil/trace.go:171","msg":"trace[2099458618] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"124.104649ms","start":"2026-08-11T15:42:19.962174Z","end":"2026-08-11T15:42:20.086278Z","steps":["trace[2099458618] 'process raft request' (duration: 110.207641ms)","trace[2099458618] 'compare' (duration: 13.739265ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:20.086601Z","caller":"traceutil/trace.go:171","msg":"trace[427841226] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"124.199651ms","start":"2026-08-11T15:42:19.962375Z","end":"2026-08-11T15:42:20.086574Z","steps":["trace[427841226] 'process raft request' (duration: 123.852664ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:20.086624Z","caller":"traceutil/trace.go:171","msg":"trace[409934256] linearizableReadLoop","detail":"{readStateIndex:5052; appliedIndex:5049; }","duration":"117.40849ms","start":"2026-08-11T15:42:19.969196Z","end":"2026-08-11T15:42:20.086605Z","steps":["trace[409934256] 'read index received' (duration: 103.246056ms)","trace[409934256] 'applied index is now lower than readState.Index' (duration: 14.161674ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:20.086792Z","caller":"traceutil/trace.go:171","msg":"trace[1765373765] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"123.628761ms","start":"2026-08-11T15:42:19.963123Z","end":"2026-08-11T15:42:20.086751Z","steps":["trace[1765373765] 'process raft request' (duration: 123.394345ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:20.086982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.490372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1453"} {"level":"warn","ts":"2026-08-11T15:42:20.087003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.797689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18caca9396fe5b22\" ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-08-11T15:42:20.087036Z","caller":"traceutil/trace.go:171","msg":"trace[80700170] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4871; }","duration":"117.568484ms","start":"2026-08-11T15:42:19.969454Z","end":"2026-08-11T15:42:20.087023Z","steps":["trace[80700170] 'agreement among raft nodes before linearized reading' (duration: 117.40967ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:20.087043Z","caller":"traceutil/trace.go:171","msg":"trace[444279178] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18caca9396fe5b22; range_end:; response_count:1; response_revision:4871; }","duration":"117.85161ms","start":"2026-08-11T15:42:19.969177Z","end":"2026-08-11T15:42:20.087028Z","steps":["trace[444279178] 'agreement among raft nodes before linearized reading' (duration: 117.736517ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:22.543073Z","caller":"traceutil/trace.go:171","msg":"trace[174058024] linearizableReadLoop","detail":"{readStateIndex:5081; appliedIndex:5080; }","duration":"279.188603ms","start":"2026-08-11T15:42:22.263861Z","end":"2026-08-11T15:42:22.543049Z","steps":["trace[174058024] 'read index received' (duration: 279.130801ms)","trace[174058024] 'applied index is now lower than readState.Index' (duration: 56.312µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:22.543307Z","caller":"traceutil/trace.go:171","msg":"trace[1095591617] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"294.977949ms","start":"2026-08-11T15:42:22.248286Z","end":"2026-08-11T15:42:22.543264Z","steps":["trace[1095591617] 'process raft request' (duration: 294.53172ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:22.543651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.688504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:42:22.54374Z","caller":"traceutil/trace.go:171","msg":"trace[1119114592] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4900; }","duration":"279.904467ms","start":"2026-08-11T15:42:22.263823Z","end":"2026-08-11T15:42:22.543727Z","steps":["trace[1119114592] 'agreement among raft nodes before linearized reading' (duration: 279.688603ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:22.685814Z","caller":"traceutil/trace.go:171","msg":"trace[985097851] linearizableReadLoop","detail":"{readStateIndex:5082; appliedIndex:5081; }","duration":"142.561388ms","start":"2026-08-11T15:42:22.543226Z","end":"2026-08-11T15:42:22.685787Z","steps":["trace[985097851] 'read index received' (duration: 122.569125ms)","trace[985097851] 'applied index is now lower than readState.Index' (duration: 19.991073ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:22.686051Z","caller":"traceutil/trace.go:171","msg":"trace[910787187] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"414.736095ms","start":"2026-08-11T15:42:22.271201Z","end":"2026-08-11T15:42:22.685937Z","steps":["trace[910787187] 'process raft request' (duration: 394.657281ms)","trace[910787187] 'compare' (duration: 19.536093ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:42:22.686188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.974106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:42:22.686259Z","caller":"traceutil/trace.go:171","msg":"trace[1328602184] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:4901; }","duration":"113.056818ms","start":"2026-08-11T15:42:22.573183Z","end":"2026-08-11T15:42:22.68624Z","steps":["trace[1328602184] 'agreement among raft nodes before linearized reading' (duration: 112.951245ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:22.686273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:22.271112Z","time spent":"415.047312ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:42:22.686302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.339312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:42:22.686551Z","caller":"traceutil/trace.go:171","msg":"trace[1382838504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4901; }","duration":"141.693301ms","start":"2026-08-11T15:42:22.544844Z","end":"2026-08-11T15:42:22.686537Z","steps":["trace[1382838504] 'agreement among raft nodes before linearized reading' (duration: 141.267921ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:22.686698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.568611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:42:22.686811Z","caller":"traceutil/trace.go:171","msg":"trace[1313356794] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:4901; }","duration":"265.306147ms","start":"2026-08-11T15:42:22.421491Z","end":"2026-08-11T15:42:22.686797Z","steps":["trace[1313356794] 'agreement among raft nodes before linearized reading' (duration: 264.53468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:32.274395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.935051ms","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-11T15:42:32.274466Z","caller":"traceutil/trace.go:171","msg":"trace[198647231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5029; }","duration":"126.057732ms","start":"2026-08-11T15:42:32.148393Z","end":"2026-08-11T15:42:32.274451Z","steps":["trace[198647231] 'range keys from in-memory index tree' (duration: 125.778897ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:32.274798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.821117ms","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-11T15:42:32.274923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.027839ms","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-11T15:42:32.274953Z","caller":"traceutil/trace.go:171","msg":"trace[1078601029] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5029; }","duration":"240.106591ms","start":"2026-08-11T15:42:32.034839Z","end":"2026-08-11T15:42:32.274946Z","steps":["trace[1078601029] 'range keys from in-memory index tree' (duration: 239.872976ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:32.275054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.097412ms","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-11T15:42:32.27516Z","caller":"traceutil/trace.go:171","msg":"trace[1940303089] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5029; }","duration":"123.267516ms","start":"2026-08-11T15:42:32.151874Z","end":"2026-08-11T15:42:32.275141Z","steps":["trace[1940303089] 'range keys from in-memory index tree' (duration: 122.830607ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:32.275211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.904564ms","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-11T15:42:32.275267Z","caller":"traceutil/trace.go:171","msg":"trace[89173503] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5029; }","duration":"187.018276ms","start":"2026-08-11T15:42:32.088234Z","end":"2026-08-11T15:42:32.275252Z","steps":["trace[89173503] 'range keys from in-memory index tree' (duration: 186.745271ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:32.275474Z","caller":"traceutil/trace.go:171","msg":"trace[290647512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5029; }","duration":"124.98305ms","start":"2026-08-11T15:42:32.149881Z","end":"2026-08-11T15:42:32.274864Z","steps":["trace[290647512] 'range keys from in-memory index tree' (duration: 124.602763ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:32.508098Z","caller":"traceutil/trace.go:171","msg":"trace[1241802398] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"226.615889ms","start":"2026-08-11T15:42:32.281445Z","end":"2026-08-11T15:42:32.508061Z","steps":["trace[1241802398] 'process raft request' (duration: 184.129998ms)","trace[1241802398] 'compare' (duration: 41.888188ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:32.508149Z","caller":"traceutil/trace.go:171","msg":"trace[1187722237] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"225.032448ms","start":"2026-08-11T15:42:32.283074Z","end":"2026-08-11T15:42:32.508106Z","steps":["trace[1187722237] 'process raft request' (duration: 224.776962ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:32.508109Z","caller":"traceutil/trace.go:171","msg":"trace[19902112] linearizableReadLoop","detail":"{readStateIndex:5218; appliedIndex:5216; }","duration":"225.544377ms","start":"2026-08-11T15:42:32.282537Z","end":"2026-08-11T15:42:32.508081Z","steps":["trace[19902112] 'read index received' (duration: 49.150096ms)","trace[19902112] 'applied index is now lower than readState.Index' (duration: 176.393041ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:32.508204Z","caller":"traceutil/trace.go:171","msg":"trace[1446305572] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"221.547247ms","start":"2026-08-11T15:42:32.286597Z","end":"2026-08-11T15:42:32.508144Z","steps":["trace[1446305572] 'process raft request' (duration: 221.403434ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:32.50842Z","caller":"traceutil/trace.go:171","msg":"trace[238635052] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"224.994457ms","start":"2026-08-11T15:42:32.283414Z","end":"2026-08-11T15:42:32.508409Z","steps":["trace[238635052] 'process raft request' (duration: 224.531138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:32.508753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.18741ms","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-11T15:42:32.508985Z","caller":"traceutil/trace.go:171","msg":"trace[630456505] 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:5034; }","duration":"226.436966ms","start":"2026-08-11T15:42:32.282523Z","end":"2026-08-11T15:42:32.50896Z","steps":["trace[630456505] 'agreement among raft nodes before linearized reading' (duration: 225.823924ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:32.95952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.866605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:42:32.959842Z","caller":"traceutil/trace.go:171","msg":"trace[770718173] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"244.47573ms","start":"2026-08-11T15:42:32.715348Z","end":"2026-08-11T15:42:32.959824Z","steps":["trace[770718173] 'process raft request' (duration: 244.431599ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:32.95983Z","caller":"traceutil/trace.go:171","msg":"trace[1007681291] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"432.066498ms","start":"2026-08-11T15:42:32.527729Z","end":"2026-08-11T15:42:32.959796Z","steps":["trace[1007681291] 'process raft request' (duration: 283.777836ms)","trace[1007681291] 'compare' (duration: 147.511087ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:32.960014Z","caller":"traceutil/trace.go:171","msg":"trace[2103748295] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"374.989953ms","start":"2026-08-11T15:42:32.585012Z","end":"2026-08-11T15:42:32.960002Z","steps":["trace[2103748295] 'process raft request' (duration: 374.632106ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:42:32.960007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:32.527717Z","time spent":"432.18296ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17110,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:42:32.960082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:42:32.584995Z","time spent":"375.051164ms","remote":"127.0.0.1:33948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:42:33.285181Z","caller":"traceutil/trace.go:171","msg":"trace[1809851389] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"155.950562ms","start":"2026-08-11T15:42:33.129211Z","end":"2026-08-11T15:42:33.285162Z","steps":["trace[1809851389] 'process raft request' (duration: 155.913521ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:33.285554Z","caller":"traceutil/trace.go:171","msg":"trace[1930535826] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"194.867706ms","start":"2026-08-11T15:42:33.090677Z","end":"2026-08-11T15:42:33.285544Z","steps":["trace[1930535826] 'process raft request' (duration: 105.860358ms)","trace[1930535826] 'compare' (duration: 87.641951ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:42:33.285732Z","caller":"traceutil/trace.go:171","msg":"trace[2109002594] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"193.555241ms","start":"2026-08-11T15:42:33.092151Z","end":"2026-08-11T15:42:33.285706Z","steps":["trace[2109002594] 'process raft request' (duration: 192.949849ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:33.286159Z","caller":"traceutil/trace.go:171","msg":"trace[1637061782] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"195.172323ms","start":"2026-08-11T15:42:33.090975Z","end":"2026-08-11T15:42:33.286148Z","steps":["trace[1637061782] 'process raft request' (duration: 194.037751ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:33.286179Z","caller":"traceutil/trace.go:171","msg":"trace[1274596998] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"194.288595ms","start":"2026-08-11T15:42:33.091857Z","end":"2026-08-11T15:42:33.286146Z","steps":["trace[1274596998] 'process raft request' (duration: 193.203054ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:42:34.191633Z","caller":"traceutil/trace.go:171","msg":"trace[1373576566] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"148.510334ms","start":"2026-08-11T15:42:34.043092Z","end":"2026-08-11T15:42:34.191603Z","steps":["trace[1373576566] 'process raft request' (duration: 148.34851ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:43:00.089821Z","caller":"traceutil/trace.go:171","msg":"trace[1110348995] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"102.623021ms","start":"2026-08-11T15:42:59.987166Z","end":"2026-08-11T15:43:00.089789Z","steps":["trace[1110348995] 'process raft request' (duration: 101.741554ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:43:02.647122Z","caller":"traceutil/trace.go:171","msg":"trace[170910506] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"150.643064ms","start":"2026-08-11T15:43:02.496454Z","end":"2026-08-11T15:43:02.647097Z","steps":["trace[170910506] 'process raft request' (duration: 150.500211ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:43:02.806199Z","caller":"traceutil/trace.go:171","msg":"trace[801691985] transaction","detail":"{read_only:false; response_revision:5322; number_of_response:1; }","duration":"101.134956ms","start":"2026-08-11T15:43:02.705044Z","end":"2026-08-11T15:43:02.806179Z","steps":["trace[801691985] 'process raft request' (duration: 101.103846ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:43:02.806228Z","caller":"traceutil/trace.go:171","msg":"trace[411963475] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"101.285699ms","start":"2026-08-11T15:43:02.704908Z","end":"2026-08-11T15:43:02.806194Z","steps":["trace[411963475] 'process raft request' (duration: 101.120185ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:43:34.696676Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2906} {"level":"info","ts":"2026-08-11T15:43:34.797456Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2906,"took":"98.885431ms","hash":2407741487,"current-db-size-bytes":53526528,"current-db-size":"54 MB","current-db-size-in-use-bytes":29360128,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-11T15:43:34.79755Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2407741487,"revision":2906,"compact-revision":-1} {"level":"info","ts":"2026-08-11T15:46:05.986876Z","caller":"traceutil/trace.go:171","msg":"trace[223895102] transaction","detail":"{read_only:false; response_revision:6589; number_of_response:1; }","duration":"132.980912ms","start":"2026-08-11T15:46:05.853869Z","end":"2026-08-11T15:46:05.98685Z","steps":["trace[223895102] 'process raft request' (duration: 132.800969ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:46:06.063521Z","caller":"traceutil/trace.go:171","msg":"trace[1977872785] transaction","detail":"{read_only:false; response_revision:6590; number_of_response:1; }","duration":"202.401519ms","start":"2026-08-11T15:46:05.861089Z","end":"2026-08-11T15:46:06.063491Z","steps":["trace[1977872785] 'process raft request' (duration: 202.274077ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:46:06.595072Z","caller":"traceutil/trace.go:171","msg":"trace[1201579645] transaction","detail":"{read_only:false; response_revision:6591; number_of_response:1; }","duration":"270.091017ms","start":"2026-08-11T15:46:06.324953Z","end":"2026-08-11T15:46:06.595044Z","steps":["trace[1201579645] 'process raft request' (duration: 269.855514ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:46:42.016621Z","caller":"traceutil/trace.go:171","msg":"trace[1038565576] transaction","detail":"{read_only:false; response_revision:6828; number_of_response:1; }","duration":"143.750309ms","start":"2026-08-11T15:46:41.872839Z","end":"2026-08-11T15:46:42.01659Z","steps":["trace[1038565576] 'process raft request' (duration: 143.554185ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:46:42.173606Z","caller":"traceutil/trace.go:171","msg":"trace[379894275] transaction","detail":"{read_only:false; response_revision:6829; number_of_response:1; }","duration":"103.09816ms","start":"2026-08-11T15:46:42.070475Z","end":"2026-08-11T15:46:42.173573Z","steps":["trace[379894275] 'process raft request' (duration: 34.536382ms)","trace[379894275] 'compare' (duration: 68.158851ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:46:42.403708Z","caller":"traceutil/trace.go:171","msg":"trace[1220926900] transaction","detail":"{read_only:false; response_revision:6833; number_of_response:1; }","duration":"223.346478ms","start":"2026-08-11T15:46:42.180331Z","end":"2026-08-11T15:46:42.403677Z","steps":["trace[1220926900] 'process raft request' (duration: 222.983002ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:46:42.40407Z","caller":"traceutil/trace.go:171","msg":"trace[1080771304] linearizableReadLoop","detail":"{readStateIndex:7082; appliedIndex:7079; }","duration":"212.784742ms","start":"2026-08-11T15:46:42.191261Z","end":"2026-08-11T15:46:42.404046Z","steps":["trace[1080771304] 'read index received' (duration: 58.679632ms)","trace[1080771304] 'applied index is now lower than readState.Index' (duration: 154.1038ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:46:42.404301Z","caller":"traceutil/trace.go:171","msg":"trace[491844477] transaction","detail":"{read_only:false; response_revision:6834; number_of_response:1; }","duration":"222.849711ms","start":"2026-08-11T15:46:42.181439Z","end":"2026-08-11T15:46:42.404289Z","steps":["trace[491844477] 'process raft request' (duration: 222.13849ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:46:42.404535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.245569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:46:42.40457Z","caller":"traceutil/trace.go:171","msg":"trace[684901286] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:6834; }","duration":"213.3362ms","start":"2026-08-11T15:46:42.191224Z","end":"2026-08-11T15:46:42.404561Z","steps":["trace[684901286] 'agreement among raft nodes before linearized reading' (duration: 213.246879ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:46:42.404806Z","caller":"traceutil/trace.go:171","msg":"trace[1548661935] transaction","detail":"{read_only:false; response_revision:6832; number_of_response:1; }","duration":"224.874922ms","start":"2026-08-11T15:46:42.178517Z","end":"2026-08-11T15:46:42.403391Z","steps":["trace[1548661935] 'process raft request' (duration: 221.674541ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:46:42.406684Z","caller":"traceutil/trace.go:171","msg":"trace[729374094] transaction","detail":"{read_only:false; response_revision:6835; number_of_response:1; }","duration":"145.81028ms","start":"2026-08-11T15:46:42.260853Z","end":"2026-08-11T15:46:42.406664Z","steps":["trace[729374094] 'process raft request' (duration: 145.405063ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:48:34.707747Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5566} {"level":"info","ts":"2026-08-11T15:48:34.826168Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5566,"took":"116.058808ms","hash":933846282,"current-db-size-bytes":53526528,"current-db-size":"54 MB","current-db-size-in-use-bytes":18538496,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-11T15:48:34.826228Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":933846282,"revision":5566,"compact-revision":2906}