{"level":"warn","ts":"2026-10-26T00:49:50.689748Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T00:49:50.689883Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.72: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://162.253.55.72:2380","--initial-cluster=instance=https://162.253.55.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.72: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-10-26T00:49:50.68999Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T00:49:50.690017Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.72:2380"]} {"level":"info","ts":"2026-10-26T00:49:50.690053Z","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-10-26T00:49:50.690793Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"]} {"level":"info","ts":"2026-10-26T00:49:50.690925Z","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://162.253.55.72:2380"],"listen-peer-urls":["https://162.253.55.72:2380"],"advertise-client-urls":["https://162.253.55.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.72: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-10-26T00:49:50.700125Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.934307ms"} {"level":"info","ts":"2026-10-26T00:49:50.711751Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"638d1b11488f2a2e","cluster-id":"9ca31ccb1db898d"} {"level":"info","ts":"2026-10-26T00:49:50.711885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=()"} {"level":"info","ts":"2026-10-26T00:49:50.711913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became follower at term 0"} {"level":"info","ts":"2026-10-26T00:49:50.711923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 638d1b11488f2a2e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-26T00:49:50.711943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became follower at term 1"} {"level":"info","ts":"2026-10-26T00:49:50.711989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=(7173419542516804142)"} {"level":"warn","ts":"2026-10-26T00:49:50.721341Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-26T00:49:50.722895Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-26T00:49:50.72463Z","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-10-26T00:49:50.72783Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"638d1b11488f2a2e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-26T00:49:50.7283Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"638d1b11488f2a2e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-26T00:49:50.728351Z","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-10-26T00:49:50.728644Z","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-10-26T00:49:50.728815Z","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-10-26T00:49:50.730366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=(7173419542516804142)"} {"level":"info","ts":"2026-10-26T00:49:50.731661Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ca31ccb1db898d","local-member-id":"638d1b11488f2a2e","added-peer-id":"638d1b11488f2a2e","added-peer-peer-urls":["https://162.253.55.72:2380"]} {"level":"info","ts":"2026-10-26T00:49:50.73428Z","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-10-26T00:49:50.7345Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"638d1b11488f2a2e","initial-advertise-peer-urls":["https://162.253.55.72:2380"],"listen-peer-urls":["https://162.253.55.72:2380"],"advertise-client-urls":["https://162.253.55.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-26T00:49:50.734523Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-26T00:49:50.734657Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.72:2380"} {"level":"info","ts":"2026-10-26T00:49:50.73467Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.72:2380"} {"level":"info","ts":"2026-10-26T00:49:51.212913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e is starting a new election at term 1"} {"level":"info","ts":"2026-10-26T00:49:51.213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became pre-candidate at term 1"} {"level":"info","ts":"2026-10-26T00:49:51.213025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e received MsgPreVoteResp from 638d1b11488f2a2e at term 1"} {"level":"info","ts":"2026-10-26T00:49:51.213045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became candidate at term 2"} {"level":"info","ts":"2026-10-26T00:49:51.213053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e received MsgVoteResp from 638d1b11488f2a2e at term 2"} {"level":"info","ts":"2026-10-26T00:49:51.213067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became leader at term 2"} {"level":"info","ts":"2026-10-26T00:49:51.213079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 638d1b11488f2a2e elected leader 638d1b11488f2a2e at term 2"} {"level":"info","ts":"2026-10-26T00:49:51.22519Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T00:49:51.225461Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T00:49:51.225474Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T00:49:51.225818Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-26T00:49:51.225921Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-26T00:49:51.225925Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"638d1b11488f2a2e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.72:2379]}","request-path":"/0/members/638d1b11488f2a2e/attributes","cluster-id":"9ca31ccb1db898d","publish-timeout":"7s"} {"level":"info","ts":"2026-10-26T00:49:51.227996Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.72:2379"} {"level":"info","ts":"2026-10-26T00:49:51.228125Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-26T00:49:51.255094Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ca31ccb1db898d","local-member-id":"638d1b11488f2a2e","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T00:49:51.255212Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T00:49:51.255244Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T00:49:53.803329Z","caller":"traceutil/trace.go:171","msg":"trace[831697375] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"185.348029ms","start":"2026-10-26T00:49:53.617952Z","end":"2026-10-26T00:49:53.8033Z","steps":["trace[831697375] 'read index received' (duration: 185.097705ms)","trace[831697375] 'applied index is now lower than readState.Index' (duration: 249.144µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:49:53.803379Z","caller":"traceutil/trace.go:171","msg":"trace[823704618] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"186.698062ms","start":"2026-10-26T00:49:53.61665Z","end":"2026-10-26T00:49:53.803348Z","steps":["trace[823704618] 'process raft request' (duration: 186.459758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:49:53.803616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.601094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-26T00:49:53.803716Z","caller":"traceutil/trace.go:171","msg":"trace[1035953870] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:72; }","duration":"185.771476ms","start":"2026-10-26T00:49:53.617922Z","end":"2026-10-26T00:49:53.803694Z","steps":["trace[1035953870] 'agreement among raft nodes before linearized reading' (duration: 185.498882ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:49:54.601488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.514839ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-10-26T00:49:54.601723Z","caller":"traceutil/trace.go:171","msg":"trace[402565468] linearizableReadLoop","detail":"{readStateIndex:147; appliedIndex:146; }","duration":"231.822341ms","start":"2026-10-26T00:49:54.36988Z","end":"2026-10-26T00:49:54.601702Z","steps":["trace[402565468] 'read index received' (duration: 4.877057ms)","trace[402565468] 'applied index is now lower than readState.Index' (duration: 226.943274ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:49:54.601842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.980923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-dns\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:49:54.60193Z","caller":"traceutil/trace.go:171","msg":"trace[219619604] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-dns; range_end:; response_count:0; response_revision:143; }","duration":"232.096666ms","start":"2026-10-26T00:49:54.369821Z","end":"2026-10-26T00:49:54.601918Z","steps":["trace[219619604] 'agreement among raft nodes before linearized reading' (duration: 231.968324ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:49:54.966782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.123769ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:49:54.966942Z","caller":"traceutil/trace.go:171","msg":"trace[1451908107] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"363.190091ms","start":"2026-10-26T00:49:54.60373Z","end":"2026-10-26T00:49:54.96692Z","steps":["trace[1451908107] 'process raft request' (duration: 173.518953ms)","trace[1451908107] 'compare' (duration: 188.908185ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:49:54.967009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:49:54.603706Z","time spent":"363.275152ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T00:49:55.215841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.402808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:49:55.215994Z","caller":"traceutil/trace.go:171","msg":"trace[522166357] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"244.255513ms","start":"2026-10-26T00:49:54.971719Z","end":"2026-10-26T00:49:55.215975Z","steps":["trace[522166357] 'process raft request' (duration: 244.213703ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:49:55.216038Z","caller":"traceutil/trace.go:171","msg":"trace[608509539] linearizableReadLoop","detail":"{readStateIndex:149; appliedIndex:147; }","duration":"494.706647ms","start":"2026-10-26T00:49:54.721283Z","end":"2026-10-26T00:49:55.21599Z","steps":["trace[608509539] 'read index received' (duration: 56.086753ms)","trace[608509539] 'applied index is now lower than readState.Index' (duration: 438.616294ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:49:55.216045Z","caller":"traceutil/trace.go:171","msg":"trace[1083262912] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"610.405981ms","start":"2026-10-26T00:49:54.605553Z","end":"2026-10-26T00:49:55.215959Z","steps":["trace[1083262912] 'process raft request' (duration: 462.82959ms)","trace[1083262912] 'compare' (duration: 147.259576ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:49:55.21621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.91024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-26T00:49:55.216249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:49:54.605533Z","time spent":"610.618714ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":659,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T00:49:55.216296Z","caller":"traceutil/trace.go:171","msg":"trace[1551162071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:146; }","duration":"495.057793ms","start":"2026-10-26T00:49:54.721219Z","end":"2026-10-26T00:49:55.216276Z","steps":["trace[1551162071] 'agreement among raft nodes before linearized reading' (duration: 494.8754ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:49:55.216337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:49:54.721196Z","time spent":"495.133675ms","remote":"127.0.0.1:44858","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-10-26T00:50:01.374758Z","caller":"traceutil/trace.go:171","msg":"trace[1611237986] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"142.676456ms","start":"2026-10-26T00:50:01.232039Z","end":"2026-10-26T00:50:01.374715Z","steps":["trace[1611237986] 'process raft request' (duration: 77.034412ms)","trace[1611237986] 'compare' (duration: 65.36429ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:50:01.374933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.548234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-10-26T00:50:01.374991Z","caller":"traceutil/trace.go:171","msg":"trace[1027052493] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"136.426743ms","start":"2026-10-26T00:50:01.238517Z","end":"2026-10-26T00:50:01.374943Z","steps":["trace[1027052493] 'process raft request' (duration: 136.17268ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:01.375053Z","caller":"traceutil/trace.go:171","msg":"trace[1806936726] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:366; }","duration":"112.726626ms","start":"2026-10-26T00:50:01.262306Z","end":"2026-10-26T00:50:01.375033Z","steps":["trace[1806936726] 'agreement among raft nodes before linearized reading' (duration: 112.483762ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:01.374766Z","caller":"traceutil/trace.go:171","msg":"trace[1793584254] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:375; }","duration":"108.065587ms","start":"2026-10-26T00:50:01.266679Z","end":"2026-10-26T00:50:01.374744Z","steps":["trace[1793584254] 'read index received' (duration: 42.479384ms)","trace[1793584254] 'applied index is now lower than readState.Index' (duration: 65.584863ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:50:01.375289Z","caller":"traceutil/trace.go:171","msg":"trace[1478374429] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"142.170758ms","start":"2026-10-26T00:50:01.232627Z","end":"2026-10-26T00:50:01.374798Z","steps":["trace[1478374429] 'process raft request' (duration: 141.997356ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:01.417736Z","caller":"traceutil/trace.go:171","msg":"trace[617178419] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"142.446872ms","start":"2026-10-26T00:50:01.275265Z","end":"2026-10-26T00:50:01.417712Z","steps":["trace[617178419] 'process raft request' (duration: 142.186688ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:01.417722Z","caller":"traceutil/trace.go:171","msg":"trace[1098823529] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"140.341381ms","start":"2026-10-26T00:50:01.277343Z","end":"2026-10-26T00:50:01.417685Z","steps":["trace[1098823529] 'process raft request' (duration: 140.22455ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:50:01.418007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.24674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-10-26T00:50:01.41812Z","caller":"traceutil/trace.go:171","msg":"trace[1728959842] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:369; }","duration":"106.414553ms","start":"2026-10-26T00:50:01.311649Z","end":"2026-10-26T00:50:01.418064Z","steps":["trace[1728959842] 'agreement among raft nodes before linearized reading' (duration: 106.133619ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:01.418267Z","caller":"traceutil/trace.go:171","msg":"trace[1282603844] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"136.970312ms","start":"2026-10-26T00:50:01.28112Z","end":"2026-10-26T00:50:01.418091Z","steps":["trace[1282603844] 'process raft request' (duration: 136.488485ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:01.535179Z","caller":"traceutil/trace.go:171","msg":"trace[512885270] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"110.524954ms","start":"2026-10-26T00:50:01.424627Z","end":"2026-10-26T00:50:01.535152Z","steps":["trace[512885270] 'process raft request' (duration: 84.319559ms)","trace[512885270] 'compare' (duration: 25.623096ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:50:01.535152Z","caller":"traceutil/trace.go:171","msg":"trace[1500152143] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"106.668977ms","start":"2026-10-26T00:50:01.428416Z","end":"2026-10-26T00:50:01.535085Z","steps":["trace[1500152143] 'process raft request' (duration: 106.498214ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:01.535806Z","caller":"traceutil/trace.go:171","msg":"trace[22425345] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"106.987161ms","start":"2026-10-26T00:50:01.428807Z","end":"2026-10-26T00:50:01.535794Z","steps":["trace[22425345] 'process raft request' (duration: 106.20626ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:01.535814Z","caller":"traceutil/trace.go:171","msg":"trace[226019728] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"108.371702ms","start":"2026-10-26T00:50:01.427425Z","end":"2026-10-26T00:50:01.535797Z","steps":["trace[226019728] 'process raft request' (duration: 107.359637ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:35.39632Z","caller":"traceutil/trace.go:171","msg":"trace[807794936] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"100.117302ms","start":"2026-10-26T00:50:35.296145Z","end":"2026-10-26T00:50:35.396263Z","steps":["trace[807794936] 'process raft request' (duration: 99.81233ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:38.203854Z","caller":"traceutil/trace.go:171","msg":"trace[971557319] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"141.477729ms","start":"2026-10-26T00:50:38.062341Z","end":"2026-10-26T00:50:38.203819Z","steps":["trace[971557319] 'process raft request' (duration: 78.495827ms)","trace[971557319] 'compare' (duration: 62.79726ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:50:38.207319Z","caller":"traceutil/trace.go:171","msg":"trace[1084613737] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"122.545686ms","start":"2026-10-26T00:50:38.084754Z","end":"2026-10-26T00:50:38.2073Z","steps":["trace[1084613737] 'process raft request' (duration: 122.202083ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:38.207891Z","caller":"traceutil/trace.go:171","msg":"trace[1292215359] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"104.175351ms","start":"2026-10-26T00:50:38.103686Z","end":"2026-10-26T00:50:38.207861Z","steps":["trace[1292215359] 'process raft request' (duration: 103.860107ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:38.223001Z","caller":"traceutil/trace.go:171","msg":"trace[66742833] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"123.630288ms","start":"2026-10-26T00:50:38.099339Z","end":"2026-10-26T00:50:38.222969Z","steps":["trace[66742833] 'process raft request' (duration: 107.859819ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:44.343833Z","caller":"traceutil/trace.go:171","msg":"trace[471581309] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"334.039698ms","start":"2026-10-26T00:50:44.008904Z","end":"2026-10-26T00:50:44.342943Z","steps":["trace[471581309] 'process raft request' (duration: 333.187179ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:50:44.345069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:50:44.008867Z","time spent":"335.2346ms","remote":"127.0.0.1:44942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036249,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:50:44.835296Z","caller":"traceutil/trace.go:171","msg":"trace[846855941] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:680; }","duration":"339.814407ms","start":"2026-10-26T00:50:44.495458Z","end":"2026-10-26T00:50:44.835272Z","steps":["trace[846855941] 'read index received' (duration: 240.385372ms)","trace[846855941] 'applied index is now lower than readState.Index' (duration: 99.428175ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:50:44.83539Z","caller":"traceutil/trace.go:171","msg":"trace[1867614827] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"467.434218ms","start":"2026-10-26T00:50:44.367921Z","end":"2026-10-26T00:50:44.835355Z","steps":["trace[1867614827] 'process raft request' (duration: 467.258956ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:50:44.835624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.432377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-26T00:50:44.835678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:50:44.367898Z","time spent":"467.5783ms","remote":"127.0.0.1:45056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:50:44.83577Z","caller":"traceutil/trace.go:171","msg":"trace[615831571] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"486.882277ms","start":"2026-10-26T00:50:44.348866Z","end":"2026-10-26T00:50:44.835749Z","steps":["trace[615831571] 'process raft request' (duration: 386.847366ms)","trace[615831571] 'compare' (duration: 99.319423ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:50:44.835481Z","caller":"traceutil/trace.go:171","msg":"trace[1897545741] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"407.317875ms","start":"2026-10-26T00:50:44.428106Z","end":"2026-10-26T00:50:44.835424Z","steps":["trace[1897545741] 'process raft request' (duration: 407.129563ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:50:44.835864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:50:44.348824Z","time spent":"486.987477ms","remote":"127.0.0.1:45148","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-10-26T00:50:44.836025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:50:44.428071Z","time spent":"407.845431ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T00:50:44.835697Z","caller":"traceutil/trace.go:171","msg":"trace[980625510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"212.543078ms","start":"2026-10-26T00:50:44.623121Z","end":"2026-10-26T00:50:44.835664Z","steps":["trace[980625510] 'agreement among raft nodes before linearized reading' (duration: 212.342626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:50:44.835683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.217121ms","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-10-26T00:50:44.836433Z","caller":"traceutil/trace.go:171","msg":"trace[1934324356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:659; }","duration":"341.011909ms","start":"2026-10-26T00:50:44.495398Z","end":"2026-10-26T00:50:44.83641Z","steps":["trace[1934324356] 'agreement among raft nodes before linearized reading' (duration: 340.040269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:50:44.836595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:50:44.495377Z","time spent":"341.109139ms","remote":"127.0.0.1:45148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-26T00:50:59.777162Z","caller":"traceutil/trace.go:171","msg":"trace[447667403] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"234.439063ms","start":"2026-10-26T00:50:59.542681Z","end":"2026-10-26T00:50:59.77712Z","steps":["trace[447667403] 'process raft request' (duration: 234.152321ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:50:59.779107Z","caller":"traceutil/trace.go:171","msg":"trace[1600619337] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"236.356921ms","start":"2026-10-26T00:50:59.542718Z","end":"2026-10-26T00:50:59.779075Z","steps":["trace[1600619337] 'process raft request' (duration: 236.16827ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:51:08.621535Z","caller":"traceutil/trace.go:171","msg":"trace[112389185] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"114.581762ms","start":"2026-10-26T00:51:08.50692Z","end":"2026-10-26T00:51:08.621502Z","steps":["trace[112389185] 'process raft request' (duration: 114.354869ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:02.347149Z","caller":"traceutil/trace.go:171","msg":"trace[906096766] transaction","detail":"{read_only:false; response_revision:1593; number_of_response:1; }","duration":"118.934953ms","start":"2026-10-26T00:52:02.228183Z","end":"2026-10-26T00:52:02.347118Z","steps":["trace[906096766] 'process raft request' (duration: 45.921467ms)","trace[906096766] 'compare' (duration: 72.870995ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:52:27.338696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.246149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-63017a4c-e0c9-4c15-a40e-f3d3bb6c4b88\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-26T00:52:27.338783Z","caller":"traceutil/trace.go:171","msg":"trace[2051376416] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-63017a4c-e0c9-4c15-a40e-f3d3bb6c4b88; range_end:; response_count:1; response_revision:1940; }","duration":"436.384055ms","start":"2026-10-26T00:52:26.90238Z","end":"2026-10-26T00:52:27.338764Z","steps":["trace[2051376416] 'range keys from in-memory index tree' (duration: 436.027601ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:52:27.33882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:52:26.902362Z","time spent":"436.448708ms","remote":"127.0.0.1:45056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-63017a4c-e0c9-4c15-a40e-f3d3bb6c4b88\" "} {"level":"info","ts":"2026-10-26T00:52:27.379824Z","caller":"traceutil/trace.go:171","msg":"trace[149416044] linearizableReadLoop","detail":"{readStateIndex:2016; appliedIndex:2015; }","duration":"303.219773ms","start":"2026-10-26T00:52:27.076571Z","end":"2026-10-26T00:52:27.37979Z","steps":["trace[149416044] 'read index received' (duration: 303.189422ms)","trace[149416044] 'applied index is now lower than readState.Index' (duration: 28.991µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:52:27.379895Z","caller":"traceutil/trace.go:171","msg":"trace[428043555] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"325.228682ms","start":"2026-10-26T00:52:27.054644Z","end":"2026-10-26T00:52:27.379873Z","steps":["trace[428043555] 'process raft request' (duration: 325.018583ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:52:27.380095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.514384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-10-26T00:52:27.380173Z","caller":"traceutil/trace.go:171","msg":"trace[272768658] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1941; }","duration":"303.631569ms","start":"2026-10-26T00:52:27.076488Z","end":"2026-10-26T00:52:27.380147Z","steps":["trace[272768658] 'agreement among raft nodes before linearized reading' (duration: 303.440122ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:52:27.38021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:52:27.076467Z","time spent":"303.734803ms","remote":"127.0.0.1:40840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5754,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-10-26T00:52:27.380221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:52:27.054617Z","time spent":"325.411009ms","remote":"127.0.0.1:45148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:52:27.472518Z","caller":"traceutil/trace.go:171","msg":"trace[1782452072] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"126.02583ms","start":"2026-10-26T00:52:27.346445Z","end":"2026-10-26T00:52:27.47247Z","steps":["trace[1782452072] 'process raft request' (duration: 119.452455ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:27.591974Z","caller":"traceutil/trace.go:171","msg":"trace[1331777659] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"114.408688ms","start":"2026-10-26T00:52:27.477542Z","end":"2026-10-26T00:52:27.591951Z","steps":["trace[1331777659] 'process raft request' (duration: 111.916511ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:27.592275Z","caller":"traceutil/trace.go:171","msg":"trace[1996405437] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"114.639216ms","start":"2026-10-26T00:52:27.477604Z","end":"2026-10-26T00:52:27.592243Z","steps":["trace[1996405437] 'process raft request' (duration: 114.307423ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:27.592485Z","caller":"traceutil/trace.go:171","msg":"trace[1621334011] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"102.68622ms","start":"2026-10-26T00:52:27.489764Z","end":"2026-10-26T00:52:27.59245Z","steps":["trace[1621334011] 'process raft request' (duration: 102.42481ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:52:27.803997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.048928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:52:27.80439Z","caller":"traceutil/trace.go:171","msg":"trace[289695632] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"206.639142ms","start":"2026-10-26T00:52:27.597682Z","end":"2026-10-26T00:52:27.804321Z","steps":["trace[289695632] 'process raft request' (duration: 106.113775ms)","trace[289695632] 'compare' (duration: 99.934493ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:52:27.82786Z","caller":"traceutil/trace.go:171","msg":"trace[1343342888] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"228.599616ms","start":"2026-10-26T00:52:27.599238Z","end":"2026-10-26T00:52:27.827838Z","steps":["trace[1343342888] 'process raft request' (duration: 228.43489ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:27.828244Z","caller":"traceutil/trace.go:171","msg":"trace[1820387370] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"228.804694ms","start":"2026-10-26T00:52:27.599417Z","end":"2026-10-26T00:52:27.828222Z","steps":["trace[1820387370] 'process raft request' (duration: 228.383208ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:52:27.828376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.282212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:52:27.828242Z","caller":"traceutil/trace.go:171","msg":"trace[1331168779] linearizableReadLoop","detail":"{readStateIndex:2025; appliedIndex:2021; }","duration":"162.138997ms","start":"2026-10-26T00:52:27.666079Z","end":"2026-10-26T00:52:27.828218Z","steps":["trace[1331168779] 'read index received' (duration: 37.726901ms)","trace[1331168779] 'applied index is now lower than readState.Index' (duration: 124.410786ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:52:27.828432Z","caller":"traceutil/trace.go:171","msg":"trace[834009354] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1950; }","duration":"162.387097ms","start":"2026-10-26T00:52:27.666032Z","end":"2026-10-26T00:52:27.828419Z","steps":["trace[834009354] 'agreement among raft nodes before linearized reading' (duration: 162.264592ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:27.828568Z","caller":"traceutil/trace.go:171","msg":"trace[105748188] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"228.762872ms","start":"2026-10-26T00:52:27.599717Z","end":"2026-10-26T00:52:27.82848Z","steps":["trace[105748188] 'process raft request' (duration: 228.397918ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:39.946471Z","caller":"traceutil/trace.go:171","msg":"trace[174266108] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"286.181458ms","start":"2026-10-26T00:52:39.660264Z","end":"2026-10-26T00:52:39.946445Z","steps":["trace[174266108] 'process raft request' (duration: 251.897864ms)","trace[174266108] 'compare' (duration: 33.961352ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:52:39.946979Z","caller":"traceutil/trace.go:171","msg":"trace[1575416871] linearizableReadLoop","detail":"{readStateIndex:2133; appliedIndex:2132; }","duration":"284.667683ms","start":"2026-10-26T00:52:39.66158Z","end":"2026-10-26T00:52:39.946247Z","steps":["trace[1575416871] 'read index received' (duration: 250.469501ms)","trace[1575416871] 'applied index is now lower than readState.Index' (duration: 34.193732ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:52:39.947289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.69395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-10-26T00:52:39.947291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.163753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-10-26T00:52:39.947336Z","caller":"traceutil/trace.go:171","msg":"trace[188271134] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2055; }","duration":"285.812774ms","start":"2026-10-26T00:52:39.661511Z","end":"2026-10-26T00:52:39.947324Z","steps":["trace[188271134] 'agreement among raft nodes before linearized reading' (duration: 285.664049ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:39.947345Z","caller":"traceutil/trace.go:171","msg":"trace[1641967111] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2055; }","duration":"260.311229ms","start":"2026-10-26T00:52:39.687021Z","end":"2026-10-26T00:52:39.947332Z","steps":["trace[1641967111] 'agreement among raft nodes before linearized reading' (duration: 260.058519ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:52:43.577602Z","caller":"traceutil/trace.go:171","msg":"trace[1709340089] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"126.338999ms","start":"2026-10-26T00:52:43.451241Z","end":"2026-10-26T00:52:43.57758Z","steps":["trace[1709340089] 'process raft request' (duration: 126.210096ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:53:11.798561Z","caller":"traceutil/trace.go:171","msg":"trace[154016180] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"120.339317ms","start":"2026-10-26T00:53:11.678176Z","end":"2026-10-26T00:53:11.798516Z","steps":["trace[154016180] 'process raft request' (duration: 120.11726ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:53:12.133385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.688292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:53:12.133923Z","caller":"traceutil/trace.go:171","msg":"trace[785304746] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"330.869246ms","start":"2026-10-26T00:53:11.803016Z","end":"2026-10-26T00:53:12.133885Z","steps":["trace[785304746] 'process raft request' (duration: 189.595156ms)","trace[785304746] 'compare' (duration: 140.440465ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:53:12.134133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:53:11.802992Z","time spent":"331.040171ms","remote":"127.0.0.1:45148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T00:54:05.61298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.768004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-10-26T00:54:05.613061Z","caller":"traceutil/trace.go:171","msg":"trace[526671370] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2631; }","duration":"241.895727ms","start":"2026-10-26T00:54:05.371148Z","end":"2026-10-26T00:54:05.613044Z","steps":["trace[526671370] 'range keys from in-memory index tree' (duration: 241.61391ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:54:36.35302Z","caller":"traceutil/trace.go:171","msg":"trace[1568613324] linearizableReadLoop","detail":"{readStateIndex:2905; appliedIndex:2904; }","duration":"131.258086ms","start":"2026-10-26T00:54:36.221731Z","end":"2026-10-26T00:54:36.352989Z","steps":["trace[1568613324] 'read index received' (duration: 131.061392ms)","trace[1568613324] 'applied index is now lower than readState.Index' (duration: 195.674µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:54:36.35314Z","caller":"traceutil/trace.go:171","msg":"trace[2115189414] transaction","detail":"{read_only:false; response_revision:2800; number_of_response:1; }","duration":"156.975723ms","start":"2026-10-26T00:54:36.196132Z","end":"2026-10-26T00:54:36.353108Z","steps":["trace[2115189414] 'process raft request' (duration: 156.717057ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:54:36.353168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.44172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:54:36.353347Z","caller":"traceutil/trace.go:171","msg":"trace[62239324] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2800; }","duration":"131.709775ms","start":"2026-10-26T00:54:36.221623Z","end":"2026-10-26T00:54:36.353333Z","steps":["trace[62239324] 'agreement among raft nodes before linearized reading' (duration: 131.480751ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:05.946514Z","caller":"traceutil/trace.go:171","msg":"trace[454557985] transaction","detail":"{read_only:false; response_revision:3994; number_of_response:1; }","duration":"156.902928ms","start":"2026-10-26T00:58:05.789584Z","end":"2026-10-26T00:58:05.946487Z","steps":["trace[454557985] 'process raft request' (duration: 156.737666ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:06.278953Z","caller":"traceutil/trace.go:171","msg":"trace[1719888239] transaction","detail":"{read_only:false; response_revision:3996; number_of_response:1; }","duration":"127.849445ms","start":"2026-10-26T00:58:06.151061Z","end":"2026-10-26T00:58:06.27891Z","steps":["trace[1719888239] 'process raft request' (duration: 97.651711ms)","trace[1719888239] 'compare' (duration: 30.041702ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:07.525242Z","caller":"traceutil/trace.go:171","msg":"trace[731723320] transaction","detail":"{read_only:false; response_revision:4000; number_of_response:1; }","duration":"115.199329ms","start":"2026-10-26T00:58:07.410014Z","end":"2026-10-26T00:58:07.525214Z","steps":["trace[731723320] 'process raft request' (duration: 115.014297ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:07.558586Z","caller":"traceutil/trace.go:171","msg":"trace[1141023257] transaction","detail":"{read_only:false; response_revision:4001; number_of_response:1; }","duration":"100.013317ms","start":"2026-10-26T00:58:07.458553Z","end":"2026-10-26T00:58:07.558566Z","steps":["trace[1141023257] 'process raft request' (duration: 93.778285ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:08.402149Z","caller":"traceutil/trace.go:171","msg":"trace[1450989331] linearizableReadLoop","detail":"{readStateIndex:4158; appliedIndex:4157; }","duration":"119.166771ms","start":"2026-10-26T00:58:08.282954Z","end":"2026-10-26T00:58:08.402121Z","steps":["trace[1450989331] 'read index received' (duration: 118.94085ms)","trace[1450989331] 'applied index is now lower than readState.Index' (duration: 224.661µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:08.402411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.426734ms","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-10-26T00:58:08.402459Z","caller":"traceutil/trace.go:171","msg":"trace[1062069943] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4006; }","duration":"119.544836ms","start":"2026-10-26T00:58:08.282902Z","end":"2026-10-26T00:58:08.402447Z","steps":["trace[1062069943] 'agreement among raft nodes before linearized reading' (duration: 119.333844ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:08.40255Z","caller":"traceutil/trace.go:171","msg":"trace[76209787] transaction","detail":"{read_only:false; response_revision:4006; number_of_response:1; }","duration":"162.812097ms","start":"2026-10-26T00:58:08.239659Z","end":"2026-10-26T00:58:08.402472Z","steps":["trace[76209787] 'process raft request' (duration: 162.307322ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:09.388239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.891248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12431"} {"level":"info","ts":"2026-10-26T00:58:09.388323Z","caller":"traceutil/trace.go:171","msg":"trace[1764603620] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4009; }","duration":"142.03967ms","start":"2026-10-26T00:58:09.246263Z","end":"2026-10-26T00:58:09.388303Z","steps":["trace[1764603620] 'range keys from in-memory index tree' (duration: 141.639025ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:09.388356Z","caller":"traceutil/trace.go:171","msg":"trace[1797462855] transaction","detail":"{read_only:false; response_revision:4010; number_of_response:1; }","duration":"132.514131ms","start":"2026-10-26T00:58:09.255808Z","end":"2026-10-26T00:58:09.388322Z","steps":["trace[1797462855] 'process raft request' (duration: 93.54709ms)","trace[1797462855] 'compare' (duration: 38.637787ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:09.767019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.271923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:58:09.767157Z","caller":"traceutil/trace.go:171","msg":"trace[1846355583] linearizableReadLoop","detail":"{readStateIndex:4165; appliedIndex:4164; }","duration":"144.160414ms","start":"2026-10-26T00:58:09.622976Z","end":"2026-10-26T00:58:09.767136Z","steps":["trace[1846355583] 'read index received' (duration: 45.131µs)","trace[1846355583] 'applied index is now lower than readState.Index' (duration: 144.113473ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:09.767261Z","caller":"traceutil/trace.go:171","msg":"trace[1773444640] transaction","detail":"{read_only:false; response_revision:4013; number_of_response:1; }","duration":"204.819101ms","start":"2026-10-26T00:58:09.562428Z","end":"2026-10-26T00:58:09.767247Z","steps":["trace[1773444640] 'process raft request' (duration: 46.187794ms)","trace[1773444640] 'compare' (duration: 158.114821ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:09.767635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.62215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/monitoring/kube-prometheus-stack-prometheus-oauth2-proxy\" ","response":"range_response_count:1 size:2872"} {"level":"info","ts":"2026-10-26T00:58:09.767731Z","caller":"traceutil/trace.go:171","msg":"trace[829258428] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/monitoring/kube-prometheus-stack-prometheus-oauth2-proxy; range_end:; response_count:1; response_revision:4013; }","duration":"144.770871ms","start":"2026-10-26T00:58:09.622932Z","end":"2026-10-26T00:58:09.767703Z","steps":["trace[829258428] 'agreement among raft nodes before linearized reading' (duration: 144.463007ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:10.072532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.779915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-26T00:58:10.072574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.588881ms","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-10-26T00:58:10.072625Z","caller":"traceutil/trace.go:171","msg":"trace[1071906284] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:4014; }","duration":"148.943456ms","start":"2026-10-26T00:58:09.923654Z","end":"2026-10-26T00:58:10.072597Z","steps":["trace[1071906284] 'count revisions from in-memory index tree' (duration: 148.557862ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:10.072599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.929398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:10.072668Z","caller":"traceutil/trace.go:171","msg":"trace[154414909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4014; }","duration":"192.774933ms","start":"2026-10-26T00:58:09.87987Z","end":"2026-10-26T00:58:10.072645Z","steps":["trace[154414909] 'range keys from in-memory index tree' (duration: 192.325568ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:10.072696Z","caller":"traceutil/trace.go:171","msg":"trace[1354763688] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4014; }","duration":"105.14844ms","start":"2026-10-26T00:58:09.967518Z","end":"2026-10-26T00:58:10.072667Z","steps":["trace[1354763688] 'count revisions from in-memory index tree' (duration: 104.756835ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:10.515378Z","caller":"traceutil/trace.go:171","msg":"trace[1628605178] linearizableReadLoop","detail":"{readStateIndex:4169; appliedIndex:4168; }","duration":"108.402178ms","start":"2026-10-26T00:58:10.406937Z","end":"2026-10-26T00:58:10.515339Z","steps":["trace[1628605178] 'read index received' (duration: 108.126194ms)","trace[1628605178] 'applied index is now lower than readState.Index' (duration: 274.774µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:10.515893Z","caller":"traceutil/trace.go:171","msg":"trace[1529208256] transaction","detail":"{read_only:false; response_revision:4017; number_of_response:1; }","duration":"132.793523ms","start":"2026-10-26T00:58:10.383071Z","end":"2026-10-26T00:58:10.515864Z","steps":["trace[1529208256] 'process raft request' (duration: 132.077465ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:10.516143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.173366ms","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-10-26T00:58:10.516353Z","caller":"traceutil/trace.go:171","msg":"trace[1561499846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4017; }","duration":"109.415318ms","start":"2026-10-26T00:58:10.406919Z","end":"2026-10-26T00:58:10.516334Z","steps":["trace[1561499846] 'agreement among raft nodes before linearized reading' (duration: 108.838761ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:10.763077Z","caller":"traceutil/trace.go:171","msg":"trace[1461415545] transaction","detail":"{read_only:false; response_revision:4022; number_of_response:1; }","duration":"180.785186ms","start":"2026-10-26T00:58:10.582262Z","end":"2026-10-26T00:58:10.763047Z","steps":["trace[1461415545] 'process raft request' (duration: 157.003177ms)","trace[1461415545] 'compare' (duration: 23.531486ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:10.763426Z","caller":"traceutil/trace.go:171","msg":"trace[841977504] transaction","detail":"{read_only:false; response_revision:4023; number_of_response:1; }","duration":"178.185266ms","start":"2026-10-26T00:58:10.585139Z","end":"2026-10-26T00:58:10.763325Z","steps":["trace[841977504] 'process raft request' (duration: 177.850352ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:10.764171Z","caller":"traceutil/trace.go:171","msg":"trace[1949999702] linearizableReadLoop","detail":"{readStateIndex:4178; appliedIndex:4175; }","duration":"140.427219ms","start":"2026-10-26T00:58:10.623725Z","end":"2026-10-26T00:58:10.764153Z","steps":["trace[1949999702] 'read index received' (duration: 115.542217ms)","trace[1949999702] 'applied index is now lower than readState.Index' (duration: 24.883922ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:10.764263Z","caller":"traceutil/trace.go:171","msg":"trace[454605994] transaction","detail":"{read_only:false; response_revision:4024; number_of_response:1; }","duration":"172.896207ms","start":"2026-10-26T00:58:10.591358Z","end":"2026-10-26T00:58:10.764255Z","steps":["trace[454605994] 'process raft request' (duration: 171.910376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:10.764563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.813713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:10.764646Z","caller":"traceutil/trace.go:171","msg":"trace[1541064412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4024; }","duration":"140.946666ms","start":"2026-10-26T00:58:10.623684Z","end":"2026-10-26T00:58:10.764631Z","steps":["trace[1541064412] 'agreement among raft nodes before linearized reading' (duration: 140.779764ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:10.76492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.503369ms","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-10-26T00:58:10.764948Z","caller":"traceutil/trace.go:171","msg":"trace[1872640527] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4024; }","duration":"139.558019ms","start":"2026-10-26T00:58:10.625381Z","end":"2026-10-26T00:58:10.764939Z","steps":["trace[1872640527] 'agreement among raft nodes before linearized reading' (duration: 139.415098ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:11.323854Z","caller":"traceutil/trace.go:171","msg":"trace[1282572199] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4045; }","duration":"170.882711ms","start":"2026-10-26T00:58:11.152938Z","end":"2026-10-26T00:58:11.323821Z","steps":["trace[1282572199] 'process raft request' (duration: 112.106537ms)","trace[1282572199] 'compare' (duration: 58.644043ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:11.32394Z","caller":"traceutil/trace.go:171","msg":"trace[866629528] transaction","detail":"{read_only:false; response_revision:4046; number_of_response:1; }","duration":"163.65149ms","start":"2026-10-26T00:58:11.16027Z","end":"2026-10-26T00:58:11.323922Z","steps":["trace[866629528] 'process raft request' (duration: 163.557069ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:11.32397Z","caller":"traceutil/trace.go:171","msg":"trace[1673718451] linearizableReadLoop","detail":"{readStateIndex:4202; appliedIndex:4201; }","duration":"164.389468ms","start":"2026-10-26T00:58:11.159546Z","end":"2026-10-26T00:58:11.323935Z","steps":["trace[1673718451] 'read index received' (duration: 105.36579ms)","trace[1673718451] 'applied index is now lower than readState.Index' (duration: 59.020288ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:11.3242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.62856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/kube-prometheus-stack-ca-q4b7q\" ","response":"range_response_count:1 size:1037"} {"level":"info","ts":"2026-10-26T00:58:11.324259Z","caller":"traceutil/trace.go:171","msg":"trace[1970672946] range","detail":"{range_begin:/registry/secrets/cert-manager/kube-prometheus-stack-ca-q4b7q; range_end:; response_count:1; response_revision:4046; }","duration":"164.725571ms","start":"2026-10-26T00:58:11.159517Z","end":"2026-10-26T00:58:11.324243Z","steps":["trace[1970672946] 'agreement among raft nodes before linearized reading' (duration: 164.514999ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:11.324282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.877489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/kube-prometheus-stack-ca\" ","response":"range_response_count:1 size:2550"} {"level":"info","ts":"2026-10-26T00:58:11.324325Z","caller":"traceutil/trace.go:171","msg":"trace[1884678485] range","detail":"{range_begin:/registry/secrets/cert-manager/kube-prometheus-stack-ca; range_end:; response_count:1; response_revision:4046; }","duration":"161.986361ms","start":"2026-10-26T00:58:11.162328Z","end":"2026-10-26T00:58:11.324314Z","steps":["trace[1884678485] 'agreement among raft nodes before linearized reading' (duration: 161.776079ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:29.740948Z","caller":"traceutil/trace.go:171","msg":"trace[1377323625] transaction","detail":"{read_only:false; response_revision:4190; number_of_response:1; }","duration":"117.668549ms","start":"2026-10-26T00:58:29.623241Z","end":"2026-10-26T00:58:29.74091Z","steps":["trace[1377323625] 'process raft request' (duration: 52.150956ms)","trace[1377323625] 'compare' (duration: 65.382121ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:37.889403Z","caller":"traceutil/trace.go:171","msg":"trace[625858626] transaction","detail":"{read_only:false; response_revision:4230; number_of_response:1; }","duration":"116.018479ms","start":"2026-10-26T00:58:37.773357Z","end":"2026-10-26T00:58:37.889375Z","steps":["trace[625858626] 'process raft request' (duration: 115.866637ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:38.624213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.875048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-26T00:58:38.624286Z","caller":"traceutil/trace.go:171","msg":"trace[236857234] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4234; }","duration":"238.99948ms","start":"2026-10-26T00:58:38.385268Z","end":"2026-10-26T00:58:38.624268Z","steps":["trace[236857234] 'range keys from in-memory index tree' (duration: 238.744697ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:38.73981Z","caller":"traceutil/trace.go:171","msg":"trace[1352823292] transaction","detail":"{read_only:false; response_revision:4235; number_of_response:1; }","duration":"112.896923ms","start":"2026-10-26T00:58:38.626883Z","end":"2026-10-26T00:58:38.73978Z","steps":["trace[1352823292] 'process raft request' (duration: 112.532809ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:39.664863Z","caller":"traceutil/trace.go:171","msg":"trace[1033753173] transaction","detail":"{read_only:false; response_revision:4240; number_of_response:1; }","duration":"149.648472ms","start":"2026-10-26T00:58:39.515156Z","end":"2026-10-26T00:58:39.664805Z","steps":["trace[1033753173] 'process raft request' (duration: 149.47204ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:39.808325Z","caller":"traceutil/trace.go:171","msg":"trace[843074967] linearizableReadLoop","detail":"{readStateIndex:4414; appliedIndex:4413; }","duration":"143.535316ms","start":"2026-10-26T00:58:39.664764Z","end":"2026-10-26T00:58:39.808299Z","steps":["trace[843074967] 'read index received' (duration: 72.324478ms)","trace[843074967] 'applied index is now lower than readState.Index' (duration: 71.209728ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:39.808494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.193241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:39.808532Z","caller":"traceutil/trace.go:171","msg":"trace[1297316832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4241; }","duration":"186.303901ms","start":"2026-10-26T00:58:39.622218Z","end":"2026-10-26T00:58:39.808522Z","steps":["trace[1297316832] 'agreement among raft nodes before linearized reading' (duration: 186.17649ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:39.80887Z","caller":"traceutil/trace.go:171","msg":"trace[784989089] transaction","detail":"{read_only:false; response_revision:4241; number_of_response:1; }","duration":"150.601622ms","start":"2026-10-26T00:58:39.658255Z","end":"2026-10-26T00:58:39.808856Z","steps":["trace[784989089] 'process raft request' (duration: 78.869719ms)","trace[784989089] 'compare' (duration: 71.064785ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:40.468499Z","caller":"traceutil/trace.go:171","msg":"trace[1267395553] transaction","detail":"{read_only:false; response_revision:4245; number_of_response:1; }","duration":"104.308576ms","start":"2026-10-26T00:58:40.364142Z","end":"2026-10-26T00:58:40.46845Z","steps":["trace[1267395553] 'process raft request' (duration: 104.134144ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:40.990073Z","caller":"traceutil/trace.go:171","msg":"trace[1364586316] transaction","detail":"{read_only:false; response_revision:4247; number_of_response:1; }","duration":"186.526691ms","start":"2026-10-26T00:58:40.803509Z","end":"2026-10-26T00:58:40.990036Z","steps":["trace[1364586316] 'process raft request' (duration: 186.308119ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:41.119367Z","caller":"traceutil/trace.go:171","msg":"trace[1486022737] linearizableReadLoop","detail":"{readStateIndex:4421; appliedIndex:4419; }","duration":"221.177308ms","start":"2026-10-26T00:58:40.898168Z","end":"2026-10-26T00:58:41.119345Z","steps":["trace[1486022737] 'read index received' (duration: 91.584187ms)","trace[1486022737] 'applied index is now lower than readState.Index' (duration: 129.591781ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:41.119611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.427191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-26T00:58:41.119686Z","caller":"traceutil/trace.go:171","msg":"trace[1299404680] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4247; }","duration":"221.566832ms","start":"2026-10-26T00:58:40.898104Z","end":"2026-10-26T00:58:41.119671Z","steps":["trace[1299404680] 'agreement among raft nodes before linearized reading' (duration: 221.3455ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:42.104176Z","caller":"traceutil/trace.go:171","msg":"trace[1199483998] transaction","detail":"{read_only:false; response_revision:4251; number_of_response:1; }","duration":"138.601807ms","start":"2026-10-26T00:58:41.965541Z","end":"2026-10-26T00:58:42.104143Z","steps":["trace[1199483998] 'process raft request' (duration: 115.530786ms)","trace[1199483998] 'compare' (duration: 22.838419ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:42.579529Z","caller":"traceutil/trace.go:171","msg":"trace[409184433] transaction","detail":"{read_only:false; response_revision:4254; number_of_response:1; }","duration":"104.702827ms","start":"2026-10-26T00:58:42.474795Z","end":"2026-10-26T00:58:42.579498Z","steps":["trace[409184433] 'process raft request' (duration: 104.527755ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:43.458612Z","caller":"traceutil/trace.go:171","msg":"trace[980217059] linearizableReadLoop","detail":"{readStateIndex:4432; appliedIndex:4431; }","duration":"261.677201ms","start":"2026-10-26T00:58:43.196904Z","end":"2026-10-26T00:58:43.458581Z","steps":["trace[980217059] 'read index received' (duration: 243.240021ms)","trace[980217059] 'applied index is now lower than readState.Index' (duration: 18.43598ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:43.458613Z","caller":"traceutil/trace.go:171","msg":"trace[1919075571] transaction","detail":"{read_only:false; response_revision:4258; number_of_response:1; }","duration":"276.135048ms","start":"2026-10-26T00:58:43.182448Z","end":"2026-10-26T00:58:43.458583Z","steps":["trace[1919075571] 'process raft request' (duration: 257.820679ms)","trace[1919075571] 'compare' (duration: 17.965105ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:43.458928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.979444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:43.459028Z","caller":"traceutil/trace.go:171","msg":"trace[509765779] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:4258; }","duration":"262.135805ms","start":"2026-10-26T00:58:43.196869Z","end":"2026-10-26T00:58:43.459005Z","steps":["trace[509765779] 'agreement among raft nodes before linearized reading' (duration: 261.931333ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:44.408005Z","caller":"traceutil/trace.go:171","msg":"trace[1023267076] transaction","detail":"{read_only:false; response_revision:4263; number_of_response:1; }","duration":"200.424333ms","start":"2026-10-26T00:58:44.207546Z","end":"2026-10-26T00:58:44.40797Z","steps":["trace[1023267076] 'process raft request' (duration: 200.234831ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:45.753702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.592024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-26T00:58:45.753757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.206498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-26T00:58:45.753827Z","caller":"traceutil/trace.go:171","msg":"trace[84768104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4268; }","duration":"130.801927ms","start":"2026-10-26T00:58:45.62299Z","end":"2026-10-26T00:58:45.753792Z","steps":["trace[84768104] 'range keys from in-memory index tree' (duration: 130.427283ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:45.753847Z","caller":"traceutil/trace.go:171","msg":"trace[782516413] range","detail":"{range_begin:/registry/masterleases/162.253.55.72; range_end:; response_count:1; response_revision:4268; }","duration":"103.345639ms","start":"2026-10-26T00:58:45.65048Z","end":"2026-10-26T00:58:45.753825Z","steps":["trace[782516413] 'range keys from in-memory index tree' (duration: 102.985236ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:46.169809Z","caller":"traceutil/trace.go:171","msg":"trace[1789616058] linearizableReadLoop","detail":"{readStateIndex:4445; appliedIndex:4444; }","duration":"241.835618ms","start":"2026-10-26T00:58:45.927942Z","end":"2026-10-26T00:58:46.169778Z","steps":["trace[1789616058] 'read index received' (duration: 241.567165ms)","trace[1789616058] 'applied index is now lower than readState.Index' (duration: 267.563µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:46.169863Z","caller":"traceutil/trace.go:171","msg":"trace[1776731626] transaction","detail":"{read_only:false; response_revision:4270; number_of_response:1; }","duration":"265.181212ms","start":"2026-10-26T00:58:45.904642Z","end":"2026-10-26T00:58:46.169823Z","steps":["trace[1776731626] 'process raft request' (duration: 264.955879ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:46.170206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.221832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:46.170302Z","caller":"traceutil/trace.go:171","msg":"trace[1727411539] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:4270; }","duration":"242.387095ms","start":"2026-10-26T00:58:45.927893Z","end":"2026-10-26T00:58:46.17028Z","steps":["trace[1727411539] 'agreement among raft nodes before linearized reading' (duration: 242.018641ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:47.170719Z","caller":"traceutil/trace.go:171","msg":"trace[1108676984] linearizableReadLoop","detail":"{readStateIndex:4450; appliedIndex:4449; }","duration":"298.650049ms","start":"2026-10-26T00:58:46.872033Z","end":"2026-10-26T00:58:47.170683Z","steps":["trace[1108676984] 'read index received' (duration: 298.417947ms)","trace[1108676984] 'applied index is now lower than readState.Index' (duration: 230.602µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:47.17091Z","caller":"traceutil/trace.go:171","msg":"trace[1576442139] transaction","detail":"{read_only:false; response_revision:4275; number_of_response:1; }","duration":"476.030879ms","start":"2026-10-26T00:58:46.694817Z","end":"2026-10-26T00:58:47.170848Z","steps":["trace[1576442139] 'process raft request' (duration: 475.654615ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:47.171051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.990173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-26T00:58:47.171129Z","caller":"traceutil/trace.go:171","msg":"trace[342955464] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4275; }","duration":"299.143995ms","start":"2026-10-26T00:58:46.87196Z","end":"2026-10-26T00:58:47.171104Z","steps":["trace[342955464] 'agreement among raft nodes before linearized reading' (duration: 298.897902ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:47.171169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:46.694787Z","time spent":"476.254211ms","remote":"127.0.0.1:45148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:58:47.680611Z","caller":"traceutil/trace.go:171","msg":"trace[1359658279] transaction","detail":"{read_only:false; response_revision:4280; number_of_response:1; }","duration":"165.115175ms","start":"2026-10-26T00:58:47.515463Z","end":"2026-10-26T00:58:47.680578Z","steps":["trace[1359658279] 'process raft request' (duration: 161.931381ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:48.341023Z","caller":"traceutil/trace.go:171","msg":"trace[732331975] transaction","detail":"{read_only:false; response_revision:4282; number_of_response:1; }","duration":"104.493288ms","start":"2026-10-26T00:58:48.236471Z","end":"2026-10-26T00:58:48.340964Z","steps":["trace[732331975] 'process raft request' (duration: 104.306206ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:48.377486Z","caller":"traceutil/trace.go:171","msg":"trace[323143197] transaction","detail":"{read_only:false; response_revision:4283; number_of_response:1; }","duration":"117.028313ms","start":"2026-10-26T00:58:48.260427Z","end":"2026-10-26T00:58:48.377455Z","steps":["trace[323143197] 'process raft request' (duration: 116.841561ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:49.384802Z","caller":"traceutil/trace.go:171","msg":"trace[1241461124] linearizableReadLoop","detail":"{readStateIndex:4461; appliedIndex:4460; }","duration":"160.658272ms","start":"2026-10-26T00:58:49.22412Z","end":"2026-10-26T00:58:49.384778Z","steps":["trace[1241461124] 'read index received' (duration: 160.44108ms)","trace[1241461124] 'applied index is now lower than readState.Index' (duration: 213.062µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:49.384869Z","caller":"traceutil/trace.go:171","msg":"trace[24339903] transaction","detail":"{read_only:false; response_revision:4286; number_of_response:1; }","duration":"160.927986ms","start":"2026-10-26T00:58:49.223904Z","end":"2026-10-26T00:58:49.384832Z","steps":["trace[24339903] 'process raft request' (duration: 160.735994ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:49.384955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.818974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:49.384999Z","caller":"traceutil/trace.go:171","msg":"trace[338609142] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:0; response_revision:4286; }","duration":"160.899904ms","start":"2026-10-26T00:58:49.224088Z","end":"2026-10-26T00:58:49.384988Z","steps":["trace[338609142] 'agreement among raft nodes before linearized reading' (duration: 160.821593ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:49.385189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.932227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-26T00:58:49.385267Z","caller":"traceutil/trace.go:171","msg":"trace[901919668] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4286; }","duration":"112.062598ms","start":"2026-10-26T00:58:49.273183Z","end":"2026-10-26T00:58:49.385246Z","steps":["trace[901919668] 'agreement among raft nodes before linearized reading' (duration: 111.771675ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:49.884552Z","caller":"traceutil/trace.go:171","msg":"trace[1783673672] linearizableReadLoop","detail":"{readStateIndex:4465; appliedIndex:4464; }","duration":"199.976418ms","start":"2026-10-26T00:58:49.684544Z","end":"2026-10-26T00:58:49.88452Z","steps":["trace[1783673672] 'read index received' (duration: 199.498462ms)","trace[1783673672] 'applied index is now lower than readState.Index' (duration: 476.406µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:49.884758Z","caller":"traceutil/trace.go:171","msg":"trace[1703314800] transaction","detail":"{read_only:false; response_revision:4289; number_of_response:1; }","duration":"210.555831ms","start":"2026-10-26T00:58:49.674115Z","end":"2026-10-26T00:58:49.884671Z","steps":["trace[1703314800] 'process raft request' (duration: 210.057506ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:49.884814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.302682ms","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-10-26T00:58:49.884875Z","caller":"traceutil/trace.go:171","msg":"trace[173319833] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4289; }","duration":"200.411092ms","start":"2026-10-26T00:58:49.684453Z","end":"2026-10-26T00:58:49.884864Z","steps":["trace[173319833] 'agreement among raft nodes before linearized reading' (duration: 200.18548ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:50.218834Z","caller":"traceutil/trace.go:171","msg":"trace[884311866] transaction","detail":"{read_only:false; response_revision:4291; number_of_response:1; }","duration":"222.189954ms","start":"2026-10-26T00:58:49.996603Z","end":"2026-10-26T00:58:50.218793Z","steps":["trace[884311866] 'process raft request' (duration: 221.940421ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:50.219208Z","caller":"traceutil/trace.go:171","msg":"trace[739290263] linearizableReadLoop","detail":"{readStateIndex:4467; appliedIndex:4467; }","duration":"166.705655ms","start":"2026-10-26T00:58:50.052474Z","end":"2026-10-26T00:58:50.21918Z","steps":["trace[739290263] 'read index received' (duration: 166.698115ms)","trace[739290263] 'applied index is now lower than readState.Index' (duration: 4.76µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:50.219354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.855328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:50.219398Z","caller":"traceutil/trace.go:171","msg":"trace[1752571619] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:4291; }","duration":"166.965409ms","start":"2026-10-26T00:58:50.052419Z","end":"2026-10-26T00:58:50.219385Z","steps":["trace[1752571619] 'agreement among raft nodes before linearized reading' (duration: 166.879628ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:50.761644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.681075ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:58:50.761893Z","caller":"traceutil/trace.go:171","msg":"trace[992077337] transaction","detail":"{read_only:false; response_revision:4294; number_of_response:1; }","duration":"379.452488ms","start":"2026-10-26T00:58:50.38242Z","end":"2026-10-26T00:58:50.761872Z","steps":["trace[992077337] 'process raft request' (duration: 379.415138ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:50.761974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:50.382386Z","time spent":"379.546029ms","remote":"127.0.0.1:45148","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-10-26T00:58:50.762156Z","caller":"traceutil/trace.go:171","msg":"trace[908464874] linearizableReadLoop","detail":"{readStateIndex:4468; appliedIndex:4467; }","duration":"418.235646ms","start":"2026-10-26T00:58:50.343859Z","end":"2026-10-26T00:58:50.762094Z","steps":["trace[908464874] 'read index received' (duration: 264.872493ms)","trace[908464874] 'applied index is now lower than readState.Index' (duration: 153.355852ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:50.762212Z","caller":"traceutil/trace.go:171","msg":"trace[2079369075] transaction","detail":"{read_only:false; response_revision:4293; number_of_response:1; }","duration":"415.289704ms","start":"2026-10-26T00:58:50.34691Z","end":"2026-10-26T00:58:50.7622Z","steps":["trace[2079369075] 'process raft request' (duration: 414.864089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:50.76227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:50.34687Z","time spent":"415.370914ms","remote":"127.0.0.1:45148","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-10-26T00:58:50.762535Z","caller":"traceutil/trace.go:171","msg":"trace[1925281612] transaction","detail":"{read_only:false; response_revision:4292; number_of_response:1; }","duration":"689.419938ms","start":"2026-10-26T00:58:50.07308Z","end":"2026-10-26T00:58:50.7625Z","steps":["trace[1925281612] 'process raft request' (duration: 535.793163ms)","trace[1925281612] 'compare' (duration: 152.435433ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:50.762628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.087922ms","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-10-26T00:58:50.762664Z","caller":"traceutil/trace.go:171","msg":"trace[1017114401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4294; }","duration":"248.192594ms","start":"2026-10-26T00:58:50.51446Z","end":"2026-10-26T00:58:50.762653Z","steps":["trace[1017114401] 'agreement among raft nodes before linearized reading' (duration: 248.055842ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:50.762709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:50.073043Z","time spent":"689.571729ms","remote":"127.0.0.1:44942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459449,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T00:58:50.762755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.861182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12431"} {"level":"info","ts":"2026-10-26T00:58:50.762857Z","caller":"traceutil/trace.go:171","msg":"trace[888039104] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4294; }","duration":"419.032045ms","start":"2026-10-26T00:58:50.343798Z","end":"2026-10-26T00:58:50.76283Z","steps":["trace[888039104] 'agreement among raft nodes before linearized reading' (duration: 418.64236ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:50.762913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:50.343775Z","time spent":"419.128366ms","remote":"127.0.0.1:45056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12453,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-26T00:58:51.092575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.406947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:58:51.092829Z","caller":"traceutil/trace.go:171","msg":"trace[2007115433] transaction","detail":"{read_only:false; response_revision:4296; number_of_response:1; }","duration":"324.148201ms","start":"2026-10-26T00:58:50.768631Z","end":"2026-10-26T00:58:51.092779Z","steps":["trace[2007115433] 'process raft request' (duration: 98.418141ms)","trace[2007115433] 'compare' (duration: 225.168374ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:51.092874Z","caller":"traceutil/trace.go:171","msg":"trace[568712278] linearizableReadLoop","detail":"{readStateIndex:4472; appliedIndex:4470; }","duration":"323.781217ms","start":"2026-10-26T00:58:50.769061Z","end":"2026-10-26T00:58:51.092842Z","steps":["trace[568712278] 'read index received' (duration: 26.707297ms)","trace[568712278] 'applied index is now lower than readState.Index' (duration: 297.07212ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:51.093053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:50.768571Z","time spent":"324.358573ms","remote":"127.0.0.1:45148","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-10-26T00:58:51.093078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.99929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:8808"} {"level":"info","ts":"2026-10-26T00:58:51.093117Z","caller":"traceutil/trace.go:171","msg":"trace[1335544770] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4296; }","duration":"324.110261ms","start":"2026-10-26T00:58:50.768994Z","end":"2026-10-26T00:58:51.093104Z","steps":["trace[1335544770] 'agreement among raft nodes before linearized reading' (duration: 323.947139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:51.09316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:50.768981Z","time spent":"324.169372ms","remote":"127.0.0.1:45042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":8830,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-10-26T00:58:51.093345Z","caller":"traceutil/trace.go:171","msg":"trace[1874019499] transaction","detail":"{read_only:false; response_revision:4297; number_of_response:1; }","duration":"286.955552ms","start":"2026-10-26T00:58:50.806377Z","end":"2026-10-26T00:58:51.093332Z","steps":["trace[1874019499] 'process raft request' (duration: 286.398705ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:51.430293Z","caller":"traceutil/trace.go:171","msg":"trace[970833561] transaction","detail":"{read_only:false; response_revision:4298; number_of_response:1; }","duration":"120.930712ms","start":"2026-10-26T00:58:51.309336Z","end":"2026-10-26T00:58:51.430267Z","steps":["trace[970833561] 'process raft request' (duration: 119.954501ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:51.570043Z","caller":"traceutil/trace.go:171","msg":"trace[1306272827] transaction","detail":"{read_only:false; response_revision:4300; number_of_response:1; }","duration":"131.220612ms","start":"2026-10-26T00:58:51.438794Z","end":"2026-10-26T00:58:51.570014Z","steps":["trace[1306272827] 'process raft request' (duration: 131.04759ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:51.643745Z","caller":"traceutil/trace.go:171","msg":"trace[1299183757] linearizableReadLoop","detail":"{readStateIndex:4478; appliedIndex:4476; }","duration":"160.099983ms","start":"2026-10-26T00:58:51.48362Z","end":"2026-10-26T00:58:51.64372Z","steps":["trace[1299183757] 'read index received' (duration: 86.216688ms)","trace[1299183757] 'applied index is now lower than readState.Index' (duration: 73.879745ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:51.643822Z","caller":"traceutil/trace.go:171","msg":"trace[2096203386] transaction","detail":"{read_only:false; response_revision:4301; number_of_response:1; }","duration":"171.777058ms","start":"2026-10-26T00:58:51.472012Z","end":"2026-10-26T00:58:51.643789Z","steps":["trace[2096203386] 'process raft request' (duration: 171.592346ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:51.644054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.413166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-26T00:58:51.644101Z","caller":"traceutil/trace.go:171","msg":"trace[1622752979] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4301; }","duration":"160.584858ms","start":"2026-10-26T00:58:51.483502Z","end":"2026-10-26T00:58:51.644087Z","steps":["trace[1622752979] 'agreement among raft nodes before linearized reading' (duration: 160.343925ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:51.787685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.393552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:51.787758Z","caller":"traceutil/trace.go:171","msg":"trace[2029863146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4301; }","duration":"142.540714ms","start":"2026-10-26T00:58:51.645203Z","end":"2026-10-26T00:58:51.787743Z","steps":["trace[2029863146] 'range keys from in-memory index tree' (duration: 142.22515ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:51.787675Z","caller":"traceutil/trace.go:171","msg":"trace[820945535] linearizableReadLoop","detail":"{readStateIndex:4479; appliedIndex:4478; }","duration":"130.811387ms","start":"2026-10-26T00:58:51.65684Z","end":"2026-10-26T00:58:51.787652Z","steps":["trace[820945535] 'read index received' (duration: 81.394246ms)","trace[820945535] 'applied index is now lower than readState.Index' (duration: 49.416031ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:51.787696Z","caller":"traceutil/trace.go:171","msg":"trace[1483295811] transaction","detail":"{read_only:false; response_revision:4302; number_of_response:1; }","duration":"138.823724ms","start":"2026-10-26T00:58:51.648845Z","end":"2026-10-26T00:58:51.787669Z","steps":["trace[1483295811] 'process raft request' (duration: 89.376852ms)","trace[1483295811] 'compare' (duration: 49.28359ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:51.78778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.930669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kube-prometheus-stack-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:51.788074Z","caller":"traceutil/trace.go:171","msg":"trace[682333160] range","detail":"{range_begin:/registry/clusterrolebindings/kube-prometheus-stack-admission; range_end:; response_count:0; response_revision:4302; }","duration":"131.262353ms","start":"2026-10-26T00:58:51.656796Z","end":"2026-10-26T00:58:51.788058Z","steps":["trace[682333160] 'agreement among raft nodes before linearized reading' (duration: 130.933679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:52.018048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.025668ms","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-10-26T00:58:52.018167Z","caller":"traceutil/trace.go:171","msg":"trace[382983925] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4302; }","duration":"102.2397ms","start":"2026-10-26T00:58:51.915903Z","end":"2026-10-26T00:58:52.018143Z","steps":["trace[382983925] 'range keys from in-memory index tree' (duration: 101.805216ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:52.456569Z","caller":"traceutil/trace.go:171","msg":"trace[261877881] transaction","detail":"{read_only:false; response_revision:4303; number_of_response:1; }","duration":"536.805022ms","start":"2026-10-26T00:58:51.919726Z","end":"2026-10-26T00:58:52.456531Z","steps":["trace[261877881] 'process raft request' (duration: 536.276596ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:52.456799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:51.919694Z","time spent":"536.974514ms","remote":"127.0.0.1:44942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:58:52.741712Z","caller":"traceutil/trace.go:171","msg":"trace[518838381] linearizableReadLoop","detail":"{readStateIndex:4483; appliedIndex:4480; }","duration":"118.816007ms","start":"2026-10-26T00:58:52.622873Z","end":"2026-10-26T00:58:52.741689Z","steps":["trace[518838381] 'read index received' (duration: 94.580516ms)","trace[518838381] 'applied index is now lower than readState.Index' (duration: 24.234671ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:52.741753Z","caller":"traceutil/trace.go:171","msg":"trace[241492069] transaction","detail":"{read_only:false; response_revision:4304; number_of_response:1; }","duration":"718.209491ms","start":"2026-10-26T00:58:52.023488Z","end":"2026-10-26T00:58:52.741698Z","steps":["trace[241492069] 'process raft request' (duration: 693.93636ms)","trace[241492069] 'compare' (duration: 23.792335ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:52.741829Z","caller":"traceutil/trace.go:171","msg":"trace[691189771] transaction","detail":"{read_only:false; response_revision:4306; number_of_response:1; }","duration":"244.461958ms","start":"2026-10-26T00:58:52.497356Z","end":"2026-10-26T00:58:52.741818Z","steps":["trace[691189771] 'process raft request' (duration: 244.293856ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:52.741909Z","caller":"traceutil/trace.go:171","msg":"trace[1773639928] transaction","detail":"{read_only:false; response_revision:4305; number_of_response:1; }","duration":"518.97417ms","start":"2026-10-26T00:58:52.2229Z","end":"2026-10-26T00:58:52.741874Z","steps":["trace[1773639928] 'process raft request' (duration: 518.651886ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:52.742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.12649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:52.74207Z","caller":"traceutil/trace.go:171","msg":"trace[1844332605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4306; }","duration":"119.242512ms","start":"2026-10-26T00:58:52.622809Z","end":"2026-10-26T00:58:52.742052Z","steps":["trace[1844332605] 'agreement among raft nodes before linearized reading' (duration: 119.10045ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:52.742074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:52.222866Z","time spent":"519.119751ms","remote":"127.0.0.1:45148","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-10-26T00:58:52.741909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:52.023307Z","time spent":"718.502844ms","remote":"127.0.0.1:45148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:58:53.115731Z","caller":"traceutil/trace.go:171","msg":"trace[1886400600] transaction","detail":"{read_only:false; response_revision:4310; number_of_response:1; }","duration":"199.929629ms","start":"2026-10-26T00:58:52.915773Z","end":"2026-10-26T00:58:53.115702Z","steps":["trace[1886400600] 'process raft request' (duration: 191.122955ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:53.606437Z","caller":"traceutil/trace.go:171","msg":"trace[1288821569] linearizableReadLoop","detail":"{readStateIndex:4489; appliedIndex:4488; }","duration":"272.450066ms","start":"2026-10-26T00:58:53.333962Z","end":"2026-10-26T00:58:53.606412Z","steps":["trace[1288821569] 'read index received' (duration: 272.237703ms)","trace[1288821569] 'applied index is now lower than readState.Index' (duration: 211.223µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:53.606556Z","caller":"traceutil/trace.go:171","msg":"trace[1919371734] transaction","detail":"{read_only:false; response_revision:4312; number_of_response:1; }","duration":"451.347098ms","start":"2026-10-26T00:58:53.155187Z","end":"2026-10-26T00:58:53.606534Z","steps":["trace[1919371734] 'process raft request' (duration: 451.072975ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:53.606972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.096032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:53.607009Z","caller":"traceutil/trace.go:171","msg":"trace[1360460757] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:4312; }","duration":"245.157063ms","start":"2026-10-26T00:58:53.361841Z","end":"2026-10-26T00:58:53.606998Z","steps":["trace[1360460757] 'agreement among raft nodes before linearized reading' (duration: 245.089442ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:53.607266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.854774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-26T00:58:53.607297Z","caller":"traceutil/trace.go:171","msg":"trace[880028512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4312; }","duration":"154.921444ms","start":"2026-10-26T00:58:53.452367Z","end":"2026-10-26T00:58:53.607289Z","steps":["trace[880028512] 'agreement among raft nodes before linearized reading' (duration: 154.836463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:53.60678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.807349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-10-26T00:58:53.607611Z","caller":"traceutil/trace.go:171","msg":"trace[1577421433] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4312; }","duration":"273.706759ms","start":"2026-10-26T00:58:53.333896Z","end":"2026-10-26T00:58:53.607603Z","steps":["trace[1577421433] 'agreement among raft nodes before linearized reading' (duration: 272.700948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:53.607545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:53.155154Z","time spent":"452.293678ms","remote":"127.0.0.1:55002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1279,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T00:58:53.838653Z","caller":"traceutil/trace.go:171","msg":"trace[1426933388] linearizableReadLoop","detail":"{readStateIndex:4492; appliedIndex:4489; }","duration":"216.732017ms","start":"2026-10-26T00:58:53.621895Z","end":"2026-10-26T00:58:53.838627Z","steps":["trace[1426933388] 'read index received' (duration: 184.34907ms)","trace[1426933388] 'applied index is now lower than readState.Index' (duration: 32.381847ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:53.838808Z","caller":"traceutil/trace.go:171","msg":"trace[1588687915] transaction","detail":"{read_only:false; response_revision:4313; number_of_response:1; }","duration":"227.374031ms","start":"2026-10-26T00:58:53.611421Z","end":"2026-10-26T00:58:53.838795Z","steps":["trace[1588687915] 'process raft request' (duration: 194.751891ms)","trace[1588687915] 'compare' (duration: 32.108685ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:53.839091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.613755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T00:58:53.839138Z","caller":"traceutil/trace.go:171","msg":"trace[1762391861] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:4316; }","duration":"120.727717ms","start":"2026-10-26T00:58:53.718398Z","end":"2026-10-26T00:58:53.839126Z","steps":["trace[1762391861] 'agreement among raft nodes before linearized reading' (duration: 120.630016ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:53.839143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.203233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:53.839292Z","caller":"traceutil/trace.go:171","msg":"trace[28362477] range","detail":"{range_begin:/registry/rolebindings/monitoring/kube-prometheus-stack-admission; range_end:; response_count:0; response_revision:4316; }","duration":"217.371204ms","start":"2026-10-26T00:58:53.621861Z","end":"2026-10-26T00:58:53.839232Z","steps":["trace[28362477] 'agreement among raft nodes before linearized reading' (duration: 217.105471ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:53.839331Z","caller":"traceutil/trace.go:171","msg":"trace[368397596] transaction","detail":"{read_only:false; response_revision:4314; number_of_response:1; }","duration":"226.745415ms","start":"2026-10-26T00:58:53.612561Z","end":"2026-10-26T00:58:53.839306Z","steps":["trace[368397596] 'process raft request' (duration: 225.938576ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:53.839448Z","caller":"traceutil/trace.go:171","msg":"trace[2027231114] transaction","detail":"{read_only:false; response_revision:4315; number_of_response:1; }","duration":"223.782073ms","start":"2026-10-26T00:58:53.615606Z","end":"2026-10-26T00:58:53.839388Z","steps":["trace[2027231114] 'process raft request' (duration: 222.943844ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:54.708632Z","caller":"traceutil/trace.go:171","msg":"trace[198891972] transaction","detail":"{read_only:false; response_revision:4320; number_of_response:1; }","duration":"384.688337ms","start":"2026-10-26T00:58:54.323892Z","end":"2026-10-26T00:58:54.708581Z","steps":["trace[198891972] 'process raft request' (duration: 383.839338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:54.708822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:54.32386Z","time spent":"384.856399ms","remote":"127.0.0.1:44942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459633,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T00:58:55.099848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.717849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:58:55.099992Z","caller":"traceutil/trace.go:171","msg":"trace[1249687219] linearizableReadLoop","detail":"{readStateIndex:4498; appliedIndex:4497; }","duration":"391.424548ms","start":"2026-10-26T00:58:54.708542Z","end":"2026-10-26T00:58:55.099967Z","steps":["trace[1249687219] 'read index received' (duration: 153.362645ms)","trace[1249687219] 'applied index is now lower than readState.Index' (duration: 238.059713ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:55.100106Z","caller":"traceutil/trace.go:171","msg":"trace[1390079413] transaction","detail":"{read_only:false; response_revision:4321; number_of_response:1; }","duration":"423.29476ms","start":"2026-10-26T00:58:54.676794Z","end":"2026-10-26T00:58:55.100089Z","steps":["trace[1390079413] 'process raft request' (duration: 185.211197ms)","trace[1390079413] 'compare' (duration: 237.416066ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:58:55.100201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:54.676755Z","time spent":"423.397272ms","remote":"127.0.0.1:45148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T00:58:55.100367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.6025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-26T00:58:55.100432Z","caller":"traceutil/trace.go:171","msg":"trace[1013168953] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4321; }","duration":"431.695321ms","start":"2026-10-26T00:58:54.668719Z","end":"2026-10-26T00:58:55.100414Z","steps":["trace[1013168953] 'agreement among raft nodes before linearized reading' (duration: 431.490549ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.100515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:54.668704Z","time spent":"431.797472ms","remote":"127.0.0.1:45148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":580,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-10-26T00:58:55.133061Z","caller":"traceutil/trace.go:171","msg":"trace[1186860265] transaction","detail":"{read_only:false; response_revision:4322; number_of_response:1; }","duration":"385.598985ms","start":"2026-10-26T00:58:54.747426Z","end":"2026-10-26T00:58:55.133025Z","steps":["trace[1186860265] 'process raft request' (duration: 385.384873ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:55.133176Z","caller":"traceutil/trace.go:171","msg":"trace[661709238] transaction","detail":"{read_only:false; response_revision:4323; number_of_response:1; }","duration":"375.967102ms","start":"2026-10-26T00:58:54.757169Z","end":"2026-10-26T00:58:55.133137Z","steps":["trace[661709238] 'process raft request' (duration: 375.73503ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.133343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.427469ms","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-10-26T00:58:55.133374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:54.757149Z","time spent":"376.132265ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3700,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T00:58:55.133405Z","caller":"traceutil/trace.go:171","msg":"trace[757225512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4325; }","duration":"269.536891ms","start":"2026-10-26T00:58:54.86385Z","end":"2026-10-26T00:58:55.133387Z","steps":["trace[757225512] 'agreement among raft nodes before linearized reading' (duration: 269.40754ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.133341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:54.747411Z","time spent":"385.772328ms","remote":"127.0.0.1:45148","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-10-26T00:58:55.133512Z","caller":"traceutil/trace.go:171","msg":"trace[1977495905] transaction","detail":"{read_only:false; response_revision:4324; number_of_response:1; }","duration":"333.988462ms","start":"2026-10-26T00:58:54.799503Z","end":"2026-10-26T00:58:55.133491Z","steps":["trace[1977495905] 'process raft request' (duration: 333.564558ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.13362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.117013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-26T00:58:55.133638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:54.799408Z","time spent":"334.175154ms","remote":"127.0.0.1:45148","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-10-26T00:58:55.133674Z","caller":"traceutil/trace.go:171","msg":"trace[1162631832] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4325; }","duration":"387.245724ms","start":"2026-10-26T00:58:54.746416Z","end":"2026-10-26T00:58:55.133662Z","steps":["trace[1162631832] 'agreement among raft nodes before linearized reading' (duration: 387.122303ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.133721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:54.746395Z","time spent":"387.314025ms","remote":"127.0.0.1:45148","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-10-26T00:58:55.133749Z","caller":"traceutil/trace.go:171","msg":"trace[357934483] transaction","detail":"{read_only:false; response_revision:4325; number_of_response:1; }","duration":"298.813355ms","start":"2026-10-26T00:58:54.834922Z","end":"2026-10-26T00:58:55.133735Z","steps":["trace[357934483] 'process raft request' (duration: 298.207938ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.133228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.476412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:58:55.133828Z","caller":"traceutil/trace.go:171","msg":"trace[491513496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4325; }","duration":"424.11162ms","start":"2026-10-26T00:58:54.709704Z","end":"2026-10-26T00:58:55.133815Z","steps":["trace[491513496] 'agreement among raft nodes before linearized reading' (duration: 423.467463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.133874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:54.709686Z","time spent":"424.17749ms","remote":"127.0.0.1:44860","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-10-26T00:58:55.425648Z","caller":"traceutil/trace.go:171","msg":"trace[519790879] transaction","detail":"{read_only:false; response_revision:4328; number_of_response:1; }","duration":"283.77277ms","start":"2026-10-26T00:58:55.141841Z","end":"2026-10-26T00:58:55.425614Z","steps":["trace[519790879] 'process raft request' (duration: 270.914513ms)","trace[519790879] 'compare' (duration: 12.190211ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:55.425701Z","caller":"traceutil/trace.go:171","msg":"trace[1226759031] linearizableReadLoop","detail":"{readStateIndex:4506; appliedIndex:4503; }","duration":"255.968813ms","start":"2026-10-26T00:58:55.169715Z","end":"2026-10-26T00:58:55.425683Z","steps":["trace[1226759031] 'read index received' (duration: 4.026753ms)","trace[1226759031] 'applied index is now lower than readState.Index' (duration: 251.94124ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:55.42577Z","caller":"traceutil/trace.go:171","msg":"trace[2034334015] transaction","detail":"{read_only:false; response_revision:4329; number_of_response:1; }","duration":"281.880441ms","start":"2026-10-26T00:58:55.143848Z","end":"2026-10-26T00:58:55.425729Z","steps":["trace[2034334015] 'process raft request' (duration: 281.702839ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.425912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.172535ms","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-10-26T00:58:55.425945Z","caller":"traceutil/trace.go:171","msg":"trace[1438705762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4329; }","duration":"256.254356ms","start":"2026-10-26T00:58:55.16968Z","end":"2026-10-26T00:58:55.425935Z","steps":["trace[1438705762] 'agreement among raft nodes before linearized reading' (duration: 256.056744ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:55.657828Z","caller":"traceutil/trace.go:171","msg":"trace[689833964] transaction","detail":"{read_only:false; response_revision:4330; number_of_response:1; }","duration":"225.544838ms","start":"2026-10-26T00:58:55.432257Z","end":"2026-10-26T00:58:55.657802Z","steps":["trace[689833964] 'process raft request' (duration: 225.376026ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:55.873885Z","caller":"traceutil/trace.go:171","msg":"trace[702782393] transaction","detail":"{read_only:false; response_revision:4331; number_of_response:1; }","duration":"441.502061ms","start":"2026-10-26T00:58:55.432321Z","end":"2026-10-26T00:58:55.873823Z","steps":["trace[702782393] 'process raft request' (duration: 403.96162ms)","trace[702782393] 'compare' (duration: 37.302779ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:55.873984Z","caller":"traceutil/trace.go:171","msg":"trace[1071738297] linearizableReadLoop","detail":"{readStateIndex:4510; appliedIndex:4506; }","duration":"222.764078ms","start":"2026-10-26T00:58:55.651191Z","end":"2026-10-26T00:58:55.873955Z","steps":["trace[1071738297] 'read index received' (duration: 6.42857ms)","trace[1071738297] 'applied index is now lower than readState.Index' (duration: 216.333888ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:55.874122Z","caller":"traceutil/trace.go:171","msg":"trace[85888271] transaction","detail":"{read_only:false; response_revision:4332; number_of_response:1; }","duration":"440.925405ms","start":"2026-10-26T00:58:55.433187Z","end":"2026-10-26T00:58:55.874112Z","steps":["trace[85888271] 'process raft request' (duration: 440.584582ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:55.874117Z","caller":"traceutil/trace.go:171","msg":"trace[1195606895] transaction","detail":"{read_only:false; response_revision:4333; number_of_response:1; }","duration":"440.088557ms","start":"2026-10-26T00:58:55.434Z","end":"2026-10-26T00:58:55.874089Z","steps":["trace[1195606895] 'process raft request' (duration: 439.874625ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:55.874197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:55.433173Z","time spent":"440.978846ms","remote":"127.0.0.1:45056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3385,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T00:58:55.874064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:55.432287Z","time spent":"441.698094ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":762,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T00:58:55.87431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:58:55.433988Z","time spent":"440.205708ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3882,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T00:58:55.874604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.410265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-26T00:58:55.87474Z","caller":"traceutil/trace.go:171","msg":"trace[983977137] range","detail":"{range_begin:/registry/masterleases/162.253.55.72; range_end:; response_count:1; response_revision:4333; }","duration":"223.606286ms","start":"2026-10-26T00:58:55.651113Z","end":"2026-10-26T00:58:55.874719Z","steps":["trace[983977137] 'agreement among raft nodes before linearized reading' (duration: 223.210902ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:56.084039Z","caller":"traceutil/trace.go:171","msg":"trace[1076711818] transaction","detail":"{read_only:false; response_revision:4339; number_of_response:1; }","duration":"106.256868ms","start":"2026-10-26T00:58:55.977756Z","end":"2026-10-26T00:58:56.084013Z","steps":["trace[1076711818] 'process raft request' (duration: 106.069396ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:57.24528Z","caller":"traceutil/trace.go:171","msg":"trace[1223370460] transaction","detail":"{read_only:false; response_revision:4343; number_of_response:1; }","duration":"104.465037ms","start":"2026-10-26T00:58:57.140771Z","end":"2026-10-26T00:58:57.245236Z","steps":["trace[1223370460] 'process raft request' (duration: 104.219945ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:57.245571Z","caller":"traceutil/trace.go:171","msg":"trace[630771687] transaction","detail":"{read_only:false; response_revision:4344; number_of_response:1; }","duration":"104.691319ms","start":"2026-10-26T00:58:57.140853Z","end":"2026-10-26T00:58:57.245544Z","steps":["trace[630771687] 'process raft request' (duration: 104.285476ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:58:57.406501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.739606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:58:57.406835Z","caller":"traceutil/trace.go:171","msg":"trace[2022513121] transaction","detail":"{read_only:false; response_revision:4345; number_of_response:1; }","duration":"216.00769ms","start":"2026-10-26T00:58:57.190751Z","end":"2026-10-26T00:58:57.406759Z","steps":["trace[2022513121] 'process raft request' (duration: 101.86994ms)","trace[2022513121] 'compare' (duration: 113.564314ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:58:57.413604Z","caller":"traceutil/trace.go:171","msg":"trace[1927923959] transaction","detail":"{read_only:false; response_revision:4346; number_of_response:1; }","duration":"163.452527ms","start":"2026-10-26T00:58:57.250125Z","end":"2026-10-26T00:58:57.413578Z","steps":["trace[1927923959] 'process raft request' (duration: 163.336496ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:57.588215Z","caller":"traceutil/trace.go:171","msg":"trace[663474486] transaction","detail":"{read_only:false; response_revision:4347; number_of_response:1; }","duration":"154.2771ms","start":"2026-10-26T00:58:57.43391Z","end":"2026-10-26T00:58:57.588187Z","steps":["trace[663474486] 'process raft request' (duration: 149.788723ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:57.912647Z","caller":"traceutil/trace.go:171","msg":"trace[1721521620] transaction","detail":"{read_only:false; response_revision:4349; number_of_response:1; }","duration":"119.001382ms","start":"2026-10-26T00:58:57.793616Z","end":"2026-10-26T00:58:57.912617Z","steps":["trace[1721521620] 'process raft request' (duration: 118.78686ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:59.744289Z","caller":"traceutil/trace.go:171","msg":"trace[6816867] transaction","detail":"{read_only:false; response_revision:4357; number_of_response:1; }","duration":"118.100771ms","start":"2026-10-26T00:58:59.62614Z","end":"2026-10-26T00:58:59.744241Z","steps":["trace[6816867] 'process raft request' (duration: 117.786487ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:58:59.854721Z","caller":"traceutil/trace.go:171","msg":"trace[781839620] transaction","detail":"{read_only:false; response_revision:4358; number_of_response:1; }","duration":"105.087561ms","start":"2026-10-26T00:58:59.74958Z","end":"2026-10-26T00:58:59.854667Z","steps":["trace[781839620] 'process raft request' (duration: 86.903907ms)","trace[781839620] 'compare' (duration: 17.965082ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:00.161551Z","caller":"traceutil/trace.go:171","msg":"trace[1366204809] transaction","detail":"{read_only:false; response_revision:4360; number_of_response:1; }","duration":"119.774397ms","start":"2026-10-26T00:59:00.041713Z","end":"2026-10-26T00:59:00.161488Z","steps":["trace[1366204809] 'process raft request' (duration: 119.414043ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:00.161688Z","caller":"traceutil/trace.go:171","msg":"trace[982733337] transaction","detail":"{read_only:false; response_revision:4361; number_of_response:1; }","duration":"119.789127ms","start":"2026-10-26T00:59:00.041875Z","end":"2026-10-26T00:59:00.161664Z","steps":["trace[982733337] 'process raft request' (duration: 119.502044ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:01.973703Z","caller":"traceutil/trace.go:171","msg":"trace[1816887938] linearizableReadLoop","detail":"{readStateIndex:4546; appliedIndex:4545; }","duration":"114.969723ms","start":"2026-10-26T00:59:01.858704Z","end":"2026-10-26T00:59:01.973674Z","steps":["trace[1816887938] 'read index received' (duration: 114.852223ms)","trace[1816887938] 'applied index is now lower than readState.Index' (duration: 116.39µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:01.973845Z","caller":"traceutil/trace.go:171","msg":"trace[190655926] transaction","detail":"{read_only:false; response_revision:4367; number_of_response:1; }","duration":"197.311922ms","start":"2026-10-26T00:59:01.776485Z","end":"2026-10-26T00:59:01.973797Z","steps":["trace[190655926] 'process raft request' (duration: 196.960359ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:01.973979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.253097ms","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-10-26T00:59:01.974023Z","caller":"traceutil/trace.go:171","msg":"trace[620937438] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4367; }","duration":"115.322978ms","start":"2026-10-26T00:59:01.858687Z","end":"2026-10-26T00:59:01.97401Z","steps":["trace[620937438] 'agreement among raft nodes before linearized reading' (duration: 115.094336ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:02.156148Z","caller":"traceutil/trace.go:171","msg":"trace[1265009064] transaction","detail":"{read_only:false; response_revision:4370; number_of_response:1; }","duration":"102.911125ms","start":"2026-10-26T00:59:02.053202Z","end":"2026-10-26T00:59:02.156113Z","steps":["trace[1265009064] 'process raft request' (duration: 37.040725ms)","trace[1265009064] 'compare' (duration: 65.632318ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:02.167867Z","caller":"traceutil/trace.go:171","msg":"trace[1518869191] transaction","detail":"{read_only:false; response_revision:4371; number_of_response:1; }","duration":"111.192383ms","start":"2026-10-26T00:59:02.056627Z","end":"2026-10-26T00:59:02.167819Z","steps":["trace[1518869191] 'process raft request' (duration: 111.035542ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:03.269823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3039544325347385587,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-26T00:59:03.515702Z","caller":"traceutil/trace.go:171","msg":"trace[748280297] linearizableReadLoop","detail":"{readStateIndex:4554; appliedIndex:4553; }","duration":"745.908173ms","start":"2026-10-26T00:59:02.769764Z","end":"2026-10-26T00:59:03.515672Z","steps":["trace[748280297] 'read index received' (duration: 745.576129ms)","trace[748280297] 'applied index is now lower than readState.Index' (duration: 330.924µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:03.515811Z","caller":"traceutil/trace.go:171","msg":"trace[1578412930] transaction","detail":"{read_only:false; response_revision:4375; number_of_response:1; }","duration":"910.492104ms","start":"2026-10-26T00:59:02.605286Z","end":"2026-10-26T00:59:03.515778Z","steps":["trace[1578412930] 'process raft request' (duration: 910.018609ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:03.515933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.150126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-create-dwjmv\" ","response":"range_response_count:1 size:4356"} {"level":"warn","ts":"2026-10-26T00:59:03.51596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:02.605249Z","time spent":"910.629325ms","remote":"127.0.0.1:45148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:59:03.515983Z","caller":"traceutil/trace.go:171","msg":"trace[246657463] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-create-dwjmv; range_end:; response_count:1; response_revision:4375; }","duration":"746.272287ms","start":"2026-10-26T00:59:02.769693Z","end":"2026-10-26T00:59:03.515966Z","steps":["trace[246657463] 'agreement among raft nodes before linearized reading' (duration: 746.082485ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:03.516022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:02.769631Z","time spent":"746.380738ms","remote":"127.0.0.1:45056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":4378,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-create-dwjmv\" "} {"level":"info","ts":"2026-10-26T00:59:03.923482Z","caller":"traceutil/trace.go:171","msg":"trace[1305219107] transaction","detail":"{read_only:false; response_revision:4376; number_of_response:1; }","duration":"643.139727ms","start":"2026-10-26T00:59:03.28031Z","end":"2026-10-26T00:59:03.923449Z","steps":["trace[1305219107] 'process raft request' (duration: 642.894265ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:03.923484Z","caller":"traceutil/trace.go:171","msg":"trace[1660476714] transaction","detail":"{read_only:false; response_revision:4378; number_of_response:1; }","duration":"551.043178ms","start":"2026-10-26T00:59:03.372422Z","end":"2026-10-26T00:59:03.923465Z","steps":["trace[1660476714] 'process raft request' (duration: 551.000208ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:03.923745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:03.280277Z","time spent":"643.378471ms","remote":"127.0.0.1:45148","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-10-26T00:59:03.923905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:03.372403Z","time spent":"551.363412ms","remote":"127.0.0.1:45148","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-10-26T00:59:03.923506Z","caller":"traceutil/trace.go:171","msg":"trace[18663277] transaction","detail":"{read_only:false; response_revision:4377; number_of_response:1; }","duration":"557.169354ms","start":"2026-10-26T00:59:03.366304Z","end":"2026-10-26T00:59:03.923474Z","steps":["trace[18663277] 'process raft request' (duration: 557.081943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:03.92411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:03.366268Z","time spent":"557.806991ms","remote":"127.0.0.1:45148","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-10-26T00:59:03.933053Z","caller":"traceutil/trace.go:171","msg":"trace[436217285] linearizableReadLoop","detail":"{readStateIndex:4558; appliedIndex:4554; }","duration":"363.939309ms","start":"2026-10-26T00:59:03.569094Z","end":"2026-10-26T00:59:03.933034Z","steps":["trace[436217285] 'read index received' (duration: 354.098424ms)","trace[436217285] 'applied index is now lower than readState.Index' (duration: 9.837755ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:03.933127Z","caller":"traceutil/trace.go:171","msg":"trace[1145636102] transaction","detail":"{read_only:false; response_revision:4379; number_of_response:1; }","duration":"408.397273ms","start":"2026-10-26T00:59:03.524702Z","end":"2026-10-26T00:59:03.933099Z","steps":["trace[1145636102] 'process raft request' (duration: 408.211171ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:03.933206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.271709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T00:59:03.933239Z","caller":"traceutil/trace.go:171","msg":"trace[1097757891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4379; }","duration":"310.330441ms","start":"2026-10-26T00:59:03.622901Z","end":"2026-10-26T00:59:03.933232Z","steps":["trace[1097757891] 'agreement among raft nodes before linearized reading' (duration: 310.27733ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:03.933243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.148922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-26T00:59:03.933256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:03.62289Z","time spent":"310.362711ms","remote":"127.0.0.1:44858","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-10-26T00:59:03.933275Z","caller":"traceutil/trace.go:171","msg":"trace[62385381] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4379; }","duration":"364.239432ms","start":"2026-10-26T00:59:03.569028Z","end":"2026-10-26T00:59:03.933267Z","steps":["trace[62385381] 'agreement among raft nodes before linearized reading' (duration: 364.099391ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:03.933263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:03.524673Z","time spent":"408.532444ms","remote":"127.0.0.1:45056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T00:59:03.933307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:03.569Z","time spent":"364.300202ms","remote":"127.0.0.1:45148","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-10-26T00:59:05.803507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.714781ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:59:05.803663Z","caller":"traceutil/trace.go:171","msg":"trace[1702419269] transaction","detail":"{read_only:false; response_revision:4388; number_of_response:1; }","duration":"141.741564ms","start":"2026-10-26T00:59:05.661898Z","end":"2026-10-26T00:59:05.803639Z","steps":["trace[1702419269] 'process raft request' (duration: 35.79721ms)","trace[1702419269] 'compare' (duration: 105.445679ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:09.865877Z","caller":"traceutil/trace.go:171","msg":"trace[1047157950] linearizableReadLoop","detail":"{readStateIndex:4919; appliedIndex:4918; }","duration":"116.145987ms","start":"2026-10-26T00:59:09.749704Z","end":"2026-10-26T00:59:09.86585Z","steps":["trace[1047157950] 'read index received' (duration: 116.013176ms)","trace[1047157950] 'applied index is now lower than readState.Index' (duration: 131.681µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:09.865988Z","caller":"traceutil/trace.go:171","msg":"trace[872326948] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"163.034483ms","start":"2026-10-26T00:59:09.702918Z","end":"2026-10-26T00:59:09.865952Z","steps":["trace[872326948] 'process raft request' (duration: 162.80048ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:09.866121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.39579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/grafana-tls\" ","response":"range_response_count:1 size:2543"} {"level":"info","ts":"2026-10-26T00:59:09.866166Z","caller":"traceutil/trace.go:171","msg":"trace[872800656] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/grafana-tls; range_end:; response_count:1; response_revision:4733; }","duration":"116.495371ms","start":"2026-10-26T00:59:09.749656Z","end":"2026-10-26T00:59:09.866151Z","steps":["trace[872800656] 'agreement among raft nodes before linearized reading' (duration: 116.321579ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:11.410787Z","caller":"traceutil/trace.go:171","msg":"trace[1332413732] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"100.33398ms","start":"2026-10-26T00:59:11.310414Z","end":"2026-10-26T00:59:11.410748Z","steps":["trace[1332413732] 'process raft request' (duration: 85.289161ms)","trace[1332413732] 'compare' (duration: 14.342881ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:59:12.205317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.157841ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:59:12.205513Z","caller":"traceutil/trace.go:171","msg":"trace[163319519] linearizableReadLoop","detail":"{readStateIndex:4990; appliedIndex:4989; }","duration":"327.06926ms","start":"2026-10-26T00:59:11.878425Z","end":"2026-10-26T00:59:12.205495Z","steps":["trace[163319519] 'read index received' (duration: 26.674082ms)","trace[163319519] 'applied index is now lower than readState.Index' (duration: 300.394218ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:12.205754Z","caller":"traceutil/trace.go:171","msg":"trace[464532009] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"327.619355ms","start":"2026-10-26T00:59:11.878121Z","end":"2026-10-26T00:59:12.205741Z","steps":["trace[464532009] 'process raft request' (duration: 34.909428ms)","trace[464532009] 'compare' (duration: 292.011409ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:59:12.20583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:11.87809Z","time spent":"327.701036ms","remote":"127.0.0.1:54580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:59:12.206075Z","caller":"traceutil/trace.go:171","msg":"trace[343662336] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"314.072441ms","start":"2026-10-26T00:59:11.891994Z","end":"2026-10-26T00:59:12.206066Z","steps":["trace[343662336] 'process raft request' (duration: 313.435635ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.206133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:11.891955Z","time spent":"314.149582ms","remote":"127.0.0.1:45016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1168,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T00:59:12.206445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.197185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-10-26T00:59:12.206482Z","caller":"traceutil/trace.go:171","msg":"trace[741448023] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4802; }","duration":"336.253266ms","start":"2026-10-26T00:59:11.870219Z","end":"2026-10-26T00:59:12.206472Z","steps":["trace[741448023] 'agreement among raft nodes before linearized reading' (duration: 336.072004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.206512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:11.870213Z","time spent":"336.292866ms","remote":"127.0.0.1:44942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3980,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" "} {"level":"warn","ts":"2026-10-26T00:59:12.206724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.62821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:46687"} {"level":"info","ts":"2026-10-26T00:59:12.206755Z","caller":"traceutil/trace.go:171","msg":"trace[1383296366] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4802; }","duration":"336.68089ms","start":"2026-10-26T00:59:11.870067Z","end":"2026-10-26T00:59:12.206748Z","steps":["trace[1383296366] 'agreement among raft nodes before linearized reading' (duration: 336.561809ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.206779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:11.870056Z","time spent":"336.715781ms","remote":"127.0.0.1:45056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":6,"response size":46709,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"info","ts":"2026-10-26T00:59:12.218257Z","caller":"traceutil/trace.go:171","msg":"trace[122154163] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"302.044334ms","start":"2026-10-26T00:59:11.916181Z","end":"2026-10-26T00:59:12.218225Z","steps":["trace[122154163] 'process raft request' (duration: 301.780182ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.218505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:11.91615Z","time spent":"302.250187ms","remote":"127.0.0.1:45026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1329,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:59:12.229594Z","caller":"traceutil/trace.go:171","msg":"trace[1499322010] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"312.772667ms","start":"2026-10-26T00:59:11.916793Z","end":"2026-10-26T00:59:12.229566Z","steps":["trace[1499322010] 'process raft request' (duration: 311.979928ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.229776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:11.916778Z","time spent":"312.91394ms","remote":"127.0.0.1:45152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1903,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:59:12.230205Z","caller":"traceutil/trace.go:171","msg":"trace[634318736] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"310.17347ms","start":"2026-10-26T00:59:11.919996Z","end":"2026-10-26T00:59:12.23017Z","steps":["trace[634318736] 'process raft request' (duration: 308.992717ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.230387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:59:11.919981Z","time spent":"310.296012ms","remote":"127.0.0.1:55172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5194,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:59:12.230642Z","caller":"traceutil/trace.go:171","msg":"trace[2109436607] transaction","detail":"{read_only:false; response_revision:4806; number_of_response:1; }","duration":"249.046175ms","start":"2026-10-26T00:59:11.981584Z","end":"2026-10-26T00:59:12.23063Z","steps":["trace[2109436607] 'process raft request' (duration: 247.460967ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:12.230791Z","caller":"traceutil/trace.go:171","msg":"trace[1652902620] transaction","detail":"{read_only:false; response_revision:4807; number_of_response:1; }","duration":"243.260326ms","start":"2026-10-26T00:59:11.98752Z","end":"2026-10-26T00:59:12.23078Z","steps":["trace[1652902620] 'process raft request' (duration: 241.571367ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:12.230928Z","caller":"traceutil/trace.go:171","msg":"trace[1757537930] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"242.869811ms","start":"2026-10-26T00:59:11.988049Z","end":"2026-10-26T00:59:12.230919Z","steps":["trace[1757537930] 'process raft request' (duration: 241.090472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.231791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.507744ms","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-10-26T00:59:12.23184Z","caller":"traceutil/trace.go:171","msg":"trace[2053052656] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4810; }","duration":"201.596495ms","start":"2026-10-26T00:59:12.030231Z","end":"2026-10-26T00:59:12.231828Z","steps":["trace[2053052656] 'agreement among raft nodes before linearized reading' (duration: 201.414273ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.232036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.766583ms","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-10-26T00:59:12.232068Z","caller":"traceutil/trace.go:171","msg":"trace[735670754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4810; }","duration":"138.877983ms","start":"2026-10-26T00:59:12.093181Z","end":"2026-10-26T00:59:12.232059Z","steps":["trace[735670754] 'agreement among raft nodes before linearized reading' (duration: 138.758982ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:12.232239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.477981ms","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-10-26T00:59:12.232263Z","caller":"traceutil/trace.go:171","msg":"trace[2066710923] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4810; }","duration":"141.526652ms","start":"2026-10-26T00:59:12.090729Z","end":"2026-10-26T00:59:12.232255Z","steps":["trace[2066710923] 'agreement among raft nodes before linearized reading' (duration: 141.446611ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:25.017542Z","caller":"traceutil/trace.go:171","msg":"trace[640966240] transaction","detail":"{read_only:false; response_revision:5065; number_of_response:1; }","duration":"109.546233ms","start":"2026-10-26T00:59:24.90796Z","end":"2026-10-26T00:59:25.017506Z","steps":["trace[640966240] 'process raft request' (duration: 109.3035ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:25.131024Z","caller":"traceutil/trace.go:171","msg":"trace[1303339184] transaction","detail":"{read_only:false; response_revision:5066; number_of_response:1; }","duration":"103.265637ms","start":"2026-10-26T00:59:25.027723Z","end":"2026-10-26T00:59:25.130989Z","steps":["trace[1303339184] 'process raft request' (duration: 103.054035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:42.420369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.491495ms","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-10-26T00:59:42.421081Z","caller":"traceutil/trace.go:171","msg":"trace[1506167059] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5264; }","duration":"248.209921ms","start":"2026-10-26T00:59:42.172848Z","end":"2026-10-26T00:59:42.421058Z","steps":["trace[1506167059] 'range keys from in-memory index tree' (duration: 247.337703ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:42.420436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.435425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10685"} {"level":"info","ts":"2026-10-26T00:59:42.421341Z","caller":"traceutil/trace.go:171","msg":"trace[1224870341] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5264; }","duration":"250.368124ms","start":"2026-10-26T00:59:42.170937Z","end":"2026-10-26T00:59:42.421306Z","steps":["trace[1224870341] 'range keys from in-memory index tree' (duration: 248.928889ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:42.549224Z","caller":"traceutil/trace.go:171","msg":"trace[1314180574] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"177.397405ms","start":"2026-10-26T00:59:42.371801Z","end":"2026-10-26T00:59:42.549199Z","steps":["trace[1314180574] 'process raft request' (duration: 174.916069ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:42.549699Z","caller":"traceutil/trace.go:171","msg":"trace[1696521280] linearizableReadLoop","detail":"{readStateIndex:5470; appliedIndex:5467; }","duration":"168.678745ms","start":"2026-10-26T00:59:42.380997Z","end":"2026-10-26T00:59:42.549675Z","steps":["trace[1696521280] 'read index received' (duration: 81.503168ms)","trace[1696521280] 'applied index is now lower than readState.Index' (duration: 87.174487ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:59:42.549777Z","caller":"traceutil/trace.go:171","msg":"trace[484478333] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"177.848088ms","start":"2026-10-26T00:59:42.371916Z","end":"2026-10-26T00:59:42.549764Z","steps":["trace[484478333] 'process raft request' (duration: 177.237882ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:42.550079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.035047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-10-26T00:59:42.550196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.465849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9129a6a5-7d3c-4f1e-a255-7a6693e1529c\" ","response":"range_response_count:1 size:1322"} {"level":"warn","ts":"2026-10-26T00:59:42.55023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.321241ms","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-10-26T00:59:42.550151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.799064ms","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-10-26T00:59:42.550263Z","caller":"traceutil/trace.go:171","msg":"trace[747936561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5268; }","duration":"134.404492ms","start":"2026-10-26T00:59:42.415847Z","end":"2026-10-26T00:59:42.550251Z","steps":["trace[747936561] 'agreement among raft nodes before linearized reading' (duration: 134.331371ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:42.550267Z","caller":"traceutil/trace.go:171","msg":"trace[1514756430] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9129a6a5-7d3c-4f1e-a255-7a6693e1529c; range_end:; response_count:1; response_revision:5268; }","duration":"124.570781ms","start":"2026-10-26T00:59:42.425679Z","end":"2026-10-26T00:59:42.55025Z","steps":["trace[1514756430] 'agreement among raft nodes before linearized reading' (duration: 124.406959ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:42.550274Z","caller":"traceutil/trace.go:171","msg":"trace[2059198502] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5268; }","duration":"161.983975ms","start":"2026-10-26T00:59:42.388278Z","end":"2026-10-26T00:59:42.550262Z","steps":["trace[2059198502] 'agreement among raft nodes before linearized reading' (duration: 161.727182ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:42.550211Z","caller":"traceutil/trace.go:171","msg":"trace[484644283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5268; }","duration":"169.243999ms","start":"2026-10-26T00:59:42.380947Z","end":"2026-10-26T00:59:42.550191Z","steps":["trace[484644283] 'agreement among raft nodes before linearized reading' (duration: 168.929516ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:59:42.55059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.015199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12431"} {"level":"info","ts":"2026-10-26T00:59:42.550637Z","caller":"traceutil/trace.go:171","msg":"trace[697076319] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5268; }","duration":"105.101851ms","start":"2026-10-26T00:59:42.445521Z","end":"2026-10-26T00:59:42.550623Z","steps":["trace[697076319] 'agreement among raft nodes before linearized reading' (duration: 104.979579ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:42.550986Z","caller":"traceutil/trace.go:171","msg":"trace[858182988] transaction","detail":"{read_only:false; response_revision:5268; number_of_response:1; }","duration":"113.477626ms","start":"2026-10-26T00:59:42.436337Z","end":"2026-10-26T00:59:42.549815Z","steps":["trace[858182988] 'process raft request' (duration: 113.221785ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:59:51.255832Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2882} {"level":"info","ts":"2026-10-26T00:59:51.34633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2882,"took":"85.619884ms","hash":1859822614,"current-db-size-bytes":52109312,"current-db-size":"52 MB","current-db-size-in-use-bytes":27443200,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-26T00:59:51.346419Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1859822614,"revision":2882,"compact-revision":-1} {"level":"info","ts":"2026-10-26T01:03:21.885692Z","caller":"traceutil/trace.go:171","msg":"trace[533066956] transaction","detail":"{read_only:false; response_revision:6871; number_of_response:1; }","duration":"104.728097ms","start":"2026-10-26T01:03:21.780907Z","end":"2026-10-26T01:03:21.885635Z","steps":["trace[533066956] 'process raft request' (duration: 59.084195ms)","trace[533066956] 'compare' (duration: 45.385526ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:04:51.26371Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5343} {"level":"info","ts":"2026-10-26T01:04:51.341652Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5343,"took":"76.870279ms","hash":3978866597,"current-db-size-bytes":52109312,"current-db-size":"52 MB","current-db-size-in-use-bytes":18739200,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-26T01:04:51.341707Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3978866597,"revision":5343,"compact-revision":2882}