{"level":"warn","ts":"2026-06-10T08:00:47.728487Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:00:47.728755Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-10T08:00:47.728828Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:00:47.728841Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-06-10T08:00:47.728858Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T08:00:47.729557Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-06-10T08:00:47.729639Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-10T08:00:47.733319Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.425382ms"} {"level":"info","ts":"2026-06-10T08:00:47.738539Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-06-10T08:00:47.738619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T08:00:47.738642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-06-10T08:00:47.73866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T08:00:47.73868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-06-10T08:00:47.738717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-06-10T08:00:47.74574Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T08:00:47.746872Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T08:00:47.748966Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-10T08:00:47.751075Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T08:00:47.751329Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T08:00:47.751281Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T08:00:47.752045Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T08:00:47.753341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-06-10T08:00:47.753532Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-06-10T08:00:47.75212Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T08:00:47.756757Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T08:00:47.756854Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-06-10T08:00:47.756894Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-06-10T08:00:47.757051Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T08:00:47.757086Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T08:00:48.539658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T08:00:48.539758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T08:00:48.539794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-06-10T08:00:48.539818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-06-10T08:00:48.53983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-06-10T08:00:48.539849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-06-10T08:00:48.539871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-06-10T08:00:48.540942Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:00:48.541918Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:00:48.541971Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:00:48.54192Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T08:00:48.542305Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T08:00:48.542342Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T08:00:48.542545Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:00:48.542651Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:00:48.542693Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:00:48.544365Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-06-10T08:00:48.544628Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T08:00:50.151909Z","caller":"traceutil/trace.go:171","msg":"trace[1100964080] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"236.111866ms","start":"2026-06-10T08:00:49.915772Z","end":"2026-06-10T08:00:50.151884Z","steps":["trace[1100964080] 'process raft request' (duration: 235.881874ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.543351Z","caller":"traceutil/trace.go:171","msg":"trace[17262807] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"543.44313ms","start":"2026-06-10T08:00:49.999872Z","end":"2026-06-10T08:00:50.543315Z","steps":["trace[17262807] 'process raft request' (duration: 543.276949ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.543428Z","caller":"traceutil/trace.go:171","msg":"trace[994122386] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"627.45515ms","start":"2026-06-10T08:00:49.915946Z","end":"2026-06-10T08:00:50.543401Z","steps":["trace[994122386] 'read index received' (duration: 235.729712ms)","trace[994122386] 'applied index is now lower than readState.Index' (duration: 391.724028ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:00:50.543833Z","caller":"traceutil/trace.go:171","msg":"trace[1529520173] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"627.978665ms","start":"2026-06-10T08:00:49.915808Z","end":"2026-06-10T08:00:50.543786Z","steps":["trace[1529520173] 'process raft request' (duration: 615.313979ms)","trace[1529520173] 'compare' (duration: 11.857858ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:00:50.544002Z","caller":"traceutil/trace.go:171","msg":"trace[264111471] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"537.93942ms","start":"2026-06-10T08:00:50.006024Z","end":"2026-06-10T08:00:50.543964Z","steps":["trace[264111471] 'process raft request' (duration: 537.336035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.544167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.236896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:50.544196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.006015Z","time spent":"538.038821ms","remote":"127.0.0.1:48384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:50.544224Z","caller":"traceutil/trace.go:171","msg":"trace[882070924] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"544.217547ms","start":"2026-06-10T08:00:49.999956Z","end":"2026-06-10T08:00:50.544174Z","steps":["trace[882070924] 'process raft request' (duration: 543.238648ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.54425Z","caller":"traceutil/trace.go:171","msg":"trace[1580008819] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"546.341637ms","start":"2026-06-10T08:00:49.997897Z","end":"2026-06-10T08:00:50.544238Z","steps":["trace[1580008819] 'agreement among raft nodes before linearized reading' (duration: 546.135415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.544199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:49.999842Z","time spent":"543.617332ms","remote":"127.0.0.1:48698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:50.544229Z","caller":"traceutil/trace.go:171","msg":"trace[327994810] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"539.799587ms","start":"2026-06-10T08:00:50.004369Z","end":"2026-06-10T08:00:50.544169Z","steps":["trace[327994810] 'process raft request' (duration: 538.953869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.544286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:49.997835Z","time spent":"546.442798ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-10T08:00:50.544325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:49.999929Z","time spent":"544.347479ms","remote":"127.0.0.1:48770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:50.544386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.004362Z","time spent":"539.948548ms","remote":"127.0.0.1:48456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:50.544511Z","caller":"traceutil/trace.go:171","msg":"trace[1609335472] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"544.46454ms","start":"2026-06-10T08:00:50.000034Z","end":"2026-06-10T08:00:50.544499Z","steps":["trace[1609335472] 'process raft request' (duration: 543.189968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.544606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.979905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:50.544606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.000028Z","time spent":"544.539711ms","remote":"127.0.0.1:48770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:50.544641Z","caller":"traceutil/trace.go:171","msg":"trace[1077975562] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"477.030345ms","start":"2026-06-10T08:00:50.067597Z","end":"2026-06-10T08:00:50.544628Z","steps":["trace[1077975562] 'agreement among raft nodes before linearized reading' (duration: 476.987945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.544674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.067586Z","time spent":"477.081926ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-10T08:00:50.544755Z","caller":"traceutil/trace.go:171","msg":"trace[1905556142] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"544.709692ms","start":"2026-06-10T08:00:50.000036Z","end":"2026-06-10T08:00:50.544745Z","steps":["trace[1905556142] 'process raft request' (duration: 543.212869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.544802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.000015Z","time spent":"544.761843ms","remote":"127.0.0.1:48770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:50.544848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.189521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:00:50.544875Z","caller":"traceutil/trace.go:171","msg":"trace[329086649] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"495.264431ms","start":"2026-06-10T08:00:50.049602Z","end":"2026-06-10T08:00:50.544867Z","steps":["trace[329086649] 'agreement among raft nodes before linearized reading' (duration: 495.222281ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.54488Z","caller":"traceutil/trace.go:171","msg":"trace[1279813661] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"544.757453ms","start":"2026-06-10T08:00:50.000114Z","end":"2026-06-10T08:00:50.544872Z","steps":["trace[1279813661] 'process raft request' (duration: 543.159428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.5449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.049573Z","time spent":"495.321922ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-10T08:00:50.544898Z","caller":"traceutil/trace.go:171","msg":"trace[1053982446] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"544.42754ms","start":"2026-06-10T08:00:50.000456Z","end":"2026-06-10T08:00:50.544884Z","steps":["trace[1053982446] 'process raft request' (duration: 542.841475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.544916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.000109Z","time spent":"544.789313ms","remote":"127.0.0.1:48770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:50.544515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.56391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:50.54496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.000446Z","time spent":"544.48559ms","remote":"127.0.0.1:48770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:50.544995Z","caller":"traceutil/trace.go:171","msg":"trace[1436746572] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"629.049235ms","start":"2026-06-10T08:00:49.915937Z","end":"2026-06-10T08:00:50.544986Z","steps":["trace[1436746572] 'agreement among raft nodes before linearized reading' (duration: 628.55275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.545022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:49.915931Z","time spent":"629.083645ms","remote":"127.0.0.1:48628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-10T08:00:50.545037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.99592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:00:50.545064Z","caller":"traceutil/trace.go:171","msg":"trace[244844906] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:0; response_revision:11; }","duration":"539.05377ms","start":"2026-06-10T08:00:50.006002Z","end":"2026-06-10T08:00:50.545056Z","steps":["trace[244844906] 'agreement among raft nodes before linearized reading' (duration: 539.01301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.545089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.00599Z","time spent":"539.09335ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-06-10T08:00:50.545155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.078035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:00:50.545192Z","caller":"traceutil/trace.go:171","msg":"trace[1294883188] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"545.144436ms","start":"2026-06-10T08:00:50.000035Z","end":"2026-06-10T08:00:50.545179Z","steps":["trace[1294883188] 'agreement among raft nodes before linearized reading' (duration: 545.068126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.545224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:50.000026Z","time spent":"545.191527ms","remote":"127.0.0.1:48280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-06-10T08:00:50.546289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:49.915794Z","time spent":"628.134566ms","remote":"127.0.0.1:48242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:00:50.84844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.520038ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-10T08:00:50.848774Z","caller":"traceutil/trace.go:171","msg":"trace[1873677111] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"298.885522ms","start":"2026-06-10T08:00:50.54984Z","end":"2026-06-10T08:00:50.848726Z","steps":["trace[1873677111] 'process raft request' (duration: 110.775329ms)","trace[1873677111] 'compare' (duration: 187.349806ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:00:50.849208Z","caller":"traceutil/trace.go:171","msg":"trace[209432759] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"298.266277ms","start":"2026-06-10T08:00:50.550892Z","end":"2026-06-10T08:00:50.849158Z","steps":["trace[209432759] 'process raft request' (duration: 297.702432ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.849239Z","caller":"traceutil/trace.go:171","msg":"trace[465633600] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"297.207318ms","start":"2026-06-10T08:00:50.552017Z","end":"2026-06-10T08:00:50.849225Z","steps":["trace[465633600] 'process raft request' (duration: 297.023666ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.849218Z","caller":"traceutil/trace.go:171","msg":"trace[316593154] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"297.827633ms","start":"2026-06-10T08:00:50.55131Z","end":"2026-06-10T08:00:50.849137Z","steps":["trace[316593154] 'process raft request' (duration: 297.572701ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.849406Z","caller":"traceutil/trace.go:171","msg":"trace[383184999] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"295.502182ms","start":"2026-06-10T08:00:50.553879Z","end":"2026-06-10T08:00:50.849381Z","steps":["trace[383184999] 'process raft request' (duration: 295.337311ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.849433Z","caller":"traceutil/trace.go:171","msg":"trace[583274797] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"295.608763ms","start":"2026-06-10T08:00:50.55379Z","end":"2026-06-10T08:00:50.849399Z","steps":["trace[583274797] 'process raft request' (duration: 295.308621ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.850348Z","caller":"traceutil/trace.go:171","msg":"trace[1564725039] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"296.149167ms","start":"2026-06-10T08:00:50.55414Z","end":"2026-06-10T08:00:50.85029Z","steps":["trace[1564725039] 'process raft request' (duration: 295.136448ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.851258Z","caller":"traceutil/trace.go:171","msg":"trace[1046649044] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"295.447542ms","start":"2026-06-10T08:00:50.554006Z","end":"2026-06-10T08:00:50.849453Z","steps":["trace[1046649044] 'process raft request' (duration: 295.24582ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.851605Z","caller":"traceutil/trace.go:171","msg":"trace[348013361] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:14; }","duration":"244.84469ms","start":"2026-06-10T08:00:50.606744Z","end":"2026-06-10T08:00:50.851589Z","steps":["trace[348013361] 'read index received' (duration: 53.75141ms)","trace[348013361] 'applied index is now lower than readState.Index' (duration: 191.09207ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:00:50.851728Z","caller":"traceutil/trace.go:171","msg":"trace[406317373] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"297.375899ms","start":"2026-06-10T08:00:50.554333Z","end":"2026-06-10T08:00:50.851709Z","steps":["trace[406317373] 'process raft request' (duration: 295.100439ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:50.851759Z","caller":"traceutil/trace.go:171","msg":"trace[1011000105] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"294.516753ms","start":"2026-06-10T08:00:50.557229Z","end":"2026-06-10T08:00:50.851746Z","steps":["trace[1011000105] 'process raft request' (duration: 294.2935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:50.852206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.335044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-06-10T08:00:50.852259Z","caller":"traceutil/trace.go:171","msg":"trace[383044080] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"245.542386ms","start":"2026-06-10T08:00:50.606704Z","end":"2026-06-10T08:00:50.852247Z","steps":["trace[383044080] 'agreement among raft nodes before linearized reading' (duration: 245.327444ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:38.584223Z","caller":"traceutil/trace.go:171","msg":"trace[1275190133] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"105.359289ms","start":"2026-06-10T08:01:38.478808Z","end":"2026-06-10T08:01:38.584167Z","steps":["trace[1275190133] 'process raft request' (duration: 105.158112ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:38.591613Z","caller":"traceutil/trace.go:171","msg":"trace[600022019] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"100.843133ms","start":"2026-06-10T08:01:38.490749Z","end":"2026-06-10T08:01:38.591592Z","steps":["trace[600022019] 'process raft request' (duration: 100.669187ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:38.591917Z","caller":"traceutil/trace.go:171","msg":"trace[1673758759] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"101.07157ms","start":"2026-06-10T08:01:38.490837Z","end":"2026-06-10T08:01:38.591909Z","steps":["trace[1673758759] 'process raft request' (duration: 100.694668ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:38.59201Z","caller":"traceutil/trace.go:171","msg":"trace[1140317950] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"101.010978ms","start":"2026-06-10T08:01:38.490992Z","end":"2026-06-10T08:01:38.592003Z","steps":["trace[1140317950] 'process raft request' (duration: 100.589445ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:44.540303Z","caller":"traceutil/trace.go:171","msg":"trace[276585961] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"154.720893ms","start":"2026-06-10T08:01:44.385549Z","end":"2026-06-10T08:01:44.54027Z","steps":["trace[276585961] 'read index received' (duration: 153.620979ms)","trace[276585961] 'applied index is now lower than readState.Index' (duration: 1.098334ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:01:44.540436Z","caller":"traceutil/trace.go:171","msg":"trace[622987036] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"207.130732ms","start":"2026-06-10T08:01:44.333257Z","end":"2026-06-10T08:01:44.540388Z","steps":["trace[622987036] 'process raft request' (duration: 206.191604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:44.540821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.204627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-10T08:01:44.540942Z","caller":"traceutil/trace.go:171","msg":"trace[2034937324] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"155.407003ms","start":"2026-06-10T08:01:44.385501Z","end":"2026-06-10T08:01:44.540908Z","steps":["trace[2034937324] 'agreement among raft nodes before linearized reading' (duration: 154.959479ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:44.933241Z","caller":"traceutil/trace.go:171","msg":"trace[676073493] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"385.050053ms","start":"2026-06-10T08:01:44.548146Z","end":"2026-06-10T08:01:44.933197Z","steps":["trace[676073493] 'process raft request' (duration: 384.730224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:44.933662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:44.548118Z","time spent":"385.308431ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:01:45.391467Z","caller":"traceutil/trace.go:171","msg":"trace[1646024854] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"163.980978ms","start":"2026-06-10T08:01:45.227463Z","end":"2026-06-10T08:01:45.391444Z","steps":["trace[1646024854] 'read index received' (duration: 163.724301ms)","trace[1646024854] 'applied index is now lower than readState.Index' (duration: 255.587µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:01:45.39163Z","caller":"traceutil/trace.go:171","msg":"trace[104751933] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"831.684745ms","start":"2026-06-10T08:01:44.559893Z","end":"2026-06-10T08:01:45.391577Z","steps":["trace[104751933] 'process raft request' (duration: 831.371216ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:45.391784Z","caller":"traceutil/trace.go:171","msg":"trace[1912371108] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"793.438067ms","start":"2026-06-10T08:01:44.598309Z","end":"2026-06-10T08:01:45.391747Z","steps":["trace[1912371108] 'process raft request' (duration: 793.090097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:45.39187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.39129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:01:45.391914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:44.59828Z","time spent":"793.559001ms","remote":"127.0.0.1:48754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:45.391965Z","caller":"traceutil/trace.go:171","msg":"trace[247664610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"164.550165ms","start":"2026-06-10T08:01:45.227395Z","end":"2026-06-10T08:01:45.391945Z","steps":["trace[247664610] 'agreement among raft nodes before linearized reading' (duration: 164.363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:45.392158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:44.559873Z","time spent":"831.945173ms","remote":"127.0.0.1:48388","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-06-10T08:01:46.454965Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869985015725907,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:01:46.612939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.232447ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:01:46.613132Z","caller":"traceutil/trace.go:171","msg":"trace[918634572] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:631; }","duration":"412.439913ms","start":"2026-06-10T08:01:46.200665Z","end":"2026-06-10T08:01:46.613105Z","steps":["trace[918634572] 'range keys from in-memory index tree' (duration: 412.213326ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:46.745938Z","caller":"traceutil/trace.go:171","msg":"trace[1957977311] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"791.029047ms","start":"2026-06-10T08:01:45.954882Z","end":"2026-06-10T08:01:46.745911Z","steps":["trace[1957977311] 'read index received' (duration: 790.13645ms)","trace[1957977311] 'applied index is now lower than readState.Index' (duration: 891.357µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:01:46.746018Z","caller":"traceutil/trace.go:171","msg":"trace[2052456898] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"927.568035ms","start":"2026-06-10T08:01:45.81839Z","end":"2026-06-10T08:01:46.745958Z","steps":["trace[2052456898] 'process raft request' (duration: 926.883975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:46.746262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.648332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-10T08:01:46.746331Z","caller":"traceutil/trace.go:171","msg":"trace[992822069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"551.783877ms","start":"2026-06-10T08:01:46.194532Z","end":"2026-06-10T08:01:46.746316Z","steps":["trace[992822069] 'agreement among raft nodes before linearized reading' (duration: 551.57491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:46.746311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.404527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-10T08:01:46.746331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.041693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-10T08:01:46.746384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:46.194507Z","time spent":"551.865958ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:01:46.746258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:45.818357Z","time spent":"927.758171ms","remote":"127.0.0.1:48292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:01:46.746398Z","caller":"traceutil/trace.go:171","msg":"trace[501230167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"791.564713ms","start":"2026-06-10T08:01:45.954814Z","end":"2026-06-10T08:01:46.746379Z","steps":["trace[501230167] 'agreement among raft nodes before linearized reading' (duration: 791.209212ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:46.746413Z","caller":"traceutil/trace.go:171","msg":"trace[405957222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"576.142526ms","start":"2026-06-10T08:01:46.170253Z","end":"2026-06-10T08:01:46.746396Z","steps":["trace[405957222] 'agreement among raft nodes before linearized reading' (duration: 575.856428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:46.746461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:46.170154Z","time spent":"576.299281ms","remote":"127.0.0.1:48466","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-06-10T08:01:46.746545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:45.954785Z","time spent":"791.749108ms","remote":"127.0.0.1:48466","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-06-10T08:02:01.702185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.200937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nbc7l\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-10T08:02:01.702313Z","caller":"traceutil/trace.go:171","msg":"trace[1903938281] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nbc7l; range_end:; response_count:1; response_revision:788; }","duration":"136.399562ms","start":"2026-06-10T08:02:01.565887Z","end":"2026-06-10T08:02:01.702286Z","steps":["trace[1903938281] 'range keys from in-memory index tree' (duration: 135.93778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:02.085988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:02:01.704388Z","time spent":"381.596194ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-10T08:02:02.197991Z","caller":"traceutil/trace.go:171","msg":"trace[1346267767] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"485.815969ms","start":"2026-06-10T08:02:01.712153Z","end":"2026-06-10T08:02:02.197969Z","steps":["trace[1346267767] 'process raft request' (duration: 485.531092ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:02:02.198176Z","caller":"traceutil/trace.go:171","msg":"trace[2005025677] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"235.778401ms","start":"2026-06-10T08:02:01.962359Z","end":"2026-06-10T08:02:02.198137Z","steps":["trace[2005025677] 'process raft request' (duration: 235.538705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:02.198623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:02:01.712123Z","time spent":"485.988674ms","remote":"127.0.0.1:48388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:02:02.201932Z","caller":"traceutil/trace.go:171","msg":"trace[358906212] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"114.491593ms","start":"2026-06-10T08:02:02.087406Z","end":"2026-06-10T08:02:02.201898Z","steps":["trace[358906212] 'process raft request' (duration: 113.827136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:20.878554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.180739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-75c4c745bc\" ","response":"range_response_count:1 size:4425"} {"level":"info","ts":"2026-06-10T08:02:20.878734Z","caller":"traceutil/trace.go:171","msg":"trace[1628087463] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-75c4c745bc; range_end:; response_count:1; response_revision:1087; }","duration":"152.361643ms","start":"2026-06-10T08:02:20.726287Z","end":"2026-06-10T08:02:20.878649Z","steps":["trace[1628087463] 'agreement among raft nodes before linearized reading' (duration: 152.129418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:20.879065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.255078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-webhook-548949fc64\" ","response":"range_response_count:1 size:4690"} {"level":"info","ts":"2026-06-10T08:02:20.879865Z","caller":"traceutil/trace.go:171","msg":"trace[423325095] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-webhook-548949fc64; range_end:; response_count:1; response_revision:1087; }","duration":"152.096967ms","start":"2026-06-10T08:02:20.727723Z","end":"2026-06-10T08:02:20.87982Z","steps":["trace[423325095] 'agreement among raft nodes before linearized reading' (duration: 151.108065ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:02:21.477395Z","caller":"traceutil/trace.go:171","msg":"trace[350956115] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"146.086657ms","start":"2026-06-10T08:02:21.331265Z","end":"2026-06-10T08:02:21.477351Z","steps":["trace[350956115] 'process raft request' (duration: 122.100411ms)","trace[350956115] 'compare' (duration: 23.734451ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:02:21.485976Z","caller":"traceutil/trace.go:171","msg":"trace[1402438337] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"120.003884ms","start":"2026-06-10T08:02:21.365922Z","end":"2026-06-10T08:02:21.485926Z","steps":["trace[1402438337] 'process raft request' (duration: 119.83112ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:02:32.214025Z","caller":"traceutil/trace.go:171","msg":"trace[1217784699] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"312.647164ms","start":"2026-06-10T08:02:31.901346Z","end":"2026-06-10T08:02:32.213993Z","steps":["trace[1217784699] 'process raft request' (duration: 257.680585ms)","trace[1217784699] 'compare' (duration: 54.614272ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:02:32.21421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:02:31.901319Z","time spent":"312.793356ms","remote":"127.0.0.1:48218","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-06-10T08:02:55.09037Z","caller":"traceutil/trace.go:171","msg":"trace[1033487621] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"138.147635ms","start":"2026-06-10T08:02:54.952189Z","end":"2026-06-10T08:02:55.090336Z","steps":["trace[1033487621] 'process raft request' (duration: 137.924961ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:03:20.91492Z","caller":"traceutil/trace.go:171","msg":"trace[1122579678] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"300.203091ms","start":"2026-06-10T08:03:20.614685Z","end":"2026-06-10T08:03:20.914888Z","steps":["trace[1122579678] 'process raft request' (duration: 299.994878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:20.915138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:20.614658Z","time spent":"300.363625ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:03:21.271473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.283386ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:03:21.271618Z","caller":"traceutil/trace.go:171","msg":"trace[1231514406] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1957; }","duration":"472.126627ms","start":"2026-06-10T08:03:20.799468Z","end":"2026-06-10T08:03:21.271594Z","steps":["trace[1231514406] 'read index received' (duration: 115.265529ms)","trace[1231514406] 'applied index is now lower than readState.Index' (duration: 356.859458ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:03:21.271752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.285099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:03:21.271792Z","caller":"traceutil/trace.go:171","msg":"trace[832389160] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1884; }","duration":"472.3299ms","start":"2026-06-10T08:03:20.79945Z","end":"2026-06-10T08:03:21.27178Z","steps":["trace[832389160] 'agreement among raft nodes before linearized reading' (duration: 472.253359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.271828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:20.799373Z","time spent":"472.445302ms","remote":"127.0.0.1:59910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-10T08:03:21.271736Z","caller":"traceutil/trace.go:171","msg":"trace[282387971] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"558.434019ms","start":"2026-06-10T08:03:20.713261Z","end":"2026-06-10T08:03:21.271695Z","steps":["trace[282387971] 'process raft request' (duration: 428.821947ms)","trace[282387971] 'compare' (duration: 129.097844ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:03:21.272115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:20.713205Z","time spent":"558.759334ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:03:21.319233Z","caller":"traceutil/trace.go:171","msg":"trace[2124824472] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"129.632213ms","start":"2026-06-10T08:03:21.189565Z","end":"2026-06-10T08:03:21.319197Z","steps":["trace[2124824472] 'process raft request' (duration: 129.42617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.348854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.458998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b27f86b0-53e9-4a47-88f1-8986560d5754\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-10T08:03:21.348945Z","caller":"traceutil/trace.go:171","msg":"trace[961537714] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"129.146825ms","start":"2026-06-10T08:03:21.219742Z","end":"2026-06-10T08:03:21.348889Z","steps":["trace[961537714] 'process raft request' (duration: 128.743298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.348981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.896978ms","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-06-10T08:03:21.349247Z","caller":"traceutil/trace.go:171","msg":"trace[57915061] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1886; }","duration":"310.241924ms","start":"2026-06-10T08:03:21.038982Z","end":"2026-06-10T08:03:21.349224Z","steps":["trace[57915061] 'agreement among raft nodes before linearized reading' (duration: 309.720176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.349306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:21.038948Z","time spent":"310.343145ms","remote":"127.0.0.1:38900","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-06-10T08:03:21.348935Z","caller":"traceutil/trace.go:171","msg":"trace[1367010211] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b27f86b0-53e9-4a47-88f1-8986560d5754; range_end:; response_count:1; response_revision:1886; }","duration":"348.585829ms","start":"2026-06-10T08:03:21.00033Z","end":"2026-06-10T08:03:21.348916Z","steps":["trace[1367010211] 'agreement among raft nodes before linearized reading' (duration: 348.385786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.349429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.678966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-10T08:03:21.349505Z","caller":"traceutil/trace.go:171","msg":"trace[708780152] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1886; }","duration":"548.782208ms","start":"2026-06-10T08:03:20.800698Z","end":"2026-06-10T08:03:21.34948Z","steps":["trace[708780152] 'agreement among raft nodes before linearized reading' (duration: 548.653146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.349556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:20.800669Z","time spent":"548.876739ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T08:03:21.348965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.864227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:03:21.349667Z","caller":"traceutil/trace.go:171","msg":"trace[2046543701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1886; }","duration":"122.63385ms","start":"2026-06-10T08:03:21.227021Z","end":"2026-06-10T08:03:21.349655Z","steps":["trace[2046543701] 'agreement among raft nodes before linearized reading' (duration: 121.869918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.349543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:21.000308Z","time spent":"349.140949ms","remote":"127.0.0.1:48388","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-b27f86b0-53e9-4a47-88f1-8986560d5754\" "} {"level":"warn","ts":"2026-06-10T08:03:21.962636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.335999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:03:21.962738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.456332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T08:03:21.962842Z","caller":"traceutil/trace.go:171","msg":"trace[1740224168] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:1892; }","duration":"301.578484ms","start":"2026-06-10T08:03:21.66124Z","end":"2026-06-10T08:03:21.962818Z","steps":["trace[1740224168] 'range keys from in-memory index tree' (duration: 301.218109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.962902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:21.661201Z","time spent":"301.687486ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"info","ts":"2026-06-10T08:03:21.962861Z","caller":"traceutil/trace.go:171","msg":"trace[684407714] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1892; }","duration":"347.661055ms","start":"2026-06-10T08:03:21.615138Z","end":"2026-06-10T08:03:21.962799Z","steps":["trace[684407714] 'count revisions from in-memory index tree' (duration: 347.256029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:21.963307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:21.615119Z","time spent":"348.164893ms","remote":"127.0.0.1:39514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-10T08:03:21.96363Z","caller":"traceutil/trace.go:171","msg":"trace[512997722] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"137.864625ms","start":"2026-06-10T08:03:21.825743Z","end":"2026-06-10T08:03:21.963607Z","steps":["trace[512997722] 'process raft request' (duration: 105.838671ms)","trace[512997722] 'compare' (duration: 30.920966ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:03:33.977553Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869985015728619,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:03:34.031759Z","caller":"traceutil/trace.go:171","msg":"trace[1563148050] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"720.11895ms","start":"2026-06-10T08:03:33.311603Z","end":"2026-06-10T08:03:34.031722Z","steps":["trace[1563148050] 'process raft request' (duration: 719.835036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.031979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.311571Z","time spent":"720.288253ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:03:34.039276Z","caller":"traceutil/trace.go:171","msg":"trace[1472965959] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"572.474909ms","start":"2026-06-10T08:03:33.466786Z","end":"2026-06-10T08:03:34.039261Z","steps":["trace[1472965959] 'process raft request' (duration: 572.251796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.039359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.46675Z","time spent":"572.567831ms","remote":"127.0.0.1:48466","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-06-10T08:03:34.039439Z","caller":"traceutil/trace.go:171","msg":"trace[412744362] linearizableReadLoop","detail":"{readStateIndex:2067; appliedIndex:2064; }","duration":"561.942808ms","start":"2026-06-10T08:03:33.477473Z","end":"2026-06-10T08:03:34.039416Z","steps":["trace[412744362] 'read index received' (duration: 553.922685ms)","trace[412744362] 'applied index is now lower than readState.Index' (duration: 8.019073ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:03:34.039829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.509198ms","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-06-10T08:03:34.039863Z","caller":"traceutil/trace.go:171","msg":"trace[319979882] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1989; }","duration":"553.558768ms","start":"2026-06-10T08:03:33.486292Z","end":"2026-06-10T08:03:34.03985Z","steps":["trace[319979882] 'agreement among raft nodes before linearized reading' (duration: 553.395446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.039883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.486282Z","time spent":"553.596879ms","remote":"127.0.0.1:38900","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-06-10T08:03:34.039966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.487327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-10T08:03:34.039999Z","caller":"traceutil/trace.go:171","msg":"trace[1918937463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1989; }","duration":"510.562048ms","start":"2026-06-10T08:03:33.529427Z","end":"2026-06-10T08:03:34.039989Z","steps":["trace[1918937463] 'agreement among raft nodes before linearized reading' (duration: 510.408395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.040022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.529415Z","time spent":"510.600729ms","remote":"127.0.0.1:48466","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-06-10T08:03:34.040038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.234388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T08:03:34.040063Z","caller":"traceutil/trace.go:171","msg":"trace[998676012] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1989; }","duration":"537.276369ms","start":"2026-06-10T08:03:33.50278Z","end":"2026-06-10T08:03:34.040057Z","steps":["trace[998676012] 'agreement among raft nodes before linearized reading' (duration: 537.213288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.040087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.502771Z","time spent":"537.307519ms","remote":"127.0.0.1:48466","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-06-10T08:03:34.040133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.670899ms","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-06-10T08:03:34.040156Z","caller":"traceutil/trace.go:171","msg":"trace[1883396341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1989; }","duration":"562.7434ms","start":"2026-06-10T08:03:33.477404Z","end":"2026-06-10T08:03:34.040148Z","steps":["trace[1883396341] 'agreement among raft nodes before linearized reading' (duration: 562.686879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.040174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.477378Z","time spent":"562.79157ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:03:34.040235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.429911ms","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-06-10T08:03:34.040261Z","caller":"traceutil/trace.go:171","msg":"trace[511033161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1989; }","duration":"537.471482ms","start":"2026-06-10T08:03:33.502782Z","end":"2026-06-10T08:03:34.040254Z","steps":["trace[511033161] 'agreement among raft nodes before linearized reading' (duration: 537.39059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.040279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.502775Z","time spent":"537.500062ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:03:34.040288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.94944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"} {"level":"info","ts":"2026-06-10T08:03:34.040307Z","caller":"traceutil/trace.go:171","msg":"trace[1403509663] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1989; }","duration":"315.019491ms","start":"2026-06-10T08:03:33.725282Z","end":"2026-06-10T08:03:34.040301Z","steps":["trace[1403509663] 'agreement among raft nodes before linearized reading' (duration: 314.95253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.040331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.725254Z","time spent":"315.073542ms","remote":"127.0.0.1:48388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12011,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-10T08:03:34.040389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.366752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-10T08:03:34.040406Z","caller":"traceutil/trace.go:171","msg":"trace[32109823] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1989; }","duration":"541.463723ms","start":"2026-06-10T08:03:33.498937Z","end":"2026-06-10T08:03:34.040401Z","steps":["trace[32109823] 'agreement among raft nodes before linearized reading' (duration: 541.409102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:34.040422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:33.498922Z","time spent":"541.496703ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T08:03:49.273679Z","caller":"traceutil/trace.go:171","msg":"trace[1506848985] linearizableReadLoop","detail":"{readStateIndex:2172; appliedIndex:2171; }","duration":"143.422189ms","start":"2026-06-10T08:03:49.130232Z","end":"2026-06-10T08:03:49.273654Z","steps":["trace[1506848985] 'read index received' (duration: 143.202476ms)","trace[1506848985] 'applied index is now lower than readState.Index' (duration: 218.493µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:03:49.27375Z","caller":"traceutil/trace.go:171","msg":"trace[2144468561] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"249.564183ms","start":"2026-06-10T08:03:49.024133Z","end":"2026-06-10T08:03:49.273697Z","steps":["trace[2144468561] 'process raft request' (duration: 249.334279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:49.274051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.800834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"warn","ts":"2026-06-10T08:03:49.274051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.645214ms","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-06-10T08:03:49.274132Z","caller":"traceutil/trace.go:171","msg":"trace[853576658] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2090; }","duration":"143.947077ms","start":"2026-06-10T08:03:49.130165Z","end":"2026-06-10T08:03:49.274112Z","steps":["trace[853576658] 'agreement among raft nodes before linearized reading' (duration: 143.652673ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:03:49.274136Z","caller":"traceutil/trace.go:171","msg":"trace[933471112] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2090; }","duration":"109.863058ms","start":"2026-06-10T08:03:49.164254Z","end":"2026-06-10T08:03:49.274117Z","steps":["trace[933471112] 'agreement among raft nodes before linearized reading' (duration: 109.579504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:56.871233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.044325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:03:56.871767Z","caller":"traceutil/trace.go:171","msg":"trace[769575094] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2210; }","duration":"647.100797ms","start":"2026-06-10T08:03:56.224462Z","end":"2026-06-10T08:03:56.871563Z","steps":["trace[769575094] 'read index received' (duration: 6.063037ms)","trace[769575094] 'applied index is now lower than readState.Index' (duration: 641.03614ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:03:56.871889Z","caller":"traceutil/trace.go:171","msg":"trace[701353007] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"655.06248ms","start":"2026-06-10T08:03:56.21681Z","end":"2026-06-10T08:03:56.871873Z","steps":["trace[701353007] 'process raft request' (duration: 211.236244ms)","trace[701353007] 'compare' (duration: 442.67536ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:03:56.87195Z","caller":"traceutil/trace.go:171","msg":"trace[382679630] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"654.194089ms","start":"2026-06-10T08:03:56.217704Z","end":"2026-06-10T08:03:56.871898Z","steps":["trace[382679630] 'process raft request' (duration: 653.764373ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:03:56.872166Z","caller":"traceutil/trace.go:171","msg":"trace[397501694] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"653.560449ms","start":"2026-06-10T08:03:56.218565Z","end":"2026-06-10T08:03:56.872125Z","steps":["trace[397501694] 'process raft request' (duration: 652.9394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:56.872246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:56.216794Z","time spent":"655.126952ms","remote":"127.0.0.1:48466","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-06-10T08:03:56.872251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:56.217696Z","time spent":"654.417072ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:03:56.872376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:56.218535Z","time spent":"653.723082ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:03:56.872576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.110951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:03:56.872583Z","caller":"traceutil/trace.go:171","msg":"trace[1826130539] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"655.544678ms","start":"2026-06-10T08:03:56.21696Z","end":"2026-06-10T08:03:56.872504Z","steps":["trace[1826130539] 'process raft request' (duration: 654.407611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:56.872803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:56.21695Z","time spent":"655.73599ms","remote":"127.0.0.1:48466","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-06-10T08:03:56.872619Z","caller":"traceutil/trace.go:171","msg":"trace[1750099812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2131; }","duration":"648.179832ms","start":"2026-06-10T08:03:56.224424Z","end":"2026-06-10T08:03:56.872604Z","steps":["trace[1750099812] 'agreement among raft nodes before linearized reading' (duration: 648.05472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:56.873156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:56.224414Z","time spent":"648.72827ms","remote":"127.0.0.1:48176","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-06-10T08:03:56.886759Z","caller":"traceutil/trace.go:171","msg":"trace[1811488213] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"323.724041ms","start":"2026-06-10T08:03:56.563009Z","end":"2026-06-10T08:03:56.886733Z","steps":["trace[1811488213] 'process raft request' (duration: 323.560259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:56.886964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:56.56297Z","time spent":"323.882773ms","remote":"127.0.0.1:48384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:03:56.92593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.801279ms","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-06-10T08:03:56.925931Z","caller":"traceutil/trace.go:171","msg":"trace[869386469] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"286.306564ms","start":"2026-06-10T08:03:56.639586Z","end":"2026-06-10T08:03:56.925892Z","steps":["trace[869386469] 'process raft request' (duration: 285.998149ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:03:56.925999Z","caller":"traceutil/trace.go:171","msg":"trace[1268518912] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2133; }","duration":"542.90732ms","start":"2026-06-10T08:03:56.383073Z","end":"2026-06-10T08:03:56.925981Z","steps":["trace[1268518912] 'agreement among raft nodes before linearized reading' (duration: 542.690877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:56.926239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:56.383054Z","time spent":"543.170595ms","remote":"127.0.0.1:38900","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-06-10T08:03:57.874412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.196292ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-10T08:03:57.875019Z","caller":"traceutil/trace.go:171","msg":"trace[480705886] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"493.812526ms","start":"2026-06-10T08:03:57.381185Z","end":"2026-06-10T08:03:57.874998Z","steps":["trace[480705886] 'process raft request' (duration: 493.37268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:57.875148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:57.381149Z","time spent":"493.920317ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:03:57.8749Z","caller":"traceutil/trace.go:171","msg":"trace[331889400] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2217; }","duration":"648.300379ms","start":"2026-06-10T08:03:57.226574Z","end":"2026-06-10T08:03:57.874874Z","steps":["trace[331889400] 'read index received' (duration: 72.931µs)","trace[331889400] 'applied index is now lower than readState.Index' (duration: 648.225048ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:03:57.876287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.70138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:03:57.876382Z","caller":"traceutil/trace.go:171","msg":"trace[644022325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2134; }","duration":"649.856492ms","start":"2026-06-10T08:03:57.226504Z","end":"2026-06-10T08:03:57.876361Z","steps":["trace[644022325] 'agreement among raft nodes before linearized reading' (duration: 649.696259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:57.876427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:57.226472Z","time spent":"649.945974ms","remote":"127.0.0.1:48176","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-06-10T08:03:57.876427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.204137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:03:57.876476Z","caller":"traceutil/trace.go:171","msg":"trace[890768045] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2134; }","duration":"382.331359ms","start":"2026-06-10T08:03:57.494132Z","end":"2026-06-10T08:03:57.876463Z","steps":["trace[890768045] 'agreement among raft nodes before linearized reading' (duration: 382.189937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:57.876512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:57.494095Z","time spent":"382.40522ms","remote":"127.0.0.1:48388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":22,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-06-10T08:03:58.603328Z","caller":"traceutil/trace.go:171","msg":"trace[1317748643] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"397.477121ms","start":"2026-06-10T08:03:58.205813Z","end":"2026-06-10T08:03:58.60329Z","steps":["trace[1317748643] 'process raft request' (duration: 397.140456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:58.604079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:58.205788Z","time spent":"397.649683ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:03:58.959003Z","caller":"traceutil/trace.go:171","msg":"trace[115149186] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"737.974028ms","start":"2026-06-10T08:03:58.220982Z","end":"2026-06-10T08:03:58.958956Z","steps":["trace[115149186] 'process raft request' (duration: 685.874763ms)","trace[115149186] 'compare' (duration: 51.647618ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:03:58.959256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.173862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:03:58.959307Z","caller":"traceutil/trace.go:171","msg":"trace[268012781] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2138; }","duration":"673.368695ms","start":"2026-06-10T08:03:58.28593Z","end":"2026-06-10T08:03:58.959298Z","steps":["trace[268012781] 'agreement among raft nodes before linearized reading' (duration: 673.140811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:58.959348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:58.285903Z","time spent":"673.434166ms","remote":"127.0.0.1:48688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:03:58.959715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:58.220882Z","time spent":"738.354913ms","remote":"127.0.0.1:48466","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-06-10T08:03:58.959013Z","caller":"traceutil/trace.go:171","msg":"trace[19214533] linearizableReadLoop","detail":"{readStateIndex:2222; appliedIndex:2219; }","duration":"672.919608ms","start":"2026-06-10T08:03:58.286071Z","end":"2026-06-10T08:03:58.958991Z","steps":["trace[19214533] 'read index received' (duration: 316.92585ms)","trace[19214533] 'applied index is now lower than readState.Index' (duration: 355.992318ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:03:58.959106Z","caller":"traceutil/trace.go:171","msg":"trace[1701850235] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"737.073255ms","start":"2026-06-10T08:03:58.22202Z","end":"2026-06-10T08:03:58.959093Z","steps":["trace[1701850235] 'process raft request' (duration: 736.811851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:58.960221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:58.221962Z","time spent":"738.12078ms","remote":"127.0.0.1:48466","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-06-10T08:03:58.960406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.979883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b7a99384f31e2f\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-06-10T08:03:58.960399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.781168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T08:03:58.960459Z","caller":"traceutil/trace.go:171","msg":"trace[981189536] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b7a99384f31e2f; range_end:; response_count:1; response_revision:2138; }","duration":"241.084005ms","start":"2026-06-10T08:03:58.719362Z","end":"2026-06-10T08:03:58.960446Z","steps":["trace[981189536] 'agreement among raft nodes before linearized reading' (duration: 240.984944ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:03:58.9605Z","caller":"traceutil/trace.go:171","msg":"trace[159024772] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2138; }","duration":"649.935609ms","start":"2026-06-10T08:03:58.310539Z","end":"2026-06-10T08:03:58.960474Z","steps":["trace[159024772] 'agreement among raft nodes before linearized reading' (duration: 649.534884ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:03:58.959156Z","caller":"traceutil/trace.go:171","msg":"trace[1809401100] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"103.736672ms","start":"2026-06-10T08:03:58.855412Z","end":"2026-06-10T08:03:58.959149Z","steps":["trace[1809401100] 'process raft request' (duration: 103.54069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:58.960715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.354367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"warn","ts":"2026-06-10T08:03:58.960754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.85089ms","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-06-10T08:03:58.960807Z","caller":"traceutil/trace.go:171","msg":"trace[1035030265] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2138; }","duration":"335.943761ms","start":"2026-06-10T08:03:58.624846Z","end":"2026-06-10T08:03:58.960789Z","steps":["trace[1035030265] 'agreement among raft nodes before linearized reading' (duration: 335.86498ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:03:58.960834Z","caller":"traceutil/trace.go:171","msg":"trace[1265977260] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2138; }","duration":"308.453559ms","start":"2026-06-10T08:03:58.652323Z","end":"2026-06-10T08:03:58.960776Z","steps":["trace[1265977260] 'agreement among raft nodes before linearized reading' (duration: 308.293026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:03:58.960853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:58.624822Z","time spent":"336.022933ms","remote":"127.0.0.1:48448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:03:58.960858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:58.310518Z","time spent":"650.279184ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T08:03:58.960893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:03:58.65231Z","time spent":"308.57271ms","remote":"127.0.0.1:48394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2012,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-06-10T08:05:33.405024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.199265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:05:33.405119Z","caller":"traceutil/trace.go:171","msg":"trace[284897309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2751; }","duration":"180.360552ms","start":"2026-06-10T08:05:33.224737Z","end":"2026-06-10T08:05:33.405097Z","steps":["trace[284897309] 'range keys from in-memory index tree' (duration: 180.0544ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:05:38.939472Z","caller":"traceutil/trace.go:171","msg":"trace[1805748612] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"143.35956ms","start":"2026-06-10T08:05:38.796062Z","end":"2026-06-10T08:05:38.939422Z","steps":["trace[1805748612] 'process raft request' (duration: 143.141742ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:08:02.095775Z","caller":"traceutil/trace.go:171","msg":"trace[1152103413] transaction","detail":"{read_only:false; response_revision:3625; number_of_response:1; }","duration":"119.21411ms","start":"2026-06-10T08:08:01.976509Z","end":"2026-06-10T08:08:02.095723Z","steps":["trace[1152103413] 'process raft request' (duration: 118.914884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:08:37.761572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.272088ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:08:37.761884Z","caller":"traceutil/trace.go:171","msg":"trace[1379577103] transaction","detail":"{read_only:false; response_revision:3848; number_of_response:1; }","duration":"244.569082ms","start":"2026-06-10T08:08:37.517292Z","end":"2026-06-10T08:08:37.761861Z","steps":["trace[1379577103] 'process raft request' (duration: 123.962836ms)","trace[1379577103] 'compare' (duration: 119.84112ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:08:37.761992Z","caller":"traceutil/trace.go:171","msg":"trace[1873472032] linearizableReadLoop","detail":"{readStateIndex:4000; appliedIndex:3999; }","duration":"243.51071ms","start":"2026-06-10T08:08:37.518444Z","end":"2026-06-10T08:08:37.761955Z","steps":["trace[1873472032] 'read index received' (duration: 122.798332ms)","trace[1873472032] 'applied index is now lower than readState.Index' (duration: 120.710358ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:08:37.762115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.665293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagers.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:08:37.762145Z","caller":"traceutil/trace.go:171","msg":"trace[1619191346] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagers.monitoring.coreos.com; range_end:; response_count:0; response_revision:3848; }","duration":"243.736445ms","start":"2026-06-10T08:08:37.518401Z","end":"2026-06-10T08:08:37.762137Z","steps":["trace[1619191346] 'agreement among raft nodes before linearized reading' (duration: 243.670503ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:08:37.762717Z","caller":"traceutil/trace.go:171","msg":"trace[1232639837] transaction","detail":"{read_only:false; response_revision:3849; number_of_response:1; }","duration":"200.854703ms","start":"2026-06-10T08:08:37.561856Z","end":"2026-06-10T08:08:37.762711Z","steps":["trace[1232639837] 'process raft request' (duration: 200.157548ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.250691Z","caller":"traceutil/trace.go:171","msg":"trace[1852108996] transaction","detail":"{read_only:false; response_revision:4170; number_of_response:1; }","duration":"154.136664ms","start":"2026-06-10T08:09:24.096528Z","end":"2026-06-10T08:09:24.250665Z","steps":["trace[1852108996] 'process raft request' (duration: 150.799519ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.329395Z","caller":"traceutil/trace.go:171","msg":"trace[454902302] transaction","detail":"{read_only:false; response_revision:4171; number_of_response:1; }","duration":"232.043737ms","start":"2026-06-10T08:09:24.097307Z","end":"2026-06-10T08:09:24.329351Z","steps":["trace[454902302] 'process raft request' (duration: 231.70321ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.32949Z","caller":"traceutil/trace.go:171","msg":"trace[354381349] transaction","detail":"{read_only:false; response_revision:4172; number_of_response:1; }","duration":"232.118208ms","start":"2026-06-10T08:09:24.097342Z","end":"2026-06-10T08:09:24.329461Z","steps":["trace[354381349] 'process raft request' (duration: 231.913074ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.329755Z","caller":"traceutil/trace.go:171","msg":"trace[1111289671] transaction","detail":"{read_only:false; response_revision:4174; number_of_response:1; }","duration":"232.239751ms","start":"2026-06-10T08:09:24.097468Z","end":"2026-06-10T08:09:24.329708Z","steps":["trace[1111289671] 'process raft request' (duration: 231.970835ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.32996Z","caller":"traceutil/trace.go:171","msg":"trace[1153649612] transaction","detail":"{read_only:false; response_revision:4173; number_of_response:1; }","duration":"232.094867ms","start":"2026-06-10T08:09:24.097444Z","end":"2026-06-10T08:09:24.329539Z","steps":["trace[1153649612] 'process raft request' (duration: 231.934054ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.330498Z","caller":"traceutil/trace.go:171","msg":"trace[1629090339] transaction","detail":"{read_only:false; response_revision:4175; number_of_response:1; }","duration":"232.629348ms","start":"2026-06-10T08:09:24.097857Z","end":"2026-06-10T08:09:24.330486Z","steps":["trace[1629090339] 'process raft request' (duration: 231.650799ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.330548Z","caller":"traceutil/trace.go:171","msg":"trace[1774985357] transaction","detail":"{read_only:false; response_revision:4176; number_of_response:1; }","duration":"160.924605ms","start":"2026-06-10T08:09:24.169612Z","end":"2026-06-10T08:09:24.330537Z","steps":["trace[1774985357] 'process raft request' (duration: 160.777112ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.330545Z","caller":"traceutil/trace.go:171","msg":"trace[58068899] linearizableReadLoop","detail":"{readStateIndex:4347; appliedIndex:4341; }","duration":"224.96489ms","start":"2026-06-10T08:09:24.105551Z","end":"2026-06-10T08:09:24.330516Z","steps":["trace[58068899] 'read index received' (duration: 141.864067ms)","trace[58068899] 'applied index is now lower than readState.Index' (duration: 83.098863ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:09:24.331074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.006645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:09:24.33115Z","caller":"traceutil/trace.go:171","msg":"trace[8269315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4176; }","duration":"106.124217ms","start":"2026-06-10T08:09:24.225009Z","end":"2026-06-10T08:09:24.331133Z","steps":["trace[8269315] 'agreement among raft nodes before linearized reading' (duration: 105.990994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:24.331665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.123223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-create-xnhcf\" ","response":"range_response_count:1 size:4595"} {"level":"info","ts":"2026-06-10T08:09:24.331807Z","caller":"traceutil/trace.go:171","msg":"trace[1700712238] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-create-xnhcf; range_end:; response_count:1; response_revision:4176; }","duration":"226.223874ms","start":"2026-06-10T08:09:24.105495Z","end":"2026-06-10T08:09:24.331719Z","steps":["trace[1700712238] 'agreement among raft nodes before linearized reading' (duration: 225.097403ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.445373Z","caller":"traceutil/trace.go:171","msg":"trace[1116596747] transaction","detail":"{read_only:false; response_revision:4177; number_of_response:1; }","duration":"108.717157ms","start":"2026-06-10T08:09:24.336621Z","end":"2026-06-10T08:09:24.445338Z","steps":["trace[1116596747] 'process raft request' (duration: 40.171455ms)","trace[1116596747] 'compare' (duration: 68.311398ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:24.448016Z","caller":"traceutil/trace.go:171","msg":"trace[1503931496] transaction","detail":"{read_only:false; response_revision:4179; number_of_response:1; }","duration":"110.574453ms","start":"2026-06-10T08:09:24.337399Z","end":"2026-06-10T08:09:24.447973Z","steps":["trace[1503931496] 'process raft request' (duration: 110.136325ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:24.448084Z","caller":"traceutil/trace.go:171","msg":"trace[2037810240] transaction","detail":"{read_only:false; response_revision:4178; number_of_response:1; }","duration":"111.285427ms","start":"2026-06-10T08:09:24.33674Z","end":"2026-06-10T08:09:24.448026Z","steps":["trace[2037810240] 'process raft request' (duration: 110.583604ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:31.802348Z","caller":"traceutil/trace.go:171","msg":"trace[272145558] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"101.004718ms","start":"2026-06-10T08:09:31.701292Z","end":"2026-06-10T08:09:31.802297Z","steps":["trace[272145558] 'process raft request' (duration: 88.356406ms)","trace[272145558] 'compare' (duration: 12.378687ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:31.802413Z","caller":"traceutil/trace.go:171","msg":"trace[2112041606] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"100.950196ms","start":"2026-06-10T08:09:31.70143Z","end":"2026-06-10T08:09:31.80238Z","steps":["trace[2112041606] 'process raft request' (duration: 100.792583ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:35.212677Z","caller":"traceutil/trace.go:171","msg":"trace[1605673362] linearizableReadLoop","detail":"{readStateIndex:4895; appliedIndex:4894; }","duration":"236.965037ms","start":"2026-06-10T08:09:34.975678Z","end":"2026-06-10T08:09:35.212643Z","steps":["trace[1605673362] 'read index received' (duration: 236.810794ms)","trace[1605673362] 'applied index is now lower than readState.Index' (duration: 152.443µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:09:35.212978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.252803ms","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-06-10T08:09:35.213078Z","caller":"traceutil/trace.go:171","msg":"trace[504522863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4712; }","duration":"237.446206ms","start":"2026-06-10T08:09:34.975613Z","end":"2026-06-10T08:09:35.213059Z","steps":["trace[504522863] 'agreement among raft nodes before linearized reading' (duration: 237.1092ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:35.291934Z","caller":"traceutil/trace.go:171","msg":"trace[1919873090] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"309.971321ms","start":"2026-06-10T08:09:34.981918Z","end":"2026-06-10T08:09:35.291889Z","steps":["trace[1919873090] 'process raft request' (duration: 309.663585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:35.292027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.732362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:09:35.292114Z","caller":"traceutil/trace.go:171","msg":"trace[1968275131] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4713; }","duration":"314.839874ms","start":"2026-06-10T08:09:34.977253Z","end":"2026-06-10T08:09:35.292092Z","steps":["trace[1968275131] 'agreement among raft nodes before linearized reading' (duration: 314.559529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:35.292173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:34.977159Z","time spent":"315.004837ms","remote":"127.0.0.1:48466","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-06-10T08:09:35.292164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.284762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-10T08:09:35.292238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:34.981889Z","time spent":"310.160375ms","remote":"127.0.0.1:48388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9773,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:09:35.292281Z","caller":"traceutil/trace.go:171","msg":"trace[1248615482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4713; }","duration":"188.481306ms","start":"2026-06-10T08:09:35.103771Z","end":"2026-06-10T08:09:35.292252Z","steps":["trace[1248615482] 'agreement among raft nodes before linearized reading' (duration: 188.104999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:35.292337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.656222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:09:35.292373Z","caller":"traceutil/trace.go:171","msg":"trace[456926789] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:4713; }","duration":"196.747123ms","start":"2026-06-10T08:09:35.095611Z","end":"2026-06-10T08:09:35.292359Z","steps":["trace[456926789] 'agreement among raft nodes before linearized reading' (duration: 196.694502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:35.292589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.258423ms","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-06-10T08:09:35.292666Z","caller":"traceutil/trace.go:171","msg":"trace[465759732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4713; }","duration":"206.387156ms","start":"2026-06-10T08:09:35.086265Z","end":"2026-06-10T08:09:35.292652Z","steps":["trace[465759732] 'agreement among raft nodes before linearized reading' (duration: 206.177352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:35.292508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.198877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-10T08:09:35.292961Z","caller":"traceutil/trace.go:171","msg":"trace[1038267428] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4713; }","duration":"143.696436ms","start":"2026-06-10T08:09:35.149242Z","end":"2026-06-10T08:09:35.292938Z","steps":["trace[1038267428] 'agreement among raft nodes before linearized reading' (duration: 143.087785ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:39.91743Z","caller":"traceutil/trace.go:171","msg":"trace[1184693552] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"128.943132ms","start":"2026-06-10T08:09:39.788457Z","end":"2026-06-10T08:09:39.9174Z","steps":["trace[1184693552] 'process raft request' (duration: 45.515599ms)","trace[1184693552] 'compare' (duration: 83.27711ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:40.654739Z","caller":"traceutil/trace.go:171","msg":"trace[696917933] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"112.184673ms","start":"2026-06-10T08:09:40.542524Z","end":"2026-06-10T08:09:40.654709Z","steps":["trace[696917933] 'process raft request' (duration: 111.954848ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:41.304099Z","caller":"traceutil/trace.go:171","msg":"trace[1525611099] linearizableReadLoop","detail":"{readStateIndex:4968; appliedIndex:4967; }","duration":"118.457048ms","start":"2026-06-10T08:09:41.185593Z","end":"2026-06-10T08:09:41.30405Z","steps":["trace[1525611099] 'read index received' (duration: 106.202418ms)","trace[1525611099] 'applied index is now lower than readState.Index' (duration: 12.25307ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:41.304378Z","caller":"traceutil/trace.go:171","msg":"trace[1942428141] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"119.649311ms","start":"2026-06-10T08:09:41.184691Z","end":"2026-06-10T08:09:41.304341Z","steps":["trace[1942428141] 'process raft request' (duration: 107.096945ms)","trace[1942428141] 'compare' (duration: 12.053356ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:09:41.30464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.151666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-06-10T08:09:41.304745Z","caller":"traceutil/trace.go:171","msg":"trace[780245337] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4784; }","duration":"114.29962ms","start":"2026-06-10T08:09:41.190415Z","end":"2026-06-10T08:09:41.304715Z","steps":["trace[780245337] 'agreement among raft nodes before linearized reading' (duration: 113.947483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:41.304993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.375065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:72 size:60103"} {"level":"info","ts":"2026-06-10T08:09:41.305106Z","caller":"traceutil/trace.go:171","msg":"trace[1910265748] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:72; response_revision:4784; }","duration":"119.504138ms","start":"2026-06-10T08:09:41.185583Z","end":"2026-06-10T08:09:41.305088Z","steps":["trace[1910265748] 'agreement among raft nodes before linearized reading' (duration: 118.722723ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:41.749618Z","caller":"traceutil/trace.go:171","msg":"trace[1549566575] linearizableReadLoop","detail":"{readStateIndex:4996; appliedIndex:4994; }","duration":"151.112582ms","start":"2026-06-10T08:09:41.59848Z","end":"2026-06-10T08:09:41.749593Z","steps":["trace[1549566575] 'read index received' (duration: 7.797857ms)","trace[1549566575] 'applied index is now lower than readState.Index' (duration: 143.313425ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:41.749856Z","caller":"traceutil/trace.go:171","msg":"trace[56914732] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"152.183923ms","start":"2026-06-10T08:09:41.597658Z","end":"2026-06-10T08:09:41.749841Z","steps":["trace[56914732] 'process raft request' (duration: 133.203475ms)","trace[56914732] 'compare' (duration: 17.947248ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:41.750077Z","caller":"traceutil/trace.go:171","msg":"trace[1140136705] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"150.384958ms","start":"2026-06-10T08:09:41.599659Z","end":"2026-06-10T08:09:41.750044Z","steps":["trace[1140136705] 'process raft request' (duration: 149.882979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:41.75023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.729033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-06-10T08:09:41.750276Z","caller":"traceutil/trace.go:171","msg":"trace[338019027] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4814; }","duration":"151.813715ms","start":"2026-06-10T08:09:41.598448Z","end":"2026-06-10T08:09:41.750262Z","steps":["trace[338019027] 'agreement among raft nodes before linearized reading' (duration: 151.608282ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:41.750334Z","caller":"traceutil/trace.go:171","msg":"trace[636982301] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"150.865557ms","start":"2026-06-10T08:09:41.599438Z","end":"2026-06-10T08:09:41.750304Z","steps":["trace[636982301] 'process raft request' (duration: 150.026501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:42.985189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090712837s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:09:42.985551Z","caller":"traceutil/trace.go:171","msg":"trace[2072678273] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"1.223712428s","start":"2026-06-10T08:09:41.761817Z","end":"2026-06-10T08:09:42.985529Z","steps":["trace[2072678273] 'process raft request' (duration: 1.223668927s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:42.985625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.76179Z","time spent":"1.22380923s","remote":"127.0.0.1:48272","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-06-10T08:09:42.985684Z","caller":"traceutil/trace.go:171","msg":"trace[1300439268] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"1.374681767s","start":"2026-06-10T08:09:41.610916Z","end":"2026-06-10T08:09:42.985598Z","steps":["trace[1300439268] 'process raft request' (duration: 1.374381811s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:42.985838Z","caller":"traceutil/trace.go:171","msg":"trace[1587832764] transaction","detail":"{read_only:false; response_revision:4817; number_of_response:1; }","duration":"1.328663042s","start":"2026-06-10T08:09:41.657162Z","end":"2026-06-10T08:09:42.985825Z","steps":["trace[1587832764] 'process raft request' (duration: 1.328264495s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:42.985903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.657141Z","time spent":"1.328733883s","remote":"127.0.0.1:48272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:09:42.986023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.610903Z","time spent":"1.374939252s","remote":"127.0.0.1:48466","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-06-10T08:09:42.986203Z","caller":"traceutil/trace.go:171","msg":"trace[2068291255] linearizableReadLoop","detail":"{readStateIndex:5001; appliedIndex:4998; }","duration":"1.236455787s","start":"2026-06-10T08:09:41.749705Z","end":"2026-06-10T08:09:42.986161Z","steps":["trace[2068291255] 'read index received' (duration: 144.681691ms)","trace[2068291255] 'applied index is now lower than readState.Index' (duration: 1.091770416s)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:42.986653Z","caller":"traceutil/trace.go:171","msg":"trace[94310989] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"1.380392815s","start":"2026-06-10T08:09:41.606216Z","end":"2026-06-10T08:09:42.986609Z","steps":["trace[94310989] 'process raft request' (duration: 288.15402ms)","trace[94310989] 'compare' (duration: 1.089627646s)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:09:42.986686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.291647475s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T08:09:42.986771Z","caller":"traceutil/trace.go:171","msg":"trace[52920386] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:4818; }","duration":"1.291798798s","start":"2026-06-10T08:09:41.694954Z","end":"2026-06-10T08:09:42.986753Z","steps":["trace[52920386] 'agreement among raft nodes before linearized reading' (duration: 1.291408991s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:42.986839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.69493Z","time spent":"1.2918931s","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-06-10T08:09:42.987158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.60619Z","time spent":"1.380560137s","remote":"127.0.0.1:47060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7495,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:09:43.007456Z","caller":"traceutil/trace.go:171","msg":"trace[1733567323] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"543.338914ms","start":"2026-06-10T08:09:42.464096Z","end":"2026-06-10T08:09:43.007434Z","steps":["trace[1733567323] 'process raft request' (duration: 543.13071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.007577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:42.464064Z","time spent":"543.456096ms","remote":"127.0.0.1:48466","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-06-10T08:09:43.007845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.247896662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ae9b2070-a5c6-4f01-9d52-7f53fe58acaa\" ","response":"range_response_count:1 size:2580"} {"level":"info","ts":"2026-06-10T08:09:43.007937Z","caller":"traceutil/trace.go:171","msg":"trace[143269679] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ae9b2070-a5c6-4f01-9d52-7f53fe58acaa; range_end:; response_count:1; response_revision:4821; }","duration":"1.248030695s","start":"2026-06-10T08:09:41.759889Z","end":"2026-06-10T08:09:43.00792Z","steps":["trace[143269679] 'agreement among raft nodes before linearized reading' (duration: 1.24776692s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.008115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.759871Z","time spent":"1.248168447s","remote":"127.0.0.1:48388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":2602,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ae9b2070-a5c6-4f01-9d52-7f53fe58acaa\" "} {"level":"info","ts":"2026-06-10T08:09:43.008311Z","caller":"traceutil/trace.go:171","msg":"trace[1943017321] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"332.83788ms","start":"2026-06-10T08:09:42.675455Z","end":"2026-06-10T08:09:43.008292Z","steps":["trace[1943017321] 'process raft request' (duration: 332.136047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.008402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:42.675423Z","time spent":"332.933512ms","remote":"127.0.0.1:48466","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-06-10T08:09:43.008566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098005883s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-06-10T08:09:43.008635Z","caller":"traceutil/trace.go:171","msg":"trace[1967082728] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4821; }","duration":"1.098126825s","start":"2026-06-10T08:09:41.910487Z","end":"2026-06-10T08:09:43.008614Z","steps":["trace[1967082728] 'agreement among raft nodes before linearized reading' (duration: 1.097830499s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.008854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.787421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:09:43.008868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.247045176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"} {"level":"warn","ts":"2026-06-10T08:09:43.008897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248797329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ae9b2070-a5c6-4f01-9d52-7f53fe58acaa\" ","response":"range_response_count:1 size:2580"} {"level":"info","ts":"2026-06-10T08:09:43.00921Z","caller":"traceutil/trace.go:171","msg":"trace[1318664294] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ae9b2070-a5c6-4f01-9d52-7f53fe58acaa; range_end:; response_count:1; response_revision:4821; }","duration":"1.249147126s","start":"2026-06-10T08:09:41.760049Z","end":"2026-06-10T08:09:43.009196Z","steps":["trace[1318664294] 'agreement among raft nodes before linearized reading' (duration: 1.248531534s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.008436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.694844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-10T08:09:43.008899Z","caller":"traceutil/trace.go:171","msg":"trace[457320083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4821; }","duration":"782.873563ms","start":"2026-06-10T08:09:42.226011Z","end":"2026-06-10T08:09:43.008885Z","steps":["trace[457320083] 'agreement among raft nodes before linearized reading' (duration: 782.777941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.009264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.760045Z","time spent":"1.249204457s","remote":"127.0.0.1:48388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":2602,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ae9b2070-a5c6-4f01-9d52-7f53fe58acaa\" "} {"level":"info","ts":"2026-06-10T08:09:43.009281Z","caller":"traceutil/trace.go:171","msg":"trace[211418355] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4821; }","duration":"237.580701ms","start":"2026-06-10T08:09:42.771662Z","end":"2026-06-10T08:09:43.009242Z","steps":["trace[211418355] 'agreement among raft nodes before linearized reading' (duration: 236.128384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.00931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:42.225989Z","time spent":"783.311622ms","remote":"127.0.0.1:48176","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-06-10T08:09:43.008943Z","caller":"traceutil/trace.go:171","msg":"trace[309118305] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4821; }","duration":"1.247190209s","start":"2026-06-10T08:09:41.761736Z","end":"2026-06-10T08:09:43.008927Z","steps":["trace[309118305] 'agreement among raft nodes before linearized reading' (duration: 1.246967245s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.008928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.793074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T08:09:43.009006Z","caller":"traceutil/trace.go:171","msg":"trace[1164703128] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"332.582335ms","start":"2026-06-10T08:09:42.67541Z","end":"2026-06-10T08:09:43.007993Z","steps":["trace[1164703128] 'process raft request' (duration: 331.988894ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:43.009512Z","caller":"traceutil/trace.go:171","msg":"trace[852988419] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4821; }","duration":"576.415706ms","start":"2026-06-10T08:09:42.433084Z","end":"2026-06-10T08:09:43.009499Z","steps":["trace[852988419] 'agreement among raft nodes before linearized reading' (duration: 575.696842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.009554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:42.433064Z","time spent":"576.476816ms","remote":"127.0.0.1:48388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-10T08:09:43.009545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:42.675379Z","time spent":"334.126724ms","remote":"127.0.0.1:48466","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-06-10T08:09:43.009437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.761702Z","time spent":"1.247714068s","remote":"127.0.0.1:48394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":1477,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-06-10T08:09:43.009938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.910471Z","time spent":"1.098246848s","remote":"127.0.0.1:48402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":919,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-06-10T08:09:43.014376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.153499947s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-10T08:09:43.014463Z","caller":"traceutil/trace.go:171","msg":"trace[423108993] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4821; }","duration":"1.153634748s","start":"2026-06-10T08:09:41.860816Z","end":"2026-06-10T08:09:43.014451Z","steps":["trace[423108993] 'agreement among raft nodes before linearized reading' (duration: 1.147689117s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.01449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:41.860786Z","time spent":"1.15369472s","remote":"127.0.0.1:48306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206995,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-06-10T08:09:43.213783Z","caller":"traceutil/trace.go:171","msg":"trace[1504428854] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"199.718736ms","start":"2026-06-10T08:09:43.014039Z","end":"2026-06-10T08:09:43.213757Z","steps":["trace[1504428854] 'process raft request' (duration: 199.362409ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:43.214154Z","caller":"traceutil/trace.go:171","msg":"trace[2080217945] linearizableReadLoop","detail":"{readStateIndex:5010; appliedIndex:5007; }","duration":"139.290442ms","start":"2026-06-10T08:09:43.074819Z","end":"2026-06-10T08:09:43.21411Z","steps":["trace[2080217945] 'read index received' (duration: 138.554518ms)","trace[2080217945] 'applied index is now lower than readState.Index' (duration: 733.064µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:43.214207Z","caller":"traceutil/trace.go:171","msg":"trace[1646705946] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"197.044466ms","start":"2026-06-10T08:09:43.01715Z","end":"2026-06-10T08:09:43.214194Z","steps":["trace[1646705946] 'process raft request' (duration: 196.442634ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:43.214393Z","caller":"traceutil/trace.go:171","msg":"trace[181453028] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"194.861214ms","start":"2026-06-10T08:09:43.019522Z","end":"2026-06-10T08:09:43.214383Z","steps":["trace[181453028] 'process raft request' (duration: 194.126721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.214667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.471336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-06-10T08:09:43.214703Z","caller":"traceutil/trace.go:171","msg":"trace[1964858621] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4825; }","duration":"171.519457ms","start":"2026-06-10T08:09:43.043172Z","end":"2026-06-10T08:09:43.214691Z","steps":["trace[1964858621] 'agreement among raft nodes before linearized reading' (duration: 171.375804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.214774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.206313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ae9b2070-a5c6-4f01-9d52-7f53fe58acaa\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-10T08:09:43.214833Z","caller":"traceutil/trace.go:171","msg":"trace[939154822] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ae9b2070-a5c6-4f01-9d52-7f53fe58acaa; range_end:; response_count:1; response_revision:4825; }","duration":"202.326414ms","start":"2026-06-10T08:09:43.012491Z","end":"2026-06-10T08:09:43.214817Z","steps":["trace[939154822] 'agreement among raft nodes before linearized reading' (duration: 202.195882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.215059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.107306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-06-10T08:09:43.215093Z","caller":"traceutil/trace.go:171","msg":"trace[1814137710] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4825; }","duration":"198.170856ms","start":"2026-06-10T08:09:43.016913Z","end":"2026-06-10T08:09:43.215084Z","steps":["trace[1814137710] 'agreement among raft nodes before linearized reading' (duration: 198.008533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.215117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.204707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-88c94eaf-867f-4324-b916-66950fa009b3\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-06-10T08:09:43.215149Z","caller":"traceutil/trace.go:171","msg":"trace[1057419704] range","detail":"{range_begin:/registry/persistentvolumes/pvc-88c94eaf-867f-4324-b916-66950fa009b3; range_end:; response_count:1; response_revision:4825; }","duration":"198.259558ms","start":"2026-06-10T08:09:43.01688Z","end":"2026-06-10T08:09:43.21514Z","steps":["trace[1057419704] 'agreement among raft nodes before linearized reading' (duration: 198.184407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.2154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.446021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T08:09:43.215523Z","caller":"traceutil/trace.go:171","msg":"trace[52559106] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4825; }","duration":"198.617895ms","start":"2026-06-10T08:09:43.016881Z","end":"2026-06-10T08:09:43.215499Z","steps":["trace[52559106] 'agreement among raft nodes before linearized reading' (duration: 198.169617ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:43.23565Z","caller":"traceutil/trace.go:171","msg":"trace[2104588385] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"156.893393ms","start":"2026-06-10T08:09:43.078727Z","end":"2026-06-10T08:09:43.235621Z","steps":["trace[2104588385] 'process raft request' (duration: 156.660298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.236327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.999206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-5f9dd6fb44-cww4d.18b7a9e58cae8ef7\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-06-10T08:09:43.236363Z","caller":"traceutil/trace.go:171","msg":"trace[958077940] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-5f9dd6fb44-cww4d.18b7a9e58cae8ef7; range_end:; response_count:1; response_revision:4827; }","duration":"156.093447ms","start":"2026-06-10T08:09:43.08026Z","end":"2026-06-10T08:09:43.236354Z","steps":["trace[958077940] 'agreement among raft nodes before linearized reading' (duration: 155.937974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.912713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.776593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:09:43.912902Z","caller":"traceutil/trace.go:171","msg":"trace[188580175] linearizableReadLoop","detail":"{readStateIndex:5024; appliedIndex:5022; }","duration":"445.713979ms","start":"2026-06-10T08:09:43.46717Z","end":"2026-06-10T08:09:43.912884Z","steps":["trace[188580175] 'read index received' (duration: 129.662522ms)","trace[188580175] 'applied index is now lower than readState.Index' (duration: 316.050407ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:43.913088Z","caller":"traceutil/trace.go:171","msg":"trace[1229708516] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"450.53918ms","start":"2026-06-10T08:09:43.462538Z","end":"2026-06-10T08:09:43.913078Z","steps":["trace[1229708516] 'process raft request' (duration: 134.280328ms)","trace[1229708516] 'compare' (duration: 315.62468ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:09:43.91314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.462519Z","time spent":"450.596061ms","remote":"127.0.0.1:48466","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-06-10T08:09:43.913388Z","caller":"traceutil/trace.go:171","msg":"trace[627505566] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"446.931982ms","start":"2026-06-10T08:09:43.466449Z","end":"2026-06-10T08:09:43.913381Z","steps":["trace[627505566] 'process raft request' (duration: 446.375062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.913447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.4664Z","time spent":"447.008344ms","remote":"127.0.0.1:48272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:09:43.913632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.463033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T08:09:43.913655Z","caller":"traceutil/trace.go:171","msg":"trace[1193589894] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4839; }","duration":"446.527665ms","start":"2026-06-10T08:09:43.467121Z","end":"2026-06-10T08:09:43.913648Z","steps":["trace[1193589894] 'agreement among raft nodes before linearized reading' (duration: 446.436273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.913674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.4671Z","time spent":"446.570155ms","remote":"127.0.0.1:48466","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-06-10T08:09:43.913926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.660623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:09:43.913949Z","caller":"traceutil/trace.go:171","msg":"trace[993891221] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4839; }","duration":"345.722124ms","start":"2026-06-10T08:09:43.568222Z","end":"2026-06-10T08:09:43.913944Z","steps":["trace[993891221] 'agreement among raft nodes before linearized reading' (duration: 345.674933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.913968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.568203Z","time spent":"345.759244ms","remote":"127.0.0.1:48492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":3,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:09:43.914219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.7738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"warn","ts":"2026-06-10T08:09:43.914328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.957756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-06-10T08:09:43.914328Z","caller":"traceutil/trace.go:171","msg":"trace[911523281] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4839; }","duration":"445.916423ms","start":"2026-06-10T08:09:43.468386Z","end":"2026-06-10T08:09:43.914302Z","steps":["trace[911523281] 'agreement among raft nodes before linearized reading' (duration: 445.569086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.914364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.540109ms","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-06-10T08:09:43.914372Z","caller":"traceutil/trace.go:171","msg":"trace[1844546447] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4839; }","duration":"444.013018ms","start":"2026-06-10T08:09:43.470345Z","end":"2026-06-10T08:09:43.914358Z","steps":["trace[1844546447] 'agreement among raft nodes before linearized reading' (duration: 443.881115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.914383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.46838Z","time spent":"445.992755ms","remote":"127.0.0.1:48394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":1015,"request content":"key:\"/registry/services/specs/monitoring/prometheus-operated\" "} {"level":"info","ts":"2026-06-10T08:09:43.914398Z","caller":"traceutil/trace.go:171","msg":"trace[39124216] 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:4839; }","duration":"186.606149ms","start":"2026-06-10T08:09:43.727779Z","end":"2026-06-10T08:09:43.914385Z","steps":["trace[39124216] 'agreement among raft nodes before linearized reading' (duration: 186.526568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.914405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.47034Z","time spent":"444.057059ms","remote":"127.0.0.1:48712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9661,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"warn","ts":"2026-06-10T08:09:43.914773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.525933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:09:43.914814Z","caller":"traceutil/trace.go:171","msg":"trace[152114432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4839; }","duration":"447.576174ms","start":"2026-06-10T08:09:43.467228Z","end":"2026-06-10T08:09:43.914805Z","steps":["trace[152114432] 'agreement among raft nodes before linearized reading' (duration: 447.468872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.914842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.467218Z","time spent":"447.617405ms","remote":"127.0.0.1:48466","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-06-10T08:09:43.914927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.689976ms","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-06-10T08:09:43.914959Z","caller":"traceutil/trace.go:171","msg":"trace[818859022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4839; }","duration":"447.734517ms","start":"2026-06-10T08:09:43.467217Z","end":"2026-06-10T08:09:43.914951Z","steps":["trace[818859022] 'agreement among raft nodes before linearized reading' (duration: 447.658385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.914979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.467211Z","time spent":"447.763797ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:09:43.915093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.84322ms","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-06-10T08:09:43.916274Z","caller":"traceutil/trace.go:171","msg":"trace[1717039885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4839; }","duration":"449.050521ms","start":"2026-06-10T08:09:43.467162Z","end":"2026-06-10T08:09:43.916212Z","steps":["trace[1717039885] 'agreement among raft nodes before linearized reading' (duration: 446.547185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:43.916383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:43.467147Z","time spent":"449.213705ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:09:43.916516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.199239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16085"} {"level":"info","ts":"2026-06-10T08:09:43.916897Z","caller":"traceutil/trace.go:171","msg":"trace[176777365] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4839; }","duration":"189.589506ms","start":"2026-06-10T08:09:43.72728Z","end":"2026-06-10T08:09:43.91687Z","steps":["trace[176777365] 'agreement among raft nodes before linearized reading' (duration: 186.890185ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:44.072683Z","caller":"traceutil/trace.go:171","msg":"trace[891399392] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"152.511399ms","start":"2026-06-10T08:09:43.920137Z","end":"2026-06-10T08:09:44.072648Z","steps":["trace[891399392] 'process raft request' (duration: 114.531917ms)","trace[891399392] 'compare' (duration: 37.696756ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:44.073Z","caller":"traceutil/trace.go:171","msg":"trace[1816003855] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"150.424039ms","start":"2026-06-10T08:09:43.922559Z","end":"2026-06-10T08:09:44.072983Z","steps":["trace[1816003855] 'process raft request' (duration: 150.033152ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:44.073226Z","caller":"traceutil/trace.go:171","msg":"trace[346413673] linearizableReadLoop","detail":"{readStateIndex:5026; appliedIndex:5024; }","duration":"151.941087ms","start":"2026-06-10T08:09:43.921235Z","end":"2026-06-10T08:09:44.073176Z","steps":["trace[346413673] 'read index received' (duration: 32.927067ms)","trace[346413673] 'applied index is now lower than readState.Index' (duration: 119.01282ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:44.07384Z","caller":"traceutil/trace.go:171","msg":"trace[1059868038] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"144.900915ms","start":"2026-06-10T08:09:43.928915Z","end":"2026-06-10T08:09:44.073816Z","steps":["trace[1059868038] 'process raft request' (duration: 144.126461ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:44.073914Z","caller":"traceutil/trace.go:171","msg":"trace[1571091920] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"150.508681ms","start":"2026-06-10T08:09:43.922843Z","end":"2026-06-10T08:09:44.073351Z","steps":["trace[1571091920] 'process raft request' (duration: 149.991951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:44.074188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.921827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-10T08:09:44.07442Z","caller":"traceutil/trace.go:171","msg":"trace[1461324242] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4844; }","duration":"153.215332ms","start":"2026-06-10T08:09:43.921175Z","end":"2026-06-10T08:09:44.07439Z","steps":["trace[1461324242] 'agreement among raft nodes before linearized reading' (duration: 152.871186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:44.074459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.716224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18b7a9e61559e67e\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-06-10T08:09:44.074576Z","caller":"traceutil/trace.go:171","msg":"trace[290681505] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18b7a9e61559e67e; range_end:; response_count:1; response_revision:4844; }","duration":"151.883616ms","start":"2026-06-10T08:09:43.922672Z","end":"2026-06-10T08:09:44.074555Z","steps":["trace[290681505] 'agreement among raft nodes before linearized reading' (duration: 151.587671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:44.074577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.023352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-10T08:09:44.07462Z","caller":"traceutil/trace.go:171","msg":"trace[1293862285] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4844; }","duration":"149.090674ms","start":"2026-06-10T08:09:43.925518Z","end":"2026-06-10T08:09:44.074608Z","steps":["trace[1293862285] 'agreement among raft nodes before linearized reading' (duration: 148.984472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:44.075013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.086373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61480"} {"level":"info","ts":"2026-06-10T08:09:44.075079Z","caller":"traceutil/trace.go:171","msg":"trace[329884688] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4844; }","duration":"150.202265ms","start":"2026-06-10T08:09:43.924862Z","end":"2026-06-10T08:09:44.075064Z","steps":["trace[329884688] 'agreement among raft nodes before linearized reading' (duration: 149.737936ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:44.211791Z","caller":"traceutil/trace.go:171","msg":"trace[405576772] linearizableReadLoop","detail":"{readStateIndex:5030; appliedIndex:5029; }","duration":"129.891813ms","start":"2026-06-10T08:09:44.081871Z","end":"2026-06-10T08:09:44.211763Z","steps":["trace[405576772] 'read index received' (duration: 113.133459ms)","trace[405576772] 'applied index is now lower than readState.Index' (duration: 16.756954ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:44.21189Z","caller":"traceutil/trace.go:171","msg":"trace[653687085] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"131.613035ms","start":"2026-06-10T08:09:44.080171Z","end":"2026-06-10T08:09:44.211784Z","steps":["trace[653687085] 'process raft request' (duration: 114.719369ms)","trace[653687085] 'compare' (duration: 16.660972ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:44.212367Z","caller":"traceutil/trace.go:171","msg":"trace[1490893154] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"129.335203ms","start":"2026-06-10T08:09:44.083Z","end":"2026-06-10T08:09:44.212335Z","steps":["trace[1490893154] 'process raft request' (duration: 128.715931ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:44.212528Z","caller":"traceutil/trace.go:171","msg":"trace[1011995802] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"129.295742ms","start":"2026-06-10T08:09:44.0832Z","end":"2026-06-10T08:09:44.212496Z","steps":["trace[1011995802] 'process raft request' (duration: 128.821113ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:44.212776Z","caller":"traceutil/trace.go:171","msg":"trace[1671974729] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"129.462365ms","start":"2026-06-10T08:09:44.083301Z","end":"2026-06-10T08:09:44.212763Z","steps":["trace[1671974729] 'process raft request' (duration: 129.098158ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:44.212773Z","caller":"traceutil/trace.go:171","msg":"trace[1919374886] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"124.023753ms","start":"2026-06-10T08:09:44.088719Z","end":"2026-06-10T08:09:44.212742Z","steps":["trace[1919374886] 'process raft request' (duration: 123.943772ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:44.213148Z","caller":"traceutil/trace.go:171","msg":"trace[1808916069] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"129.72016ms","start":"2026-06-10T08:09:44.083376Z","end":"2026-06-10T08:09:44.213096Z","steps":["trace[1808916069] 'process raft request' (duration: 129.212591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:44.213703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.805709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-06-10T08:09:44.213746Z","caller":"traceutil/trace.go:171","msg":"trace[536402896] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4847; }","duration":"131.912771ms","start":"2026-06-10T08:09:44.081823Z","end":"2026-06-10T08:09:44.213736Z","steps":["trace[536402896] 'agreement among raft nodes before linearized reading' (duration: 130.059396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:45.816367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.690993ms","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-06-10T08:09:45.816458Z","caller":"traceutil/trace.go:171","msg":"trace[2070612049] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:4867; }","duration":"193.862886ms","start":"2026-06-10T08:09:45.622574Z","end":"2026-06-10T08:09:45.816437Z","steps":["trace[2070612049] 'count revisions from in-memory index tree' (duration: 193.49915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:45.816475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.799595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-10T08:09:45.81659Z","caller":"traceutil/trace.go:171","msg":"trace[240125178] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4867; }","duration":"270.996419ms","start":"2026-06-10T08:09:45.545569Z","end":"2026-06-10T08:09:45.816565Z","steps":["trace[240125178] 'range keys from in-memory index tree' (duration: 270.601671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:55.405113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.450636ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:09:55.405457Z","caller":"traceutil/trace.go:171","msg":"trace[639665927] linearizableReadLoop","detail":"{readStateIndex:5180; appliedIndex:5177; }","duration":"137.052339ms","start":"2026-06-10T08:09:55.268384Z","end":"2026-06-10T08:09:55.405436Z","steps":["trace[639665927] 'read index received' (duration: 94.32316ms)","trace[639665927] 'applied index is now lower than readState.Index' (duration: 42.727329ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:09:55.405576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.193671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:09:55.405613Z","caller":"traceutil/trace.go:171","msg":"trace[351721882] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:4990; }","duration":"137.290963ms","start":"2026-06-10T08:09:55.268313Z","end":"2026-06-10T08:09:55.405604Z","steps":["trace[351721882] 'agreement among raft nodes before linearized reading' (duration: 137.179891ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:55.405583Z","caller":"traceutil/trace.go:171","msg":"trace[322290832] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"178.692958ms","start":"2026-06-10T08:09:55.226845Z","end":"2026-06-10T08:09:55.405538Z","steps":["trace[322290832] 'process raft request' (duration: 178.448663ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:55.406002Z","caller":"traceutil/trace.go:171","msg":"trace[310871712] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"175.789734ms","start":"2026-06-10T08:09:55.230198Z","end":"2026-06-10T08:09:55.405988Z","steps":["trace[310871712] 'process raft request' (duration: 175.164303ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:55.406224Z","caller":"traceutil/trace.go:171","msg":"trace[1096348115] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"179.489712ms","start":"2026-06-10T08:09:55.226672Z","end":"2026-06-10T08:09:55.406162Z","steps":["trace[1096348115] 'process raft request' (duration: 27.890185ms)","trace[1096348115] 'compare' (duration: 150.264323ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:55.609445Z","caller":"traceutil/trace.go:171","msg":"trace[487486248] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"189.818853ms","start":"2026-06-10T08:09:55.419594Z","end":"2026-06-10T08:09:55.609413Z","steps":["trace[487486248] 'process raft request' (duration: 113.585036ms)","trace[487486248] 'compare' (duration: 75.960442ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:55.609721Z","caller":"traceutil/trace.go:171","msg":"trace[592699348] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"110.039111ms","start":"2026-06-10T08:09:55.499632Z","end":"2026-06-10T08:09:55.609671Z","steps":["trace[592699348] 'process raft request' (duration: 109.728236ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:57.698645Z","caller":"traceutil/trace.go:171","msg":"trace[161159056] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"541.437506ms","start":"2026-06-10T08:09:57.157156Z","end":"2026-06-10T08:09:57.698594Z","steps":["trace[161159056] 'process raft request' (duration: 540.972637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:57.698886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:57.157131Z","time spent":"541.63133ms","remote":"127.0.0.1:48466","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-06-10T08:09:58.63157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.790724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:09:58.632364Z","caller":"traceutil/trace.go:171","msg":"trace[1087159158] linearizableReadLoop","detail":"{readStateIndex:5197; appliedIndex:5195; }","duration":"1.407067055s","start":"2026-06-10T08:09:57.225272Z","end":"2026-06-10T08:09:58.632339Z","steps":["trace[1087159158] 'read index received' (duration: 472.860064ms)","trace[1087159158] 'applied index is now lower than readState.Index' (duration: 934.204741ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:58.632387Z","caller":"traceutil/trace.go:171","msg":"trace[35394197] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"1.010408443s","start":"2026-06-10T08:09:57.621935Z","end":"2026-06-10T08:09:58.632344Z","steps":["trace[35394197] 'process raft request' (duration: 1.009755571s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:58.632628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:57.621905Z","time spent":"1.010581586s","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:09:58.632806Z","caller":"traceutil/trace.go:171","msg":"trace[43753996] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"1.474599937s","start":"2026-06-10T08:09:57.157589Z","end":"2026-06-10T08:09:58.632189Z","steps":["trace[43753996] 'process raft request' (duration: 1.3300946s)","trace[43753996] 'compare' (duration: 143.260524ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:09:58.633056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:57.157557Z","time spent":"1.475390802s","remote":"127.0.0.1:48466","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-06-10T08:09:58.694403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.469098315s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:09:58.6945Z","caller":"traceutil/trace.go:171","msg":"trace[551516173] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5008; }","duration":"1.469252067s","start":"2026-06-10T08:09:57.225224Z","end":"2026-06-10T08:09:58.694476Z","steps":["trace[551516173] 'agreement among raft nodes before linearized reading' (duration: 1.407346339s)","trace[551516173] 'range keys from in-memory index tree' (duration: 61.764426ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:09:58.694796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.407802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:09:58.694799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.291672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-10T08:09:58.694852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.342297ms","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-06-10T08:09:58.694903Z","caller":"traceutil/trace.go:171","msg":"trace[1970486352] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5008; }","duration":"730.446128ms","start":"2026-06-10T08:09:57.964444Z","end":"2026-06-10T08:09:58.694891Z","steps":["trace[1970486352] 'agreement among raft nodes before linearized reading' (duration: 730.250585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:58.694926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.643823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T08:09:58.694935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.354303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-10T08:09:58.694936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:57.964417Z","time spent":"730.51057ms","remote":"127.0.0.1:48370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-06-10T08:09:58.694942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.301121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-10T08:09:58.694956Z","caller":"traceutil/trace.go:171","msg":"trace[1490813617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5008; }","duration":"528.430745ms","start":"2026-06-10T08:09:58.166519Z","end":"2026-06-10T08:09:58.69495Z","steps":["trace[1490813617] 'agreement among raft nodes before linearized reading' (duration: 528.362043ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:58.694954Z","caller":"traceutil/trace.go:171","msg":"trace[1265839281] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5008; }","duration":"667.714964ms","start":"2026-06-10T08:09:58.027231Z","end":"2026-06-10T08:09:58.694946Z","steps":["trace[1265839281] 'agreement among raft nodes before linearized reading' (duration: 667.657083ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:58.694984Z","caller":"traceutil/trace.go:171","msg":"trace[511349869] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5008; }","duration":"528.465915ms","start":"2026-06-10T08:09:58.166506Z","end":"2026-06-10T08:09:58.694972Z","steps":["trace[511349869] 'agreement among raft nodes before linearized reading' (duration: 528.348853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:58.694992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:58.0272Z","time spent":"667.783016ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":29,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:09:58.694987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:58.166468Z","time spent":"528.512625ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:09:58.695018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:58.166477Z","time spent":"528.533606ms","remote":"127.0.0.1:48466","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-06-10T08:09:58.694784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.700649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-10T08:09:58.695123Z","caller":"traceutil/trace.go:171","msg":"trace[2134208506] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5008; }","duration":"640.121288ms","start":"2026-06-10T08:09:58.054992Z","end":"2026-06-10T08:09:58.695114Z","steps":["trace[2134208506] 'agreement among raft nodes before linearized reading' (duration: 639.518326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:58.695142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.382842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-10T08:09:58.695157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:58.054978Z","time spent":"640.170568ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T08:09:58.695167Z","caller":"traceutil/trace.go:171","msg":"trace[1004874698] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5008; }","duration":"677.450843ms","start":"2026-06-10T08:09:58.017709Z","end":"2026-06-10T08:09:58.695159Z","steps":["trace[1004874698] 'agreement among raft nodes before linearized reading' (duration: 677.375162ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:09:58.694859Z","caller":"traceutil/trace.go:171","msg":"trace[1829299619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5008; }","duration":"522.375433ms","start":"2026-06-10T08:09:58.172471Z","end":"2026-06-10T08:09:58.694846Z","steps":["trace[1829299619] 'agreement among raft nodes before linearized reading' (duration: 522.22948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:58.695191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:58.017677Z","time spent":"677.506645ms","remote":"127.0.0.1:48466","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-06-10T08:09:58.694859Z","caller":"traceutil/trace.go:171","msg":"trace[204227168] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:5008; }","duration":"102.517335ms","start":"2026-06-10T08:09:58.592324Z","end":"2026-06-10T08:09:58.694842Z","steps":["trace[204227168] 'agreement among raft nodes before linearized reading' (duration: 102.416183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:58.69521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:58.172459Z","time spent":"522.738979ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:09:58.695245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.856432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:09:58.695374Z","caller":"traceutil/trace.go:171","msg":"trace[1739133859] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5008; }","duration":"890.125898ms","start":"2026-06-10T08:09:57.805228Z","end":"2026-06-10T08:09:58.695354Z","steps":["trace[1739133859] 'agreement among raft nodes before linearized reading' (duration: 889.894534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:58.695425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:57.805202Z","time spent":"890.213119ms","remote":"127.0.0.1:39556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:09:58.694817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:09:57.225196Z","time spent":"1.469606754s","remote":"127.0.0.1:48176","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-06-10T08:09:59.147744Z","caller":"traceutil/trace.go:171","msg":"trace[1727375720] linearizableReadLoop","detail":"{readStateIndex:5211; appliedIndex:5209; }","duration":"182.260247ms","start":"2026-06-10T08:09:58.965458Z","end":"2026-06-10T08:09:59.147718Z","steps":["trace[1727375720] 'read index received' (duration: 122.681033ms)","trace[1727375720] 'applied index is now lower than readState.Index' (duration: 59.577644ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:59.148071Z","caller":"traceutil/trace.go:171","msg":"trace[12728587] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"183.383028ms","start":"2026-06-10T08:09:58.964593Z","end":"2026-06-10T08:09:59.147976Z","steps":["trace[12728587] 'process raft request' (duration: 123.651191ms)","trace[12728587] 'compare' (duration: 58.949602ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:09:59.148192Z","caller":"traceutil/trace.go:171","msg":"trace[1832665551] transaction","detail":"{read_only:false; response_revision:5020; number_of_response:1; }","duration":"183.692133ms","start":"2026-06-10T08:09:58.964461Z","end":"2026-06-10T08:09:59.148153Z","steps":["trace[1832665551] 'process raft request' (duration: 183.194284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:09:59.148238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.692905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-06-10T08:09:59.148302Z","caller":"traceutil/trace.go:171","msg":"trace[1639060664] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5020; }","duration":"182.859388ms","start":"2026-06-10T08:09:58.965428Z","end":"2026-06-10T08:09:59.148288Z","steps":["trace[1639060664] 'agreement among raft nodes before linearized reading' (duration: 182.394169ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:10:01.842711Z","caller":"traceutil/trace.go:171","msg":"trace[1738227446] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"107.00681ms","start":"2026-06-10T08:10:01.735661Z","end":"2026-06-10T08:10:01.842667Z","steps":["trace[1738227446] 'process raft request' (duration: 91.72142ms)","trace[1738227446] 'compare' (duration: 15.108617ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:10:10.857126Z","caller":"traceutil/trace.go:171","msg":"trace[460804665] transaction","detail":"{read_only:false; response_revision:5107; number_of_response:1; }","duration":"157.518273ms","start":"2026-06-10T08:10:10.699568Z","end":"2026-06-10T08:10:10.857086Z","steps":["trace[460804665] 'process raft request' (duration: 116.573411ms)","trace[460804665] 'compare' (duration: 40.638366ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:10:35.255392Z","caller":"traceutil/trace.go:171","msg":"trace[138382257] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"114.863964ms","start":"2026-06-10T08:10:35.140485Z","end":"2026-06-10T08:10:35.255349Z","steps":["trace[138382257] 'process raft request' (duration: 98.532796ms)","trace[138382257] 'compare' (duration: 16.119854ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:10:48.580846Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2834} {"level":"info","ts":"2026-06-10T08:10:48.70348Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2834,"took":"120.734493ms","hash":2329875826,"current-db-size-bytes":53633024,"current-db-size":"54 MB","current-db-size-in-use-bytes":28721152,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-10T08:10:48.70368Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2329875826,"revision":2834,"compact-revision":-1} {"level":"info","ts":"2026-06-10T08:11:10.76206Z","caller":"traceutil/trace.go:171","msg":"trace[1936838049] transaction","detail":"{read_only:false; response_revision:5599; number_of_response:1; }","duration":"109.240747ms","start":"2026-06-10T08:11:10.652774Z","end":"2026-06-10T08:11:10.762015Z","steps":["trace[1936838049] 'process raft request' (duration: 109.099825ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:11:10.762076Z","caller":"traceutil/trace.go:171","msg":"trace[1571345341] transaction","detail":"{read_only:false; response_revision:5598; number_of_response:1; }","duration":"111.307283ms","start":"2026-06-10T08:11:10.650728Z","end":"2026-06-10T08:11:10.762035Z","steps":["trace[1571345341] 'process raft request' (duration: 103.57247ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:11:19.701311Z","caller":"traceutil/trace.go:171","msg":"trace[2121157533] transaction","detail":"{read_only:false; response_revision:5658; number_of_response:1; }","duration":"195.336457ms","start":"2026-06-10T08:11:19.505935Z","end":"2026-06-10T08:11:19.701271Z","steps":["trace[2121157533] 'process raft request' (duration: 179.096232ms)","trace[2121157533] 'compare' (duration: 15.848629ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:11:19.702191Z","caller":"traceutil/trace.go:171","msg":"trace[1130392981] transaction","detail":"{read_only:false; response_revision:5660; number_of_response:1; }","duration":"193.351664ms","start":"2026-06-10T08:11:19.50882Z","end":"2026-06-10T08:11:19.702171Z","steps":["trace[1130392981] 'process raft request' (duration: 192.850255ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:11:19.703743Z","caller":"traceutil/trace.go:171","msg":"trace[83815028] transaction","detail":"{read_only:false; response_revision:5659; number_of_response:1; }","duration":"196.562198ms","start":"2026-06-10T08:11:19.507133Z","end":"2026-06-10T08:11:19.703695Z","steps":["trace[83815028] 'process raft request' (duration: 194.038586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:12:26.394875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.273694ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:12:26.394982Z","caller":"traceutil/trace.go:171","msg":"trace[184528227] linearizableReadLoop","detail":"{readStateIndex:6269; appliedIndex:6268; }","duration":"267.561981ms","start":"2026-06-10T08:12:26.127388Z","end":"2026-06-10T08:12:26.39495Z","steps":["trace[184528227] 'read index received' (duration: 243.296224ms)","trace[184528227] 'applied index is now lower than readState.Index' (duration: 24.264257ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:12:26.395041Z","caller":"traceutil/trace.go:171","msg":"trace[812729322] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6045; }","duration":"194.451257ms","start":"2026-06-10T08:12:26.200564Z","end":"2026-06-10T08:12:26.395015Z","steps":["trace[812729322] 'range keys from in-memory index tree' (duration: 194.255084ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:12:26.395118Z","caller":"traceutil/trace.go:171","msg":"trace[1473514192] transaction","detail":"{read_only:false; response_revision:6046; number_of_response:1; }","duration":"358.77779ms","start":"2026-06-10T08:12:26.036268Z","end":"2026-06-10T08:12:26.395046Z","steps":["trace[1473514192] 'process raft request' (duration: 334.324001ms)","trace[1473514192] 'compare' (duration: 23.849299ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:12:26.395283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.870255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T08:12:26.395331Z","caller":"traceutil/trace.go:171","msg":"trace[1504853231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6046; }","duration":"267.978877ms","start":"2026-06-10T08:12:26.127335Z","end":"2026-06-10T08:12:26.395313Z","steps":["trace[1504853231] 'agreement among raft nodes before linearized reading' (duration: 267.782563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:12:26.395333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:12:26.036242Z","time spent":"358.966694ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:12:26.544755Z","caller":"traceutil/trace.go:171","msg":"trace[916052677] transaction","detail":"{read_only:false; response_revision:6048; number_of_response:1; }","duration":"332.241107ms","start":"2026-06-10T08:12:26.212483Z","end":"2026-06-10T08:12:26.544724Z","steps":["trace[916052677] 'process raft request' (duration: 331.961473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:12:26.544936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:12:26.212456Z","time spent":"332.38141ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:12:26.544973Z","caller":"traceutil/trace.go:171","msg":"trace[1941294696] linearizableReadLoop","detail":"{readStateIndex:6271; appliedIndex:6269; }","duration":"149.849267ms","start":"2026-06-10T08:12:26.395083Z","end":"2026-06-10T08:12:26.544932Z","steps":["trace[1941294696] 'read index received' (duration: 105.92148ms)","trace[1941294696] 'applied index is now lower than readState.Index' (duration: 43.926077ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:12:26.544884Z","caller":"traceutil/trace.go:171","msg":"trace[755198030] transaction","detail":"{read_only:false; response_revision:6047; number_of_response:1; }","duration":"369.558847ms","start":"2026-06-10T08:12:26.175297Z","end":"2026-06-10T08:12:26.544856Z","steps":["trace[755198030] 'process raft request' (duration: 325.693861ms)","trace[755198030] 'compare' (duration: 43.209916ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:12:26.545156Z","caller":"traceutil/trace.go:171","msg":"trace[698449110] transaction","detail":"{read_only:false; response_revision:6049; number_of_response:1; }","duration":"144.913918ms","start":"2026-06-10T08:12:26.400206Z","end":"2026-06-10T08:12:26.54512Z","steps":["trace[698449110] 'process raft request' (duration: 144.310388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:12:26.545289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.301151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-10T08:12:26.545337Z","caller":"traceutil/trace.go:171","msg":"trace[2065085646] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6050; }","duration":"345.390702ms","start":"2026-06-10T08:12:26.199934Z","end":"2026-06-10T08:12:26.545325Z","steps":["trace[2065085646] 'agreement among raft nodes before linearized reading' (duration: 345.208729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:12:26.545354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:12:26.175274Z","time spent":"369.860002ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:12:26.545377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:12:26.199893Z","time spent":"345.475624ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T08:12:26.545372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.93201ms","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-06-10T08:12:26.545511Z","caller":"traceutil/trace.go:171","msg":"trace[853353606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6050; }","duration":"398.088103ms","start":"2026-06-10T08:12:26.147366Z","end":"2026-06-10T08:12:26.545454Z","steps":["trace[853353606] 'agreement among raft nodes before linearized reading' (duration: 397.753308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:12:26.545595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:12:26.14733Z","time spent":"398.252556ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T08:13:09.129504Z","caller":"traceutil/trace.go:171","msg":"trace[101169417] transaction","detail":"{read_only:false; response_revision:6303; number_of_response:1; }","duration":"103.471852ms","start":"2026-06-10T08:13:09.025987Z","end":"2026-06-10T08:13:09.129459Z","steps":["trace[101169417] 'process raft request' (duration: 46.120071ms)","trace[101169417] 'compare' (duration: 57.106917ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:13:29.135612Z","caller":"traceutil/trace.go:171","msg":"trace[734121499] linearizableReadLoop","detail":"{readStateIndex:6752; appliedIndex:6751; }","duration":"109.634811ms","start":"2026-06-10T08:13:29.025952Z","end":"2026-06-10T08:13:29.135587Z","steps":["trace[734121499] 'read index received' (duration: 109.471379ms)","trace[734121499] 'applied index is now lower than readState.Index' (duration: 162.182µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:13:29.135666Z","caller":"traceutil/trace.go:171","msg":"trace[1130610055] transaction","detail":"{read_only:false; response_revision:6512; number_of_response:1; }","duration":"237.857209ms","start":"2026-06-10T08:13:28.897777Z","end":"2026-06-10T08:13:29.135634Z","steps":["trace[1130610055] 'process raft request' (duration: 237.634596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:29.135959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.997677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T08:13:29.136067Z","caller":"traceutil/trace.go:171","msg":"trace[335060308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6512; }","duration":"110.17964ms","start":"2026-06-10T08:13:29.025866Z","end":"2026-06-10T08:13:29.136045Z","steps":["trace[335060308] 'agreement among raft nodes before linearized reading' (duration: 109.880315ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:13:39.369581Z","caller":"traceutil/trace.go:171","msg":"trace[310969902] transaction","detail":"{read_only:false; response_revision:6612; number_of_response:1; }","duration":"100.954129ms","start":"2026-06-10T08:13:39.268597Z","end":"2026-06-10T08:13:39.369551Z","steps":["trace[310969902] 'process raft request' (duration: 88.412999ms)","trace[310969902] 'compare' (duration: 12.397667ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:13:39.37049Z","caller":"traceutil/trace.go:171","msg":"trace[231239972] transaction","detail":"{read_only:false; response_revision:6613; number_of_response:1; }","duration":"100.173906ms","start":"2026-06-10T08:13:39.270284Z","end":"2026-06-10T08:13:39.370458Z","steps":["trace[231239972] 'process raft request' (duration: 99.869571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:53.943106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869985015740031,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:13:54.053Z","caller":"traceutil/trace.go:171","msg":"trace[1596384811] transaction","detail":"{read_only:false; response_revision:6690; number_of_response:1; }","duration":"612.972714ms","start":"2026-06-10T08:13:53.439988Z","end":"2026-06-10T08:13:54.052961Z","steps":["trace[1596384811] 'process raft request' (duration: 612.705093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:54.053235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.439974Z","time spent":"613.145391ms","remote":"127.0.0.1:48466","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-06-10T08:13:54.233583Z","caller":"traceutil/trace.go:171","msg":"trace[313534652] transaction","detail":"{read_only:false; response_revision:6692; number_of_response:1; }","duration":"412.18681ms","start":"2026-06-10T08:13:53.821376Z","end":"2026-06-10T08:13:54.233563Z","steps":["trace[313534652] 'process raft request' (duration: 412.084116ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:13:54.233583Z","caller":"traceutil/trace.go:171","msg":"trace[1461553938] transaction","detail":"{read_only:false; response_revision:6691; number_of_response:1; }","duration":"793.381447ms","start":"2026-06-10T08:13:53.440159Z","end":"2026-06-10T08:13:54.233541Z","steps":["trace[1461553938] 'process raft request' (duration: 793.133257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:54.233797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.821335Z","time spent":"412.381049ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:13:54.233841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.440124Z","time spent":"793.68556ms","remote":"127.0.0.1:48466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:13:54.233929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.852693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T08:13:54.233998Z","caller":"traceutil/trace.go:171","msg":"trace[1937853515] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6693; }","duration":"791.944517ms","start":"2026-06-10T08:13:53.442034Z","end":"2026-06-10T08:13:54.233978Z","steps":["trace[1937853515] 'agreement among raft nodes before linearized reading' (duration: 791.666055ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:13:54.233634Z","caller":"traceutil/trace.go:171","msg":"trace[1121752553] transaction","detail":"{read_only:false; response_revision:6693; number_of_response:1; }","duration":"377.380916ms","start":"2026-06-10T08:13:53.856231Z","end":"2026-06-10T08:13:54.233612Z","steps":["trace[1121752553] 'process raft request' (duration: 377.262371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:54.234059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.442021Z","time spent":"792.02134ms","remote":"127.0.0.1:48466","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":"info","ts":"2026-06-10T08:13:54.233875Z","caller":"traceutil/trace.go:171","msg":"trace[1106916039] linearizableReadLoop","detail":"{readStateIndex:6939; appliedIndex:6935; }","duration":"791.449446ms","start":"2026-06-10T08:13:53.442072Z","end":"2026-06-10T08:13:54.233522Z","steps":["trace[1106916039] 'read index received' (duration: 610.598635ms)","trace[1106916039] 'applied index is now lower than readState.Index' (duration: 180.849991ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:13:54.234124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.856202Z","time spent":"377.860736ms","remote":"127.0.0.1:48466","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-06-10T08:13:54.234394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.170526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T08:13:54.234429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.59773ms","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":"warn","ts":"2026-06-10T08:13:54.234484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.397301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-06-10T08:13:54.2345Z","caller":"traceutil/trace.go:171","msg":"trace[1303346954] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:6693; }","duration":"154.722075ms","start":"2026-06-10T08:13:54.079759Z","end":"2026-06-10T08:13:54.234481Z","steps":["trace[1303346954] 'agreement among raft nodes before linearized reading' (duration: 154.60846ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:13:54.234438Z","caller":"traceutil/trace.go:171","msg":"trace[1541019641] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:6693; }","duration":"237.264091ms","start":"2026-06-10T08:13:53.997159Z","end":"2026-06-10T08:13:54.234423Z","steps":["trace[1541019641] 'agreement among raft nodes before linearized reading' (duration: 237.150666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:54.234523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.545488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-06-10T08:13:54.234526Z","caller":"traceutil/trace.go:171","msg":"trace[2039268704] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6693; }","duration":"630.500705ms","start":"2026-06-10T08:13:53.604016Z","end":"2026-06-10T08:13:54.234517Z","steps":["trace[2039268704] 'agreement among raft nodes before linearized reading' (duration: 630.361069ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:13:54.234576Z","caller":"traceutil/trace.go:171","msg":"trace[1862820530] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6693; }","duration":"631.753027ms","start":"2026-06-10T08:13:53.602811Z","end":"2026-06-10T08:13:54.234564Z","steps":["trace[1862820530] 'agreement among raft nodes before linearized reading' (duration: 631.612871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:54.234585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.865999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"warn","ts":"2026-06-10T08:13:54.234611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.602788Z","time spent":"631.81535ms","remote":"127.0.0.1:48440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4806,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-06-10T08:13:54.234619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.603995Z","time spent":"630.595249ms","remote":"127.0.0.1:48440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4806,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-06-10T08:13:54.23465Z","caller":"traceutil/trace.go:171","msg":"trace[637445983] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6693; }","duration":"422.987934ms","start":"2026-06-10T08:13:53.811646Z","end":"2026-06-10T08:13:54.234634Z","steps":["trace[637445983] 'agreement among raft nodes before linearized reading' (duration: 422.811467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:54.234702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.811612Z","time spent":"423.079038ms","remote":"127.0.0.1:48440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4806,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-06-10T08:13:54.234877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.221692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T08:13:54.234952Z","caller":"traceutil/trace.go:171","msg":"trace[384696552] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6693; }","duration":"716.332946ms","start":"2026-06-10T08:13:53.518593Z","end":"2026-06-10T08:13:54.234926Z","steps":["trace[384696552] 'agreement among raft nodes before linearized reading' (duration: 715.71379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:13:54.235024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:13:53.518566Z","time spent":"716.449421ms","remote":"127.0.0.1:48388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-10T08:13:56.587518Z","caller":"traceutil/trace.go:171","msg":"trace[1412210824] transaction","detail":"{read_only:false; response_revision:6707; number_of_response:1; }","duration":"122.547102ms","start":"2026-06-10T08:13:56.464943Z","end":"2026-06-10T08:13:56.58749Z","steps":["trace[1412210824] 'process raft request' (duration: 122.364565ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:22.011551Z","caller":"traceutil/trace.go:171","msg":"trace[491717721] transaction","detail":"{read_only:false; response_revision:6890; number_of_response:1; }","duration":"100.455989ms","start":"2026-06-10T08:14:21.91105Z","end":"2026-06-10T08:14:22.011506Z","steps":["trace[491717721] 'process raft request' (duration: 74.152178ms)","trace[491717721] 'compare' (duration: 26.097303ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:15:47.095704Z","caller":"traceutil/trace.go:171","msg":"trace[1711223964] linearizableReadLoop","detail":"{readStateIndex:7618; appliedIndex:7617; }","duration":"121.981094ms","start":"2026-06-10T08:15:46.973678Z","end":"2026-06-10T08:15:47.095659Z","steps":["trace[1711223964] 'read index received' (duration: 121.819788ms)","trace[1711223964] 'applied index is now lower than readState.Index' (duration: 160.126µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:15:47.095783Z","caller":"traceutil/trace.go:171","msg":"trace[452748922] transaction","detail":"{read_only:false; response_revision:7346; number_of_response:1; }","duration":"191.590623ms","start":"2026-06-10T08:15:46.90417Z","end":"2026-06-10T08:15:47.095761Z","steps":["trace[452748922] 'process raft request' (duration: 191.283283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:15:47.096004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.311345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T08:15:47.096086Z","caller":"traceutil/trace.go:171","msg":"trace[1865865721] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7346; }","duration":"122.477201ms","start":"2026-06-10T08:15:46.97359Z","end":"2026-06-10T08:15:47.096067Z","steps":["trace[1865865721] 'agreement among raft nodes before linearized reading' (duration: 122.249323ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:15:47.243431Z","caller":"traceutil/trace.go:171","msg":"trace[87295027] transaction","detail":"{read_only:false; response_revision:7348; number_of_response:1; }","duration":"142.503281ms","start":"2026-06-10T08:15:47.100907Z","end":"2026-06-10T08:15:47.243411Z","steps":["trace[87295027] 'process raft request' (duration: 142.450899ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:15:47.243465Z","caller":"traceutil/trace.go:171","msg":"trace[1227925654] linearizableReadLoop","detail":"{readStateIndex:7619; appliedIndex:7618; }","duration":"147.636542ms","start":"2026-06-10T08:15:47.095797Z","end":"2026-06-10T08:15:47.243434Z","steps":["trace[1227925654] 'read index received' (duration: 79.663532ms)","trace[1227925654] 'applied index is now lower than readState.Index' (duration: 67.97132ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:15:47.243483Z","caller":"traceutil/trace.go:171","msg":"trace[205080033] transaction","detail":"{read_only:false; response_revision:7347; number_of_response:1; }","duration":"205.780213ms","start":"2026-06-10T08:15:47.037639Z","end":"2026-06-10T08:15:47.243419Z","steps":["trace[205080033] 'process raft request' (duration: 137.808363ms)","trace[205080033] 'compare' (duration: 67.794304ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:15:47.243752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.466641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:15:47.243785Z","caller":"traceutil/trace.go:171","msg":"trace[1774627158] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7348; }","duration":"269.530174ms","start":"2026-06-10T08:15:46.974245Z","end":"2026-06-10T08:15:47.243775Z","steps":["trace[1774627158] 'agreement among raft nodes before linearized reading' (duration: 269.396199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:15:47.243968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.662074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:508019"} {"level":"info","ts":"2026-06-10T08:15:47.244019Z","caller":"traceutil/trace.go:171","msg":"trace[241102951] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:7348; }","duration":"229.765728ms","start":"2026-06-10T08:15:47.014238Z","end":"2026-06-10T08:15:47.244004Z","steps":["trace[241102951] 'agreement among raft nodes before linearized reading' (duration: 229.332844ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:15:47.509275Z","caller":"traceutil/trace.go:171","msg":"trace[553463180] transaction","detail":"{read_only:false; response_revision:7349; number_of_response:1; }","duration":"261.561685ms","start":"2026-06-10T08:15:47.247674Z","end":"2026-06-10T08:15:47.509235Z","steps":["trace[553463180] 'process raft request' (duration: 260.059414ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:15:48.588493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5435} {"level":"info","ts":"2026-06-10T08:15:48.695177Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5435,"took":"104.905233ms","hash":52591967,"current-db-size-bytes":53633024,"current-db-size":"54 MB","current-db-size-in-use-bytes":18649088,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-06-10T08:15:48.695241Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":52591967,"revision":5435,"compact-revision":2834}