{"level":"warn","ts":"2026-05-08T01:01:44.514306Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T01:01:44.514407Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-08T01:01:44.51448Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T01:01:44.514491Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-05-08T01:01:44.514514Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T01:01:44.515289Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-05-08T01:01:44.515376Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-08T01:01:44.519126Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.48003ms"} {"level":"info","ts":"2026-05-08T01:01:44.526277Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-05-08T01:01:44.526352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T01:01:44.52638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-05-08T01:01:44.526398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T01:01:44.52641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-05-08T01:01:44.526454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-05-08T01:01:44.531522Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T01:01:44.532541Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T01:01:44.533735Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-08T01:01:44.535818Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T01:01:44.536992Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T01:01:44.537054Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T01:01:44.537067Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T01:01:44.537013Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T01:01:44.537376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-05-08T01:01:44.537722Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-05-08T01:01:44.541592Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T01:01:44.541735Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-05-08T01:01:44.541768Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-05-08T01:01:44.541991Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T01:01:44.542021Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T01:01:45.326684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T01:01:45.326728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T01:01:45.326746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-05-08T01:01:45.326757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-05-08T01:01:45.326763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-05-08T01:01:45.326773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-05-08T01:01:45.32678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-05-08T01:01:45.32869Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T01:01:45.329558Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T01:01:45.329555Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T01:01:45.329601Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T01:01:45.329834Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T01:01:45.329872Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T01:01:45.330157Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T01:01:45.330294Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T01:01:45.330349Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T01:01:45.331564Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-08T01:01:45.337625Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-05-08T01:02:08.772497Z","caller":"traceutil/trace.go:171","msg":"trace[177018398] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"177.41739ms","start":"2026-05-08T01:02:08.595037Z","end":"2026-05-08T01:02:08.772454Z","steps":["trace[177018398] 'process raft request' (duration: 177.186838ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:11.212351Z","caller":"traceutil/trace.go:171","msg":"trace[1186947354] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"179.025101ms","start":"2026-05-08T01:02:11.033296Z","end":"2026-05-08T01:02:11.212321Z","steps":["trace[1186947354] 'process raft request' (duration: 178.830128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:11.829469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.926475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12665"} {"level":"info","ts":"2026-05-08T01:02:11.829655Z","caller":"traceutil/trace.go:171","msg":"trace[170374531] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:424; }","duration":"483.120027ms","start":"2026-05-08T01:02:11.346512Z","end":"2026-05-08T01:02:11.829632Z","steps":["trace[170374531] 'range keys from in-memory index tree' (duration: 482.789493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:11.829726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:11.346461Z","time spent":"483.250778ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12687,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-05-08T01:02:11.829956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.479671ms","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-05-08T01:02:11.830056Z","caller":"traceutil/trace.go:171","msg":"trace[95866413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:424; }","duration":"256.615782ms","start":"2026-05-08T01:02:11.573418Z","end":"2026-05-08T01:02:11.830034Z","steps":["trace[95866413] 'range keys from in-memory index tree' (duration: 256.333959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:11.830521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.777761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-08T01:02:11.830573Z","caller":"traceutil/trace.go:171","msg":"trace[7056059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:424; }","duration":"242.867722ms","start":"2026-05-08T01:02:11.587692Z","end":"2026-05-08T01:02:11.83056Z","steps":["trace[7056059] 'range keys from in-memory index tree' (duration: 242.68625ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.021597Z","caller":"traceutil/trace.go:171","msg":"trace[1551511949] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"169.666825ms","start":"2026-05-08T01:02:13.851893Z","end":"2026-05-08T01:02:14.02156Z","steps":["trace[1551511949] 'process raft request' (duration: 155.491308ms)","trace[1551511949] 'compare' (duration: 14.002615ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:14.516403Z","caller":"traceutil/trace.go:171","msg":"trace[237178363] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"131.299555ms","start":"2026-05-08T01:02:14.385081Z","end":"2026-05-08T01:02:14.51638Z","steps":["trace[237178363] 'process raft request' (duration: 131.212314ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.516437Z","caller":"traceutil/trace.go:171","msg":"trace[1566640327] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"135.355507ms","start":"2026-05-08T01:02:14.38105Z","end":"2026-05-08T01:02:14.516405Z","steps":["trace[1566640327] 'process raft request' (duration: 47.489804ms)","trace[1566640327] 'compare' (duration: 87.626991ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:14.516644Z","caller":"traceutil/trace.go:171","msg":"trace[1518019091] transaction","detail":"{read_only:false; number_of_response:1; response_revision:469; }","duration":"131.428006ms","start":"2026-05-08T01:02:14.385202Z","end":"2026-05-08T01:02:14.51663Z","steps":["trace[1518019091] 'process raft request' (duration: 131.148554ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.517173Z","caller":"traceutil/trace.go:171","msg":"trace[703266489] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"131.907282ms","start":"2026-05-08T01:02:14.385253Z","end":"2026-05-08T01:02:14.51716Z","steps":["trace[703266489] 'process raft request' (duration: 131.72444ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.51726Z","caller":"traceutil/trace.go:171","msg":"trace[2010519896] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"131.899081ms","start":"2026-05-08T01:02:14.385345Z","end":"2026-05-08T01:02:14.517244Z","steps":["trace[2010519896] 'process raft request' (duration: 131.79459ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.517292Z","caller":"traceutil/trace.go:171","msg":"trace[1056015253] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"131.976282ms","start":"2026-05-08T01:02:14.385285Z","end":"2026-05-08T01:02:14.517261Z","steps":["trace[1056015253] 'process raft request' (duration: 131.80843ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.517492Z","caller":"traceutil/trace.go:171","msg":"trace[1486774660] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"121.372202ms","start":"2026-05-08T01:02:14.396106Z","end":"2026-05-08T01:02:14.517478Z","steps":["trace[1486774660] 'process raft request' (duration: 121.070569ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.518406Z","caller":"traceutil/trace.go:171","msg":"trace[501244961] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"102.027611ms","start":"2026-05-08T01:02:14.416363Z","end":"2026-05-08T01:02:14.518391Z","steps":["trace[501244961] 'process raft request' (duration: 101.98125ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.518589Z","caller":"traceutil/trace.go:171","msg":"trace[1083296900] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"121.113059ms","start":"2026-05-08T01:02:14.397363Z","end":"2026-05-08T01:02:14.518476Z","steps":["trace[1083296900] 'process raft request' (duration: 120.608614ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.518678Z","caller":"traceutil/trace.go:171","msg":"trace[1144709403] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"117.324679ms","start":"2026-05-08T01:02:14.401313Z","end":"2026-05-08T01:02:14.518637Z","steps":["trace[1144709403] 'process raft request' (duration: 116.916185ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.518817Z","caller":"traceutil/trace.go:171","msg":"trace[1142791652] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"118.775165ms","start":"2026-05-08T01:02:14.400028Z","end":"2026-05-08T01:02:14.518803Z","steps":["trace[1142791652] 'process raft request' (duration: 118.014907ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.518859Z","caller":"traceutil/trace.go:171","msg":"trace[1334052558] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"117.462972ms","start":"2026-05-08T01:02:14.401383Z","end":"2026-05-08T01:02:14.518845Z","steps":["trace[1334052558] 'process raft request' (duration: 116.878546ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.51899Z","caller":"traceutil/trace.go:171","msg":"trace[559184601] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"118.856086ms","start":"2026-05-08T01:02:14.400077Z","end":"2026-05-08T01:02:14.518933Z","steps":["trace[559184601] 'process raft request' (duration: 118.020368ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.51909Z","caller":"traceutil/trace.go:171","msg":"trace[781947918] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"113.495151ms","start":"2026-05-08T01:02:14.405583Z","end":"2026-05-08T01:02:14.519078Z","steps":["trace[781947918] 'process raft request' (duration: 112.710173ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.954736Z","caller":"traceutil/trace.go:171","msg":"trace[1978779098] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"164.291007ms","start":"2026-05-08T01:02:14.790418Z","end":"2026-05-08T01:02:14.954709Z","steps":["trace[1978779098] 'process raft request' (duration: 159.584129ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.954985Z","caller":"traceutil/trace.go:171","msg":"trace[212685235] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"158.306196ms","start":"2026-05-08T01:02:14.796657Z","end":"2026-05-08T01:02:14.954963Z","steps":["trace[212685235] 'process raft request' (duration: 157.951561ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:14.955217Z","caller":"traceutil/trace.go:171","msg":"trace[833492785] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"151.108491ms","start":"2026-05-08T01:02:14.804104Z","end":"2026-05-08T01:02:14.955212Z","steps":["trace[833492785] 'process raft request' (duration: 150.830408ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:15.483298Z","caller":"traceutil/trace.go:171","msg":"trace[1711119009] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:540; }","duration":"244.251805ms","start":"2026-05-08T01:02:15.239023Z","end":"2026-05-08T01:02:15.483275Z","steps":["trace[1711119009] 'read index received' (duration: 225.586073ms)","trace[1711119009] 'applied index is now lower than readState.Index' (duration: 18.664812ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:15.483306Z","caller":"traceutil/trace.go:171","msg":"trace[1788561726] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"400.461079ms","start":"2026-05-08T01:02:15.082807Z","end":"2026-05-08T01:02:15.483268Z","steps":["trace[1788561726] 'process raft request' (duration: 382.192762ms)","trace[1788561726] 'compare' (duration: 17.885763ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:15.4834Z","caller":"traceutil/trace.go:171","msg":"trace[73154877] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"390.551516ms","start":"2026-05-08T01:02:15.092834Z","end":"2026-05-08T01:02:15.483385Z","steps":["trace[73154877] 'process raft request' (duration: 390.203402ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:15.483505Z","caller":"traceutil/trace.go:171","msg":"trace[199636979] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"355.193484ms","start":"2026-05-08T01:02:15.128299Z","end":"2026-05-08T01:02:15.483492Z","steps":["trace[199636979] 'process raft request' (duration: 354.83139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:15.483687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.65521ms","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-05-08T01:02:15.483737Z","caller":"traceutil/trace.go:171","msg":"trace[2073107763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:522; }","duration":"244.74983ms","start":"2026-05-08T01:02:15.238973Z","end":"2026-05-08T01:02:15.483723Z","steps":["trace[2073107763] 'agreement among raft nodes before linearized reading' (duration: 244.591369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:15.483857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:15.092818Z","time spent":"390.639016ms","remote":"127.0.0.1:46922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T01:02:15.483996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:15.12827Z","time spent":"355.276134ms","remote":"127.0.0.1:46922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:02:15.484216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:15.082785Z","time spent":"400.61519ms","remote":"127.0.0.1:46922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:02:18.196787Z","caller":"traceutil/trace.go:171","msg":"trace[927650386] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"314.729113ms","start":"2026-05-08T01:02:17.881958Z","end":"2026-05-08T01:02:18.196687Z","steps":["trace[927650386] 'process raft request' (duration: 314.583951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:18.197054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:17.881942Z","time spent":"314.943394ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:02:18.497495Z","caller":"traceutil/trace.go:171","msg":"trace[124211546] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:570; }","duration":"547.086585ms","start":"2026-05-08T01:02:17.950353Z","end":"2026-05-08T01:02:18.497439Z","steps":["trace[124211546] 'read index received' (duration: 246.291377ms)","trace[124211546] 'applied index is now lower than readState.Index' (duration: 300.794278ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:18.497598Z","caller":"traceutil/trace.go:171","msg":"trace[746295593] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"553.386178ms","start":"2026-05-08T01:02:17.944135Z","end":"2026-05-08T01:02:18.497522Z","steps":["trace[746295593] 'process raft request' (duration: 552.50872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:18.497745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:17.944103Z","time spent":"553.576491ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T01:02:18.497749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.380748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:18.497845Z","caller":"traceutil/trace.go:171","msg":"trace[2000666390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:551; }","duration":"547.487969ms","start":"2026-05-08T01:02:17.950342Z","end":"2026-05-08T01:02:18.497829Z","steps":["trace[2000666390] 'agreement among raft nodes before linearized reading' (duration: 547.333947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:18.497927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:17.950304Z","time spent":"547.608771ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T01:02:18.499323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.958821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-08T01:02:18.499362Z","caller":"traceutil/trace.go:171","msg":"trace[694687840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"455.023541ms","start":"2026-05-08T01:02:18.044329Z","end":"2026-05-08T01:02:18.499352Z","steps":["trace[694687840] 'agreement among raft nodes before linearized reading' (duration: 453.490716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:18.499393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:18.044315Z","time spent":"455.072392ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T01:02:19.217902Z","caller":"traceutil/trace.go:171","msg":"trace[1194189700] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"244.393606ms","start":"2026-05-08T01:02:18.973457Z","end":"2026-05-08T01:02:19.217851Z","steps":["trace[1194189700] 'process raft request' (duration: 242.760241ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:19.217842Z","caller":"traceutil/trace.go:171","msg":"trace[1391055216] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"242.987502ms","start":"2026-05-08T01:02:18.97483Z","end":"2026-05-08T01:02:19.217817Z","steps":["trace[1391055216] 'process raft request' (duration: 242.926921ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:22.320142Z","caller":"traceutil/trace.go:171","msg":"trace[397293813] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"193.202577ms","start":"2026-05-08T01:02:22.126906Z","end":"2026-05-08T01:02:22.320108Z","steps":["trace[397293813] 'process raft request' (duration: 164.055433ms)","trace[397293813] 'compare' (duration: 28.986563ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:22.320343Z","caller":"traceutil/trace.go:171","msg":"trace[1387301597] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"104.956957ms","start":"2026-05-08T01:02:22.215353Z","end":"2026-05-08T01:02:22.32031Z","steps":["trace[1387301597] 'read index received' (duration: 75.609091ms)","trace[1387301597] 'applied index is now lower than readState.Index' (duration: 29.343066ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:02:22.320616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.245841ms","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-05-08T01:02:22.320652Z","caller":"traceutil/trace.go:171","msg":"trace[2082695808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"105.350331ms","start":"2026-05-08T01:02:22.21529Z","end":"2026-05-08T01:02:22.320641Z","steps":["trace[2082695808] 'agreement among raft nodes before linearized reading' (duration: 105.166609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:23.343996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.300301ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:02:23.344079Z","caller":"traceutil/trace.go:171","msg":"trace[1003074596] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"1.005909884s","start":"2026-05-08T01:02:22.338156Z","end":"2026-05-08T01:02:23.344066Z","steps":["trace[1003074596] 'read index received' (duration: 31.240603ms)","trace[1003074596] 'applied index is now lower than readState.Index' (duration: 974.668371ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:02:23.344339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.310986ms","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-05-08T01:02:23.344365Z","caller":"traceutil/trace.go:171","msg":"trace[19890321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:579; }","duration":"824.396657ms","start":"2026-05-08T01:02:22.519961Z","end":"2026-05-08T01:02:23.344358Z","steps":["trace[19890321] 'agreement among raft nodes before linearized reading' (duration: 824.298396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:23.344396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:22.51993Z","time spent":"824.459728ms","remote":"127.0.0.1:47138","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":"info","ts":"2026-05-08T01:02:23.344391Z","caller":"traceutil/trace.go:171","msg":"trace[1821968202] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.008846211s","start":"2026-05-08T01:02:22.335523Z","end":"2026-05-08T01:02:23.344369Z","steps":["trace[1821968202] 'process raft request' (duration: 763.987395ms)","trace[1821968202] 'compare' (duration: 244.13142ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:02:23.344491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:22.335506Z","time spent":"1.008929122s","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:02:23.344515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.381094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:23.344315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006139506s","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-05-08T01:02:23.344559Z","caller":"traceutil/trace.go:171","msg":"trace[1971286179] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:579; }","duration":"1.006422049s","start":"2026-05-08T01:02:22.338129Z","end":"2026-05-08T01:02:23.344551Z","steps":["trace[1971286179] 'agreement among raft nodes before linearized reading' (duration: 1.006101736s)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:23.344566Z","caller":"traceutil/trace.go:171","msg":"trace[1640582595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"392.494635ms","start":"2026-05-08T01:02:22.952054Z","end":"2026-05-08T01:02:23.344549Z","steps":["trace[1640582595] 'agreement among raft nodes before linearized reading' (duration: 392.410694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:23.344591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:22.338111Z","time spent":"1.006472119s","remote":"127.0.0.1:47082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-05-08T01:02:23.344598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:22.952013Z","time spent":"392.579335ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T01:02:23.344648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.94317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-08T01:02:23.344737Z","caller":"traceutil/trace.go:171","msg":"trace[799002536] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"112.101323ms","start":"2026-05-08T01:02:23.232614Z","end":"2026-05-08T01:02:23.344715Z","steps":["trace[799002536] 'agreement among raft nodes before linearized reading' (duration: 111.914701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:23.851241Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410245023748832,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T01:02:24.351676Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410245023748832,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T01:02:24.379912Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.031832434s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-08T01:02:25.202431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.154899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:02:25.202689Z","caller":"traceutil/trace.go:171","msg":"trace[2108118235] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.854651939s","start":"2026-05-08T01:02:23.347999Z","end":"2026-05-08T01:02:25.202651Z","steps":["trace[2108118235] 'process raft request' (duration: 1.032195177s)","trace[2108118235] 'compare' (duration: 821.986128ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:25.202786Z","caller":"traceutil/trace.go:171","msg":"trace[1445837752] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.854244595s","start":"2026-05-08T01:02:23.348516Z","end":"2026-05-08T01:02:25.20276Z","steps":["trace[1445837752] 'process raft request' (duration: 1.854011043s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.202846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:23.347966Z","time spent":"1.85480028s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:02:25.202911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:23.348492Z","time spent":"1.854353597s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:02:25.407854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.248296ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-08T01:02:25.408021Z","caller":"traceutil/trace.go:171","msg":"trace[482145318] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:601; }","duration":"2.057756306s","start":"2026-05-08T01:02:23.350244Z","end":"2026-05-08T01:02:25.408Z","steps":["trace[482145318] 'read index received' (duration: 1.029964567s)","trace[482145318] 'applied index is now lower than readState.Index' (duration: 1.027789849s)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:02:25.408201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.057936127s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.408254Z","caller":"traceutil/trace.go:171","msg":"trace[1820436640] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:581; }","duration":"2.058001058s","start":"2026-05-08T01:02:23.35024Z","end":"2026-05-08T01:02:25.408241Z","steps":["trace[1820436640] 'agreement among raft nodes before linearized reading' (duration: 2.057884757s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.408298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:23.350214Z","time spent":"2.058075628s","remote":"127.0.0.1:46996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-08T01:02:25.408402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.875837773s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T01:02:25.408565Z","caller":"traceutil/trace.go:171","msg":"trace[1445772355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"1.876039704s","start":"2026-05-08T01:02:23.532513Z","end":"2026-05-08T01:02:25.408552Z","steps":["trace[1445772355] 'agreement among raft nodes before linearized reading' (duration: 1.875683891s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.408661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:23.53249Z","time spent":"1.876157896s","remote":"127.0.0.1:47138","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-05-08T01:02:25.408725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.88232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.408781Z","caller":"traceutil/trace.go:171","msg":"trace[1556197655] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:581; }","duration":"418.92751ms","start":"2026-05-08T01:02:24.989834Z","end":"2026-05-08T01:02:25.408762Z","steps":["trace[1556197655] 'agreement among raft nodes before linearized reading' (duration: 418.8691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.408705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.808759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.408826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.989812Z","time spent":"419.005021ms","remote":"127.0.0.1:53356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-05-08T01:02:25.408848Z","caller":"traceutil/trace.go:171","msg":"trace[1216999253] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:581; }","duration":"418.96058ms","start":"2026-05-08T01:02:24.989862Z","end":"2026-05-08T01:02:25.408823Z","steps":["trace[1216999253] 'agreement among raft nodes before linearized reading' (duration: 418.799628ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.408888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.989852Z","time spent":"419.02358ms","remote":"127.0.0.1:53356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T01:02:25.408991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.00637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.409022Z","caller":"traceutil/trace.go:171","msg":"trace[1816269589] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:581; }","duration":"419.049711ms","start":"2026-05-08T01:02:24.989963Z","end":"2026-05-08T01:02:25.409013Z","steps":["trace[1816269589] 'agreement among raft nodes before linearized reading' (duration: 419.00232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.409048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.989958Z","time spent":"419.083231ms","remote":"127.0.0.1:53356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-08T01:02:25.409067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.780969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.409122Z","caller":"traceutil/trace.go:171","msg":"trace[1557338716] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:581; }","duration":"443.839939ms","start":"2026-05-08T01:02:24.965249Z","end":"2026-05-08T01:02:25.409089Z","steps":["trace[1557338716] 'agreement among raft nodes before linearized reading' (duration: 443.790079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.409158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.965237Z","time spent":"443.91278ms","remote":"127.0.0.1:53352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-05-08T01:02:25.409012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.379088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.409307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.401834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.409482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.806323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.409463Z","caller":"traceutil/trace.go:171","msg":"trace[1179105928] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:581; }","duration":"392.789421ms","start":"2026-05-08T01:02:25.016546Z","end":"2026-05-08T01:02:25.409335Z","steps":["trace[1179105928] 'agreement among raft nodes before linearized reading' (duration: 392.273457ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:25.409526Z","caller":"traceutil/trace.go:171","msg":"trace[940247699] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:581; }","duration":"392.873203ms","start":"2026-05-08T01:02:25.016637Z","end":"2026-05-08T01:02:25.40951Z","steps":["trace[940247699] 'agreement among raft nodes before linearized reading' (duration: 392.832062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.409559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:25.016617Z","time spent":"392.935014ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T01:02:25.409561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.838497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.409602Z","caller":"traceutil/trace.go:171","msg":"trace[163506404] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"495.877878ms","start":"2026-05-08T01:02:24.913711Z","end":"2026-05-08T01:02:25.409588Z","steps":["trace[163506404] 'agreement among raft nodes before linearized reading' (duration: 495.819257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.409631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.913698Z","time spent":"495.925348ms","remote":"127.0.0.1:53346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:02:25.409767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.937172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.409805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.448734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.409806Z","caller":"traceutil/trace.go:171","msg":"trace[1633583542] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:581; }","duration":"467.013212ms","start":"2026-05-08T01:02:24.942784Z","end":"2026-05-08T01:02:25.409797Z","steps":["trace[1633583542] 'agreement among raft nodes before linearized reading' (duration: 466.959692ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:25.409823Z","caller":"traceutil/trace.go:171","msg":"trace[656351298] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:581; }","duration":"470.481445ms","start":"2026-05-08T01:02:24.939336Z","end":"2026-05-08T01:02:25.409817Z","steps":["trace[656351298] 'agreement among raft nodes before linearized reading' (duration: 470.458734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.4098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.138965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.409882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.11661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.40988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:25.016532Z","time spent":"392.995314ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:02:25.409973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.503624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.410016Z","caller":"traceutil/trace.go:171","msg":"trace[1505770039] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"111.603425ms","start":"2026-05-08T01:02:25.298403Z","end":"2026-05-08T01:02:25.410006Z","steps":["trace[1505770039] 'agreement among raft nodes before linearized reading' (duration: 111.536265ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:25.41022Z","caller":"traceutil/trace.go:171","msg":"trace[1834071038] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:581; }","duration":"444.609897ms","start":"2026-05-08T01:02:24.964877Z","end":"2026-05-08T01:02:25.409487Z","steps":["trace[1834071038] 'agreement among raft nodes before linearized reading' (duration: 444.389274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.410315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.964869Z","time spent":"445.428394ms","remote":"127.0.0.1:53352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:02:25.410446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037474157s","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-05-08T01:02:25.410471Z","caller":"traceutil/trace.go:171","msg":"trace[1233536235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"1.037537437s","start":"2026-05-08T01:02:24.372928Z","end":"2026-05-08T01:02:25.410465Z","steps":["trace[1233536235] 'agreement among raft nodes before linearized reading' (duration: 1.037450916s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.410413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.642954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.410506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.258041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.410519Z","caller":"traceutil/trace.go:171","msg":"trace[179853135] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"112.771616ms","start":"2026-05-08T01:02:25.297732Z","end":"2026-05-08T01:02:25.410503Z","steps":["trace[179853135] 'agreement among raft nodes before linearized reading' (duration: 112.663615ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:25.410534Z","caller":"traceutil/trace.go:171","msg":"trace[1664805782] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"497.310862ms","start":"2026-05-08T01:02:24.913209Z","end":"2026-05-08T01:02:25.41052Z","steps":["trace[1664805782] 'agreement among raft nodes before linearized reading' (duration: 497.285091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.410562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.913188Z","time spent":"497.369602ms","remote":"127.0.0.1:53346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-08T01:02:25.409901Z","caller":"traceutil/trace.go:171","msg":"trace[1629550242] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:581; }","duration":"370.270997ms","start":"2026-05-08T01:02:25.039606Z","end":"2026-05-08T01:02:25.409877Z","steps":["trace[1629550242] 'agreement among raft nodes before linearized reading' (duration: 370.091315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.41066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:25.039577Z","time spent":"371.073475ms","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:02:25.410655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.92106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.4107Z","caller":"traceutil/trace.go:171","msg":"trace[2053815006] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"198.001261ms","start":"2026-05-08T01:02:25.212689Z","end":"2026-05-08T01:02:25.41069Z","steps":["trace[2053815006] 'agreement among raft nodes before linearized reading' (duration: 197.934231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.409784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.435954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.410754Z","caller":"traceutil/trace.go:171","msg":"trace[1739099467] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:581; }","duration":"471.419703ms","start":"2026-05-08T01:02:24.939328Z","end":"2026-05-08T01:02:25.410747Z","steps":["trace[1739099467] 'agreement among raft nodes before linearized reading' (duration: 470.435454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.410776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.939321Z","time spent":"471.448803ms","remote":"127.0.0.1:53348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:02:25.409842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.942764Z","time spent":"467.069724ms","remote":"127.0.0.1:53348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-05-08T01:02:25.410852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.599728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.41088Z","caller":"traceutil/trace.go:171","msg":"trace[240286956] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"196.649218ms","start":"2026-05-08T01:02:25.214222Z","end":"2026-05-08T01:02:25.410871Z","steps":["trace[240286956] 'agreement among raft nodes before linearized reading' (duration: 196.606927ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:25.409915Z","caller":"traceutil/trace.go:171","msg":"trace[1952069401] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"496.17487ms","start":"2026-05-08T01:02:24.913732Z","end":"2026-05-08T01:02:25.409907Z","steps":["trace[1952069401] 'agreement among raft nodes before linearized reading' (duration: 496.13104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.410953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.913725Z","time spent":"497.219239ms","remote":"127.0.0.1:53346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-08T01:02:25.411022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.831402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.408653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.714068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.410485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.372905Z","time spent":"1.037576667s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-08T01:02:25.411136Z","caller":"traceutil/trace.go:171","msg":"trace[310415109] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:581; }","duration":"446.235291ms","start":"2026-05-08T01:02:24.964891Z","end":"2026-05-08T01:02:25.411126Z","steps":["trace[310415109] 'agreement among raft nodes before linearized reading' (duration: 443.682388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.409447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.864194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.411234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.460083628s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.409839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.939327Z","time spent":"470.507525ms","remote":"127.0.0.1:53348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"info","ts":"2026-05-08T01:02:25.411294Z","caller":"traceutil/trace.go:171","msg":"trace[1374571970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"1.460179458s","start":"2026-05-08T01:02:23.951101Z","end":"2026-05-08T01:02:25.41128Z","steps":["trace[1374571970] 'agreement among raft nodes before linearized reading' (duration: 1.460098418s)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:25.411295Z","caller":"traceutil/trace.go:171","msg":"trace[1430420205] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:581; }","duration":"370.988053ms","start":"2026-05-08T01:02:25.040139Z","end":"2026-05-08T01:02:25.411127Z","steps":["trace[1430420205] 'agreement among raft nodes before linearized reading' (duration: 370.801051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.411332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:23.951081Z","time spent":"1.460243979s","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T01:02:25.409394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.326488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.411362Z","caller":"traceutil/trace.go:171","msg":"trace[1861332955] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:581; }","duration":"394.338156ms","start":"2026-05-08T01:02:25.017018Z","end":"2026-05-08T01:02:25.411356Z","steps":["trace[1861332955] 'agreement among raft nodes before linearized reading' (duration: 392.293737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.411382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:25.017009Z","time spent":"394.366696ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-08T01:02:25.410927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.870305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.41037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.573003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.411488Z","caller":"traceutil/trace.go:171","msg":"trace[1470076067] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"113.730274ms","start":"2026-05-08T01:02:25.29775Z","end":"2026-05-08T01:02:25.41148Z","steps":["trace[1470076067] 'agreement among raft nodes before linearized reading' (duration: 112.573324ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:25.411484Z","caller":"traceutil/trace.go:171","msg":"trace[1730718366] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"147.44726ms","start":"2026-05-08T01:02:25.264025Z","end":"2026-05-08T01:02:25.411472Z","steps":["trace[1730718366] 'agreement among raft nodes before linearized reading' (duration: 146.788564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.411475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:25.040132Z","time spent":"371.200625ms","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-05-08T01:02:25.411434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.096027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:02:25.410859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.158983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:25.411684Z","caller":"traceutil/trace.go:171","msg":"trace[1806469017] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"199.01338ms","start":"2026-05-08T01:02:25.212661Z","end":"2026-05-08T01:02:25.411675Z","steps":["trace[1806469017] 'agreement among raft nodes before linearized reading' (duration: 198.151432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.411179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:24.964881Z","time spent":"446.286021ms","remote":"127.0.0.1:53352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-05-08T01:02:25.411511Z","caller":"traceutil/trace.go:171","msg":"trace[1113280182] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:581; }","duration":"371.72945ms","start":"2026-05-08T01:02:25.039521Z","end":"2026-05-08T01:02:25.411251Z","steps":["trace[1113280182] 'agreement among raft nodes before linearized reading' (duration: 369.910804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:25.411843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:25.039508Z","time spent":"372.321455ms","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-05-08T01:02:25.41169Z","caller":"traceutil/trace.go:171","msg":"trace[1881704576] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"147.629602ms","start":"2026-05-08T01:02:25.264025Z","end":"2026-05-08T01:02:25.411654Z","steps":["trace[1881704576] 'agreement among raft nodes before linearized reading' (duration: 147.099347ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:26.448998Z","caller":"traceutil/trace.go:171","msg":"trace[2123083932] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"148.533906ms","start":"2026-05-08T01:02:26.300424Z","end":"2026-05-08T01:02:26.448958Z","steps":["trace[2123083932] 'process raft request' (duration: 122.683893ms)","trace[2123083932] 'compare' (duration: 25.672742ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:27.727166Z","caller":"traceutil/trace.go:171","msg":"trace[1987908768] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"140.195588ms","start":"2026-05-08T01:02:27.586931Z","end":"2026-05-08T01:02:27.727127Z","steps":["trace[1987908768] 'process raft request' (duration: 139.993886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:28.414646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.505448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kh4gs\" ","response":"range_response_count:1 size:17524"} {"level":"info","ts":"2026-05-08T01:02:28.414729Z","caller":"traceutil/trace.go:171","msg":"trace[1032807634] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kh4gs; range_end:; response_count:1; response_revision:602; }","duration":"115.670829ms","start":"2026-05-08T01:02:28.299039Z","end":"2026-05-08T01:02:28.41471Z","steps":["trace[1032807634] 'range keys from in-memory index tree' (duration: 115.229245ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:02:36.876583Z","caller":"traceutil/trace.go:171","msg":"trace[1580259414] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:724; }","duration":"130.599728ms","start":"2026-05-08T01:02:36.745955Z","end":"2026-05-08T01:02:36.876555Z","steps":["trace[1580259414] 'read index received' (duration: 130.370697ms)","trace[1580259414] 'applied index is now lower than readState.Index' (duration: 228.031µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:02:36.876703Z","caller":"traceutil/trace.go:171","msg":"trace[161346038] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"246.795857ms","start":"2026-05-08T01:02:36.629852Z","end":"2026-05-08T01:02:36.876648Z","steps":["trace[161346038] 'process raft request' (duration: 246.551455ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:36.876841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.86451ms","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-05-08T01:02:36.876886Z","caller":"traceutil/trace.go:171","msg":"trace[1340070217] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:699; }","duration":"130.970671ms","start":"2026-05-08T01:02:36.745905Z","end":"2026-05-08T01:02:36.876876Z","steps":["trace[1340070217] 'agreement among raft nodes before linearized reading' (duration: 130.754859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:42.829593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.096671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:02:42.829684Z","caller":"traceutil/trace.go:171","msg":"trace[694253322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:747; }","duration":"879.240503ms","start":"2026-05-08T01:02:41.95042Z","end":"2026-05-08T01:02:42.829661Z","steps":["trace[694253322] 'range keys from in-memory index tree' (duration: 879.015151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:42.829724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:41.950401Z","time spent":"879.314583ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T01:02:42.836335Z","caller":"traceutil/trace.go:171","msg":"trace[60898651] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"437.466048ms","start":"2026-05-08T01:02:42.398805Z","end":"2026-05-08T01:02:42.836271Z","steps":["trace[60898651] 'process raft request' (duration: 437.300617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:02:42.836615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:02:42.39878Z","time spent":"437.68954ms","remote":"127.0.0.1:47116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:03:50.140655Z","caller":"traceutil/trace.go:171","msg":"trace[1411283072] transaction","detail":"{read_only:false; response_revision:1701; number_of_response:1; }","duration":"107.570931ms","start":"2026-05-08T01:03:50.033057Z","end":"2026-05-08T01:03:50.140628Z","steps":["trace[1411283072] 'process raft request' (duration: 42.516692ms)","trace[1411283072] 'compare' (duration: 64.747332ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:03:57.76849Z","caller":"traceutil/trace.go:171","msg":"trace[929218097] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1886; }","duration":"239.947934ms","start":"2026-05-08T01:03:57.528517Z","end":"2026-05-08T01:03:57.768465Z","steps":["trace[929218097] 'read index received' (duration: 239.813491ms)","trace[929218097] 'applied index is now lower than readState.Index' (duration: 133.083µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:03:57.768684Z","caller":"traceutil/trace.go:171","msg":"trace[2047841976] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"468.041469ms","start":"2026-05-08T01:03:57.300482Z","end":"2026-05-08T01:03:57.768523Z","steps":["trace[2047841976] 'process raft request' (duration: 467.837974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:57.7688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.232982ms","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":"warn","ts":"2026-05-08T01:03:57.768998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:57.300458Z","time spent":"468.401887ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:03:57.768977Z","caller":"traceutil/trace.go:171","msg":"trace[794772404] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1816; }","duration":"240.486417ms","start":"2026-05-08T01:03:57.528473Z","end":"2026-05-08T01:03:57.76896Z","steps":["trace[794772404] 'agreement among raft nodes before linearized reading' (duration: 240.112238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:58.049229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.892412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:03:58.049341Z","caller":"traceutil/trace.go:171","msg":"trace[1600622071] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1887; }","duration":"280.758589ms","start":"2026-05-08T01:03:57.768563Z","end":"2026-05-08T01:03:58.049322Z","steps":["trace[1600622071] 'read index received' (duration: 79.663813ms)","trace[1600622071] 'applied index is now lower than readState.Index' (duration: 201.093106ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:03:58.049531Z","caller":"traceutil/trace.go:171","msg":"trace[1880447669] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"365.559956ms","start":"2026-05-08T01:03:57.683836Z","end":"2026-05-08T01:03:58.049396Z","steps":["trace[1880447669] 'process raft request' (duration: 164.408429ms)","trace[1880447669] 'compare' (duration: 200.685806ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:03:58.049716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.813252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-08T01:03:58.049741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.855919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-455ffeae-4401-456a-be8f-4284ed6c454a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-08T01:03:58.049788Z","caller":"traceutil/trace.go:171","msg":"trace[1701949984] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1817; }","duration":"354.933034ms","start":"2026-05-08T01:03:57.694841Z","end":"2026-05-08T01:03:58.049774Z","steps":["trace[1701949984] 'agreement among raft nodes before linearized reading' (duration: 354.76017ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:03:58.049798Z","caller":"traceutil/trace.go:171","msg":"trace[1760621931] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-455ffeae-4401-456a-be8f-4284ed6c454a; range_end:; response_count:1; response_revision:1817; }","duration":"312.940491ms","start":"2026-05-08T01:03:57.736841Z","end":"2026-05-08T01:03:58.049781Z","steps":["trace[1760621931] 'agreement among raft nodes before linearized reading' (duration: 312.677255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:58.049724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:57.683811Z","time spent":"365.797961ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:03:58.049871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:57.736829Z","time spent":"313.026412ms","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-455ffeae-4401-456a-be8f-4284ed6c454a\" "} {"level":"warn","ts":"2026-05-08T01:03:58.049821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:57.694821Z","time spent":"354.992735ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T01:03:58.050165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.679032ms","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-05-08T01:03:58.050224Z","caller":"traceutil/trace.go:171","msg":"trace[737940796] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1817; }","duration":"358.774245ms","start":"2026-05-08T01:03:57.691436Z","end":"2026-05-08T01:03:58.05021Z","steps":["trace[737940796] 'agreement among raft nodes before linearized reading' (duration: 358.520529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:58.050256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:57.69142Z","time spent":"358.829385ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T01:03:58.050456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.501952ms","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-05-08T01:03:58.050505Z","caller":"traceutil/trace.go:171","msg":"trace[1176525466] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1817; }","duration":"107.590274ms","start":"2026-05-08T01:03:57.942903Z","end":"2026-05-08T01:03:58.050493Z","steps":["trace[1176525466] 'agreement among raft nodes before linearized reading' (duration: 107.472191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:58.681074Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410245023751276,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T01:03:58.790557Z","caller":"traceutil/trace.go:171","msg":"trace[1433994207] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"735.47982ms","start":"2026-05-08T01:03:58.055044Z","end":"2026-05-08T01:03:58.790524Z","steps":["trace[1433994207] 'process raft request' (duration: 714.503178ms)","trace[1433994207] 'compare' (duration: 20.130002ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:03:58.790602Z","caller":"traceutil/trace.go:171","msg":"trace[1379184051] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"734.479318ms","start":"2026-05-08T01:03:58.056096Z","end":"2026-05-08T01:03:58.790575Z","steps":["trace[1379184051] 'process raft request' (duration: 734.340543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:58.790719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:58.055031Z","time spent":"735.590613ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:03:58.790767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:58.056083Z","time spent":"734.58787ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:03:58.79095Z","caller":"traceutil/trace.go:171","msg":"trace[1643713930] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"733.621477ms","start":"2026-05-08T01:03:58.057298Z","end":"2026-05-08T01:03:58.790919Z","steps":["trace[1643713930] 'process raft request' (duration: 733.510014ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:03:58.791072Z","caller":"traceutil/trace.go:171","msg":"trace[228466631] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"734.940248ms","start":"2026-05-08T01:03:58.056119Z","end":"2026-05-08T01:03:58.791059Z","steps":["trace[228466631] 'process raft request' (duration: 734.375154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:58.79111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:58.057287Z","time spent":"733.737849ms","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:03:58.791134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:58.056105Z","time spent":"734.995199ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:03:58.793204Z","caller":"traceutil/trace.go:171","msg":"trace[511203358] linearizableReadLoop","detail":"{readStateIndex:1896; appliedIndex:1889; }","duration":"613.170152ms","start":"2026-05-08T01:03:58.179994Z","end":"2026-05-08T01:03:58.793164Z","steps":["trace[511203358] 'read index received' (duration: 589.57077ms)","trace[511203358] 'applied index is now lower than readState.Index' (duration: 23.598532ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:03:58.793476Z","caller":"traceutil/trace.go:171","msg":"trace[471017940] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"221.79872ms","start":"2026-05-08T01:03:58.571634Z","end":"2026-05-08T01:03:58.793432Z","steps":["trace[471017940] 'process raft request' (duration: 221.480041ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:03:58.793717Z","caller":"traceutil/trace.go:171","msg":"trace[1654658936] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"426.983699ms","start":"2026-05-08T01:03:58.366718Z","end":"2026-05-08T01:03:58.793701Z","steps":["trace[1654658936] 'process raft request' (duration: 426.324553ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:58.79378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.778447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-455ffeae-4401-456a-be8f-4284ed6c454a\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-05-08T01:03:58.793847Z","caller":"traceutil/trace.go:171","msg":"trace[2143361505] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-455ffeae-4401-456a-be8f-4284ed6c454a; range_end:; response_count:1; response_revision:1825; }","duration":"613.87862ms","start":"2026-05-08T01:03:58.179951Z","end":"2026-05-08T01:03:58.79383Z","steps":["trace[2143361505] 'agreement among raft nodes before linearized reading' (duration: 613.768257ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:03:58.793718Z","caller":"traceutil/trace.go:171","msg":"trace[136728873] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"627.478508ms","start":"2026-05-08T01:03:58.166223Z","end":"2026-05-08T01:03:58.793701Z","steps":["trace[136728873] 'process raft request' (duration: 626.664048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:03:58.793887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:58.179937Z","time spent":"613.942071ms","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-455ffeae-4401-456a-be8f-4284ed6c454a\" "} {"level":"warn","ts":"2026-05-08T01:03:58.794043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:58.366691Z","time spent":"427.111472ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:03:58.794069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:03:58.166194Z","time spent":"627.700243ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:04.539909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.215326ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-08T01:04:04.54026Z","caller":"traceutil/trace.go:171","msg":"trace[264042562] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1955; }","duration":"261.798046ms","start":"2026-05-08T01:04:04.278435Z","end":"2026-05-08T01:04:04.540233Z","steps":["trace[264042562] 'read index received' (duration: 141.163111ms)","trace[264042562] 'applied index is now lower than readState.Index' (duration: 120.631595ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:04:04.540487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.031622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-08T01:04:04.540563Z","caller":"traceutil/trace.go:171","msg":"trace[1266173051] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1883; }","duration":"262.150234ms","start":"2026-05-08T01:04:04.278395Z","end":"2026-05-08T01:04:04.540546Z","steps":["trace[1266173051] 'agreement among raft nodes before linearized reading' (duration: 261.93735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:10.517047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.498757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:04:10.517102Z","caller":"traceutil/trace.go:171","msg":"trace[896630615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1918; }","duration":"566.595181ms","start":"2026-05-08T01:04:09.950494Z","end":"2026-05-08T01:04:10.517089Z","steps":["trace[896630615] 'range keys from in-memory index tree' (duration: 566.405536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:10.517128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:09.950471Z","time spent":"566.652282ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T01:04:10.517404Z","caller":"traceutil/trace.go:171","msg":"trace[353035062] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1992; }","duration":"387.391487ms","start":"2026-05-08T01:04:10.130003Z","end":"2026-05-08T01:04:10.517395Z","steps":["trace[353035062] 'read index received' (duration: 386.60403ms)","trace[353035062] 'applied index is now lower than readState.Index' (duration: 786.817µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:04:10.517587Z","caller":"traceutil/trace.go:171","msg":"trace[1144505666] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"403.301883ms","start":"2026-05-08T01:04:10.114277Z","end":"2026-05-08T01:04:10.517579Z","steps":["trace[1144505666] 'process raft request' (duration: 402.291641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:10.517654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:10.11425Z","time spent":"403.353653ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:10.517799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.742727ms","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-05-08T01:04:10.517851Z","caller":"traceutil/trace.go:171","msg":"trace[1407292164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1919; }","duration":"339.840669ms","start":"2026-05-08T01:04:10.177997Z","end":"2026-05-08T01:04:10.517838Z","steps":["trace[1407292164] 'agreement among raft nodes before linearized reading' (duration: 339.689676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:10.51789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:10.17797Z","time spent":"339.911691ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-08T01:04:10.518032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.0382ms","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-05-08T01:04:10.518067Z","caller":"traceutil/trace.go:171","msg":"trace[1539286125] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1919; }","duration":"388.101702ms","start":"2026-05-08T01:04:10.129955Z","end":"2026-05-08T01:04:10.518057Z","steps":["trace[1539286125] 'agreement among raft nodes before linearized reading' (duration: 388.01285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:10.5181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:10.129935Z","time spent":"388.158882ms","remote":"127.0.0.1:59006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-08T01:04:10.518271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.222638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11984"} {"level":"info","ts":"2026-05-08T01:04:10.518361Z","caller":"traceutil/trace.go:171","msg":"trace[458464307] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1919; }","duration":"121.35551ms","start":"2026-05-08T01:04:10.396994Z","end":"2026-05-08T01:04:10.51835Z","steps":["trace[458464307] 'agreement among raft nodes before linearized reading' (duration: 121.172326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:14.451754Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410245023751541,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T01:04:14.571555Z","caller":"traceutil/trace.go:171","msg":"trace[1244059210] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"687.220131ms","start":"2026-05-08T01:04:13.884319Z","end":"2026-05-08T01:04:14.571539Z","steps":["trace[1244059210] 'process raft request' (duration: 687.094348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:14.571846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:13.884303Z","time spent":"687.308392ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:04:14.748685Z","caller":"traceutil/trace.go:171","msg":"trace[869263376] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"394.997195ms","start":"2026-05-08T01:04:14.353657Z","end":"2026-05-08T01:04:14.748655Z","steps":["trace[869263376] 'process raft request' (duration: 394.858082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:14.748868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:14.353633Z","time spent":"395.119028ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:04:14.748988Z","caller":"traceutil/trace.go:171","msg":"trace[1623066927] linearizableReadLoop","detail":"{readStateIndex:2023; appliedIndex:2021; }","duration":"798.056814ms","start":"2026-05-08T01:04:13.950909Z","end":"2026-05-08T01:04:14.748966Z","steps":["trace[1623066927] 'read index received' (duration: 620.626064ms)","trace[1623066927] 'applied index is now lower than readState.Index' (duration: 177.42956ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:04:14.749132Z","caller":"traceutil/trace.go:171","msg":"trace[1439584382] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"217.452052ms","start":"2026-05-08T01:04:14.531647Z","end":"2026-05-08T01:04:14.749099Z","steps":["trace[1439584382] 'process raft request' (duration: 216.969522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:14.749411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.28989ms","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":"warn","ts":"2026-05-08T01:04:14.749429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.519182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T01:04:14.749471Z","caller":"traceutil/trace.go:171","msg":"trace[168789443] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1949; }","duration":"201.378152ms","start":"2026-05-08T01:04:14.548075Z","end":"2026-05-08T01:04:14.749453Z","steps":["trace[168789443] 'agreement among raft nodes before linearized reading' (duration: 201.095436ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:04:14.749517Z","caller":"traceutil/trace.go:171","msg":"trace[800728038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1949; }","duration":"213.654834ms","start":"2026-05-08T01:04:14.535844Z","end":"2026-05-08T01:04:14.749499Z","steps":["trace[800728038] 'agreement among raft nodes before linearized reading' (duration: 213.297387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:14.749979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.059225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:04:14.750029Z","caller":"traceutil/trace.go:171","msg":"trace[1914885347] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1949; }","duration":"799.134707ms","start":"2026-05-08T01:04:13.95088Z","end":"2026-05-08T01:04:14.750015Z","steps":["trace[1914885347] 'agreement among raft nodes before linearized reading' (duration: 798.194197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:14.750068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:13.950864Z","time spent":"799.193298ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T01:04:37.166046Z","caller":"traceutil/trace.go:171","msg":"trace[1602285588] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"185.827399ms","start":"2026-05-08T01:04:36.980189Z","end":"2026-05-08T01:04:37.166016Z","steps":["trace[1602285588] 'process raft request' (duration: 123.644096ms)","trace[1602285588] 'compare' (duration: 62.060261ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:04:39.413316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.715114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:04:39.413516Z","caller":"traceutil/trace.go:171","msg":"trace[1265255516] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"599.790038ms","start":"2026-05-08T01:04:38.813654Z","end":"2026-05-08T01:04:39.413445Z","steps":["trace[1265255516] 'process raft request' (duration: 302.740148ms)","trace[1265255516] 'compare' (duration: 296.286166ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:04:39.413642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.813632Z","time spent":"599.96593ms","remote":"127.0.0.1:46902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:04:39.461879Z","caller":"traceutil/trace.go:171","msg":"trace[1961439449] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"633.602679ms","start":"2026-05-08T01:04:38.828255Z","end":"2026-05-08T01:04:39.461858Z","steps":["trace[1961439449] 'process raft request' (duration: 633.434996ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:04:39.462278Z","caller":"traceutil/trace.go:171","msg":"trace[15168545] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"517.270495ms","start":"2026-05-08T01:04:38.944984Z","end":"2026-05-08T01:04:39.462254Z","steps":["trace[15168545] 'process raft request' (duration: 516.835928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:39.462393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.828233Z","time spent":"633.71199ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:04:39.46294Z","caller":"traceutil/trace.go:171","msg":"trace[1574671841] linearizableReadLoop","detail":"{readStateIndex:2170; appliedIndex:2168; }","duration":"606.068561ms","start":"2026-05-08T01:04:38.85685Z","end":"2026-05-08T01:04:39.462918Z","steps":["trace[1574671841] 'read index received' (duration: 259.558991ms)","trace[1574671841] 'applied index is now lower than readState.Index' (duration: 346.5086ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:04:39.463285Z","caller":"traceutil/trace.go:171","msg":"trace[871892136] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"517.355755ms","start":"2026-05-08T01:04:38.945913Z","end":"2026-05-08T01:04:39.463269Z","steps":["trace[871892136] 'process raft request' (duration: 516.196676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:39.46329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.438417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T01:04:39.463314Z","caller":"traceutil/trace.go:171","msg":"trace[303849903] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"517.03302ms","start":"2026-05-08T01:04:38.946264Z","end":"2026-05-08T01:04:39.463297Z","steps":["trace[303849903] 'process raft request' (duration: 516.592862ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:39.462606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.944961Z","time spent":"517.370547ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:39.46344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.946233Z","time spent":"517.148401ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:39.463446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.030825ms","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-05-08T01:04:39.463531Z","caller":"traceutil/trace.go:171","msg":"trace[752444246] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2093; }","duration":"556.155846ms","start":"2026-05-08T01:04:38.907355Z","end":"2026-05-08T01:04:39.46351Z","steps":["trace[752444246] 'agreement among raft nodes before linearized reading' (duration: 555.925422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:39.463579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.907333Z","time spent":"556.237709ms","remote":"127.0.0.1:59006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-08T01:04:39.463614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.945885Z","time spent":"517.543098ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:04:39.463816Z","caller":"traceutil/trace.go:171","msg":"trace[1779813016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2093; }","duration":"606.496298ms","start":"2026-05-08T01:04:38.856836Z","end":"2026-05-08T01:04:39.463332Z","steps":["trace[1779813016] 'agreement among raft nodes before linearized reading' (duration: 606.288135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:39.46384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.85166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T01:04:39.463873Z","caller":"traceutil/trace.go:171","msg":"trace[1395815516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2093; }","duration":"474.921941ms","start":"2026-05-08T01:04:38.988941Z","end":"2026-05-08T01:04:39.463863Z","steps":["trace[1395815516] 'agreement among raft nodes before linearized reading' (duration: 474.83202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:39.463908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.988931Z","time spent":"474.970152ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T01:04:39.463906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.893487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-08T01:04:39.463948Z","caller":"traceutil/trace.go:171","msg":"trace[1765179623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2093; }","duration":"483.962797ms","start":"2026-05-08T01:04:38.979974Z","end":"2026-05-08T01:04:39.463937Z","steps":["trace[1765179623] 'agreement among raft nodes before linearized reading' (duration: 483.827095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:39.464008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.856792Z","time spent":"607.068609ms","remote":"127.0.0.1:47138","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-05-08T01:04:39.464042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:38.97996Z","time spent":"484.07216ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T01:04:39.464396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.354727ms","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-05-08T01:04:39.464535Z","caller":"traceutil/trace.go:171","msg":"trace[1969085999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2093; }","duration":"293.527329ms","start":"2026-05-08T01:04:39.170987Z","end":"2026-05-08T01:04:39.464515Z","steps":["trace[1969085999] 'agreement among raft nodes before linearized reading' (duration: 292.382779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:40.973709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410245023751896,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T01:04:41.429148Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.008061208s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T01:04:41.429682Z","caller":"traceutil/trace.go:171","msg":"trace[1848123159] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"1.008642398s","start":"2026-05-08T01:04:40.42102Z","end":"2026-05-08T01:04:41.429662Z","steps":["trace[1848123159] 'process raft request' (duration: 1.008485655s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:41.429809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:40.421007Z","time spent":"1.008731359s","remote":"127.0.0.1:46946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:42.026041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.014496ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:04:42.026186Z","caller":"traceutil/trace.go:171","msg":"trace[266583024] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2177; }","duration":"1.552626821s","start":"2026-05-08T01:04:40.473531Z","end":"2026-05-08T01:04:42.026158Z","steps":["trace[266583024] 'read index received' (duration: 955.959127ms)","trace[266583024] 'applied index is now lower than readState.Index' (duration: 596.666064ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:04:42.026253Z","caller":"traceutil/trace.go:171","msg":"trace[1172498560] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"1.540617135s","start":"2026-05-08T01:04:40.485614Z","end":"2026-05-08T01:04:42.026231Z","steps":["trace[1172498560] 'process raft request' (duration: 1.350308314s)","trace[1172498560] 'compare' (duration: 189.66345ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:04:42.026343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552809074s","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":"warn","ts":"2026-05-08T01:04:42.026355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:40.485597Z","time spent":"1.540710727s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:04:42.026381Z","caller":"traceutil/trace.go:171","msg":"trace[1077424028] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2099; }","duration":"1.552886954s","start":"2026-05-08T01:04:40.473483Z","end":"2026-05-08T01:04:42.02637Z","steps":["trace[1077424028] 'agreement among raft nodes before linearized reading' (duration: 1.552753022s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.026411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:40.473461Z","time spent":"1.552942426s","remote":"127.0.0.1:59006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-08T01:04:42.05668Z","caller":"traceutil/trace.go:171","msg":"trace[1731595002] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"588.274699ms","start":"2026-05-08T01:04:41.468384Z","end":"2026-05-08T01:04:42.056659Z","steps":["trace[1731595002] 'process raft request' (duration: 588.130787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.056778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.468358Z","time spent":"588.37668ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:04:42.057105Z","caller":"traceutil/trace.go:171","msg":"trace[1764581767] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"587.012826ms","start":"2026-05-08T01:04:41.470071Z","end":"2026-05-08T01:04:42.057084Z","steps":["trace[1764581767] 'process raft request' (duration: 586.862923ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:04:42.057124Z","caller":"traceutil/trace.go:171","msg":"trace[464933609] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"587.769839ms","start":"2026-05-08T01:04:41.469336Z","end":"2026-05-08T01:04:42.057106Z","steps":["trace[464933609] 'process raft request' (duration: 587.278831ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:04:42.057162Z","caller":"traceutil/trace.go:171","msg":"trace[1879563670] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"584.915161ms","start":"2026-05-08T01:04:41.472219Z","end":"2026-05-08T01:04:42.057135Z","steps":["trace[1879563670] 'process raft request' (duration: 584.787939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.057223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.469311Z","time spent":"587.86265ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:42.057222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.470062Z","time spent":"587.103248ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:42.057323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.472211Z","time spent":"585.030262ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:42.057377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.297428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T01:04:42.057423Z","caller":"traceutil/trace.go:171","msg":"trace[411942118] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2103; }","duration":"555.352629ms","start":"2026-05-08T01:04:41.502056Z","end":"2026-05-08T01:04:42.057409Z","steps":["trace[411942118] 'agreement among raft nodes before linearized reading' (duration: 555.218997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.057444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.652526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:04:42.057461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.502051Z","time spent":"555.39992ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-08T01:04:42.057486Z","caller":"traceutil/trace.go:171","msg":"trace[2097483085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2103; }","duration":"438.705786ms","start":"2026-05-08T01:04:41.618767Z","end":"2026-05-08T01:04:42.057473Z","steps":["trace[2097483085] 'agreement among raft nodes before linearized reading' (duration: 438.641095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.057528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.61875Z","time spent":"438.765028ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T01:04:42.057532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.039133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-08T01:04:42.057574Z","caller":"traceutil/trace.go:171","msg":"trace[1421420044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2103; }","duration":"555.100535ms","start":"2026-05-08T01:04:41.502463Z","end":"2026-05-08T01:04:42.057563Z","steps":["trace[1421420044] 'agreement among raft nodes before linearized reading' (duration: 554.978153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.057611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.502452Z","time spent":"555.152886ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T01:04:42.057751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.723056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-08T01:04:42.057784Z","caller":"traceutil/trace.go:171","msg":"trace[167747591] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2103; }","duration":"555.769716ms","start":"2026-05-08T01:04:41.502006Z","end":"2026-05-08T01:04:42.057776Z","steps":["trace[167747591] 'agreement among raft nodes before linearized reading' (duration: 555.690135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.057814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.501997Z","time spent":"555.810798ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T01:04:42.057821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.641543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T01:04:42.057819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.271672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T01:04:42.057877Z","caller":"traceutil/trace.go:171","msg":"trace[1487592488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2103; }","duration":"107.768355ms","start":"2026-05-08T01:04:41.950093Z","end":"2026-05-08T01:04:42.057862Z","steps":["trace[1487592488] 'agreement among raft nodes before linearized reading' (duration: 107.666983ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:04:42.057895Z","caller":"traceutil/trace.go:171","msg":"trace[2118773605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2103; }","duration":"570.390305ms","start":"2026-05-08T01:04:41.487487Z","end":"2026-05-08T01:04:42.057877Z","steps":["trace[2118773605] 'agreement among raft nodes before linearized reading' (duration: 570.135451ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.05795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:41.487475Z","time spent":"570.465616ms","remote":"127.0.0.1:47138","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-05-08T01:04:42.05804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392456327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12381"} {"level":"warn","ts":"2026-05-08T01:04:42.058219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.362008895s","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-05-08T01:04:42.058286Z","caller":"traceutil/trace.go:171","msg":"trace[649875325] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2103; }","duration":"1.362113767s","start":"2026-05-08T01:04:40.696153Z","end":"2026-05-08T01:04:42.058267Z","steps":["trace[649875325] 'agreement among raft nodes before linearized reading' (duration: 1.361929504s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.058331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:40.696133Z","time spent":"1.362184998s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-08T01:04:42.058373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.32544404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:04:42.058433Z","caller":"traceutil/trace.go:171","msg":"trace[1482915892] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2103; }","duration":"1.325498151s","start":"2026-05-08T01:04:40.732912Z","end":"2026-05-08T01:04:42.05841Z","steps":["trace[1482915892] 'agreement among raft nodes before linearized reading' (duration: 1.324956202s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.058473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:40.732874Z","time spent":"1.325590113s","remote":"127.0.0.1:39778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-08T01:04:42.058536Z","caller":"traceutil/trace.go:171","msg":"trace[1150641328] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2103; }","duration":"1.392965564s","start":"2026-05-08T01:04:40.665482Z","end":"2026-05-08T01:04:42.058448Z","steps":["trace[1150641328] 'agreement among raft nodes before linearized reading' (duration: 1.391653872s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.058638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:40.66545Z","time spent":"1.393173108s","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12403,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-08T01:04:42.462582Z","caller":"traceutil/trace.go:171","msg":"trace[524562874] linearizableReadLoop","detail":"{readStateIndex:2188; appliedIndex:2183; }","duration":"394.625034ms","start":"2026-05-08T01:04:42.067934Z","end":"2026-05-08T01:04:42.462559Z","steps":["trace[524562874] 'read index received' (duration: 24.096908ms)","trace[524562874] 'applied index is now lower than readState.Index' (duration: 370.527136ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:04:42.462906Z","caller":"traceutil/trace.go:171","msg":"trace[904761727] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"399.152569ms","start":"2026-05-08T01:04:42.06373Z","end":"2026-05-08T01:04:42.462882Z","steps":["trace[904761727] 'process raft request' (duration: 398.719332ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:04:42.463084Z","caller":"traceutil/trace.go:171","msg":"trace[1885110091] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"398.506148ms","start":"2026-05-08T01:04:42.064553Z","end":"2026-05-08T01:04:42.463059Z","steps":["trace[1885110091] 'process raft request' (duration: 397.968499ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:04:42.463093Z","caller":"traceutil/trace.go:171","msg":"trace[315928378] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"399.641777ms","start":"2026-05-08T01:04:42.06341Z","end":"2026-05-08T01:04:42.463052Z","steps":["trace[315928378] 'process raft request' (duration: 327.216374ms)","trace[315928378] 'compare' (duration: 71.691841ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:04:42.463092Z","caller":"traceutil/trace.go:171","msg":"trace[38019158] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"398.405927ms","start":"2026-05-08T01:04:42.064538Z","end":"2026-05-08T01:04:42.462944Z","steps":["trace[38019158] 'process raft request' (duration: 397.94839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.463173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:42.063688Z","time spent":"399.286082ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:42.463194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:42.064522Z","time spent":"398.62111ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:42.463208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.780366ms","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-05-08T01:04:42.463266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:42.063398Z","time spent":"399.77561ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:04:42.463269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:42.064532Z","time spent":"398.662191ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:04:42.463305Z","caller":"traceutil/trace.go:171","msg":"trace[2060087749] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2108; }","duration":"395.351375ms","start":"2026-05-08T01:04:42.067888Z","end":"2026-05-08T01:04:42.46324Z","steps":["trace[2060087749] 'agreement among raft nodes before linearized reading' (duration: 394.768035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:04:42.463346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:04:42.067871Z","time spent":"395.465808ms","remote":"127.0.0.1:47282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-05-08T01:05:22.67955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.644567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:05:22.679744Z","caller":"traceutil/trace.go:171","msg":"trace[755148974] transaction","detail":"{read_only:false; response_revision:2325; number_of_response:1; }","duration":"363.117368ms","start":"2026-05-08T01:05:22.316607Z","end":"2026-05-08T01:05:22.679725Z","steps":["trace[755148974] 'process raft request' (duration: 363.061527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:05:22.679817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:05:22.316584Z","time spent":"363.202459ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:05:22.679971Z","caller":"traceutil/trace.go:171","msg":"trace[1627245582] transaction","detail":"{read_only:false; response_revision:2324; number_of_response:1; }","duration":"417.005072ms","start":"2026-05-08T01:05:22.262794Z","end":"2026-05-08T01:05:22.679799Z","steps":["trace[1627245582] 'process raft request' (duration: 178.02657ms)","trace[1627245582] 'compare' (duration: 238.504496ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:05:22.680046Z","caller":"traceutil/trace.go:171","msg":"trace[230050985] linearizableReadLoop","detail":"{readStateIndex:2413; appliedIndex:2412; }","duration":"375.858065ms","start":"2026-05-08T01:05:22.304162Z","end":"2026-05-08T01:05:22.68002Z","steps":["trace[230050985] 'read index received' (duration: 136.677919ms)","trace[230050985] 'applied index is now lower than readState.Index' (duration: 239.176916ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:05:22.680243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:05:22.262771Z","time spent":"417.277986ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:05:22.680292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.374594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T01:05:22.680332Z","caller":"traceutil/trace.go:171","msg":"trace[1390971162] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2325; }","duration":"188.435705ms","start":"2026-05-08T01:05:22.491885Z","end":"2026-05-08T01:05:22.680321Z","steps":["trace[1390971162] 'agreement among raft nodes before linearized reading' (duration: 188.277393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:05:22.680457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.279241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"} {"level":"info","ts":"2026-05-08T01:05:22.680521Z","caller":"traceutil/trace.go:171","msg":"trace[984292580] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2325; }","duration":"376.366462ms","start":"2026-05-08T01:05:22.304135Z","end":"2026-05-08T01:05:22.680502Z","steps":["trace[984292580] 'agreement among raft nodes before linearized reading' (duration: 376.014808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:05:22.680653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:05:22.304124Z","time spent":"376.516814ms","remote":"127.0.0.1:59006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5450,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-08T01:05:47.68345Z","caller":"traceutil/trace.go:171","msg":"trace[1649971091] transaction","detail":"{read_only:false; response_revision:2555; number_of_response:1; }","duration":"175.921521ms","start":"2026-05-08T01:05:47.507504Z","end":"2026-05-08T01:05:47.683426Z","steps":["trace[1649971091] 'process raft request' (duration: 175.77584ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:05:48.392281Z","caller":"traceutil/trace.go:171","msg":"trace[273378703] transaction","detail":"{read_only:false; response_revision:2556; number_of_response:1; }","duration":"101.103568ms","start":"2026-05-08T01:05:48.291155Z","end":"2026-05-08T01:05:48.392258Z","steps":["trace[273378703] 'process raft request' (duration: 100.977707ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:06:21.019272Z","caller":"traceutil/trace.go:171","msg":"trace[1306987192] transaction","detail":"{read_only:false; response_revision:2736; number_of_response:1; }","duration":"478.550835ms","start":"2026-05-08T01:06:20.540696Z","end":"2026-05-08T01:06:21.019247Z","steps":["trace[1306987192] 'process raft request' (duration: 478.418434ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:06:21.019288Z","caller":"traceutil/trace.go:171","msg":"trace[241089666] transaction","detail":"{read_only:false; response_revision:2735; number_of_response:1; }","duration":"478.617526ms","start":"2026-05-08T01:06:20.540637Z","end":"2026-05-08T01:06:21.019254Z","steps":["trace[241089666] 'process raft request' (duration: 453.231369ms)","trace[241089666] 'compare' (duration: 24.862361ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:06:21.019439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:20.540672Z","time spent":"478.676287ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:06:21.019452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:20.540627Z","time spent":"478.732327ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:06:21.019701Z","caller":"traceutil/trace.go:171","msg":"trace[797946443] linearizableReadLoop","detail":"{readStateIndex:2840; appliedIndex:2837; }","duration":"340.980171ms","start":"2026-05-08T01:06:20.67871Z","end":"2026-05-08T01:06:21.01969Z","steps":["trace[797946443] 'read index received' (duration: 315.135018ms)","trace[797946443] 'applied index is now lower than readState.Index' (duration: 25.844013ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:06:21.019806Z","caller":"traceutil/trace.go:171","msg":"trace[874632273] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"467.365394ms","start":"2026-05-08T01:06:20.552429Z","end":"2026-05-08T01:06:21.019794Z","steps":["trace[874632273] 'process raft request' (duration: 466.770648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:06:21.019882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:20.552409Z","time spent":"467.418735ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:06:21.020178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.469597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:06:21.020224Z","caller":"traceutil/trace.go:171","msg":"trace[1682073202] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2737; }","duration":"341.548008ms","start":"2026-05-08T01:06:20.678663Z","end":"2026-05-08T01:06:21.020211Z","steps":["trace[1682073202] 'agreement among raft nodes before linearized reading' (duration: 341.415117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:06:21.020257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:20.678644Z","time spent":"341.604008ms","remote":"127.0.0.1:39778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:06:22.146314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.227764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:06:22.14652Z","caller":"traceutil/trace.go:171","msg":"trace[1118041706] linearizableReadLoop","detail":"{readStateIndex:2845; appliedIndex:2842; }","duration":"901.128386ms","start":"2026-05-08T01:06:21.245376Z","end":"2026-05-08T01:06:22.146504Z","steps":["trace[1118041706] 'read index received' (duration: 305.644329ms)","trace[1118041706] 'applied index is now lower than readState.Index' (duration: 595.483087ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:06:22.146608Z","caller":"traceutil/trace.go:171","msg":"trace[1584840402] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"1.079370273s","start":"2026-05-08T01:06:21.067227Z","end":"2026-05-08T01:06:22.146597Z","steps":["trace[1584840402] 'process raft request' (duration: 483.752634ms)","trace[1584840402] 'compare' (duration: 594.83041ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:06:22.146667Z","caller":"traceutil/trace.go:171","msg":"trace[993688504] transaction","detail":"{read_only:false; response_revision:2742; number_of_response:1; }","duration":"1.078456892s","start":"2026-05-08T01:06:21.068173Z","end":"2026-05-08T01:06:22.14663Z","steps":["trace[993688504] 'process raft request' (duration: 1.07829469s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:06:22.146762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:21.068164Z","time spent":"1.078557383s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:06:22.146811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.434419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ad71a050abf97d\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-05-08T01:06:22.146846Z","caller":"traceutil/trace.go:171","msg":"trace[291412222] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ad71a050abf97d; range_end:; response_count:1; response_revision:2742; }","duration":"901.5024ms","start":"2026-05-08T01:06:21.245334Z","end":"2026-05-08T01:06:22.146836Z","steps":["trace[291412222] 'agreement among raft nodes before linearized reading' (duration: 901.362268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:06:22.14688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:21.245314Z","time spent":"901.55931ms","remote":"127.0.0.1:46946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":803,"request content":"key:\"/registry/events/auth-system/keycloak-0.18ad71a050abf97d\" "} {"level":"warn","ts":"2026-05-08T01:06:22.146964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.607859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:06:22.147059Z","caller":"traceutil/trace.go:171","msg":"trace[2070210076] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2742; }","duration":"776.74903ms","start":"2026-05-08T01:06:21.370291Z","end":"2026-05-08T01:06:22.14704Z","steps":["trace[2070210076] 'agreement among raft nodes before linearized reading' (duration: 776.597237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:06:22.147116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:21.370273Z","time spent":"776.831612ms","remote":"127.0.0.1:41026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:06:22.147286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.131079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-05-08T01:06:22.14667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:21.067209Z","time spent":"1.079428403s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:06:22.147367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.120464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:06:22.14739Z","caller":"traceutil/trace.go:171","msg":"trace[777789627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2742; }","duration":"196.177044ms","start":"2026-05-08T01:06:21.951206Z","end":"2026-05-08T01:06:22.147383Z","steps":["trace[777789627] 'agreement among raft nodes before linearized reading' (duration: 196.141783ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:06:22.147328Z","caller":"traceutil/trace.go:171","msg":"trace[333387313] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2742; }","duration":"498.216029ms","start":"2026-05-08T01:06:21.649102Z","end":"2026-05-08T01:06:22.147318Z","steps":["trace[333387313] 'agreement among raft nodes before linearized reading' (duration: 498.068677ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:06:22.147473Z","caller":"traceutil/trace.go:171","msg":"trace[752323259] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"1.080116992s","start":"2026-05-08T01:06:21.067331Z","end":"2026-05-08T01:06:22.147448Z","steps":["trace[752323259] 'process raft request' (duration: 1.079070319s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:06:22.147523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:21.64908Z","time spent":"498.429922ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-05-08T01:06:22.147571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:21.067316Z","time spent":"1.080204593s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:06:22.147761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.03663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:06:22.148305Z","caller":"traceutil/trace.go:171","msg":"trace[247279126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2742; }","duration":"529.609987ms","start":"2026-05-08T01:06:21.618682Z","end":"2026-05-08T01:06:22.148292Z","steps":["trace[247279126] 'agreement among raft nodes before linearized reading' (duration: 528.635436ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:06:22.14834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:06:21.618634Z","time spent":"529.695788ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T01:09:43.964101Z","caller":"traceutil/trace.go:171","msg":"trace[181803357] linearizableReadLoop","detail":"{readStateIndex:4162; appliedIndex:4160; }","duration":"121.868212ms","start":"2026-05-08T01:09:43.842208Z","end":"2026-05-08T01:09:43.964076Z","steps":["trace[181803357] 'read index received' (duration: 9.704275ms)","trace[181803357] 'applied index is now lower than readState.Index' (duration: 112.162877ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:09:43.964283Z","caller":"traceutil/trace.go:171","msg":"trace[1817108962] transaction","detail":"{read_only:false; response_revision:3999; number_of_response:1; }","duration":"137.346414ms","start":"2026-05-08T01:09:43.826794Z","end":"2026-05-08T01:09:43.96414Z","steps":["trace[1817108962] 'process raft request' (duration: 137.13908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:43.964342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.104156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T01:09:43.964454Z","caller":"traceutil/trace.go:171","msg":"trace[1337533698] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:3999; }","duration":"122.271759ms","start":"2026-05-08T01:09:43.842159Z","end":"2026-05-08T01:09:43.964431Z","steps":["trace[1337533698] 'agreement among raft nodes before linearized reading' (duration: 122.061195ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.208305Z","caller":"traceutil/trace.go:171","msg":"trace[1637933765] transaction","detail":"{read_only:false; response_revision:4145; number_of_response:1; }","duration":"196.503789ms","start":"2026-05-08T01:09:48.011757Z","end":"2026-05-08T01:09:48.208261Z","steps":["trace[1637933765] 'process raft request' (duration: 155.242276ms)","trace[1637933765] 'compare' (duration: 40.687212ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:09:48.208382Z","caller":"traceutil/trace.go:171","msg":"trace[258173911] transaction","detail":"{read_only:false; response_revision:4146; number_of_response:1; }","duration":"195.184956ms","start":"2026-05-08T01:09:48.013165Z","end":"2026-05-08T01:09:48.20835Z","steps":["trace[258173911] 'process raft request' (duration: 194.745887ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.208391Z","caller":"traceutil/trace.go:171","msg":"trace[1107341392] transaction","detail":"{read_only:false; response_revision:4147; number_of_response:1; }","duration":"195.109914ms","start":"2026-05-08T01:09:48.01326Z","end":"2026-05-08T01:09:48.20837Z","steps":["trace[1107341392] 'process raft request' (duration: 194.720797ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.208673Z","caller":"traceutil/trace.go:171","msg":"trace[1046204939] transaction","detail":"{read_only:false; response_revision:4151; number_of_response:1; }","duration":"192.939083ms","start":"2026-05-08T01:09:48.015721Z","end":"2026-05-08T01:09:48.20866Z","steps":["trace[1046204939] 'process raft request' (duration: 192.451264ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.208831Z","caller":"traceutil/trace.go:171","msg":"trace[1584111025] transaction","detail":"{read_only:false; response_revision:4148; number_of_response:1; }","duration":"195.496501ms","start":"2026-05-08T01:09:48.013323Z","end":"2026-05-08T01:09:48.20882Z","steps":["trace[1584111025] 'process raft request' (duration: 194.712027ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.208905Z","caller":"traceutil/trace.go:171","msg":"trace[142941212] transaction","detail":"{read_only:false; response_revision:4155; number_of_response:1; }","duration":"190.409765ms","start":"2026-05-08T01:09:48.01846Z","end":"2026-05-08T01:09:48.208869Z","steps":["trace[142941212] 'process raft request' (duration: 189.873375ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.209098Z","caller":"traceutil/trace.go:171","msg":"trace[593900874] linearizableReadLoop","detail":"{readStateIndex:4316; appliedIndex:4307; }","duration":"193.195208ms","start":"2026-05-08T01:09:48.015878Z","end":"2026-05-08T01:09:48.209073Z","steps":["trace[593900874] 'read index received' (duration: 28.869302ms)","trace[593900874] 'applied index is now lower than readState.Index' (duration: 164.314206ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:09:48.209407Z","caller":"traceutil/trace.go:171","msg":"trace[2146585116] transaction","detail":"{read_only:false; response_revision:4156; number_of_response:1; }","duration":"186.739036ms","start":"2026-05-08T01:09:48.022641Z","end":"2026-05-08T01:09:48.20938Z","steps":["trace[2146585116] 'process raft request' (duration: 185.738268ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.209509Z","caller":"traceutil/trace.go:171","msg":"trace[1463927497] transaction","detail":"{read_only:false; response_revision:4149; number_of_response:1; }","duration":"196.112742ms","start":"2026-05-08T01:09:48.01335Z","end":"2026-05-08T01:09:48.209463Z","steps":["trace[1463927497] 'process raft request' (duration: 194.723476ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.209829Z","caller":"traceutil/trace.go:171","msg":"trace[911500361] transaction","detail":"{read_only:false; response_revision:4157; number_of_response:1; }","duration":"183.313892ms","start":"2026-05-08T01:09:48.026488Z","end":"2026-05-08T01:09:48.209802Z","steps":["trace[911500361] 'process raft request' (duration: 182.182161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:48.210265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.36169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/kube-prometheus-stack-operator\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-05-08T01:09:48.210453Z","caller":"traceutil/trace.go:171","msg":"trace[1933642315] range","detail":"{range_begin:/registry/deployments/monitoring/kube-prometheus-stack-operator; range_end:; response_count:1; response_revision:4157; }","duration":"194.560634ms","start":"2026-05-08T01:09:48.015874Z","end":"2026-05-08T01:09:48.210434Z","steps":["trace[1933642315] 'agreement among raft nodes before linearized reading' (duration: 194.231638ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.210575Z","caller":"traceutil/trace.go:171","msg":"trace[597725452] transaction","detail":"{read_only:false; response_revision:4150; number_of_response:1; }","duration":"196.092842ms","start":"2026-05-08T01:09:48.014466Z","end":"2026-05-08T01:09:48.210559Z","steps":["trace[597725452] 'process raft request' (duration: 193.667897ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.20884Z","caller":"traceutil/trace.go:171","msg":"trace[400390681] transaction","detail":"{read_only:false; response_revision:4154; number_of_response:1; }","duration":"191.678659ms","start":"2026-05-08T01:09:48.017147Z","end":"2026-05-08T01:09:48.208826Z","steps":["trace[400390681] 'process raft request' (duration: 191.138529ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.210733Z","caller":"traceutil/trace.go:171","msg":"trace[2065785450] transaction","detail":"{read_only:false; response_revision:4152; number_of_response:1; }","duration":"194.765337ms","start":"2026-05-08T01:09:48.015953Z","end":"2026-05-08T01:09:48.210718Z","steps":["trace[2065785450] 'process raft request' (duration: 192.2551ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.210807Z","caller":"traceutil/trace.go:171","msg":"trace[74716390] transaction","detail":"{read_only:false; response_revision:4153; number_of_response:1; }","duration":"193.788368ms","start":"2026-05-08T01:09:48.017008Z","end":"2026-05-08T01:09:48.210797Z","steps":["trace[74716390] 'process raft request' (duration: 191.239011ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.214393Z","caller":"traceutil/trace.go:171","msg":"trace[1591249625] transaction","detail":"{read_only:false; response_revision:4160; number_of_response:1; }","duration":"162.256598ms","start":"2026-05-08T01:09:48.052111Z","end":"2026-05-08T01:09:48.214368Z","steps":["trace[1591249625] 'process raft request' (duration: 162.193397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:48.214558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.655954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-wlbhr\" ","response":"range_response_count:1 size:8014"} {"level":"info","ts":"2026-05-08T01:09:48.214643Z","caller":"traceutil/trace.go:171","msg":"trace[1772425478] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-wlbhr; range_end:; response_count:1; response_revision:4160; }","duration":"194.784227ms","start":"2026-05-08T01:09:48.019812Z","end":"2026-05-08T01:09:48.214596Z","steps":["trace[1772425478] 'agreement among raft nodes before linearized reading' (duration: 194.549143ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.214748Z","caller":"traceutil/trace.go:171","msg":"trace[72189554] transaction","detail":"{read_only:false; response_revision:4158; number_of_response:1; }","duration":"164.794166ms","start":"2026-05-08T01:09:48.049939Z","end":"2026-05-08T01:09:48.214733Z","steps":["trace[72189554] 'process raft request' (duration: 164.021511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:48.215864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.416065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:09:48.216063Z","caller":"traceutil/trace.go:171","msg":"trace[1044972463] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:4160; }","duration":"183.628789ms","start":"2026-05-08T01:09:48.032416Z","end":"2026-05-08T01:09:48.216045Z","steps":["trace[1044972463] 'agreement among raft nodes before linearized reading' (duration: 183.420445ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.216292Z","caller":"traceutil/trace.go:171","msg":"trace[2039020335] transaction","detail":"{read_only:false; response_revision:4159; number_of_response:1; }","duration":"166.08974ms","start":"2026-05-08T01:09:48.05019Z","end":"2026-05-08T01:09:48.21628Z","steps":["trace[2039020335] 'process raft request' (duration: 164.049102ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.410832Z","caller":"traceutil/trace.go:171","msg":"trace[458553926] linearizableReadLoop","detail":"{readStateIndex:4364; appliedIndex:4361; }","duration":"114.546925ms","start":"2026-05-08T01:09:48.296262Z","end":"2026-05-08T01:09:48.410809Z","steps":["trace[458553926] 'read index received' (duration: 93.434651ms)","trace[458553926] 'applied index is now lower than readState.Index' (duration: 21.111144ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:09:48.411042Z","caller":"traceutil/trace.go:171","msg":"trace[21416937] transaction","detail":"{read_only:false; response_revision:4194; number_of_response:1; }","duration":"129.275101ms","start":"2026-05-08T01:09:48.281726Z","end":"2026-05-08T01:09:48.411001Z","steps":["trace[21416937] 'process raft request' (duration: 107.956662ms)","trace[21416937] 'compare' (duration: 20.818049ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:09:48.411098Z","caller":"traceutil/trace.go:171","msg":"trace[1872372937] transaction","detail":"{read_only:false; response_revision:4196; number_of_response:1; }","duration":"125.362337ms","start":"2026-05-08T01:09:48.285688Z","end":"2026-05-08T01:09:48.41105Z","steps":["trace[1872372937] 'process raft request' (duration: 125.048291ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.411283Z","caller":"traceutil/trace.go:171","msg":"trace[2128855868] transaction","detail":"{read_only:false; response_revision:4195; number_of_response:1; }","duration":"129.503244ms","start":"2026-05-08T01:09:48.281747Z","end":"2026-05-08T01:09:48.41125Z","steps":["trace[2128855868] 'process raft request' (duration: 128.927554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:48.411541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.819996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-operator-cd88cf4bf-hv7vk\" ","response":"range_response_count:1 size:4077"} {"level":"info","ts":"2026-05-08T01:09:48.417991Z","caller":"traceutil/trace.go:171","msg":"trace[1828709819] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-operator-cd88cf4bf-hv7vk; range_end:; response_count:1; response_revision:4196; }","duration":"139.305739ms","start":"2026-05-08T01:09:48.27866Z","end":"2026-05-08T01:09:48.417966Z","steps":["trace[1828709819] 'agreement among raft nodes before linearized reading' (duration: 132.672984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:48.411708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.409903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/kube-prometheus-stack-operator\" ","response":"range_response_count:1 size:5382"} {"level":"info","ts":"2026-05-08T01:09:48.412487Z","caller":"traceutil/trace.go:171","msg":"trace[1767013207] transaction","detail":"{read_only:false; response_revision:4197; number_of_response:1; }","duration":"111.819814ms","start":"2026-05-08T01:09:48.300651Z","end":"2026-05-08T01:09:48.412471Z","steps":["trace[1767013207] 'process raft request' (duration: 111.232963ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.412544Z","caller":"traceutil/trace.go:171","msg":"trace[1466346723] transaction","detail":"{read_only:false; response_revision:4198; number_of_response:1; }","duration":"101.598182ms","start":"2026-05-08T01:09:48.310936Z","end":"2026-05-08T01:09:48.412534Z","steps":["trace[1466346723] 'process raft request' (duration: 101.063832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:48.412996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.50436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/monitoring/kube-prometheus-stack-prometheus-node-exporter\" ","response":"range_response_count:1 size:8100"} {"level":"warn","ts":"2026-05-08T01:09:48.413524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.030969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-wlbhr\" ","response":"range_response_count:1 size:9205"} {"level":"warn","ts":"2026-05-08T01:09:48.411558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.812392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9494"} {"level":"info","ts":"2026-05-08T01:09:48.418338Z","caller":"traceutil/trace.go:171","msg":"trace[83560487] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4196; }","duration":"142.641081ms","start":"2026-05-08T01:09:48.275684Z","end":"2026-05-08T01:09:48.418325Z","steps":["trace[83560487] 'agreement among raft nodes before linearized reading' (duration: 135.692011ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.418993Z","caller":"traceutil/trace.go:171","msg":"trace[636865277] range","detail":"{range_begin:/registry/deployments/monitoring/kube-prometheus-stack-operator; range_end:; response_count:1; response_revision:4196; }","duration":"136.71538ms","start":"2026-05-08T01:09:48.282252Z","end":"2026-05-08T01:09:48.418967Z","steps":["trace[636865277] 'agreement among raft nodes before linearized reading' (duration: 129.291921ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.419528Z","caller":"traceutil/trace.go:171","msg":"trace[2054693882] range","detail":"{range_begin:/registry/daemonsets/monitoring/kube-prometheus-stack-prometheus-node-exporter; range_end:; response_count:1; response_revision:4196; }","duration":"139.572773ms","start":"2026-05-08T01:09:48.279454Z","end":"2026-05-08T01:09:48.419027Z","steps":["trace[2054693882] 'agreement among raft nodes before linearized reading' (duration: 131.805687ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:48.419664Z","caller":"traceutil/trace.go:171","msg":"trace[976000852] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-wlbhr; range_end:; response_count:1; response_revision:4210; }","duration":"117.043161ms","start":"2026-05-08T01:09:48.302457Z","end":"2026-05-08T01:09:48.4195Z","steps":["trace[976000852] 'agreement among raft nodes before linearized reading' (duration: 110.921096ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:51.863565Z","caller":"traceutil/trace.go:171","msg":"trace[1795083965] transaction","detail":"{read_only:false; response_revision:4441; number_of_response:1; }","duration":"184.967358ms","start":"2026-05-08T01:09:51.678577Z","end":"2026-05-08T01:09:51.863544Z","steps":["trace[1795083965] 'process raft request' (duration: 184.782654ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:51.916045Z","caller":"traceutil/trace.go:171","msg":"trace[2086113158] linearizableReadLoop","detail":"{readStateIndex:4614; appliedIndex:4612; }","duration":"153.667466ms","start":"2026-05-08T01:09:51.76235Z","end":"2026-05-08T01:09:51.916017Z","steps":["trace[2086113158] 'read index received' (duration: 101.021848ms)","trace[2086113158] 'applied index is now lower than readState.Index' (duration: 52.644408ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:09:51.916172Z","caller":"traceutil/trace.go:171","msg":"trace[461796156] transaction","detail":"{read_only:false; response_revision:4442; number_of_response:1; }","duration":"234.377806ms","start":"2026-05-08T01:09:51.681772Z","end":"2026-05-08T01:09:51.916149Z","steps":["trace[461796156] 'process raft request' (duration: 234.019489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:51.916368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.980823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:09:51.916475Z","caller":"traceutil/trace.go:171","msg":"trace[1150417281] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:4443; }","duration":"154.130675ms","start":"2026-05-08T01:09:51.762314Z","end":"2026-05-08T01:09:51.916445Z","steps":["trace[1150417281] 'agreement among raft nodes before linearized reading' (duration: 153.970652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:52.005951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.394308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-08T01:09:52.00603Z","caller":"traceutil/trace.go:171","msg":"trace[875824368] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4444; }","duration":"134.528731ms","start":"2026-05-08T01:09:51.871483Z","end":"2026-05-08T01:09:52.006012Z","steps":["trace[875824368] 'agreement among raft nodes before linearized reading' (duration: 134.349446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:52.007379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.639155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:7 size:60519"} {"level":"info","ts":"2026-05-08T01:09:52.007451Z","caller":"traceutil/trace.go:171","msg":"trace[214307442] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:7; response_revision:4444; }","duration":"132.711077ms","start":"2026-05-08T01:09:51.874722Z","end":"2026-05-08T01:09:52.007433Z","steps":["trace[214307442] 'agreement among raft nodes before linearized reading' (duration: 132.038074ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:58.624159Z","caller":"traceutil/trace.go:171","msg":"trace[824074103] transaction","detail":"{read_only:false; response_revision:4577; number_of_response:1; }","duration":"224.8396ms","start":"2026-05-08T01:09:58.399292Z","end":"2026-05-08T01:09:58.624132Z","steps":["trace[824074103] 'process raft request' (duration: 224.665626ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:59.432689Z","caller":"traceutil/trace.go:171","msg":"trace[637621865] linearizableReadLoop","detail":"{readStateIndex:4766; appliedIndex:4765; }","duration":"137.491237ms","start":"2026-05-08T01:09:59.295171Z","end":"2026-05-08T01:09:59.432662Z","steps":["trace[637621865] 'read index received' (duration: 137.403106ms)","trace[637621865] 'applied index is now lower than readState.Index' (duration: 87.221µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:09:59.432747Z","caller":"traceutil/trace.go:171","msg":"trace[1493819649] transaction","detail":"{read_only:false; response_revision:4587; number_of_response:1; }","duration":"238.147543ms","start":"2026-05-08T01:09:59.194565Z","end":"2026-05-08T01:09:59.432712Z","steps":["trace[1493819649] 'process raft request' (duration: 237.917349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:59.433122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.925505ms","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-05-08T01:09:59.433178Z","caller":"traceutil/trace.go:171","msg":"trace[847989035] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4587; }","duration":"138.037457ms","start":"2026-05-08T01:09:59.295125Z","end":"2026-05-08T01:09:59.433162Z","steps":["trace[847989035] 'agreement among raft nodes before linearized reading' (duration: 137.672231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:59.490012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.673813ms","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-05-08T01:09:59.49007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.176315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T01:09:59.490082Z","caller":"traceutil/trace.go:171","msg":"trace[318971082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4588; }","duration":"159.770954ms","start":"2026-05-08T01:09:59.330294Z","end":"2026-05-08T01:09:59.490065Z","steps":["trace[318971082] 'agreement among raft nodes before linearized reading' (duration: 159.55954ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:59.49024Z","caller":"traceutil/trace.go:171","msg":"trace[303014401] transaction","detail":"{read_only:false; response_revision:4588; number_of_response:1; }","duration":"102.457778ms","start":"2026-05-08T01:09:59.387767Z","end":"2026-05-08T01:09:59.490225Z","steps":["trace[303014401] 'process raft request' (duration: 101.964479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:09:59.490026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.658461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-wlbhr\" ","response":"range_response_count:1 size:9686"} {"level":"info","ts":"2026-05-08T01:09:59.49043Z","caller":"traceutil/trace.go:171","msg":"trace[1715974724] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-wlbhr; range_end:; response_count:1; response_revision:4588; }","duration":"104.015427ms","start":"2026-05-08T01:09:59.386351Z","end":"2026-05-08T01:09:59.490367Z","steps":["trace[1715974724] 'agreement among raft nodes before linearized reading' (duration: 103.540829ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:09:59.490155Z","caller":"traceutil/trace.go:171","msg":"trace[270450613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4588; }","duration":"152.281577ms","start":"2026-05-08T01:09:59.337834Z","end":"2026-05-08T01:09:59.490115Z","steps":["trace[270450613] 'agreement among raft nodes before linearized reading' (duration: 152.101624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:00.779673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.217996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:10:00.779754Z","caller":"traceutil/trace.go:171","msg":"trace[1012924847] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:4602; }","duration":"120.356749ms","start":"2026-05-08T01:10:00.659381Z","end":"2026-05-08T01:10:00.779738Z","steps":["trace[1012924847] 'count revisions from in-memory index tree' (duration: 120.099194ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:01.632639Z","caller":"traceutil/trace.go:171","msg":"trace[1602942194] transaction","detail":"{read_only:false; response_revision:4604; number_of_response:1; }","duration":"125.456628ms","start":"2026-05-08T01:10:01.507154Z","end":"2026-05-08T01:10:01.632611Z","steps":["trace[1602942194] 'process raft request' (duration: 125.253494ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:01.6328Z","caller":"traceutil/trace.go:171","msg":"trace[104977941] transaction","detail":"{read_only:false; response_revision:4605; number_of_response:1; }","duration":"125.533069ms","start":"2026-05-08T01:10:01.507241Z","end":"2026-05-08T01:10:01.632774Z","steps":["trace[104977941] 'process raft request' (duration: 125.329415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:05.48486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.406808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:10:05.485021Z","caller":"traceutil/trace.go:171","msg":"trace[1214535754] linearizableReadLoop","detail":"{readStateIndex:4818; appliedIndex:4817; }","duration":"404.69033ms","start":"2026-05-08T01:10:05.080265Z","end":"2026-05-08T01:10:05.484955Z","steps":["trace[1214535754] 'read index received' (duration: 42.031µs)","trace[1214535754] 'applied index is now lower than readState.Index' (duration: 404.647179ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:05.485156Z","caller":"traceutil/trace.go:171","msg":"trace[1558216337] transaction","detail":"{read_only:false; response_revision:4637; number_of_response:1; }","duration":"527.384818ms","start":"2026-05-08T01:10:04.957757Z","end":"2026-05-08T01:10:05.485142Z","steps":["trace[1558216337] 'process raft request' (duration: 44.617284ms)","trace[1558216337] 'compare' (duration: 481.94261ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:10:05.485245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:04.957747Z","time spent":"527.44508ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1250,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T01:10:05.485577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.28506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T01:10:05.485579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.110002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-08T01:10:05.485838Z","caller":"traceutil/trace.go:171","msg":"trace[1092733110] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4637; }","duration":"258.421188ms","start":"2026-05-08T01:10:05.227394Z","end":"2026-05-08T01:10:05.485815Z","steps":["trace[1092733110] 'agreement among raft nodes before linearized reading' (duration: 257.910819ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:05.485665Z","caller":"traceutil/trace.go:171","msg":"trace[906949653] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:4637; }","duration":"405.439173ms","start":"2026-05-08T01:10:05.080207Z","end":"2026-05-08T01:10:05.485646Z","steps":["trace[906949653] 'agreement among raft nodes before linearized reading' (duration: 405.227479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:05.486004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.080183Z","time spent":"405.768569ms","remote":"127.0.0.1:47186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":25,"response size":29,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:10:06.126022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.113066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:10:06.126163Z","caller":"traceutil/trace.go:171","msg":"trace[297512741] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"634.698423ms","start":"2026-05-08T01:10:05.49141Z","end":"2026-05-08T01:10:06.126108Z","steps":["trace[297512741] 'process raft request' (duration: 116.308922ms)","trace[297512741] 'compare' (duration: 517.961614ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:10:06.126225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.491383Z","time spent":"634.816296ms","remote":"127.0.0.1:47030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T01:10:06.137481Z","caller":"traceutil/trace.go:171","msg":"trace[238753829] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"645.585278ms","start":"2026-05-08T01:10:05.491859Z","end":"2026-05-08T01:10:06.137445Z","steps":["trace[238753829] 'process raft request' (duration: 645.269292ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:06.137595Z","caller":"traceutil/trace.go:171","msg":"trace[937547089] linearizableReadLoop","detail":"{readStateIndex:4823; appliedIndex:4818; }","duration":"598.703865ms","start":"2026-05-08T01:10:05.538874Z","end":"2026-05-08T01:10:06.137578Z","steps":["trace[937547089] 'read index received' (duration: 68.823308ms)","trace[937547089] 'applied index is now lower than readState.Index' (duration: 529.879567ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:06.137592Z","caller":"traceutil/trace.go:171","msg":"trace[1820237339] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"645.511967ms","start":"2026-05-08T01:10:05.492056Z","end":"2026-05-08T01:10:06.137568Z","steps":["trace[1820237339] 'process raft request' (duration: 645.185461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.137656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.491841Z","time spent":"645.727451ms","remote":"127.0.0.1:47142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1249,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T01:10:06.13771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.492047Z","time spent":"645.600238ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:10:06.137781Z","caller":"traceutil/trace.go:171","msg":"trace[2123217835] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"645.343803ms","start":"2026-05-08T01:10:05.492426Z","end":"2026-05-08T01:10:06.137769Z","steps":["trace[2123217835] 'process raft request' (duration: 644.879115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.137841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.492414Z","time spent":"645.391804ms","remote":"127.0.0.1:46946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T01:10:06.138023Z","caller":"traceutil/trace.go:171","msg":"trace[1930831960] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"644.846995ms","start":"2026-05-08T01:10:05.493166Z","end":"2026-05-08T01:10:06.138013Z","steps":["trace[1930831960] 'process raft request' (duration: 644.261724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.138081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.493155Z","time spent":"644.892595ms","remote":"127.0.0.1:46928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":128347,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:10:06.138241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.364486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T01:10:06.138329Z","caller":"traceutil/trace.go:171","msg":"trace[71553411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4642; }","duration":"599.468779ms","start":"2026-05-08T01:10:05.538824Z","end":"2026-05-08T01:10:06.138293Z","steps":["trace[71553411] 'agreement among raft nodes before linearized reading' (duration: 599.220204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.138383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.538809Z","time spent":"599.55702ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-08T01:10:06.177317Z","caller":"traceutil/trace.go:171","msg":"trace[1389755076] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"513.380138ms","start":"2026-05-08T01:10:05.663909Z","end":"2026-05-08T01:10:06.177289Z","steps":["trace[1389755076] 'process raft request' (duration: 513.116484ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:06.177455Z","caller":"traceutil/trace.go:171","msg":"trace[1893510089] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"178.979043ms","start":"2026-05-08T01:10:05.998414Z","end":"2026-05-08T01:10:06.177393Z","steps":["trace[1893510089] 'process raft request' (duration: 178.766429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.177614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.663891Z","time spent":"513.50878ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:10:06.178409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.411135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:10:06.178461Z","caller":"traceutil/trace.go:171","msg":"trace[261252594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4646; }","duration":"227.504417ms","start":"2026-05-08T01:10:05.950944Z","end":"2026-05-08T01:10:06.178448Z","steps":["trace[261252594] 'agreement among raft nodes before linearized reading' (duration: 227.416065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.178717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.289417ms","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-05-08T01:10:06.178734Z","caller":"traceutil/trace.go:171","msg":"trace[661710133] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"175.210476ms","start":"2026-05-08T01:10:06.003412Z","end":"2026-05-08T01:10:06.178623Z","steps":["trace[661710133] 'process raft request' (duration: 174.462382ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:06.178772Z","caller":"traceutil/trace.go:171","msg":"trace[1833882570] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4646; }","duration":"533.370839ms","start":"2026-05-08T01:10:05.645387Z","end":"2026-05-08T01:10:06.178757Z","steps":["trace[1833882570] 'agreement among raft nodes before linearized reading' (duration: 533.076424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.178807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.645376Z","time spent":"533.4239ms","remote":"127.0.0.1:47138","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-05-08T01:10:06.179012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.826403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12974"} {"level":"info","ts":"2026-05-08T01:10:06.179299Z","caller":"traceutil/trace.go:171","msg":"trace[1086162004] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4646; }","duration":"178.114278ms","start":"2026-05-08T01:10:06.001129Z","end":"2026-05-08T01:10:06.179243Z","steps":["trace[1086162004] 'agreement among raft nodes before linearized reading' (duration: 177.462056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.178413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.325628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T01:10:06.180084Z","caller":"traceutil/trace.go:171","msg":"trace[963769984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4646; }","duration":"534.601321ms","start":"2026-05-08T01:10:05.645044Z","end":"2026-05-08T01:10:06.179646Z","steps":["trace[963769984] 'agreement among raft nodes before linearized reading' (duration: 533.213306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:06.180142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:05.645033Z","time spent":"535.093489ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T01:10:07.442045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043650006s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:10:07.442243Z","caller":"traceutil/trace.go:171","msg":"trace[589172277] linearizableReadLoop","detail":"{readStateIndex:4844; appliedIndex:4842; }","duration":"1.117099274s","start":"2026-05-08T01:10:06.325129Z","end":"2026-05-08T01:10:07.442229Z","steps":["trace[589172277] 'read index received' (duration: 73.160813ms)","trace[589172277] 'applied index is now lower than readState.Index' (duration: 1.043937641s)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:07.442321Z","caller":"traceutil/trace.go:171","msg":"trace[869957023] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"1.151410819s","start":"2026-05-08T01:10:06.290901Z","end":"2026-05-08T01:10:07.442312Z","steps":["trace[869957023] 'process raft request' (duration: 107.398917ms)","trace[869957023] 'compare' (duration: 1.042341302s)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:10:07.442366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:06.290878Z","time spent":"1.15146641s","remote":"127.0.0.1:46946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":738,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T01:10:07.44239Z","caller":"traceutil/trace.go:171","msg":"trace[308404978] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"1.151315068s","start":"2026-05-08T01:10:06.291042Z","end":"2026-05-08T01:10:07.442357Z","steps":["trace[308404978] 'process raft request' (duration: 1.151108814s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:07.442483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:06.291033Z","time spent":"1.151410199s","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1306,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T01:10:07.442568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.150408391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-08T01:10:07.442669Z","caller":"traceutil/trace.go:171","msg":"trace[68311342] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4663; }","duration":"1.150592115s","start":"2026-05-08T01:10:06.292052Z","end":"2026-05-08T01:10:07.442644Z","steps":["trace[68311342] 'agreement among raft nodes before linearized reading' (duration: 1.150286389s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:07.442713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.165253227s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16086"} {"level":"warn","ts":"2026-05-08T01:10:07.442734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:06.292039Z","time spent":"1.150679326s","remote":"127.0.0.1:47234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1146,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"info","ts":"2026-05-08T01:10:07.442774Z","caller":"traceutil/trace.go:171","msg":"trace[1102160690] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4663; }","duration":"1.1653699s","start":"2026-05-08T01:10:06.277386Z","end":"2026-05-08T01:10:07.442755Z","steps":["trace[1102160690] 'agreement among raft nodes before linearized reading' (duration: 1.165188927s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:07.443064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15090435s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-08T01:10:07.443121Z","caller":"traceutil/trace.go:171","msg":"trace[2000846027] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4663; }","duration":"1.150983601s","start":"2026-05-08T01:10:06.292123Z","end":"2026-05-08T01:10:07.443107Z","steps":["trace[2000846027] 'agreement among raft nodes before linearized reading' (duration: 1.150844729s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:07.443158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:06.292064Z","time spent":"1.151085064s","remote":"127.0.0.1:47234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1146,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"warn","ts":"2026-05-08T01:10:07.44324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114358744s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-455ffeae-4401-456a-be8f-4284ed6c454a\" ","response":"range_response_count:1 size:1303"} {"level":"info","ts":"2026-05-08T01:10:07.443327Z","caller":"traceutil/trace.go:171","msg":"trace[241355761] range","detail":"{range_begin:/registry/persistentvolumes/pvc-455ffeae-4401-456a-be8f-4284ed6c454a; range_end:; response_count:1; response_revision:4663; }","duration":"1.114477306s","start":"2026-05-08T01:10:06.328831Z","end":"2026-05-08T01:10:07.443308Z","steps":["trace[241355761] 'agreement among raft nodes before linearized reading' (duration: 1.114227422s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:07.44336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.025534999s","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-05-08T01:10:07.443413Z","caller":"traceutil/trace.go:171","msg":"trace[1285080268] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4663; }","duration":"1.025628231s","start":"2026-05-08T01:10:06.417772Z","end":"2026-05-08T01:10:07.4434Z","steps":["trace[1285080268] 'agreement among raft nodes before linearized reading' (duration: 1.025499449s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:07.443452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:06.417749Z","time spent":"1.025695402s","remote":"127.0.0.1:47138","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-05-08T01:10:07.44418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028775869s","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-05-08T01:10:07.445443Z","caller":"traceutil/trace.go:171","msg":"trace[65730621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4663; }","duration":"1.030071042s","start":"2026-05-08T01:10:06.415355Z","end":"2026-05-08T01:10:07.445426Z","steps":["trace[65730621] 'agreement among raft nodes before linearized reading' (duration: 1.028720267s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:07.445611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:06.415323Z","time spent":"1.030272465s","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T01:10:07.445666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:06.277367Z","time spent":"1.165436241s","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16108,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-05-08T01:10:07.443393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:06.328814Z","time spent":"1.114566848s","remote":"127.0.0.1:47010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1325,"request content":"key:\"/registry/persistentvolumes/pvc-455ffeae-4401-456a-be8f-4284ed6c454a\" "} {"level":"warn","ts":"2026-05-08T01:10:10.616674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.746231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29582fb3-075e-47ba-b0d5-f63c5f9baa48\" ","response":"range_response_count:1 size:3936"} {"level":"info","ts":"2026-05-08T01:10:10.616773Z","caller":"traceutil/trace.go:171","msg":"trace[1003117592] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29582fb3-075e-47ba-b0d5-f63c5f9baa48; range_end:; response_count:1; response_revision:4746; }","duration":"426.896544ms","start":"2026-05-08T01:10:10.189852Z","end":"2026-05-08T01:10:10.616749Z","steps":["trace[1003117592] 'range keys from in-memory index tree' (duration: 426.572719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:10.616807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:10.189831Z","time spent":"426.968465ms","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3958,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29582fb3-075e-47ba-b0d5-f63c5f9baa48\" "} {"level":"info","ts":"2026-05-08T01:10:10.627921Z","caller":"traceutil/trace.go:171","msg":"trace[617993579] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"437.408662ms","start":"2026-05-08T01:10:10.190487Z","end":"2026-05-08T01:10:10.627896Z","steps":["trace[617993579] 'process raft request' (duration: 437.269149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:10.628086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:10.19047Z","time spent":"437.523213ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:10:10.644608Z","caller":"traceutil/trace.go:171","msg":"trace[229144628] linearizableReadLoop","detail":"{readStateIndex:4932; appliedIndex:4928; }","duration":"418.419844ms","start":"2026-05-08T01:10:10.226166Z","end":"2026-05-08T01:10:10.644586Z","steps":["trace[229144628] 'read index received' (duration: 401.550164ms)","trace[229144628] 'applied index is now lower than readState.Index' (duration: 16.86871ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:10.644646Z","caller":"traceutil/trace.go:171","msg":"trace[110254877] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"453.463067ms","start":"2026-05-08T01:10:10.191151Z","end":"2026-05-08T01:10:10.644614Z","steps":["trace[110254877] 'process raft request' (duration: 453.250494ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:10.644668Z","caller":"traceutil/trace.go:171","msg":"trace[214134481] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"452.301257ms","start":"2026-05-08T01:10:10.192346Z","end":"2026-05-08T01:10:10.644647Z","steps":["trace[214134481] 'process raft request' (duration: 452.177405ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:10.6447Z","caller":"traceutil/trace.go:171","msg":"trace[1716395554] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"422.229212ms","start":"2026-05-08T01:10:10.222463Z","end":"2026-05-08T01:10:10.644692Z","steps":["trace[1716395554] 'process raft request' (duration: 422.088829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:10.644764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:10.192327Z","time spent":"452.385438ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:10:10.644787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:10.222448Z","time spent":"422.272613ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:10:10.644791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:10.19112Z","time spent":"453.59203ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:10:10.644976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.857651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T01:10:10.64501Z","caller":"traceutil/trace.go:171","msg":"trace[196835921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4750; }","duration":"418.928723ms","start":"2026-05-08T01:10:10.226074Z","end":"2026-05-08T01:10:10.645003Z","steps":["trace[196835921] 'agreement among raft nodes before linearized reading' (duration: 418.813371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:10.64503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:10.226057Z","time spent":"418.969363ms","remote":"127.0.0.1:47138","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-05-08T01:10:10.645216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.937885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T01:10:10.645272Z","caller":"traceutil/trace.go:171","msg":"trace[1769365902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4750; }","duration":"359.021597ms","start":"2026-05-08T01:10:10.286234Z","end":"2026-05-08T01:10:10.645256Z","steps":["trace[1769365902] 'agreement among raft nodes before linearized reading' (duration: 358.849504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:10.645315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:10.286223Z","time spent":"359.079408ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T01:10:10.64539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.023777ms","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-05-08T01:10:10.645426Z","caller":"traceutil/trace.go:171","msg":"trace[1937871345] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4750; }","duration":"359.118319ms","start":"2026-05-08T01:10:10.286297Z","end":"2026-05-08T01:10:10.645415Z","steps":["trace[1937871345] 'agreement among raft nodes before linearized reading' (duration: 359.022177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:10.645458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:10.286251Z","time spent":"359.20033ms","remote":"127.0.0.1:47138","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-05-08T01:10:11.815089Z","caller":"traceutil/trace.go:171","msg":"trace[1133660072] linearizableReadLoop","detail":"{readStateIndex:4939; appliedIndex:4938; }","duration":"314.017795ms","start":"2026-05-08T01:10:11.501045Z","end":"2026-05-08T01:10:11.815063Z","steps":["trace[1133660072] 'read index received' (duration: 313.800851ms)","trace[1133660072] 'applied index is now lower than readState.Index' (duration: 215.894µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:11.815147Z","caller":"traceutil/trace.go:171","msg":"trace[488509167] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"330.381435ms","start":"2026-05-08T01:10:11.484739Z","end":"2026-05-08T01:10:11.81512Z","steps":["trace[488509167] 'process raft request' (duration: 330.176891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:11.815382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:11.484721Z","time spent":"330.576359ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:10:11.815366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.560194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T01:10:11.815528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.941948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29582fb3-075e-47ba-b0d5-f63c5f9baa48\" ","response":"range_response_count:1 size:3951"} {"level":"info","ts":"2026-05-08T01:10:11.815564Z","caller":"traceutil/trace.go:171","msg":"trace[915957160] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:4757; }","duration":"301.789328ms","start":"2026-05-08T01:10:11.513736Z","end":"2026-05-08T01:10:11.815525Z","steps":["trace[915957160] 'agreement among raft nodes before linearized reading' (duration: 301.522743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:11.815591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.496893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-08T01:10:11.815703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:11.513723Z","time spent":"301.91862ms","remote":"127.0.0.1:41034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":29,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"info","ts":"2026-05-08T01:10:11.81573Z","caller":"traceutil/trace.go:171","msg":"trace[882771575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4757; }","duration":"314.725046ms","start":"2026-05-08T01:10:11.500991Z","end":"2026-05-08T01:10:11.815716Z","steps":["trace[882771575] 'agreement among raft nodes before linearized reading' (duration: 314.199517ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:11.815635Z","caller":"traceutil/trace.go:171","msg":"trace[1686811863] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29582fb3-075e-47ba-b0d5-f63c5f9baa48; range_end:; response_count:1; response_revision:4757; }","duration":"165.117391ms","start":"2026-05-08T01:10:11.65049Z","end":"2026-05-08T01:10:11.815608Z","steps":["trace[1686811863] 'agreement among raft nodes before linearized reading' (duration: 164.847597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:11.815776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:11.500967Z","time spent":"314.795648ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T01:10:16.953561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.697842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:10:16.953654Z","caller":"traceutil/trace.go:171","msg":"trace[1401297036] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:4845; }","duration":"164.855155ms","start":"2026-05-08T01:10:16.788779Z","end":"2026-05-08T01:10:16.953634Z","steps":["trace[1401297036] 'count revisions from in-memory index tree' (duration: 164.54585ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:21.439412Z","caller":"traceutil/trace.go:171","msg":"trace[812586342] linearizableReadLoop","detail":"{readStateIndex:5065; appliedIndex:5064; }","duration":"306.525708ms","start":"2026-05-08T01:10:21.132868Z","end":"2026-05-08T01:10:21.439394Z","steps":["trace[812586342] 'read index received' (duration: 306.394956ms)","trace[812586342] 'applied index is now lower than readState.Index' (duration: 129.602µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:21.43966Z","caller":"traceutil/trace.go:171","msg":"trace[104024464] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"315.29839ms","start":"2026-05-08T01:10:21.124326Z","end":"2026-05-08T01:10:21.439624Z","steps":["trace[104024464] 'process raft request' (duration: 314.961384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:21.439785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:21.124299Z","time spent":"315.397421ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:10:21.43982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.36687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-05-08T01:10:21.439966Z","caller":"traceutil/trace.go:171","msg":"trace[681082728] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4878; }","duration":"297.515372ms","start":"2026-05-08T01:10:21.142431Z","end":"2026-05-08T01:10:21.439946Z","steps":["trace[681082728] 'agreement among raft nodes before linearized reading' (duration: 297.224746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:21.440082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.21095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16403"} {"level":"info","ts":"2026-05-08T01:10:21.440165Z","caller":"traceutil/trace.go:171","msg":"trace[1229169986] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4878; }","duration":"307.322142ms","start":"2026-05-08T01:10:21.132832Z","end":"2026-05-08T01:10:21.440154Z","steps":["trace[1229169986] 'agreement among raft nodes before linearized reading' (duration: 306.749511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:21.440196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:21.132814Z","time spent":"307.375953ms","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16425,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-05-08T01:10:21.440255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.679031ms","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-05-08T01:10:21.440321Z","caller":"traceutil/trace.go:171","msg":"trace[3673387] 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:4878; }","duration":"306.764852ms","start":"2026-05-08T01:10:21.133538Z","end":"2026-05-08T01:10:21.440303Z","steps":["trace[3673387] 'agreement among raft nodes before linearized reading' (duration: 306.074279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:21.440351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:21.133531Z","time spent":"306.813683ms","remote":"127.0.0.1:47024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2104,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-05-08T01:10:21.926621Z","caller":"traceutil/trace.go:171","msg":"trace[1498235623] linearizableReadLoop","detail":"{readStateIndex:5066; appliedIndex:5065; }","duration":"478.629399ms","start":"2026-05-08T01:10:21.44796Z","end":"2026-05-08T01:10:21.926589Z","steps":["trace[1498235623] 'read index received' (duration: 478.418216ms)","trace[1498235623] 'applied index is now lower than readState.Index' (duration: 209.923µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:10:21.92689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.900884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-29582fb3-075e-47ba-b0d5-f63c5f9baa48\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-05-08T01:10:21.926971Z","caller":"traceutil/trace.go:171","msg":"trace[1987955120] range","detail":"{range_begin:/registry/persistentvolumes/pvc-29582fb3-075e-47ba-b0d5-f63c5f9baa48; range_end:; response_count:1; response_revision:4879; }","duration":"479.019655ms","start":"2026-05-08T01:10:21.447933Z","end":"2026-05-08T01:10:21.926953Z","steps":["trace[1987955120] 'agreement among raft nodes before linearized reading' (duration: 478.800982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:21.927035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:21.447917Z","time spent":"479.098066ms","remote":"127.0.0.1:47010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1344,"request content":"key:\"/registry/persistentvolumes/pvc-29582fb3-075e-47ba-b0d5-f63c5f9baa48\" "} {"level":"info","ts":"2026-05-08T01:10:21.926731Z","caller":"traceutil/trace.go:171","msg":"trace[1919618606] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"479.802059ms","start":"2026-05-08T01:10:21.446886Z","end":"2026-05-08T01:10:21.926688Z","steps":["trace[1919618606] 'process raft request' (duration: 479.467823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:21.927346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:21.446855Z","time spent":"480.320819ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T01:10:22.055702Z","caller":"traceutil/trace.go:171","msg":"trace[209920366] linearizableReadLoop","detail":"{readStateIndex:5067; appliedIndex:5066; }","duration":"128.9743ms","start":"2026-05-08T01:10:21.9267Z","end":"2026-05-08T01:10:22.055674Z","steps":["trace[209920366] 'read index received' (duration: 102.279078ms)","trace[209920366] 'applied index is now lower than readState.Index' (duration: 26.694032ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:22.055809Z","caller":"traceutil/trace.go:171","msg":"trace[932163310] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"603.800442ms","start":"2026-05-08T01:10:21.45197Z","end":"2026-05-08T01:10:22.05577Z","steps":["trace[932163310] 'process raft request' (duration: 576.996988ms)","trace[932163310] 'compare' (duration: 26.57135ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:10:22.055898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.758841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T01:10:22.055949Z","caller":"traceutil/trace.go:171","msg":"trace[607087086] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:4880; }","duration":"309.883984ms","start":"2026-05-08T01:10:21.746052Z","end":"2026-05-08T01:10:22.055936Z","steps":["trace[607087086] 'agreement among raft nodes before linearized reading' (duration: 309.738111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:22.055989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:21.746029Z","time spent":"309.949114ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":9,"response size":29,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-05-08T01:10:22.056032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T01:10:21.451956Z","time spent":"603.948425ms","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17137,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T01:10:22.056332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.751034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-08T01:10:22.056335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.319357ms","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-05-08T01:10:22.056366Z","caller":"traceutil/trace.go:171","msg":"trace[63367094] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4880; }","duration":"194.823815ms","start":"2026-05-08T01:10:21.861532Z","end":"2026-05-08T01:10:22.056356Z","steps":["trace[63367094] 'agreement among raft nodes before linearized reading' (duration: 194.703953ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:22.056386Z","caller":"traceutil/trace.go:171","msg":"trace[1490088387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4880; }","duration":"201.372678ms","start":"2026-05-08T01:10:21.854999Z","end":"2026-05-08T01:10:22.056372Z","steps":["trace[1490088387] 'agreement among raft nodes before linearized reading' (duration: 201.197655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:22.354546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.50073ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:10:22.354773Z","caller":"traceutil/trace.go:171","msg":"trace[1207722548] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"212.025518ms","start":"2026-05-08T01:10:22.142679Z","end":"2026-05-08T01:10:22.354704Z","steps":["trace[1207722548] 'process raft request' (duration: 57.277294ms)","trace[1207722548] 'compare' (duration: 154.338687ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:22.355075Z","caller":"traceutil/trace.go:171","msg":"trace[558026715] linearizableReadLoop","detail":"{readStateIndex:5071; appliedIndex:5070; }","duration":"119.369621ms","start":"2026-05-08T01:10:22.23526Z","end":"2026-05-08T01:10:22.354629Z","steps":["trace[558026715] 'read index received' (duration: 46.481µs)","trace[558026715] 'applied index is now lower than readState.Index' (duration: 119.32206ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:10:22.355399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.120904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-08T01:10:22.355458Z","caller":"traceutil/trace.go:171","msg":"trace[1859603041] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4884; }","duration":"120.240716ms","start":"2026-05-08T01:10:22.2352Z","end":"2026-05-08T01:10:22.355441Z","steps":["trace[1859603041] 'agreement among raft nodes before linearized reading' (duration: 119.850419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:22.589149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.325337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:10:22.589498Z","caller":"traceutil/trace.go:171","msg":"trace[1703802214] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"226.845245ms","start":"2026-05-08T01:10:22.362568Z","end":"2026-05-08T01:10:22.589413Z","steps":["trace[1703802214] 'process raft request' (duration: 117.173302ms)","trace[1703802214] 'compare' (duration: 109.037992ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:22.589556Z","caller":"traceutil/trace.go:171","msg":"trace[402754743] linearizableReadLoop","detail":"{readStateIndex:5074; appliedIndex:5072; }","duration":"225.98323ms","start":"2026-05-08T01:10:22.363557Z","end":"2026-05-08T01:10:22.589541Z","steps":["trace[402754743] 'read index received' (duration: 63.170126ms)","trace[402754743] 'applied index is now lower than readState.Index' (duration: 162.812174ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:22.589586Z","caller":"traceutil/trace.go:171","msg":"trace[1185009925] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"219.170791ms","start":"2026-05-08T01:10:22.370405Z","end":"2026-05-08T01:10:22.589576Z","steps":["trace[1185009925] 'process raft request' (duration: 218.905847ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:22.589492Z","caller":"traceutil/trace.go:171","msg":"trace[711397513] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"226.760813ms","start":"2026-05-08T01:10:22.36267Z","end":"2026-05-08T01:10:22.589431Z","steps":["trace[711397513] 'process raft request' (duration: 226.56423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:22.589769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.221877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:10:22.589795Z","caller":"traceutil/trace.go:171","msg":"trace[594794550] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:4888; }","duration":"183.285909ms","start":"2026-05-08T01:10:22.406502Z","end":"2026-05-08T01:10:22.589788Z","steps":["trace[594794550] 'agreement among raft nodes before linearized reading' (duration: 183.224568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:22.589868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.287935ms","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-05-08T01:10:22.589937Z","caller":"traceutil/trace.go:171","msg":"trace[705704235] 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:4888; }","duration":"226.389437ms","start":"2026-05-08T01:10:22.363521Z","end":"2026-05-08T01:10:22.58991Z","steps":["trace[705704235] 'agreement among raft nodes before linearized reading' (duration: 226.214644ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:22.79494Z","caller":"traceutil/trace.go:171","msg":"trace[807821557] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"105.173314ms","start":"2026-05-08T01:10:22.689734Z","end":"2026-05-08T01:10:22.794908Z","steps":["trace[807821557] 'process raft request' (duration: 77.663196ms)","trace[807821557] 'compare' (duration: 27.338395ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:22.831843Z","caller":"traceutil/trace.go:171","msg":"trace[141792691] linearizableReadLoop","detail":"{readStateIndex:5080; appliedIndex:5077; }","duration":"114.133229ms","start":"2026-05-08T01:10:22.717684Z","end":"2026-05-08T01:10:22.831817Z","steps":["trace[141792691] 'read index received' (duration: 49.800603ms)","trace[141792691] 'applied index is now lower than readState.Index' (duration: 64.330956ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:22.831985Z","caller":"traceutil/trace.go:171","msg":"trace[629601643] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"141.746848ms","start":"2026-05-08T01:10:22.690226Z","end":"2026-05-08T01:10:22.831973Z","steps":["trace[629601643] 'process raft request' (duration: 141.499974ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:22.832107Z","caller":"traceutil/trace.go:171","msg":"trace[2096637914] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"142.063895ms","start":"2026-05-08T01:10:22.689992Z","end":"2026-05-08T01:10:22.832056Z","steps":["trace[2096637914] 'process raft request' (duration: 141.571105ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:22.832329Z","caller":"traceutil/trace.go:171","msg":"trace[598029900] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"106.442947ms","start":"2026-05-08T01:10:22.725799Z","end":"2026-05-08T01:10:22.832242Z","steps":["trace[598029900] 'process raft request' (duration: 105.968438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:22.832417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.71575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T01:10:22.832544Z","caller":"traceutil/trace.go:171","msg":"trace[459543667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4894; }","duration":"114.897273ms","start":"2026-05-08T01:10:22.71763Z","end":"2026-05-08T01:10:22.832527Z","steps":["trace[459543667] 'agreement among raft nodes before linearized reading' (duration: 114.521216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:22.833178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.7784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-08T01:10:22.833232Z","caller":"traceutil/trace.go:171","msg":"trace[360906880] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4894; }","duration":"107.862931ms","start":"2026-05-08T01:10:22.725354Z","end":"2026-05-08T01:10:22.833217Z","steps":["trace[360906880] 'agreement among raft nodes before linearized reading' (duration: 106.990027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:23.075135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.324896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T01:10:23.075319Z","caller":"traceutil/trace.go:171","msg":"trace[1981763333] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"236.631202ms","start":"2026-05-08T01:10:22.838665Z","end":"2026-05-08T01:10:23.075296Z","steps":["trace[1981763333] 'process raft request' (duration: 64.048421ms)","trace[1981763333] 'compare' (duration: 172.200684ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:23.075517Z","caller":"traceutil/trace.go:171","msg":"trace[1059852657] linearizableReadLoop","detail":"{readStateIndex:5084; appliedIndex:5081; }","duration":"230.452315ms","start":"2026-05-08T01:10:22.845039Z","end":"2026-05-08T01:10:23.075491Z","steps":["trace[1059852657] 'read index received' (duration: 29.789007ms)","trace[1059852657] 'applied index is now lower than readState.Index' (duration: 200.661218ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:23.075562Z","caller":"traceutil/trace.go:171","msg":"trace[365897702] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"235.92153ms","start":"2026-05-08T01:10:22.839609Z","end":"2026-05-08T01:10:23.07553Z","steps":["trace[365897702] 'process raft request' (duration: 235.634955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:23.075686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.813114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:10:23.075743Z","caller":"traceutil/trace.go:171","msg":"trace[1002554310] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4897; }","duration":"206.899426ms","start":"2026-05-08T01:10:22.868815Z","end":"2026-05-08T01:10:23.075715Z","steps":["trace[1002554310] 'agreement among raft nodes before linearized reading' (duration: 206.808664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T01:10:23.075796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.745141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"warn","ts":"2026-05-08T01:10:23.075758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.023023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:10:23.075834Z","caller":"traceutil/trace.go:171","msg":"trace[1400427794] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4897; }","duration":"230.821502ms","start":"2026-05-08T01:10:22.845003Z","end":"2026-05-08T01:10:23.075825Z","steps":["trace[1400427794] 'agreement among raft nodes before linearized reading' (duration: 230.624097ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:23.07587Z","caller":"traceutil/trace.go:171","msg":"trace[146821424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4897; }","duration":"126.160276ms","start":"2026-05-08T01:10:22.949683Z","end":"2026-05-08T01:10:23.075843Z","steps":["trace[146821424] 'agreement among raft nodes before linearized reading' (duration: 125.972662ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:10:27.053736Z","caller":"traceutil/trace.go:171","msg":"trace[1111017416] linearizableReadLoop","detail":"{readStateIndex:5109; appliedIndex:5108; }","duration":"102.831168ms","start":"2026-05-08T01:10:26.950876Z","end":"2026-05-08T01:10:27.053707Z","steps":["trace[1111017416] 'read index received' (duration: 75.175323ms)","trace[1111017416] 'applied index is now lower than readState.Index' (duration: 27.654685ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:10:27.054037Z","caller":"traceutil/trace.go:171","msg":"trace[428251283] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"129.67607ms","start":"2026-05-08T01:10:26.924288Z","end":"2026-05-08T01:10:27.053964Z","steps":["trace[428251283] 'process raft request' (duration: 101.734281ms)","trace[428251283] 'compare' (duration: 27.43388ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:10:27.054238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.190444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T01:10:27.054288Z","caller":"traceutil/trace.go:171","msg":"trace[814736710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4921; }","duration":"103.452108ms","start":"2026-05-08T01:10:26.950823Z","end":"2026-05-08T01:10:27.054275Z","steps":["trace[814736710] 'agreement among raft nodes before linearized reading' (duration: 102.983401ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:11:45.35653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2866} {"level":"info","ts":"2026-05-08T01:11:45.458583Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2866,"took":"100.933763ms","hash":4140461114,"current-db-size-bytes":53923840,"current-db-size":"54 MB","current-db-size-in-use-bytes":28983296,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-08T01:11:45.45863Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4140461114,"revision":2866,"compact-revision":-1} {"level":"info","ts":"2026-05-08T01:14:02.024031Z","caller":"traceutil/trace.go:171","msg":"trace[654663452] transaction","detail":"{read_only:false; response_revision:6477; number_of_response:1; }","duration":"103.802336ms","start":"2026-05-08T01:14:01.920204Z","end":"2026-05-08T01:14:02.024006Z","steps":["trace[654663452] 'process raft request' (duration: 103.48562ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:14:02.288357Z","caller":"traceutil/trace.go:171","msg":"trace[1018121654] transaction","detail":"{read_only:false; response_revision:6478; number_of_response:1; }","duration":"106.816486ms","start":"2026-05-08T01:14:02.18151Z","end":"2026-05-08T01:14:02.288326Z","steps":["trace[1018121654] 'process raft request' (duration: 106.656464ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:14:02.329168Z","caller":"traceutil/trace.go:171","msg":"trace[1454948560] linearizableReadLoop","detail":"{readStateIndex:6718; appliedIndex:6716; }","duration":"134.727458ms","start":"2026-05-08T01:14:02.194412Z","end":"2026-05-08T01:14:02.32914Z","steps":["trace[1454948560] 'read index received' (duration: 93.859441ms)","trace[1454948560] 'applied index is now lower than readState.Index' (duration: 40.866637ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T01:14:02.329402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.962911ms","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-05-08T01:14:02.329449Z","caller":"traceutil/trace.go:171","msg":"trace[819504428] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6479; }","duration":"135.052202ms","start":"2026-05-08T01:14:02.194385Z","end":"2026-05-08T01:14:02.329437Z","steps":["trace[819504428] 'agreement among raft nodes before linearized reading' (duration: 134.851329ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:14:02.32951Z","caller":"traceutil/trace.go:171","msg":"trace[1318692279] transaction","detail":"{read_only:false; response_revision:6479; number_of_response:1; }","duration":"147.542062ms","start":"2026-05-08T01:14:02.181948Z","end":"2026-05-08T01:14:02.32949Z","steps":["trace[1318692279] 'process raft request' (duration: 147.032634ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:14:02.534307Z","caller":"traceutil/trace.go:171","msg":"trace[575701790] transaction","detail":"{read_only:false; response_revision:6480; number_of_response:1; }","duration":"198.463866ms","start":"2026-05-08T01:14:02.335802Z","end":"2026-05-08T01:14:02.534266Z","steps":["trace[575701790] 'process raft request' (duration: 181.041208ms)","trace[575701790] 'compare' (duration: 16.85528ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T01:14:03.37472Z","caller":"traceutil/trace.go:171","msg":"trace[141197278] transaction","detail":"{read_only:false; response_revision:6483; number_of_response:1; }","duration":"114.925427ms","start":"2026-05-08T01:14:03.259764Z","end":"2026-05-08T01:14:03.374689Z","steps":["trace[141197278] 'process raft request' (duration: 114.496001ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:14:22.241269Z","caller":"traceutil/trace.go:171","msg":"trace[1920321204] transaction","detail":"{read_only:false; response_revision:6633; number_of_response:1; }","duration":"132.793436ms","start":"2026-05-08T01:14:22.108447Z","end":"2026-05-08T01:14:22.24124Z","steps":["trace[1920321204] 'process raft request' (duration: 122.909222ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T01:16:45.364326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5552} {"level":"info","ts":"2026-05-08T01:16:45.44601Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5552,"took":"80.153293ms","hash":2516164290,"current-db-size-bytes":53923840,"current-db-size":"54 MB","current-db-size-in-use-bytes":18231296,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-08T01:16:45.446155Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2516164290,"revision":5552,"compact-revision":2866}