{"level":"warn","ts":"2026-04-22T13:49:46.635592Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T13:49:46.635727Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.9:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.9:2380","--initial-cluster=instance=https://199.19.213.9:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.9:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.9: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-04-22T13:49:46.636002Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T13:49:46.636021Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.9:2380"]} {"level":"info","ts":"2026-04-22T13:49:46.636686Z","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-04-22T13:49:46.637507Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"]} {"level":"info","ts":"2026-04-22T13:49:46.637832Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.9:2380"],"listen-peer-urls":["https://199.19.213.9:2380"],"advertise-client-urls":["https://199.19.213.9:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.9: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-04-22T13:49:46.642345Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.116857ms"} {"level":"info","ts":"2026-04-22T13:49:46.651099Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3a0c9d65f167b31b","cluster-id":"86e523b598166645"} {"level":"info","ts":"2026-04-22T13:49:46.65121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T13:49:46.651242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became follower at term 0"} {"level":"info","ts":"2026-04-22T13:49:46.65126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3a0c9d65f167b31b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T13:49:46.651294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became follower at term 1"} {"level":"info","ts":"2026-04-22T13:49:46.651373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=(4182891215087711003)"} {"level":"warn","ts":"2026-04-22T13:49:46.656801Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T13:49:46.658479Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T13:49:46.660698Z","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-04-22T13:49:46.663538Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3a0c9d65f167b31b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T13:49:46.663873Z","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-04-22T13:49:46.663943Z","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-04-22T13:49:46.663976Z","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-04-22T13:49:46.664323Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3a0c9d65f167b31b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T13:49:46.665163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=(4182891215087711003)"} {"level":"info","ts":"2026-04-22T13:49:46.66877Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"86e523b598166645","local-member-id":"3a0c9d65f167b31b","added-peer-id":"3a0c9d65f167b31b","added-peer-peer-urls":["https://199.19.213.9:2380"]} {"level":"info","ts":"2026-04-22T13:49:46.670545Z","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-04-22T13:49:46.670725Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.9:2380"} {"level":"info","ts":"2026-04-22T13:49:46.670772Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.9:2380"} {"level":"info","ts":"2026-04-22T13:49:46.671001Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3a0c9d65f167b31b","initial-advertise-peer-urls":["https://199.19.213.9:2380"],"listen-peer-urls":["https://199.19.213.9:2380"],"advertise-client-urls":["https://199.19.213.9:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T13:49:46.671049Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T13:49:47.052579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T13:49:47.052649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T13:49:47.052678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b received MsgPreVoteResp from 3a0c9d65f167b31b at term 1"} {"level":"info","ts":"2026-04-22T13:49:47.052693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became candidate at term 2"} {"level":"info","ts":"2026-04-22T13:49:47.052701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b received MsgVoteResp from 3a0c9d65f167b31b at term 2"} {"level":"info","ts":"2026-04-22T13:49:47.052711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became leader at term 2"} {"level":"info","ts":"2026-04-22T13:49:47.052721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3a0c9d65f167b31b elected leader 3a0c9d65f167b31b at term 2"} {"level":"info","ts":"2026-04-22T13:49:47.054478Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:49:47.056288Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"86e523b598166645","local-member-id":"3a0c9d65f167b31b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:49:47.056363Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:49:47.056387Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:49:47.056418Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3a0c9d65f167b31b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.9:2379]}","request-path":"/0/members/3a0c9d65f167b31b/attributes","cluster-id":"86e523b598166645","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T13:49:47.056522Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T13:49:47.056482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T13:49:47.056941Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T13:49:47.056999Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T13:49:47.058976Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.9:2379"} {"level":"info","ts":"2026-04-22T13:49:47.059674Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T13:49:50.89071Z","caller":"traceutil/trace.go:171","msg":"trace[1989521578] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"244.731413ms","start":"2026-04-22T13:49:50.645943Z","end":"2026-04-22T13:49:50.890674Z","steps":["trace[1989521578] 'process raft request' (duration: 244.511362ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:49:51.164642Z","caller":"traceutil/trace.go:171","msg":"trace[1621429272] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:208; }","duration":"396.607929ms","start":"2026-04-22T13:49:50.767999Z","end":"2026-04-22T13:49:51.164607Z","steps":["trace[1621429272] 'read index received' (duration: 122.454392ms)","trace[1621429272] 'applied index is now lower than readState.Index' (duration: 274.152207ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:49:51.164808Z","caller":"traceutil/trace.go:171","msg":"trace[601790007] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"513.476617ms","start":"2026-04-22T13:49:50.651275Z","end":"2026-04-22T13:49:51.164751Z","steps":["trace[601790007] 'process raft request' (duration: 481.805091ms)","trace[601790007] 'compare' (duration: 31.310574ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:49:51.165118Z","caller":"traceutil/trace.go:171","msg":"trace[1934399384] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"491.608526ms","start":"2026-04-22T13:49:50.673495Z","end":"2026-04-22T13:49:51.165104Z","steps":["trace[1934399384] 'process raft request' (duration: 491.055533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:49:51.165289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.281142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-04-22T13:49:51.165353Z","caller":"traceutil/trace.go:171","msg":"trace[612330412] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:206; }","duration":"397.417843ms","start":"2026-04-22T13:49:50.76792Z","end":"2026-04-22T13:49:51.165338Z","steps":["trace[612330412] 'agreement among raft nodes before linearized reading' (duration: 397.257622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:49:51.165387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:49:50.767897Z","time spent":"397.479203ms","remote":"127.0.0.1:34372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-22T13:49:51.165411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:49:50.651243Z","time spent":"513.664178ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T13:49:51.165638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.639162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:49:51.165678Z","caller":"traceutil/trace.go:171","msg":"trace[1305431284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:206; }","duration":"373.680182ms","start":"2026-04-22T13:49:50.791989Z","end":"2026-04-22T13:49:51.165669Z","steps":["trace[1305431284] 'agreement among raft nodes before linearized reading' (duration: 373.621802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:49:51.165713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:49:50.791913Z","time spent":"373.792673ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T13:49:51.166131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:49:50.673478Z","time spent":"491.680957ms","remote":"127.0.0.1:34382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T13:49:52.333861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.146341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:49:52.333951Z","caller":"traceutil/trace.go:171","msg":"trace[58268402] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:0; response_revision:241; }","duration":"187.308083ms","start":"2026-04-22T13:49:52.14662Z","end":"2026-04-22T13:49:52.333928Z","steps":["trace[58268402] 'range keys from in-memory index tree' (duration: 187.051231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:49:52.334159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.75172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:49:52.334191Z","caller":"traceutil/trace.go:171","msg":"trace[159202080] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:241; }","duration":"186.80408ms","start":"2026-04-22T13:49:52.147377Z","end":"2026-04-22T13:49:52.334181Z","steps":["trace[159202080] 'range keys from in-memory index tree' (duration: 186.704969ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:49:53.125802Z","caller":"traceutil/trace.go:171","msg":"trace[874223631] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"130.470702ms","start":"2026-04-22T13:49:52.995292Z","end":"2026-04-22T13:49:53.125763Z","steps":["trace[874223631] 'process raft request' (duration: 69.510572ms)","trace[874223631] 'compare' (duration: 60.780869ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:49:53.262998Z","caller":"traceutil/trace.go:171","msg":"trace[1325097698] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"117.124815ms","start":"2026-04-22T13:49:53.145345Z","end":"2026-04-22T13:49:53.26247Z","steps":["trace[1325097698] 'process raft request' (duration: 116.744133ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.482872Z","caller":"traceutil/trace.go:171","msg":"trace[67757120] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"117.653167ms","start":"2026-04-22T13:50:19.365191Z","end":"2026-04-22T13:50:19.482844Z","steps":["trace[67757120] 'process raft request' (duration: 117.483106ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.482948Z","caller":"traceutil/trace.go:171","msg":"trace[1586195452] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"116.324121ms","start":"2026-04-22T13:50:19.366572Z","end":"2026-04-22T13:50:19.482897Z","steps":["trace[1586195452] 'process raft request' (duration: 116.236171ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.483014Z","caller":"traceutil/trace.go:171","msg":"trace[443266684] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"105.38762ms","start":"2026-04-22T13:50:19.377617Z","end":"2026-04-22T13:50:19.483005Z","steps":["trace[443266684] 'process raft request' (duration: 105.25276ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.483108Z","caller":"traceutil/trace.go:171","msg":"trace[1905310821] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"105.537491ms","start":"2026-04-22T13:50:19.377561Z","end":"2026-04-22T13:50:19.483098Z","steps":["trace[1905310821] 'process raft request' (duration: 105.27529ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.483166Z","caller":"traceutil/trace.go:171","msg":"trace[880471938] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"102.588898ms","start":"2026-04-22T13:50:19.380571Z","end":"2026-04-22T13:50:19.48316Z","steps":["trace[880471938] 'process raft request' (duration: 102.359007ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.483222Z","caller":"traceutil/trace.go:171","msg":"trace[1218372612] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"102.99082ms","start":"2026-04-22T13:50:19.380225Z","end":"2026-04-22T13:50:19.483216Z","steps":["trace[1218372612] 'process raft request' (duration: 102.681389ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.483305Z","caller":"traceutil/trace.go:171","msg":"trace[430201046] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"101.472664ms","start":"2026-04-22T13:50:19.381819Z","end":"2026-04-22T13:50:19.483292Z","steps":["trace[430201046] 'process raft request' (duration: 101.135052ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.735803Z","caller":"traceutil/trace.go:171","msg":"trace[100010270] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"119.590775ms","start":"2026-04-22T13:50:19.616151Z","end":"2026-04-22T13:50:19.735741Z","steps":["trace[100010270] 'process raft request' (duration: 99.373563ms)","trace[100010270] 'compare' (duration: 19.989171ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:50:19.736101Z","caller":"traceutil/trace.go:171","msg":"trace[1978930926] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"116.118199ms","start":"2026-04-22T13:50:19.619969Z","end":"2026-04-22T13:50:19.736087Z","steps":["trace[1978930926] 'process raft request' (duration: 115.714878ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:19.736298Z","caller":"traceutil/trace.go:171","msg":"trace[2026843481] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"107.869343ms","start":"2026-04-22T13:50:19.628404Z","end":"2026-04-22T13:50:19.736274Z","steps":["trace[2026843481] 'process raft request' (duration: 107.623151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:19.744965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.72504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-04-22T13:50:19.745051Z","caller":"traceutil/trace.go:171","msg":"trace[733108527] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:507; }","duration":"100.84913ms","start":"2026-04-22T13:50:19.644178Z","end":"2026-04-22T13:50:19.745027Z","steps":["trace[733108527] 'agreement among raft nodes before linearized reading' (duration: 100.581549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:19.746282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.070005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-04-22T13:50:19.746449Z","caller":"traceutil/trace.go:171","msg":"trace[61606743] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:507; }","duration":"102.122996ms","start":"2026-04-22T13:50:19.644193Z","end":"2026-04-22T13:50:19.746316Z","steps":["trace[61606743] 'agreement among raft nodes before linearized reading' (duration: 102.044045ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:21.761161Z","caller":"traceutil/trace.go:171","msg":"trace[1092170754] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"148.942471ms","start":"2026-04-22T13:50:21.612193Z","end":"2026-04-22T13:50:21.761136Z","steps":["trace[1092170754] 'process raft request' (duration: 148.80388ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:21.852146Z","caller":"traceutil/trace.go:171","msg":"trace[1204517461] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"235.391601ms","start":"2026-04-22T13:50:21.616728Z","end":"2026-04-22T13:50:21.85212Z","steps":["trace[1204517461] 'process raft request' (duration: 235.35057ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:21.852617Z","caller":"traceutil/trace.go:171","msg":"trace[424939607] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"240.374474ms","start":"2026-04-22T13:50:21.612235Z","end":"2026-04-22T13:50:21.85261Z","steps":["trace[424939607] 'process raft request' (duration: 239.687791ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.554092Z","caller":"traceutil/trace.go:171","msg":"trace[1133764528] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"258.754403ms","start":"2026-04-22T13:50:26.2953Z","end":"2026-04-22T13:50:26.554054Z","steps":["trace[1133764528] 'read index received' (duration: 257.785459ms)","trace[1133764528] 'applied index is now lower than readState.Index' (duration: 967.724µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:50:26.554162Z","caller":"traceutil/trace.go:171","msg":"trace[68900089] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"305.655818ms","start":"2026-04-22T13:50:26.24848Z","end":"2026-04-22T13:50:26.554136Z","steps":["trace[68900089] 'process raft request' (duration: 304.937645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.554312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.936303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.554369Z","caller":"traceutil/trace.go:171","msg":"trace[50507869] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:584; }","duration":"259.007263ms","start":"2026-04-22T13:50:26.295337Z","end":"2026-04-22T13:50:26.554345Z","steps":["trace[50507869] 'agreement among raft nodes before linearized reading' (duration: 258.915353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.554402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.642004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:26.554621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.24844Z","time spent":"305.786199ms","remote":"127.0.0.1:34276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:50:26.554723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.816311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.554799Z","caller":"traceutil/trace.go:171","msg":"trace[1695464667] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"253.894092ms","start":"2026-04-22T13:50:26.30089Z","end":"2026-04-22T13:50:26.554784Z","steps":["trace[1695464667] 'agreement among raft nodes before linearized reading' (duration: 253.792481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.554979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.619144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:26.555091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.666295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:26.555094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.759482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.555145Z","caller":"traceutil/trace.go:171","msg":"trace[1599956341] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"254.729285ms","start":"2026-04-22T13:50:26.300403Z","end":"2026-04-22T13:50:26.555132Z","steps":["trace[1599956341] 'agreement among raft nodes before linearized reading' (duration: 254.662935ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.55512Z","caller":"traceutil/trace.go:171","msg":"trace[850169892] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"119.819905ms","start":"2026-04-22T13:50:26.435271Z","end":"2026-04-22T13:50:26.555091Z","steps":["trace[850169892] 'agreement among raft nodes before linearized reading' (duration: 119.464214ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.554471Z","caller":"traceutil/trace.go:171","msg":"trace[1449003334] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:584; }","duration":"222.760184ms","start":"2026-04-22T13:50:26.331691Z","end":"2026-04-22T13:50:26.554452Z","steps":["trace[1449003334] 'agreement among raft nodes before linearized reading' (duration: 222.620734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.555353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.976468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.555414Z","caller":"traceutil/trace.go:171","msg":"trace[1604473631] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:584; }","duration":"260.038208ms","start":"2026-04-22T13:50:26.295362Z","end":"2026-04-22T13:50:26.5554Z","steps":["trace[1604473631] 'agreement among raft nodes before linearized reading' (duration: 259.937178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.555539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.092758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:26.555523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.939082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l7qrp\" ","response":"range_response_count:1 size:16957"} {"level":"warn","ts":"2026-04-22T13:50:26.55566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.722629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.555708Z","caller":"traceutil/trace.go:171","msg":"trace[277935191] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:584; }","duration":"223.832199ms","start":"2026-04-22T13:50:26.331863Z","end":"2026-04-22T13:50:26.555695Z","steps":["trace[277935191] 'agreement among raft nodes before linearized reading' (duration: 223.765519ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.555704Z","caller":"traceutil/trace.go:171","msg":"trace[630619352] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l7qrp; range_end:; response_count:1; response_revision:584; }","duration":"165.153503ms","start":"2026-04-22T13:50:26.390513Z","end":"2026-04-22T13:50:26.555667Z","steps":["trace[630619352] 'agreement among raft nodes before linearized reading' (duration: 164.621211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.555037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.536355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.556187Z","caller":"traceutil/trace.go:171","msg":"trace[1392527739] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:584; }","duration":"198.73055ms","start":"2026-04-22T13:50:26.35744Z","end":"2026-04-22T13:50:26.55617Z","steps":["trace[1392527739] 'agreement among raft nodes before linearized reading' (duration: 197.553346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.556263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.145624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:26.556206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.058952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:26.556326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.878633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.556443Z","caller":"traceutil/trace.go:171","msg":"trace[1867289096] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"122.024863ms","start":"2026-04-22T13:50:26.434403Z","end":"2026-04-22T13:50:26.556428Z","steps":["trace[1867289096] 'agreement among raft nodes before linearized reading' (duration: 121.893433ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.55643Z","caller":"traceutil/trace.go:171","msg":"trace[216422420] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"165.214003ms","start":"2026-04-22T13:50:26.39112Z","end":"2026-04-22T13:50:26.556334Z","steps":["trace[216422420] 'agreement among raft nodes before linearized reading' (duration: 165.042562ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.555601Z","caller":"traceutil/trace.go:171","msg":"trace[764338978] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:584; }","duration":"198.205278ms","start":"2026-04-22T13:50:26.35738Z","end":"2026-04-22T13:50:26.555586Z","steps":["trace[764338978] 'agreement among raft nodes before linearized reading' (duration: 198.109408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.556271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.769563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.55668Z","caller":"traceutil/trace.go:171","msg":"trace[133527474] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"122.176044ms","start":"2026-04-22T13:50:26.434445Z","end":"2026-04-22T13:50:26.556621Z","steps":["trace[133527474] 'agreement among raft nodes before linearized reading' (duration: 121.793583ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.556331Z","caller":"traceutil/trace.go:171","msg":"trace[1720407923] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:584; }","duration":"165.234494ms","start":"2026-04-22T13:50:26.391078Z","end":"2026-04-22T13:50:26.556312Z","steps":["trace[1720407923] 'agreement among raft nodes before linearized reading' (duration: 165.134343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.555035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.584105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.556926Z","caller":"traceutil/trace.go:171","msg":"trace[141509090] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:584; }","duration":"256.481452ms","start":"2026-04-22T13:50:26.300429Z","end":"2026-04-22T13:50:26.55691Z","steps":["trace[141509090] 'agreement among raft nodes before linearized reading' (duration: 254.568265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.557108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.959414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:26.557195Z","caller":"traceutil/trace.go:171","msg":"trace[971445325] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:584; }","duration":"261.897346ms","start":"2026-04-22T13:50:26.295277Z","end":"2026-04-22T13:50:26.557175Z","steps":["trace[971445325] 'agreement among raft nodes before linearized reading' (duration: 258.935194ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.557775Z","caller":"traceutil/trace.go:171","msg":"trace[1585354422] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:584; }","duration":"199.451964ms","start":"2026-04-22T13:50:26.358297Z","end":"2026-04-22T13:50:26.557749Z","steps":["trace[1585354422] 'agreement among raft nodes before linearized reading' (duration: 196.766982ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:26.985083Z","caller":"traceutil/trace.go:171","msg":"trace[1920608839] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"416.951766ms","start":"2026-04-22T13:50:26.568097Z","end":"2026-04-22T13:50:26.985049Z","steps":["trace[1920608839] 'process raft request' (duration: 414.430724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:26.985243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.568045Z","time spent":"417.111287ms","remote":"127.0.0.1:34382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:50:27.022753Z","caller":"traceutil/trace.go:171","msg":"trace[1021215384] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:608; }","duration":"406.851982ms","start":"2026-04-22T13:50:26.615873Z","end":"2026-04-22T13:50:27.022725Z","steps":["trace[1021215384] 'read index received' (duration: 366.615655ms)","trace[1021215384] 'applied index is now lower than readState.Index' (duration: 40.235057ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:50:27.022942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.958773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:27.022944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.060743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.022988Z","caller":"traceutil/trace.go:171","msg":"trace[1948604792] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:586; }","duration":"407.066023ms","start":"2026-04-22T13:50:26.61591Z","end":"2026-04-22T13:50:27.022976Z","steps":["trace[1948604792] 'agreement among raft nodes before linearized reading' (duration: 406.960843ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:27.023011Z","caller":"traceutil/trace.go:171","msg":"trace[1872258823] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:586; }","duration":"407.165874ms","start":"2026-04-22T13:50:26.615824Z","end":"2026-04-22T13:50:27.02299Z","steps":["trace[1872258823] 'agreement among raft nodes before linearized reading' (duration: 407.021373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.615883Z","time spent":"407.138314ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T13:50:27.023076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.615798Z","time spent":"407.262534ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-22T13:50:27.023079Z","caller":"traceutil/trace.go:171","msg":"trace[957984831] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"407.259344ms","start":"2026-04-22T13:50:26.615682Z","end":"2026-04-22T13:50:27.022941Z","steps":["trace[957984831] 'process raft request' (duration: 406.899113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.8104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.023269Z","caller":"traceutil/trace.go:171","msg":"trace[121892907] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:586; }","duration":"134.884891ms","start":"2026-04-22T13:50:26.888376Z","end":"2026-04-22T13:50:27.02326Z","steps":["trace[121892907] 'agreement among raft nodes before linearized reading' (duration: 134.83817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.615658Z","time spent":"407.628686ms","remote":"127.0.0.1:34708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T13:50:27.023475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.223044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.023511Z","caller":"traceutil/trace.go:171","msg":"trace[1251531123] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:586; }","duration":"163.273295ms","start":"2026-04-22T13:50:26.860229Z","end":"2026-04-22T13:50:27.023503Z","steps":["trace[1251531123] 'agreement among raft nodes before linearized reading' (duration: 163.229384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.070933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.023603Z","caller":"traceutil/trace.go:171","msg":"trace[193569094] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:586; }","duration":"352.155803ms","start":"2026-04-22T13:50:26.671432Z","end":"2026-04-22T13:50:27.023588Z","steps":["trace[193569094] 'agreement among raft nodes before linearized reading' (duration: 352.066733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.646375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.02367Z","caller":"traceutil/trace.go:171","msg":"trace[1980346830] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:586; }","duration":"352.696695ms","start":"2026-04-22T13:50:26.670968Z","end":"2026-04-22T13:50:27.023665Z","steps":["trace[1980346830] 'agreement among raft nodes before linearized reading' (duration: 352.666455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.671421Z","time spent":"352.228483ms","remote":"127.0.0.1:50756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-22T13:50:27.023713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.327773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.023733Z","caller":"traceutil/trace.go:171","msg":"trace[1797485117] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:586; }","duration":"407.348323ms","start":"2026-04-22T13:50:26.61638Z","end":"2026-04-22T13:50:27.023729Z","steps":["trace[1797485117] 'agreement among raft nodes before linearized reading' (duration: 407.319953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.616349Z","time spent":"407.399344ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-22T13:50:27.023008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.978877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.023865Z","caller":"traceutil/trace.go:171","msg":"trace[272235480] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:586; }","duration":"134.893101ms","start":"2026-04-22T13:50:26.888965Z","end":"2026-04-22T13:50:27.023859Z","steps":["trace[272235480] 'agreement among raft nodes before linearized reading' (duration: 133.986867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.809607ms","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-04-22T13:50:27.024035Z","caller":"traceutil/trace.go:171","msg":"trace[1392003471] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:586; }","duration":"163.909988ms","start":"2026-04-22T13:50:26.86011Z","end":"2026-04-22T13:50:27.02402Z","steps":["trace[1392003471] 'agreement among raft nodes before linearized reading' (duration: 163.797707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.552109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.02417Z","caller":"traceutil/trace.go:171","msg":"trace[1117599153] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:586; }","duration":"135.556933ms","start":"2026-04-22T13:50:26.888599Z","end":"2026-04-22T13:50:27.024156Z","steps":["trace[1117599153] 'agreement among raft nodes before linearized reading' (duration: 134.572599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.024254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.238086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.024283Z","caller":"traceutil/trace.go:171","msg":"trace[784926046] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:586; }","duration":"106.287566ms","start":"2026-04-22T13:50:26.917989Z","end":"2026-04-22T13:50:27.024277Z","steps":["trace[784926046] 'agreement among raft nodes before linearized reading' (duration: 106.215985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.02433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.424945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:27.024378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.790158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.024397Z","caller":"traceutil/trace.go:171","msg":"trace[159563388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:586; }","duration":"106.833098ms","start":"2026-04-22T13:50:26.917559Z","end":"2026-04-22T13:50:27.024392Z","steps":["trace[159563388] 'agreement among raft nodes before linearized reading' (duration: 106.803458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.024449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.744876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:27.02448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.029639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.024498Z","caller":"traceutil/trace.go:171","msg":"trace[473495088] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:586; }","duration":"107.08696ms","start":"2026-04-22T13:50:26.917406Z","end":"2026-04-22T13:50:27.024493Z","steps":["trace[473495088] 'agreement among raft nodes before linearized reading' (duration: 107.057479ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:27.024499Z","caller":"traceutil/trace.go:171","msg":"trace[1562817505] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:586; }","duration":"181.796657ms","start":"2026-04-22T13:50:26.842689Z","end":"2026-04-22T13:50:27.024486Z","steps":["trace[1562817505] 'agreement among raft nodes before linearized reading' (duration: 181.725606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.02344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.162294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:50:27.024263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.789602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.024606Z","caller":"traceutil/trace.go:171","msg":"trace[1280438208] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:586; }","duration":"181.194723ms","start":"2026-04-22T13:50:26.843404Z","end":"2026-04-22T13:50:27.024599Z","steps":["trace[1280438208] 'agreement among raft nodes before linearized reading' (duration: 180.802611ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:27.024388Z","caller":"traceutil/trace.go:171","msg":"trace[2091730871] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:586; }","duration":"181.491705ms","start":"2026-04-22T13:50:26.842881Z","end":"2026-04-22T13:50:27.024373Z","steps":["trace[2091730871] 'agreement among raft nodes before linearized reading' (duration: 181.417245ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:27.024698Z","caller":"traceutil/trace.go:171","msg":"trace[1813491192] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:586; }","duration":"164.368949ms","start":"2026-04-22T13:50:26.860217Z","end":"2026-04-22T13:50:27.024586Z","steps":["trace[1813491192] 'agreement among raft nodes before linearized reading' (duration: 163.197914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.618275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.024837Z","caller":"traceutil/trace.go:171","msg":"trace[1715393737] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:586; }","duration":"353.85214ms","start":"2026-04-22T13:50:26.670969Z","end":"2026-04-22T13:50:27.024821Z","steps":["trace[1715393737] 'agreement among raft nodes before linearized reading' (duration: 352.636915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.023689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.670948Z","time spent":"352.736455ms","remote":"127.0.0.1:50756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T13:50:27.024914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:26.670954Z","time spent":"353.93864ms","remote":"127.0.0.1:50756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T13:50:27.528696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.114942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:50:27.528784Z","caller":"traceutil/trace.go:171","msg":"trace[1144548702] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"315.264542ms","start":"2026-04-22T13:50:27.2135Z","end":"2026-04-22T13:50:27.528765Z","steps":["trace[1144548702] 'range keys from in-memory index tree' (duration: 315.030282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.528825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:27.213481Z","time spent":"315.338272ms","remote":"127.0.0.1:34178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T13:50:27.529369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.789196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T13:50:27.529502Z","caller":"traceutil/trace.go:171","msg":"trace[1999755988] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"329.947497ms","start":"2026-04-22T13:50:27.199542Z","end":"2026-04-22T13:50:27.52949Z","steps":["trace[1999755988] 'range keys from in-memory index tree' (duration: 329.639835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:27.529526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:27.199523Z","time spent":"329.998097ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-22T13:50:27.551498Z","caller":"traceutil/trace.go:171","msg":"trace[1488620564] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"102.828937ms","start":"2026-04-22T13:50:27.448621Z","end":"2026-04-22T13:50:27.55145Z","steps":["trace[1488620564] 'process raft request' (duration: 99.429583ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:50:43.803746Z","caller":"traceutil/trace.go:171","msg":"trace[2029416878] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"481.95762ms","start":"2026-04-22T13:50:43.321755Z","end":"2026-04-22T13:50:43.803712Z","steps":["trace[2029416878] 'process raft request' (duration: 481.780461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:43.803996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:43.321732Z","time spent":"482.16012ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:50:43.946453Z","caller":"traceutil/trace.go:171","msg":"trace[1794195603] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"541.007098ms","start":"2026-04-22T13:50:43.405414Z","end":"2026-04-22T13:50:43.946421Z","steps":["trace[1794195603] 'process raft request' (duration: 540.759346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:43.946665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:43.405391Z","time spent":"541.174827ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:50:43.946824Z","caller":"traceutil/trace.go:171","msg":"trace[2111046686] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"435.798682ms","start":"2026-04-22T13:50:43.510985Z","end":"2026-04-22T13:50:43.946784Z","steps":["trace[2111046686] 'process raft request' (duration: 435.346609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:43.946971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.444926ms","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-04-22T13:50:43.947023Z","caller":"traceutil/trace.go:171","msg":"trace[1533501129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:753; }","duration":"267.532921ms","start":"2026-04-22T13:50:43.679475Z","end":"2026-04-22T13:50:43.947008Z","steps":["trace[1533501129] 'agreement among raft nodes before linearized reading' (duration: 267.378013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:50:43.947087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:50:43.510955Z","time spent":"435.985692ms","remote":"127.0.0.1:34446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:50:43.946809Z","caller":"traceutil/trace.go:171","msg":"trace[1751216651] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:778; }","duration":"266.857827ms","start":"2026-04-22T13:50:43.679526Z","end":"2026-04-22T13:50:43.946384Z","steps":["trace[1751216651] 'read index received' (duration: 124.124406ms)","trace[1751216651] 'applied index is now lower than readState.Index' (duration: 142.732171ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:51:02.300393Z","caller":"traceutil/trace.go:171","msg":"trace[1772825514] linearizableReadLoop","detail":"{readStateIndex:977; appliedIndex:974; }","duration":"114.865553ms","start":"2026-04-22T13:51:02.185486Z","end":"2026-04-22T13:51:02.300351Z","steps":["trace[1772825514] 'read index received' (duration: 59.49237ms)","trace[1772825514] 'applied index is now lower than readState.Index' (duration: 55.371463ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:51:02.300622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.100563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/issuers.cert-manager.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:51:02.300729Z","caller":"traceutil/trace.go:171","msg":"trace[436113523] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/issuers.cert-manager.io; range_end:; response_count:0; response_revision:943; }","duration":"115.269449ms","start":"2026-04-22T13:51:02.185438Z","end":"2026-04-22T13:51:02.300707Z","steps":["trace[436113523] 'agreement among raft nodes before linearized reading' (duration: 115.058331ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:02.301503Z","caller":"traceutil/trace.go:171","msg":"trace[1382926874] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"117.584693ms","start":"2026-04-22T13:51:02.183864Z","end":"2026-04-22T13:51:02.301449Z","steps":["trace[1382926874] 'process raft request' (duration: 98.472132ms)","trace[1382926874] 'compare' (duration: 17.883432ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:51:02.863357Z","caller":"traceutil/trace.go:171","msg":"trace[1771707087] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"139.759637ms","start":"2026-04-22T13:51:02.723568Z","end":"2026-04-22T13:51:02.863328Z","steps":["trace[1771707087] 'process raft request' (duration: 139.697164ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:02.863717Z","caller":"traceutil/trace.go:171","msg":"trace[855919656] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"143.043899ms","start":"2026-04-22T13:51:02.720639Z","end":"2026-04-22T13:51:02.863683Z","steps":["trace[855919656] 'process raft request' (duration: 142.488396ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:02.863845Z","caller":"traceutil/trace.go:171","msg":"trace[1104865259] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"142.745138ms","start":"2026-04-22T13:51:02.72105Z","end":"2026-04-22T13:51:02.863795Z","steps":["trace[1104865259] 'process raft request' (duration: 142.160493ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:02.863739Z","caller":"traceutil/trace.go:171","msg":"trace[940827626] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"150.860365ms","start":"2026-04-22T13:51:02.712839Z","end":"2026-04-22T13:51:02.863699Z","steps":["trace[940827626] 'process raft request' (duration: 150.181337ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:02.864066Z","caller":"traceutil/trace.go:171","msg":"trace[1550666780] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"151.361965ms","start":"2026-04-22T13:51:02.712259Z","end":"2026-04-22T13:51:02.863621Z","steps":["trace[1550666780] 'process raft request' (duration: 142.027227ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:02.887814Z","caller":"traceutil/trace.go:171","msg":"trace[482657548] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"100.722182ms","start":"2026-04-22T13:51:02.787076Z","end":"2026-04-22T13:51:02.887798Z","steps":["trace[482657548] 'process raft request' (duration: 100.548745ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:03.148312Z","caller":"traceutil/trace.go:171","msg":"trace[171853326] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1026; }","duration":"119.653967ms","start":"2026-04-22T13:51:03.028634Z","end":"2026-04-22T13:51:03.148288Z","steps":["trace[171853326] 'read index received' (duration: 13.597971ms)","trace[171853326] 'applied index is now lower than readState.Index' (duration: 106.055096ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:51:03.148496Z","caller":"traceutil/trace.go:171","msg":"trace[1916018598] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"121.811653ms","start":"2026-04-22T13:51:03.026635Z","end":"2026-04-22T13:51:03.148446Z","steps":["trace[1916018598] 'process raft request' (duration: 106.030105ms)","trace[1916018598] 'compare' (duration: 15.267048ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:51:03.148798Z","caller":"traceutil/trace.go:171","msg":"trace[771359490] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"116.298033ms","start":"2026-04-22T13:51:03.032484Z","end":"2026-04-22T13:51:03.148782Z","steps":["trace[771359490] 'process raft request' (duration: 115.641857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:51:03.148858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.194018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:1 size:2251"} {"level":"info","ts":"2026-04-22T13:51:03.14891Z","caller":"traceutil/trace.go:171","msg":"trace[1323424447] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:1; response_revision:995; }","duration":"120.286012ms","start":"2026-04-22T13:51:03.028607Z","end":"2026-04-22T13:51:03.148893Z","steps":["trace[1323424447] 'agreement among raft nodes before linearized reading' (duration: 120.044473ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:03.148914Z","caller":"traceutil/trace.go:171","msg":"trace[1591942364] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"120.744351ms","start":"2026-04-22T13:51:03.028135Z","end":"2026-04-22T13:51:03.148879Z","steps":["trace[1591942364] 'process raft request' (duration: 119.943409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:51:03.1491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.841216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:1 size:3944"} {"level":"info","ts":"2026-04-22T13:51:03.149152Z","caller":"traceutil/trace.go:171","msg":"trace[1222589610] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:1; response_revision:995; }","duration":"117.92637ms","start":"2026-04-22T13:51:03.031208Z","end":"2026-04-22T13:51:03.149135Z","steps":["trace[1222589610] 'agreement among raft nodes before linearized reading' (duration: 117.69837ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:03.149318Z","caller":"traceutil/trace.go:171","msg":"trace[825263030] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"107.360528ms","start":"2026-04-22T13:51:03.041821Z","end":"2026-04-22T13:51:03.149181Z","steps":["trace[825263030] 'process raft request' (duration: 106.40086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:51:03.149415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.7289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-04-22T13:51:03.149458Z","caller":"traceutil/trace.go:171","msg":"trace[15583087] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:995; }","duration":"117.779753ms","start":"2026-04-22T13:51:03.031667Z","end":"2026-04-22T13:51:03.149446Z","steps":["trace[15583087] 'agreement among raft nodes before linearized reading' (duration: 117.663648ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:03.38932Z","caller":"traceutil/trace.go:171","msg":"trace[1712432282] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"140.210637ms","start":"2026-04-22T13:51:03.249083Z","end":"2026-04-22T13:51:03.389294Z","steps":["trace[1712432282] 'process raft request' (duration: 140.012479ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:03.410302Z","caller":"traceutil/trace.go:171","msg":"trace[576698837] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"137.014129ms","start":"2026-04-22T13:51:03.273236Z","end":"2026-04-22T13:51:03.410251Z","steps":["trace[576698837] 'process raft request' (duration: 136.552731ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:03.410366Z","caller":"traceutil/trace.go:171","msg":"trace[2112838373] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"132.968699ms","start":"2026-04-22T13:51:03.27735Z","end":"2026-04-22T13:51:03.410318Z","steps":["trace[2112838373] 'process raft request' (duration: 132.703098ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:03.569096Z","caller":"traceutil/trace.go:171","msg":"trace[875383416] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"119.703049ms","start":"2026-04-22T13:51:03.449365Z","end":"2026-04-22T13:51:03.569068Z","steps":["trace[875383416] 'process raft request' (duration: 119.500371ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:03.569099Z","caller":"traceutil/trace.go:171","msg":"trace[1972733511] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"120.022641ms","start":"2026-04-22T13:51:03.449041Z","end":"2026-04-22T13:51:03.569064Z","steps":["trace[1972733511] 'process raft request' (duration: 92.553757ms)","trace[1972733511] 'compare' (duration: 27.11793ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:51:03.984733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.862737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-webhook-548949fc64-8b7nv\" ","response":"range_response_count:1 size:3838"} {"level":"info","ts":"2026-04-22T13:51:03.984824Z","caller":"traceutil/trace.go:171","msg":"trace[819942076] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-webhook-548949fc64-8b7nv; range_end:; response_count:1; response_revision:1043; }","duration":"109.730072ms","start":"2026-04-22T13:51:03.875071Z","end":"2026-04-22T13:51:03.984801Z","steps":["trace[819942076] 'agreement among raft nodes before linearized reading' (duration: 109.515624ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:51:15.173346Z","caller":"traceutil/trace.go:171","msg":"trace[482181024] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"135.097064ms","start":"2026-04-22T13:51:15.03822Z","end":"2026-04-22T13:51:15.173317Z","steps":["trace[482181024] 'process raft request' (duration: 134.928919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:51:15.858045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.792739ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:51:15.858233Z","caller":"traceutil/trace.go:171","msg":"trace[125700177] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1157; }","duration":"340.024767ms","start":"2026-04-22T13:51:15.518183Z","end":"2026-04-22T13:51:15.858207Z","steps":["trace[125700177] 'range keys from in-memory index tree' (duration: 339.755977ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:06.384801Z","caller":"traceutil/trace.go:171","msg":"trace[767257244] linearizableReadLoop","detail":"{readStateIndex:1906; appliedIndex:1905; }","duration":"171.199161ms","start":"2026-04-22T13:52:06.213578Z","end":"2026-04-22T13:52:06.384777Z","steps":["trace[767257244] 'read index received' (duration: 115.515746ms)","trace[767257244] 'applied index is now lower than readState.Index' (duration: 55.682345ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:52:06.384944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.348345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:52:06.384924Z","caller":"traceutil/trace.go:171","msg":"trace[422792124] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"171.945407ms","start":"2026-04-22T13:52:06.212942Z","end":"2026-04-22T13:52:06.384887Z","steps":["trace[422792124] 'process raft request' (duration: 116.16975ms)","trace[422792124] 'compare' (duration: 55.515411ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:06.384976Z","caller":"traceutil/trace.go:171","msg":"trace[72021818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1833; }","duration":"171.430677ms","start":"2026-04-22T13:52:06.213539Z","end":"2026-04-22T13:52:06.38497Z","steps":["trace[72021818] 'agreement among raft nodes before linearized reading' (duration: 171.331015ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:06.390242Z","caller":"traceutil/trace.go:171","msg":"trace[441445221] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"151.232324ms","start":"2026-04-22T13:52:06.238976Z","end":"2026-04-22T13:52:06.390208Z","steps":["trace[441445221] 'process raft request' (duration: 150.360276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.008276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.889317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:52:11.00854Z","caller":"traceutil/trace.go:171","msg":"trace[143631628] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"290.57281ms","start":"2026-04-22T13:52:10.717942Z","end":"2026-04-22T13:52:11.008515Z","steps":["trace[143631628] 'process raft request' (duration: 290.494968ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:11.008508Z","caller":"traceutil/trace.go:171","msg":"trace[1566412898] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"677.55795ms","start":"2026-04-22T13:52:10.330903Z","end":"2026-04-22T13:52:11.008461Z","steps":["trace[1566412898] 'process raft request' (duration: 516.078491ms)","trace[1566412898] 'compare' (duration: 160.623752ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:11.008705Z","caller":"traceutil/trace.go:171","msg":"trace[1898125356] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1937; }","duration":"556.314453ms","start":"2026-04-22T13:52:10.452365Z","end":"2026-04-22T13:52:11.00868Z","steps":["trace[1898125356] 'read index received' (duration: 394.695192ms)","trace[1898125356] 'applied index is now lower than readState.Index' (duration: 161.617121ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:52:11.008755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:10.330879Z","time spent":"677.741904ms","remote":"127.0.0.1:34212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:52:11.008954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.580868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a8b2251a802990\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-04-22T13:52:11.008992Z","caller":"traceutil/trace.go:171","msg":"trace[1324999184] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a8b2251a802990; range_end:; response_count:1; response_revision:1865; }","duration":"556.67362ms","start":"2026-04-22T13:52:10.452307Z","end":"2026-04-22T13:52:11.008981Z","steps":["trace[1324999184] 'agreement among raft nodes before linearized reading' (duration: 556.484316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.009016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:10.452251Z","time spent":"556.759831ms","remote":"127.0.0.1:34254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1005,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a8b2251a802990\" "} {"level":"info","ts":"2026-04-22T13:52:11.020153Z","caller":"traceutil/trace.go:171","msg":"trace[791288412] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"145.219296ms","start":"2026-04-22T13:52:10.874914Z","end":"2026-04-22T13:52:11.020134Z","steps":["trace[791288412] 'process raft request' (duration: 144.981092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.020533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.046122ms","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-04-22T13:52:11.020594Z","caller":"traceutil/trace.go:171","msg":"trace[2030900671] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"132.512836ms","start":"2026-04-22T13:52:10.888064Z","end":"2026-04-22T13:52:11.020576Z","steps":["trace[2030900671] 'process raft request' (duration: 131.997646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.020693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.060777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T13:52:11.020729Z","caller":"traceutil/trace.go:171","msg":"trace[1708544026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1867; }","duration":"132.148349ms","start":"2026-04-22T13:52:10.888572Z","end":"2026-04-22T13:52:11.020721Z","steps":["trace[1708544026] 'agreement among raft nodes before linearized reading' (duration: 132.052107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.020838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.100969ms","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-04-22T13:52:11.020877Z","caller":"traceutil/trace.go:171","msg":"trace[188803047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1867; }","duration":"129.170329ms","start":"2026-04-22T13:52:10.891696Z","end":"2026-04-22T13:52:11.020866Z","steps":["trace[188803047] 'agreement among raft nodes before linearized reading' (duration: 129.071258ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:11.020594Z","caller":"traceutil/trace.go:171","msg":"trace[161071563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1867; }","duration":"276.163114ms","start":"2026-04-22T13:52:10.744417Z","end":"2026-04-22T13:52:11.02058Z","steps":["trace[161071563] 'agreement among raft nodes before linearized reading' (duration: 275.997771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.020539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.14962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-22T13:52:11.021017Z","caller":"traceutil/trace.go:171","msg":"trace[1588935347] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1867; }","duration":"129.69179ms","start":"2026-04-22T13:52:10.891314Z","end":"2026-04-22T13:52:11.021006Z","steps":["trace[1588935347] 'agreement among raft nodes before linearized reading' (duration: 129.086728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.021103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.055208ms","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-04-22T13:52:11.021208Z","caller":"traceutil/trace.go:171","msg":"trace[1170710771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1867; }","duration":"127.318984ms","start":"2026-04-22T13:52:10.893832Z","end":"2026-04-22T13:52:11.021151Z","steps":["trace[1170710771] 'agreement among raft nodes before linearized reading' (duration: 126.850794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.021384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.812355ms","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-04-22T13:52:11.021456Z","caller":"traceutil/trace.go:171","msg":"trace[1977275083] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1867; }","duration":"412.935438ms","start":"2026-04-22T13:52:10.608511Z","end":"2026-04-22T13:52:11.021446Z","steps":["trace[1977275083] 'agreement among raft nodes before linearized reading' (duration: 412.806585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.021502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:10.608484Z","time spent":"413.005999ms","remote":"127.0.0.1:34472","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-04-22T13:52:11.021574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.926384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85799aad-d3af-4b78-a4d6-7bd25f54fe97\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-04-22T13:52:11.021626Z","caller":"traceutil/trace.go:171","msg":"trace[827824841] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-85799aad-d3af-4b78-a4d6-7bd25f54fe97; range_end:; response_count:1; response_revision:1867; }","duration":"521.056156ms","start":"2026-04-22T13:52:10.500558Z","end":"2026-04-22T13:52:11.021615Z","steps":["trace[827824841] 'agreement among raft nodes before linearized reading' (duration: 520.923903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.021664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:10.500533Z","time spent":"521.122528ms","remote":"127.0.0.1:34382","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-85799aad-d3af-4b78-a4d6-7bd25f54fe97\" "} {"level":"info","ts":"2026-04-22T13:52:11.227749Z","caller":"traceutil/trace.go:171","msg":"trace[787578216] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"207.363378ms","start":"2026-04-22T13:52:11.020352Z","end":"2026-04-22T13:52:11.227716Z","steps":["trace[787578216] 'read index received' (duration: 165.501731ms)","trace[787578216] 'applied index is now lower than readState.Index' (duration: 41.860367ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:11.227926Z","caller":"traceutil/trace.go:171","msg":"trace[68086498] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"216.305002ms","start":"2026-04-22T13:52:11.011574Z","end":"2026-04-22T13:52:11.227879Z","steps":["trace[68086498] 'process raft request' (duration: 174.266251ms)","trace[68086498] 'compare' (duration: 41.632633ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:52:11.228212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.564168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:420"} {"level":"info","ts":"2026-04-22T13:52:11.228265Z","caller":"traceutil/trace.go:171","msg":"trace[1422316494] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1868; }","duration":"216.68898ms","start":"2026-04-22T13:52:11.011563Z","end":"2026-04-22T13:52:11.228252Z","steps":["trace[1422316494] 'agreement among raft nodes before linearized reading' (duration: 216.329853ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:11.554808Z","caller":"traceutil/trace.go:171","msg":"trace[1552716754] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"529.14393ms","start":"2026-04-22T13:52:11.025627Z","end":"2026-04-22T13:52:11.554771Z","steps":["trace[1552716754] 'process raft request' (duration: 497.404991ms)","trace[1552716754] 'compare' (duration: 30.553766ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:11.55504Z","caller":"traceutil/trace.go:171","msg":"trace[741557408] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"529.331173ms","start":"2026-04-22T13:52:11.025674Z","end":"2026-04-22T13:52:11.555005Z","steps":["trace[741557408] 'process raft request' (duration: 528.944056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.555298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:11.025654Z","time spent":"529.484607ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:52:11.555472Z","caller":"traceutil/trace.go:171","msg":"trace[1400737411] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"529.544618ms","start":"2026-04-22T13:52:11.025891Z","end":"2026-04-22T13:52:11.555435Z","steps":["trace[1400737411] 'process raft request' (duration: 529.256432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.555656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:11.025852Z","time spent":"529.704521ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:52:11.555738Z","caller":"traceutil/trace.go:171","msg":"trace[698821756] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"529.825503ms","start":"2026-04-22T13:52:11.025889Z","end":"2026-04-22T13:52:11.555715Z","steps":["trace[698821756] 'process raft request' (duration: 528.842414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.555899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:11.025872Z","time spent":"529.974367ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:52:11.556081Z","caller":"traceutil/trace.go:171","msg":"trace[1763521614] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1942; }","duration":"328.202737ms","start":"2026-04-22T13:52:11.22786Z","end":"2026-04-22T13:52:11.556063Z","steps":["trace[1763521614] 'read index received' (duration: 295.267635ms)","trace[1763521614] 'applied index is now lower than readState.Index' (duration: 32.932322ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:52:11.556351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:11.025605Z","time spent":"529.452487ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:52:11.556523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.452406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:52:11.556575Z","caller":"traceutil/trace.go:171","msg":"trace[754943496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1874; }","duration":"342.539698ms","start":"2026-04-22T13:52:11.214021Z","end":"2026-04-22T13:52:11.556561Z","steps":["trace[754943496] 'agreement among raft nodes before linearized reading' (duration: 342.461627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.556614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:11.214Z","time spent":"342.607979ms","remote":"127.0.0.1:34178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T13:52:11.55687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.491668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:10328"} {"level":"info","ts":"2026-04-22T13:52:11.556965Z","caller":"traceutil/trace.go:171","msg":"trace[1956241557] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1874; }","duration":"361.672181ms","start":"2026-04-22T13:52:11.195272Z","end":"2026-04-22T13:52:11.556944Z","steps":["trace[1956241557] 'agreement among raft nodes before linearized reading' (duration: 361.308624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.55701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:11.195238Z","time spent":"361.763553ms","remote":"127.0.0.1:34382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":10351,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-22T13:52:11.556996Z","caller":"traceutil/trace.go:171","msg":"trace[1629543050] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"530.076899ms","start":"2026-04-22T13:52:11.025921Z","end":"2026-04-22T13:52:11.555998Z","steps":["trace[1629543050] 'process raft request' (duration: 529.274223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.557109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:11.025899Z","time spent":"531.1463ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:52:11.557196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.589146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-04-22T13:52:11.55725Z","caller":"traceutil/trace.go:171","msg":"trace[1927023350] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1874; }","duration":"326.680058ms","start":"2026-04-22T13:52:11.230559Z","end":"2026-04-22T13:52:11.557239Z","steps":["trace[1927023350] 'agreement among raft nodes before linearized reading' (duration: 326.532666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:11.5573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:11.230533Z","time spent":"326.759109ms","remote":"127.0.0.1:34212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-04-22T13:52:11.875353Z","caller":"traceutil/trace.go:171","msg":"trace[193696983] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"107.763913ms","start":"2026-04-22T13:52:11.767525Z","end":"2026-04-22T13:52:11.875289Z","steps":["trace[193696983] 'process raft request' (duration: 33.662957ms)","trace[193696983] 'compare' (duration: 73.881422ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:19.364512Z","caller":"traceutil/trace.go:171","msg":"trace[1619313327] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"301.420836ms","start":"2026-04-22T13:52:19.063057Z","end":"2026-04-22T13:52:19.364477Z","steps":["trace[1619313327] 'process raft request' (duration: 301.196562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.364756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:19.063019Z","time spent":"301.61475ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:52:19.819205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.925464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:52:19.819568Z","caller":"traceutil/trace.go:171","msg":"trace[1376502288] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"739.607941ms","start":"2026-04-22T13:52:19.079911Z","end":"2026-04-22T13:52:19.819519Z","steps":["trace[1376502288] 'process raft request' (duration: 390.281751ms)","trace[1376502288] 'compare' (duration: 348.780901ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:19.819697Z","caller":"traceutil/trace.go:171","msg":"trace[246609116] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"739.200183ms","start":"2026-04-22T13:52:19.080486Z","end":"2026-04-22T13:52:19.819686Z","steps":["trace[246609116] 'process raft request' (duration: 738.820057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.819938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:19.07988Z","time spent":"739.798444ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:52:19.81997Z","caller":"traceutil/trace.go:171","msg":"trace[1544159318] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"205.87875ms","start":"2026-04-22T13:52:19.614061Z","end":"2026-04-22T13:52:19.81994Z","steps":["trace[1544159318] 'process raft request' (duration: 205.497253ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:19.819618Z","caller":"traceutil/trace.go:171","msg":"trace[1157824468] linearizableReadLoop","detail":"{readStateIndex:2018; appliedIndex:2015; }","duration":"730.78119ms","start":"2026-04-22T13:52:19.088816Z","end":"2026-04-22T13:52:19.819597Z","steps":["trace[1157824468] 'read index received' (duration: 275.408072ms)","trace[1157824468] 'applied index is now lower than readState.Index' (duration: 455.371908ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:52:19.819961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:19.080449Z","time spent":"739.432508ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:52:19.820229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.355892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-22T13:52:19.820326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.582853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-22T13:52:19.820338Z","caller":"traceutil/trace.go:171","msg":"trace[17619228] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1943; }","duration":"731.514675ms","start":"2026-04-22T13:52:19.0888Z","end":"2026-04-22T13:52:19.820315Z","steps":["trace[17619228] 'agreement among raft nodes before linearized reading' (duration: 730.852032ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:19.820419Z","caller":"traceutil/trace.go:171","msg":"trace[812886442] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1943; }","duration":"697.704425ms","start":"2026-04-22T13:52:19.122695Z","end":"2026-04-22T13:52:19.820399Z","steps":["trace[812886442] 'agreement among raft nodes before linearized reading' (duration: 697.503172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.820439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.549067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-22T13:52:19.820463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.394704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-22T13:52:19.820423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:19.088742Z","time spent":"731.665707ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-22T13:52:19.820526Z","caller":"traceutil/trace.go:171","msg":"trace[1035405137] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1943; }","duration":"158.523866ms","start":"2026-04-22T13:52:19.661987Z","end":"2026-04-22T13:52:19.820511Z","steps":["trace[1035405137] 'agreement among raft nodes before linearized reading' (duration: 158.303342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.820554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.597719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:52:19.820477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:19.122684Z","time spent":"697.778876ms","remote":"127.0.0.1:34358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-22T13:52:19.820653Z","caller":"traceutil/trace.go:171","msg":"trace[1764448428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1943; }","duration":"273.68411ms","start":"2026-04-22T13:52:19.546908Z","end":"2026-04-22T13:52:19.820592Z","steps":["trace[1764448428] 'agreement among raft nodes before linearized reading' (duration: 273.609688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.820588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.748226ms","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-04-22T13:52:19.820706Z","caller":"traceutil/trace.go:171","msg":"trace[632828291] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1943; }","duration":"189.886998ms","start":"2026-04-22T13:52:19.630806Z","end":"2026-04-22T13:52:19.820693Z","steps":["trace[632828291] 'agreement among raft nodes before linearized reading' (duration: 189.715905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.820728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.847657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T13:52:19.82078Z","caller":"traceutil/trace.go:171","msg":"trace[262913324] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1943; }","duration":"542.932459ms","start":"2026-04-22T13:52:19.277836Z","end":"2026-04-22T13:52:19.820769Z","steps":["trace[262913324] 'agreement among raft nodes before linearized reading' (duration: 542.846777ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:19.820476Z","caller":"traceutil/trace.go:171","msg":"trace[874557433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1943; }","duration":"158.593567ms","start":"2026-04-22T13:52:19.66187Z","end":"2026-04-22T13:52:19.820463Z","steps":["trace[874557433] 'agreement among raft nodes before linearized reading' (duration: 158.516626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.820829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:19.27782Z","time spent":"542.9932ms","remote":"127.0.0.1:34300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":9,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-22T13:52:19.820358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.479293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T13:52:19.820869Z","caller":"traceutil/trace.go:171","msg":"trace[217243648] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1943; }","duration":"160.046163ms","start":"2026-04-22T13:52:19.660815Z","end":"2026-04-22T13:52:19.820861Z","steps":["trace[217243648] 'agreement among raft nodes before linearized reading' (duration: 159.428942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.820795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.599329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:52:19.821025Z","caller":"traceutil/trace.go:171","msg":"trace[587830323] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1943; }","duration":"232.900575ms","start":"2026-04-22T13:52:19.588085Z","end":"2026-04-22T13:52:19.820985Z","steps":["trace[587830323] 'agreement among raft nodes before linearized reading' (duration: 232.288094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:19.821039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.024115ms","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-04-22T13:52:19.821177Z","caller":"traceutil/trace.go:171","msg":"trace[1525386242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1943; }","duration":"159.167998ms","start":"2026-04-22T13:52:19.66199Z","end":"2026-04-22T13:52:19.821158Z","steps":["trace[1525386242] 'agreement among raft nodes before linearized reading' (duration: 158.303692ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:19.995411Z","caller":"traceutil/trace.go:171","msg":"trace[469824122] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"168.776023ms","start":"2026-04-22T13:52:19.826579Z","end":"2026-04-22T13:52:19.995355Z","steps":["trace[469824122] 'process raft request' (duration: 168.505388ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:19.995637Z","caller":"traceutil/trace.go:171","msg":"trace[1695998310] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"168.894025ms","start":"2026-04-22T13:52:19.826706Z","end":"2026-04-22T13:52:19.9956Z","steps":["trace[1695998310] 'process raft request' (duration: 168.572079ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:19.996197Z","caller":"traceutil/trace.go:171","msg":"trace[208411530] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"169.19059ms","start":"2026-04-22T13:52:19.826972Z","end":"2026-04-22T13:52:19.996162Z","steps":["trace[208411530] 'process raft request' (duration: 169.068668ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:19.996353Z","caller":"traceutil/trace.go:171","msg":"trace[431773077] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"169.500795ms","start":"2026-04-22T13:52:19.826836Z","end":"2026-04-22T13:52:19.996336Z","steps":["trace[431773077] 'process raft request' (duration: 168.801033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:20.354266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.009606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:52:20.354398Z","caller":"traceutil/trace.go:171","msg":"trace[641776724] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"116.803177ms","start":"2026-04-22T13:52:20.237577Z","end":"2026-04-22T13:52:20.35438Z","steps":["trace[641776724] 'compare' (duration: 108.804262ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:28.896917Z","caller":"traceutil/trace.go:171","msg":"trace[273076608] transaction","detail":"{read_only:false; response_revision:2008; number_of_response:1; }","duration":"333.651053ms","start":"2026-04-22T13:52:28.563235Z","end":"2026-04-22T13:52:28.896887Z","steps":["trace[273076608] 'process raft request' (duration: 333.43235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:28.897094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:28.563209Z","time spent":"333.797745ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:52:44.306532Z","caller":"traceutil/trace.go:171","msg":"trace[706597883] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"125.575722ms","start":"2026-04-22T13:52:44.180883Z","end":"2026-04-22T13:52:44.306459Z","steps":["trace[706597883] 'process raft request' (duration: 125.330618ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:44.306639Z","caller":"traceutil/trace.go:171","msg":"trace[1527706934] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"125.726794ms","start":"2026-04-22T13:52:44.180881Z","end":"2026-04-22T13:52:44.306608Z","steps":["trace[1527706934] 'process raft request' (duration: 125.518911ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:44.314008Z","caller":"traceutil/trace.go:171","msg":"trace[1924459973] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2183; }","duration":"120.206131ms","start":"2026-04-22T13:52:44.193789Z","end":"2026-04-22T13:52:44.313995Z","steps":["trace[1924459973] 'read index received' (duration: 112.316871ms)","trace[1924459973] 'applied index is now lower than readState.Index' (duration: 7.88862ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:44.31411Z","caller":"traceutil/trace.go:171","msg":"trace[642562998] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"132.853813ms","start":"2026-04-22T13:52:44.181209Z","end":"2026-04-22T13:52:44.314062Z","steps":["trace[642562998] 'process raft request' (duration: 132.715571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:44.314249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.256407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:52:44.314347Z","caller":"traceutil/trace.go:171","msg":"trace[1429489064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2105; }","duration":"100.398979ms","start":"2026-04-22T13:52:44.213927Z","end":"2026-04-22T13:52:44.314326Z","steps":["trace[1429489064] 'agreement among raft nodes before linearized reading' (duration: 100.207466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:44.314416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.580416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-22T13:52:44.314465Z","caller":"traceutil/trace.go:171","msg":"trace[457306188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2105; }","duration":"120.693398ms","start":"2026-04-22T13:52:44.193758Z","end":"2026-04-22T13:52:44.314451Z","steps":["trace[457306188] 'agreement among raft nodes before linearized reading' (duration: 120.323942ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:44.51013Z","caller":"traceutil/trace.go:171","msg":"trace[439411819] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"190.559742ms","start":"2026-04-22T13:52:44.319538Z","end":"2026-04-22T13:52:44.510098Z","steps":["trace[439411819] 'process raft request' (duration: 190.39968ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:45.609496Z","caller":"traceutil/trace.go:171","msg":"trace[568542711] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"105.403555ms","start":"2026-04-22T13:52:45.504056Z","end":"2026-04-22T13:52:45.609459Z","steps":["trace[568542711] 'process raft request' (duration: 105.186241ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:52:46.17499Z","caller":"traceutil/trace.go:171","msg":"trace[1539540198] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"200.832722ms","start":"2026-04-22T13:52:45.974132Z","end":"2026-04-22T13:52:46.174965Z","steps":["trace[1539540198] 'process raft request' (duration: 185.838837ms)","trace[1539540198] 'compare' (duration: 14.475397ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:46.217432Z","caller":"traceutil/trace.go:171","msg":"trace[1787799962] linearizableReadLoop","detail":"{readStateIndex:2193; appliedIndex:2191; }","duration":"189.623071ms","start":"2026-04-22T13:52:46.027734Z","end":"2026-04-22T13:52:46.217357Z","steps":["trace[1787799962] 'read index received' (duration: 132.253018ms)","trace[1787799962] 'applied index is now lower than readState.Index' (duration: 57.368443ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:46.217473Z","caller":"traceutil/trace.go:171","msg":"trace[2142467303] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"241.754308ms","start":"2026-04-22T13:52:45.975695Z","end":"2026-04-22T13:52:46.217449Z","steps":["trace[2142467303] 'process raft request' (duration: 241.508854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:46.217694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.940055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-22T13:52:46.217738Z","caller":"traceutil/trace.go:171","msg":"trace[2046328543] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2111; }","duration":"190.058457ms","start":"2026-04-22T13:52:46.027664Z","end":"2026-04-22T13:52:46.217723Z","steps":["trace[2046328543] 'agreement among raft nodes before linearized reading' (duration: 189.879415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:46.218097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.799285ms","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-04-22T13:52:46.218181Z","caller":"traceutil/trace.go:171","msg":"trace[1323200798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2111; }","duration":"106.937158ms","start":"2026-04-22T13:52:46.111227Z","end":"2026-04-22T13:52:46.218164Z","steps":["trace[1323200798] 'agreement among raft nodes before linearized reading' (duration: 106.701064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:46.997599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.416002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12384"} {"level":"info","ts":"2026-04-22T13:52:46.997668Z","caller":"traceutil/trace.go:171","msg":"trace[1065247288] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2115; }","duration":"196.497183ms","start":"2026-04-22T13:52:46.801155Z","end":"2026-04-22T13:52:46.997652Z","steps":["trace[1065247288] 'range keys from in-memory index tree' (duration: 196.177249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:46.997944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.474827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-22T13:52:46.998007Z","caller":"traceutil/trace.go:171","msg":"trace[946144714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2115; }","duration":"483.585548ms","start":"2026-04-22T13:52:46.514408Z","end":"2026-04-22T13:52:46.997994Z","steps":["trace[946144714] 'range keys from in-memory index tree' (duration: 483.192743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:46.998042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:46.514383Z","time spent":"483.65262ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-22T13:52:47.499844Z","caller":"traceutil/trace.go:171","msg":"trace[515143060] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"497.834725ms","start":"2026-04-22T13:52:47.001982Z","end":"2026-04-22T13:52:47.499816Z","steps":["trace[515143060] 'process raft request' (duration: 497.575362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:47.500007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.791331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:52:47.500081Z","caller":"traceutil/trace.go:171","msg":"trace[491142337] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2116; }","duration":"492.923223ms","start":"2026-04-22T13:52:47.00714Z","end":"2026-04-22T13:52:47.500064Z","steps":["trace[491142337] 'agreement among raft nodes before linearized reading' (duration: 492.776671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:47.500186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:47.00712Z","time spent":"493.030724ms","remote":"127.0.0.1:34666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-22T13:52:47.500419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:47.001953Z","time spent":"498.229962ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:52:47.499818Z","caller":"traceutil/trace.go:171","msg":"trace[1886882875] linearizableReadLoop","detail":"{readStateIndex:2198; appliedIndex:2197; }","duration":"492.592838ms","start":"2026-04-22T13:52:47.007188Z","end":"2026-04-22T13:52:47.499781Z","steps":["trace[1886882875] 'read index received' (duration: 492.399355ms)","trace[1886882875] 'applied index is now lower than readState.Index' (duration: 157.762µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:47.70352Z","caller":"traceutil/trace.go:171","msg":"trace[1373095743] linearizableReadLoop","detail":"{readStateIndex:2199; appliedIndex:2198; }","duration":"202.826419ms","start":"2026-04-22T13:52:47.500657Z","end":"2026-04-22T13:52:47.703483Z","steps":["trace[1373095743] 'read index received' (duration: 196.410754ms)","trace[1373095743] 'applied index is now lower than readState.Index' (duration: 6.414635ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:52:47.703905Z","caller":"traceutil/trace.go:171","msg":"trace[1962563335] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"585.838951ms","start":"2026-04-22T13:52:47.11805Z","end":"2026-04-22T13:52:47.703889Z","steps":["trace[1962563335] 'process raft request' (duration: 578.931199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:47.704092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.271404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:52:47.704256Z","caller":"traceutil/trace.go:171","msg":"trace[902612348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2118; }","duration":"490.481286ms","start":"2026-04-22T13:52:47.213762Z","end":"2026-04-22T13:52:47.704244Z","steps":["trace[902612348] 'agreement among raft nodes before linearized reading' (duration: 490.266793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:47.704151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.766801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-22T13:52:47.704392Z","caller":"traceutil/trace.go:171","msg":"trace[91244336] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2118; }","duration":"479.073326ms","start":"2026-04-22T13:52:47.225298Z","end":"2026-04-22T13:52:47.704372Z","steps":["trace[91244336] 'agreement among raft nodes before linearized reading' (duration: 478.64837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:47.704439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:47.225271Z","time spent":"479.157367ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-22T13:52:47.704323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:47.213745Z","time spent":"490.570468ms","remote":"127.0.0.1:34178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T13:52:47.704525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.700083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:52:47.704628Z","caller":"traceutil/trace.go:171","msg":"trace[794349661] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2118; }","duration":"199.862984ms","start":"2026-04-22T13:52:47.504741Z","end":"2026-04-22T13:52:47.704604Z","steps":["trace[794349661] 'agreement among raft nodes before linearized reading' (duration: 199.689602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:52:47.704652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:52:47.118019Z","time spent":"585.964372ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:54:27.122461Z","caller":"traceutil/trace.go:171","msg":"trace[1983941289] linearizableReadLoop","detail":"{readStateIndex:2848; appliedIndex:2847; }","duration":"109.472214ms","start":"2026-04-22T13:54:27.01297Z","end":"2026-04-22T13:54:27.122443Z","steps":["trace[1983941289] 'read index received' (duration: 109.325032ms)","trace[1983941289] 'applied index is now lower than readState.Index' (duration: 146.562µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:54:27.122666Z","caller":"traceutil/trace.go:171","msg":"trace[1502288987] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"149.674954ms","start":"2026-04-22T13:54:26.972983Z","end":"2026-04-22T13:54:27.122658Z","steps":["trace[1502288987] 'process raft request' (duration: 149.363641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:54:27.122875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.900348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T13:54:27.122904Z","caller":"traceutil/trace.go:171","msg":"trace[2083235327] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2743; }","duration":"109.983108ms","start":"2026-04-22T13:54:27.012915Z","end":"2026-04-22T13:54:27.122898Z","steps":["trace[2083235327] 'agreement among raft nodes before linearized reading' (duration: 109.881037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:54:27.123023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.832706ms","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-04-22T13:54:27.123049Z","caller":"traceutil/trace.go:171","msg":"trace[65383052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2743; }","duration":"105.890368ms","start":"2026-04-22T13:54:27.017152Z","end":"2026-04-22T13:54:27.123042Z","steps":["trace[65383052] 'agreement among raft nodes before linearized reading' (duration: 105.832097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:54:58.983682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.759968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:54:58.983822Z","caller":"traceutil/trace.go:171","msg":"trace[1825811000] transaction","detail":"{read_only:false; response_revision:2918; number_of_response:1; }","duration":"429.877775ms","start":"2026-04-22T13:54:58.553923Z","end":"2026-04-22T13:54:58.983801Z","steps":["trace[1825811000] 'process raft request' (duration: 208.913845ms)","trace[1825811000] 'compare' (duration: 220.220351ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:54:58.983887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:54:58.553897Z","time spent":"429.959697ms","remote":"127.0.0.1:34372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9334,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:54:59.000176Z","caller":"traceutil/trace.go:171","msg":"trace[1991855774] linearizableReadLoop","detail":"{readStateIndex:3030; appliedIndex:3028; }","duration":"297.610253ms","start":"2026-04-22T13:54:58.702539Z","end":"2026-04-22T13:54:59.000149Z","steps":["trace[1991855774] 'read index received' (duration: 60.314116ms)","trace[1991855774] 'applied index is now lower than readState.Index' (duration: 237.294437ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:54:59.000793Z","caller":"traceutil/trace.go:171","msg":"trace[992508993] transaction","detail":"{read_only:false; response_revision:2919; number_of_response:1; }","duration":"307.925856ms","start":"2026-04-22T13:54:58.692847Z","end":"2026-04-22T13:54:59.000773Z","steps":["trace[992508993] 'process raft request' (duration: 306.988095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:54:59.000922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:54:58.692823Z","time spent":"308.007138ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:54:59.001191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.649676ms","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-04-22T13:54:59.001228Z","caller":"traceutil/trace.go:171","msg":"trace[1416580012] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2919; }","duration":"298.739678ms","start":"2026-04-22T13:54:58.702479Z","end":"2026-04-22T13:54:59.001219Z","steps":["trace[1416580012] 'agreement among raft nodes before linearized reading' (duration: 298.604546ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:54:59.00895Z","caller":"traceutil/trace.go:171","msg":"trace[1497557393] transaction","detail":"{read_only:false; response_revision:2920; number_of_response:1; }","duration":"246.003304ms","start":"2026-04-22T13:54:58.762916Z","end":"2026-04-22T13:54:59.00892Z","steps":["trace[1497557393] 'process raft request' (duration: 245.705116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:54:59.401826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.18159ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:54:59.401974Z","caller":"traceutil/trace.go:171","msg":"trace[2036818863] linearizableReadLoop","detail":"{readStateIndex:3033; appliedIndex:3032; }","duration":"190.417165ms","start":"2026-04-22T13:54:59.211534Z","end":"2026-04-22T13:54:59.401952Z","steps":["trace[2036818863] 'read index received' (duration: 81.252µs)","trace[2036818863] 'applied index is now lower than readState.Index' (duration: 190.333663ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:54:59.40216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.629832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:54:59.402203Z","caller":"traceutil/trace.go:171","msg":"trace[423856771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2922; }","duration":"190.719764ms","start":"2026-04-22T13:54:59.211467Z","end":"2026-04-22T13:54:59.402187Z","steps":["trace[423856771] 'agreement among raft nodes before linearized reading' (duration: 190.632202ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:54:59.402024Z","caller":"traceutil/trace.go:171","msg":"trace[1053492113] transaction","detail":"{read_only:false; response_revision:2922; number_of_response:1; }","duration":"359.222893ms","start":"2026-04-22T13:54:59.042769Z","end":"2026-04-22T13:54:59.401992Z","steps":["trace[1053492113] 'process raft request' (duration: 164.722873ms)","trace[1053492113] 'compare' (duration: 193.474898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:54:59.40287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:54:59.042729Z","time spent":"360.009046ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:54:59.403077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.508098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:54:59.403131Z","caller":"traceutil/trace.go:171","msg":"trace[172324412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2922; }","duration":"189.607502ms","start":"2026-04-22T13:54:59.213512Z","end":"2026-04-22T13:54:59.403119Z","steps":["trace[172324412] 'agreement among raft nodes before linearized reading' (duration: 189.52528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.748797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.107676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:59:09.749446Z","caller":"traceutil/trace.go:171","msg":"trace[1370261227] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"248.288807ms","start":"2026-04-22T13:59:09.501111Z","end":"2026-04-22T13:59:09.7494Z","steps":["trace[1370261227] 'process raft request' (duration: 47.413281ms)","trace[1370261227] 'compare' (duration: 199.872613ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:09.750036Z","caller":"traceutil/trace.go:171","msg":"trace[609597660] linearizableReadLoop","detail":"{readStateIndex:5162; appliedIndex:5160; }","duration":"241.490671ms","start":"2026-04-22T13:59:09.50843Z","end":"2026-04-22T13:59:09.74992Z","steps":["trace[609597660] 'read index received' (duration: 40.097158ms)","trace[609597660] 'applied index is now lower than readState.Index' (duration: 201.392343ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:09.750063Z","caller":"traceutil/trace.go:171","msg":"trace[413766348] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"242.036639ms","start":"2026-04-22T13:59:09.507985Z","end":"2026-04-22T13:59:09.750021Z","steps":["trace[413766348] 'process raft request' (duration: 241.810486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.750432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.981578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60778"} {"level":"info","ts":"2026-04-22T13:59:09.750516Z","caller":"traceutil/trace.go:171","msg":"trace[65750058] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4969; }","duration":"242.1127ms","start":"2026-04-22T13:59:09.508387Z","end":"2026-04-22T13:59:09.750499Z","steps":["trace[65750058] 'agreement among raft nodes before linearized reading' (duration: 241.751705ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:09.967786Z","caller":"traceutil/trace.go:171","msg":"trace[1522163565] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"196.427985ms","start":"2026-04-22T13:59:09.771308Z","end":"2026-04-22T13:59:09.967736Z","steps":["trace[1522163565] 'process raft request' (duration: 196.382554ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:09.96784Z","caller":"traceutil/trace.go:171","msg":"trace[957916045] linearizableReadLoop","detail":"{readStateIndex:5163; appliedIndex:5162; }","duration":"217.708221ms","start":"2026-04-22T13:59:09.750111Z","end":"2026-04-22T13:59:09.967819Z","steps":["trace[957916045] 'read index received' (duration: 135.945113ms)","trace[957916045] 'applied index is now lower than readState.Index' (duration: 81.761108ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:09.96803Z","caller":"traceutil/trace.go:171","msg":"trace[571821712] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"210.274237ms","start":"2026-04-22T13:59:09.757748Z","end":"2026-04-22T13:59:09.968023Z","steps":["trace[571821712] 'process raft request' (duration: 209.808391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.968082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.363955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-22T13:59:09.968122Z","caller":"traceutil/trace.go:171","msg":"trace[948378245] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4974; }","duration":"459.456516ms","start":"2026-04-22T13:59:09.508651Z","end":"2026-04-22T13:59:09.968108Z","steps":["trace[948378245] 'agreement among raft nodes before linearized reading' (duration: 459.242973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.968166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:09.508644Z","time spent":"459.511617ms","remote":"127.0.0.1:34596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1147,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"info","ts":"2026-04-22T13:59:09.9682Z","caller":"traceutil/trace.go:171","msg":"trace[571194939] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"210.087674ms","start":"2026-04-22T13:59:09.758103Z","end":"2026-04-22T13:59:09.968191Z","steps":["trace[571194939] 'process raft request' (duration: 209.506816ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:09.968364Z","caller":"traceutil/trace.go:171","msg":"trace[2037775818] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"206.185681ms","start":"2026-04-22T13:59:09.762171Z","end":"2026-04-22T13:59:09.968356Z","steps":["trace[2037775818] 'process raft request' (duration: 205.478182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.968382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.833261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T13:59:09.968412Z","caller":"traceutil/trace.go:171","msg":"trace[1724899304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4974; }","duration":"283.920572ms","start":"2026-04-22T13:59:09.684482Z","end":"2026-04-22T13:59:09.968402Z","steps":["trace[1724899304] 'agreement among raft nodes before linearized reading' (duration: 283.834031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.96865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.715009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:59:09.968745Z","caller":"traceutil/trace.go:171","msg":"trace[1596938637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4974; }","duration":"423.87912ms","start":"2026-04-22T13:59:09.544843Z","end":"2026-04-22T13:59:09.968722Z","steps":["trace[1596938637] 'agreement among raft nodes before linearized reading' (duration: 423.705498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.968793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:09.544819Z","time spent":"423.966462ms","remote":"127.0.0.1:34178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T13:59:09.969297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.791013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-22T13:59:09.969342Z","caller":"traceutil/trace.go:171","msg":"trace[999484778] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4974; }","duration":"396.867835ms","start":"2026-04-22T13:59:09.572461Z","end":"2026-04-22T13:59:09.969329Z","steps":["trace[999484778] 'agreement among raft nodes before linearized reading' (duration: 396.489619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.969374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:09.572437Z","time spent":"396.929255ms","remote":"127.0.0.1:34254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":452,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-22T13:59:09.969979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.02537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194887"} {"level":"info","ts":"2026-04-22T13:59:09.970035Z","caller":"traceutil/trace.go:171","msg":"trace[591144884] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4974; }","duration":"311.112241ms","start":"2026-04-22T13:59:09.65891Z","end":"2026-04-22T13:59:09.970022Z","steps":["trace[591144884] 'agreement among raft nodes before linearized reading' (duration: 310.098026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:09.970075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:09.658888Z","time spent":"311.178461ms","remote":"127.0.0.1:34286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2194910,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-04-22T13:59:09.972987Z","caller":"traceutil/trace.go:171","msg":"trace[1919068078] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"226.828297ms","start":"2026-04-22T13:59:09.74611Z","end":"2026-04-22T13:59:09.972938Z","steps":["trace[1919068078] 'process raft request' (duration: 139.870487ms)","trace[1919068078] 'compare' (duration: 81.408563ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:10.436836Z","caller":"traceutil/trace.go:171","msg":"trace[1189272628] transaction","detail":"{read_only:false; response_revision:4987; number_of_response:1; }","duration":"309.778896ms","start":"2026-04-22T13:59:10.127034Z","end":"2026-04-22T13:59:10.436813Z","steps":["trace[1189272628] 'process raft request' (duration: 309.551193ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:10.43688Z","caller":"traceutil/trace.go:171","msg":"trace[131050343] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"295.455776ms","start":"2026-04-22T13:59:10.141406Z","end":"2026-04-22T13:59:10.436862Z","steps":["trace[131050343] 'process raft request' (duration: 295.350165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.436968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:10.127023Z","time spent":"309.874397ms","remote":"127.0.0.1:34358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1436,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:59:10.436994Z","caller":"traceutil/trace.go:171","msg":"trace[770885863] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"301.556921ms","start":"2026-04-22T13:59:10.135419Z","end":"2026-04-22T13:59:10.436975Z","steps":["trace[770885863] 'process raft request' (duration: 301.273557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.437097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:10.13539Z","time spent":"301.660853ms","remote":"127.0.0.1:34254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:59:10.437098Z","caller":"traceutil/trace.go:171","msg":"trace[226177094] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5177; }","duration":"310.676388ms","start":"2026-04-22T13:59:10.126386Z","end":"2026-04-22T13:59:10.437062Z","steps":["trace[226177094] 'read index received' (duration: 19.721664ms)","trace[226177094] 'applied index is now lower than readState.Index' (duration: 290.938394ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:10.437477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.718039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-22T13:59:10.437519Z","caller":"traceutil/trace.go:171","msg":"trace[967947903] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4990; }","duration":"310.79043ms","start":"2026-04-22T13:59:10.126716Z","end":"2026-04-22T13:59:10.437506Z","steps":["trace[967947903] 'agreement among raft nodes before linearized reading' (duration: 310.587257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.437548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:10.126708Z","time spent":"310.833431ms","remote":"127.0.0.1:34276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":731,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" "} {"level":"warn","ts":"2026-04-22T13:59:10.437755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.300457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-22T13:59:10.437799Z","caller":"traceutil/trace.go:171","msg":"trace[1304766192] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4990; }","duration":"152.361119ms","start":"2026-04-22T13:59:10.285422Z","end":"2026-04-22T13:59:10.437784Z","steps":["trace[1304766192] 'agreement among raft nodes before linearized reading' (duration: 152.234647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.437842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.432106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"warn","ts":"2026-04-22T13:59:10.437862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.656508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12971"} {"level":"info","ts":"2026-04-22T13:59:10.437918Z","caller":"traceutil/trace.go:171","msg":"trace[1517972413] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4990; }","duration":"197.73171ms","start":"2026-04-22T13:59:10.24017Z","end":"2026-04-22T13:59:10.437902Z","steps":["trace[1517972413] 'agreement among raft nodes before linearized reading' (duration: 197.604248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.437865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.849582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:59:10.437956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.569341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-22T13:59:10.437874Z","caller":"traceutil/trace.go:171","msg":"trace[2117610229] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4990; }","duration":"310.483386ms","start":"2026-04-22T13:59:10.127382Z","end":"2026-04-22T13:59:10.437866Z","steps":["trace[2117610229] 'agreement among raft nodes before linearized reading' (duration: 310.394785ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:10.437986Z","caller":"traceutil/trace.go:171","msg":"trace[905727274] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4990; }","duration":"311.616372ms","start":"2026-04-22T13:59:10.126361Z","end":"2026-04-22T13:59:10.437978Z","steps":["trace[905727274] 'agreement among raft nodes before linearized reading' (duration: 310.8586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.438003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:10.127375Z","time spent":"310.620758ms","remote":"127.0.0.1:34398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1288,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" "} {"level":"info","ts":"2026-04-22T13:59:10.437994Z","caller":"traceutil/trace.go:171","msg":"trace[1334144154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4990; }","duration":"224.038834ms","start":"2026-04-22T13:59:10.21393Z","end":"2026-04-22T13:59:10.437969Z","steps":["trace[1334144154] 'agreement among raft nodes before linearized reading' (duration: 223.780791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.438023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.183109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.9\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-04-22T13:59:10.438113Z","caller":"traceutil/trace.go:171","msg":"trace[1429757362] range","detail":"{range_begin:/registry/masterleases/199.19.213.9; range_end:; response_count:1; response_revision:4990; }","duration":"204.31235ms","start":"2026-04-22T13:59:10.233781Z","end":"2026-04-22T13:59:10.438093Z","steps":["trace[1429757362] 'agreement among raft nodes before linearized reading' (duration: 204.035236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.438011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:10.126346Z","time spent":"311.659813ms","remote":"127.0.0.1:34276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":1,"response size":1365,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" "} {"level":"info","ts":"2026-04-22T13:59:10.439921Z","caller":"traceutil/trace.go:171","msg":"trace[1600343386] transaction","detail":"{read_only:false; response_revision:4986; number_of_response:1; }","duration":"312.26996ms","start":"2026-04-22T13:59:10.124584Z","end":"2026-04-22T13:59:10.436854Z","steps":["trace[1600343386] 'process raft request' (duration: 273.962259ms)","trace[1600343386] 'compare' (duration: 37.781644ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:10.440171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:10.124559Z","time spent":"315.507565ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:59:10.599518Z","caller":"traceutil/trace.go:171","msg":"trace[1922665366] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"149.084442ms","start":"2026-04-22T13:59:10.450396Z","end":"2026-04-22T13:59:10.599481Z","steps":["trace[1922665366] 'process raft request' (duration: 123.536217ms)","trace[1922665366] 'compare' (duration: 25.283241ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:10.599731Z","caller":"traceutil/trace.go:171","msg":"trace[1165092659] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"148.063787ms","start":"2026-04-22T13:59:10.451634Z","end":"2026-04-22T13:59:10.599698Z","steps":["trace[1165092659] 'process raft request' (duration: 147.749862ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:10.602964Z","caller":"traceutil/trace.go:171","msg":"trace[499952512] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"142.45426ms","start":"2026-04-22T13:59:10.457436Z","end":"2026-04-22T13:59:10.59989Z","steps":["trace[499952512] 'process raft request' (duration: 142.076324ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:10.603269Z","caller":"traceutil/trace.go:171","msg":"trace[1271366945] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"109.692615ms","start":"2026-04-22T13:59:10.493399Z","end":"2026-04-22T13:59:10.603092Z","steps":["trace[1271366945] 'process raft request' (duration: 107.095648ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:10.60397Z","caller":"traceutil/trace.go:171","msg":"trace[1949999051] linearizableReadLoop","detail":"{readStateIndex:5190; appliedIndex:5187; }","duration":"118.68801ms","start":"2026-04-22T13:59:10.485232Z","end":"2026-04-22T13:59:10.60392Z","steps":["trace[1949999051] 'read index received' (duration: 88.718693ms)","trace[1949999051] 'applied index is now lower than readState.Index' (duration: 29.858275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:10.605112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.100344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-22T13:59:10.605167Z","caller":"traceutil/trace.go:171","msg":"trace[209226538] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4998; }","duration":"152.60475ms","start":"2026-04-22T13:59:10.452537Z","end":"2026-04-22T13:59:10.605142Z","steps":["trace[209226538] 'agreement among raft nodes before linearized reading' (duration: 151.658038ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:10.605859Z","caller":"traceutil/trace.go:171","msg":"trace[2140588701] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"110.093812ms","start":"2026-04-22T13:59:10.495726Z","end":"2026-04-22T13:59:10.60582Z","steps":["trace[2140588701] 'process raft request' (duration: 107.184101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.60829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.90536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-22T13:59:10.608371Z","caller":"traceutil/trace.go:171","msg":"trace[327263427] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4999; }","duration":"118.019651ms","start":"2026-04-22T13:59:10.490323Z","end":"2026-04-22T13:59:10.608343Z","steps":["trace[327263427] 'agreement among raft nodes before linearized reading' (duration: 117.750716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.608493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.512784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-04-22T13:59:10.608584Z","caller":"traceutil/trace.go:171","msg":"trace[710632796] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4999; }","duration":"112.626037ms","start":"2026-04-22T13:59:10.495939Z","end":"2026-04-22T13:59:10.608565Z","steps":["trace[710632796] 'agreement among raft nodes before linearized reading' (duration: 112.473455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.608628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.05951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18a8b2880f582fa3\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-04-22T13:59:10.608674Z","caller":"traceutil/trace.go:171","msg":"trace[893204533] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18a8b2880f582fa3; range_end:; response_count:1; response_revision:4999; }","duration":"118.131292ms","start":"2026-04-22T13:59:10.49053Z","end":"2026-04-22T13:59:10.608661Z","steps":["trace[893204533] 'agreement among raft nodes before linearized reading' (duration: 118.039731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.608896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.380816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-22T13:59:10.608932Z","caller":"traceutil/trace.go:171","msg":"trace[377628562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4999; }","duration":"118.445026ms","start":"2026-04-22T13:59:10.490471Z","end":"2026-04-22T13:59:10.608916Z","steps":["trace[377628562] 'agreement among raft nodes before linearized reading' (duration: 118.325735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:10.609372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.895863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:59:10.609408Z","caller":"traceutil/trace.go:171","msg":"trace[1494504621] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4999; }","duration":"118.961424ms","start":"2026-04-22T13:59:10.490432Z","end":"2026-04-22T13:59:10.609394Z","steps":["trace[1494504621] 'agreement among raft nodes before linearized reading' (duration: 118.752231ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:10.609432Z","caller":"traceutil/trace.go:171","msg":"trace[67886115] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"112.285371ms","start":"2026-04-22T13:59:10.496974Z","end":"2026-04-22T13:59:10.609259Z","steps":["trace[67886115] 'process raft request' (duration: 106.051915ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:13.505901Z","caller":"traceutil/trace.go:171","msg":"trace[818468935] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"147.698664ms","start":"2026-04-22T13:59:13.358173Z","end":"2026-04-22T13:59:13.505872Z","steps":["trace[818468935] 'process raft request' (duration: 147.513932ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:23.372295Z","caller":"traceutil/trace.go:171","msg":"trace[17124875] linearizableReadLoop","detail":"{readStateIndex:5380; appliedIndex:5379; }","duration":"325.536372ms","start":"2026-04-22T13:59:23.046733Z","end":"2026-04-22T13:59:23.372269Z","steps":["trace[17124875] 'read index received' (duration: 306.241789ms)","trace[17124875] 'applied index is now lower than readState.Index' (duration: 19.293273ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:23.372439Z","caller":"traceutil/trace.go:171","msg":"trace[775321682] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"334.608036ms","start":"2026-04-22T13:59:23.037817Z","end":"2026-04-22T13:59:23.372425Z","steps":["trace[775321682] 'process raft request' (duration: 315.15101ms)","trace[775321682] 'compare' (duration: 18.752277ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:23.372577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:23.037785Z","time spent":"334.691117ms","remote":"127.0.0.1:34472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:59:23.37284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.414038ms","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-04-22T13:59:23.372934Z","caller":"traceutil/trace.go:171","msg":"trace[673584411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5181; }","duration":"297.643201ms","start":"2026-04-22T13:59:23.075267Z","end":"2026-04-22T13:59:23.37291Z","steps":["trace[673584411] 'agreement among raft nodes before linearized reading' (duration: 297.205616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:23.373269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.716582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:59:23.373342Z","caller":"traceutil/trace.go:171","msg":"trace[2073365417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5181; }","duration":"157.835713ms","start":"2026-04-22T13:59:23.215492Z","end":"2026-04-22T13:59:23.373328Z","steps":["trace[2073365417] 'agreement among raft nodes before linearized reading' (duration: 157.717341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:23.373347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.112345ms","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-04-22T13:59:23.373387Z","caller":"traceutil/trace.go:171","msg":"trace[2138474263] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5181; }","duration":"278.284878ms","start":"2026-04-22T13:59:23.095092Z","end":"2026-04-22T13:59:23.373376Z","steps":["trace[2138474263] 'agreement among raft nodes before linearized reading' (duration: 278.157076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:23.373556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.796089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-04-22T13:59:23.37366Z","caller":"traceutil/trace.go:171","msg":"trace[513138828] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5181; }","duration":"326.951521ms","start":"2026-04-22T13:59:23.046677Z","end":"2026-04-22T13:59:23.373628Z","steps":["trace[513138828] 'agreement among raft nodes before linearized reading' (duration: 326.647727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:23.373735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:59:23.046659Z","time spent":"327.064842ms","remote":"127.0.0.1:34382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-22T13:59:23.653615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.347804ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:59:23.653905Z","caller":"traceutil/trace.go:171","msg":"trace[797936705] transaction","detail":"{read_only:false; response_revision:5184; number_of_response:1; }","duration":"101.218451ms","start":"2026-04-22T13:59:23.552662Z","end":"2026-04-22T13:59:23.653881Z","steps":["trace[797936705] 'process raft request' (duration: 101.142ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:23.654153Z","caller":"traceutil/trace.go:171","msg":"trace[315404276] linearizableReadLoop","detail":"{readStateIndex:5382; appliedIndex:5381; }","duration":"231.890024ms","start":"2026-04-22T13:59:23.42222Z","end":"2026-04-22T13:59:23.65411Z","steps":["trace[315404276] 'read index received' (duration: 104.83109ms)","trace[315404276] 'applied index is now lower than readState.Index' (duration: 127.053784ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:23.654368Z","caller":"traceutil/trace.go:171","msg":"trace[1205151821] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"275.208517ms","start":"2026-04-22T13:59:23.379142Z","end":"2026-04-22T13:59:23.654351Z","steps":["trace[1205151821] 'process raft request' (duration: 147.98935ms)","trace[1205151821] 'compare' (duration: 126.169752ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:23.654568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.258698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:59:23.654611Z","caller":"traceutil/trace.go:171","msg":"trace[283089536] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5184; }","duration":"152.35678ms","start":"2026-04-22T13:59:23.502243Z","end":"2026-04-22T13:59:23.6546Z","steps":["trace[283089536] 'agreement among raft nodes before linearized reading' (duration: 152.272119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:23.654658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.388232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13287"} {"level":"warn","ts":"2026-04-22T13:59:23.654878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.452461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-22T13:59:23.65509Z","caller":"traceutil/trace.go:171","msg":"trace[386629750] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5184; }","duration":"196.603813ms","start":"2026-04-22T13:59:23.458319Z","end":"2026-04-22T13:59:23.654923Z","steps":["trace[386629750] 'agreement among raft nodes before linearized reading' (duration: 196.162287ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:23.655339Z","caller":"traceutil/trace.go:171","msg":"trace[121694105] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5184; }","duration":"232.568813ms","start":"2026-04-22T13:59:23.422158Z","end":"2026-04-22T13:59:23.654726Z","steps":["trace[121694105] 'agreement among raft nodes before linearized reading' (duration: 232.246969ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:23.785759Z","caller":"traceutil/trace.go:171","msg":"trace[1953703857] linearizableReadLoop","detail":"{readStateIndex:5384; appliedIndex:5383; }","duration":"109.017948ms","start":"2026-04-22T13:59:23.676715Z","end":"2026-04-22T13:59:23.785733Z","steps":["trace[1953703857] 'read index received' (duration: 82.14109ms)","trace[1953703857] 'applied index is now lower than readState.Index' (duration: 26.876018ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:23.785814Z","caller":"traceutil/trace.go:171","msg":"trace[1307305978] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"109.758668ms","start":"2026-04-22T13:59:23.676034Z","end":"2026-04-22T13:59:23.785793Z","steps":["trace[1307305978] 'process raft request' (duration: 82.923612ms)","trace[1307305978] 'compare' (duration: 26.656483ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:23.78625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.494084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-22T13:59:23.786367Z","caller":"traceutil/trace.go:171","msg":"trace[1884066667] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5185; }","duration":"109.686547ms","start":"2026-04-22T13:59:23.676654Z","end":"2026-04-22T13:59:23.786341Z","steps":["trace[1884066667] 'agreement among raft nodes before linearized reading' (duration: 109.19122ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:24.39191Z","caller":"traceutil/trace.go:171","msg":"trace[321755775] linearizableReadLoop","detail":"{readStateIndex:5388; appliedIndex:5387; }","duration":"153.579704ms","start":"2026-04-22T13:59:24.238301Z","end":"2026-04-22T13:59:24.391881Z","steps":["trace[321755775] 'read index received' (duration: 153.340061ms)","trace[321755775] 'applied index is now lower than readState.Index' (duration: 238.213µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:24.392075Z","caller":"traceutil/trace.go:171","msg":"trace[790710604] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"167.883178ms","start":"2026-04-22T13:59:24.224046Z","end":"2026-04-22T13:59:24.391929Z","steps":["trace[790710604] 'process raft request' (duration: 167.626955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:24.392151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.780606ms","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-04-22T13:59:24.392506Z","caller":"traceutil/trace.go:171","msg":"trace[848876127] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5189; }","duration":"154.232742ms","start":"2026-04-22T13:59:24.23824Z","end":"2026-04-22T13:59:24.392473Z","steps":["trace[848876127] 'agreement among raft nodes before linearized reading' (duration: 153.731605ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:24.69012Z","caller":"traceutil/trace.go:171","msg":"trace[1361836448] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"196.797562ms","start":"2026-04-22T13:59:24.49328Z","end":"2026-04-22T13:59:24.690077Z","steps":["trace[1361836448] 'process raft request' (duration: 196.580099ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:24.719856Z","caller":"traceutil/trace.go:171","msg":"trace[250495078] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"225.637865ms","start":"2026-04-22T13:59:24.49417Z","end":"2026-04-22T13:59:24.719808Z","steps":["trace[250495078] 'process raft request' (duration: 225.409532ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:24.893242Z","caller":"traceutil/trace.go:171","msg":"trace[1876250895] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"157.04153ms","start":"2026-04-22T13:59:24.736168Z","end":"2026-04-22T13:59:24.89321Z","steps":["trace[1876250895] 'process raft request' (duration: 83.756581ms)","trace[1876250895] 'compare' (duration: 72.819432ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:25.135346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.884266ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:59:25.135541Z","caller":"traceutil/trace.go:171","msg":"trace[1598127985] linearizableReadLoop","detail":"{readStateIndex:5398; appliedIndex:5397; }","duration":"155.404015ms","start":"2026-04-22T13:59:24.980111Z","end":"2026-04-22T13:59:25.135515Z","steps":["trace[1598127985] 'read index received' (duration: 45.144744ms)","trace[1598127985] 'applied index is now lower than readState.Index' (duration: 110.257621ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:25.135531Z","caller":"traceutil/trace.go:171","msg":"trace[1700233523] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"223.663716ms","start":"2026-04-22T13:59:24.911831Z","end":"2026-04-22T13:59:25.135495Z","steps":["trace[1700233523] 'process raft request' (duration: 113.505727ms)","trace[1700233523] 'compare' (duration: 109.717053ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:25.135838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.726689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61779"} {"level":"info","ts":"2026-04-22T13:59:25.135872Z","caller":"traceutil/trace.go:171","msg":"trace[1915687077] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5199; }","duration":"155.81291ms","start":"2026-04-22T13:59:24.980049Z","end":"2026-04-22T13:59:25.135862Z","steps":["trace[1915687077] 'agreement among raft nodes before linearized reading' (duration: 155.569217ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:25.135965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.80689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-04-22T13:59:25.136019Z","caller":"traceutil/trace.go:171","msg":"trace[565281121] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5199; }","duration":"111.919943ms","start":"2026-04-22T13:59:25.024085Z","end":"2026-04-22T13:59:25.136005Z","steps":["trace[565281121] 'agreement among raft nodes before linearized reading' (duration: 111.71318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:25.136058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.817958ms","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-04-22T13:59:25.136202Z","caller":"traceutil/trace.go:171","msg":"trace[86332357] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5199; }","duration":"155.028831ms","start":"2026-04-22T13:59:24.981148Z","end":"2026-04-22T13:59:25.136177Z","steps":["trace[86332357] 'agreement among raft nodes before linearized reading' (duration: 154.635424ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:47.104966Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2858} {"level":"info","ts":"2026-04-22T13:59:47.174492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2858,"took":"67.876249ms","hash":2440942942,"current-db-size-bytes":51232768,"current-db-size":"51 MB","current-db-size-in-use-bytes":27557888,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-22T13:59:47.174553Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2440942942,"revision":2858,"compact-revision":-1} {"level":"info","ts":"2026-04-22T14:03:23.7519Z","caller":"traceutil/trace.go:171","msg":"trace[1924090047] transaction","detail":"{read_only:false; response_revision:6890; number_of_response:1; }","duration":"114.371751ms","start":"2026-04-22T14:03:23.637501Z","end":"2026-04-22T14:03:23.751872Z","steps":["trace[1924090047] 'process raft request' (duration: 114.187099ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:04:47.112207Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5345} {"level":"info","ts":"2026-04-22T14:04:47.192548Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5345,"took":"78.767963ms","hash":966161592,"current-db-size-bytes":51232768,"current-db-size":"51 MB","current-db-size-in-use-bytes":18829312,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-04-22T14:04:47.192635Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":966161592,"revision":5345,"compact-revision":2858}