{"level":"warn","ts":"2026-07-02T05:03:24.412401Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T05:03:24.412489Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.177:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.177:2380","--initial-cluster=instance=https://199.204.45.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.177: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-07-02T05:03:24.412554Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T05:03:24.412568Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-07-02T05:03:24.412586Z","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-07-02T05:03:24.413202Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"]} {"level":"info","ts":"2026-07-02T05:03:24.413272Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.177: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-07-02T05:03:24.417971Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.488893ms"} {"level":"info","ts":"2026-07-02T05:03:24.425171Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7c53a18098324dc9","cluster-id":"4717e8aa221973c8"} {"level":"info","ts":"2026-07-02T05:03:24.425226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T05:03:24.425243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 0"} {"level":"info","ts":"2026-07-02T05:03:24.425256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7c53a18098324dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T05:03:24.425262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 1"} {"level":"info","ts":"2026-07-02T05:03:24.42529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"warn","ts":"2026-07-02T05:03:24.437829Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T05:03:24.443615Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T05:03:24.444756Z","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-07-02T05:03:24.4475Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7c53a18098324dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T05:03:24.447911Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7c53a18098324dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T05:03:24.450132Z","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-07-02T05:03:24.450867Z","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-07-02T05:03:24.450881Z","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-07-02T05:03:24.455161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"info","ts":"2026-07-02T05:03:24.455389Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","added-peer-id":"7c53a18098324dc9","added-peer-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-07-02T05:03:24.464313Z","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-07-02T05:03:24.464502Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7c53a18098324dc9","initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T05:03:24.464535Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T05:03:24.464649Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-07-02T05:03:24.464666Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-07-02T05:03:25.325859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T05:03:25.325949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T05:03:25.325979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgPreVoteResp from 7c53a18098324dc9 at term 1"} {"level":"info","ts":"2026-07-02T05:03:25.325999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became candidate at term 2"} {"level":"info","ts":"2026-07-02T05:03:25.32601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgVoteResp from 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-07-02T05:03:25.326027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became leader at term 2"} {"level":"info","ts":"2026-07-02T05:03:25.326046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7c53a18098324dc9 elected leader 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-07-02T05:03:25.560571Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7c53a18098324dc9","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.177:2379]}","request-path":"/0/members/7c53a18098324dc9/attributes","cluster-id":"4717e8aa221973c8","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T05:03:25.560581Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T05:03:25.560678Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T05:03:25.560593Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:03:25.561072Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T05:03:25.561191Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T05:03:25.56356Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T05:03:25.564184Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.177:2379"} {"level":"warn","ts":"2026-07-02T05:03:25.818432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.035003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-02T05:03:25.81853Z","caller":"traceutil/trace.go:171","msg":"trace[299656240] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"123.159021ms","start":"2026-07-02T05:03:25.69536Z","end":"2026-07-02T05:03:25.818519Z","steps":["trace[299656240] 'agreement among raft nodes before linearized reading' (duration: 123.057134ms)"],"step_count":1} 2026/07/02 05:03:25 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T05:03:25.818646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.066325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-02T05:03:25.818674Z","caller":"traceutil/trace.go:171","msg":"trace[9829214] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"123.377566ms","start":"2026-07-02T05:03:25.69529Z","end":"2026-07-02T05:03:25.818668Z","steps":["trace[9829214] 'agreement among raft nodes before linearized reading' (duration: 123.086076ms)"],"step_count":1} 2026/07/02 05:03:25 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-07-02T05:03:25.862931Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:03:25.863046Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:03:25.86309Z","caller":"traceutil/trace.go:171","msg":"trace[839933817] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"258.525638ms","start":"2026-07-02T05:03:25.604553Z","end":"2026-07-02T05:03:25.863079Z","steps":["trace[839933817] 'read index received' (duration: 258.305162ms)","trace[839933817] 'applied index is now lower than readState.Index' (duration: 219.496µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:25.863136Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-02T05:03:25.863272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.503389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.8633Z","caller":"traceutil/trace.go:171","msg":"trace[1088227950] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"120.552872ms","start":"2026-07-02T05:03:25.74274Z","end":"2026-07-02T05:03:25.863293Z","steps":["trace[1088227950] 'agreement among raft nodes before linearized reading' (duration: 120.500939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.863367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.619527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:25.863416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.652647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.863444Z","caller":"traceutil/trace.go:171","msg":"trace[864809651] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"178.756426ms","start":"2026-07-02T05:03:25.684666Z","end":"2026-07-02T05:03:25.863422Z","steps":["trace[864809651] 'agreement among raft nodes before linearized reading' (duration: 178.589695ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:25.863459Z","caller":"traceutil/trace.go:171","msg":"trace[50321431] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"258.84445ms","start":"2026-07-02T05:03:25.604603Z","end":"2026-07-02T05:03:25.863447Z","steps":["trace[50321431] 'agreement among raft nodes before linearized reading' (duration: 258.635356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.86359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.6786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:25.863616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.404623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.863621Z","caller":"traceutil/trace.go:171","msg":"trace[614987762] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"108.721923ms","start":"2026-07-02T05:03:25.754891Z","end":"2026-07-02T05:03:25.863613Z","steps":["trace[614987762] 'agreement among raft nodes before linearized reading' (duration: 108.67727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.863636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.951109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.863638Z","caller":"traceutil/trace.go:171","msg":"trace[975152367] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"133.449505ms","start":"2026-07-02T05:03:25.730182Z","end":"2026-07-02T05:03:25.863632Z","steps":["trace[975152367] 'agreement among raft nodes before linearized reading' (duration: 133.411333ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:25.863655Z","caller":"traceutil/trace.go:171","msg":"trace[1939704157] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"211.979272ms","start":"2026-07-02T05:03:25.65167Z","end":"2026-07-02T05:03:25.863649Z","steps":["trace[1939704157] 'agreement among raft nodes before linearized reading' (duration: 211.94998ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.863743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.880154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:25.863765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.625857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.863769Z","caller":"traceutil/trace.go:171","msg":"trace[1131051985] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"108.907525ms","start":"2026-07-02T05:03:25.754856Z","end":"2026-07-02T05:03:25.863763Z","steps":["trace[1131051985] 'agreement among raft nodes before linearized reading' (duration: 108.870163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.863812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.602236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:25.863837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.672072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.863849Z","caller":"traceutil/trace.go:171","msg":"trace[905543104] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"223.667281ms","start":"2026-07-02T05:03:25.640176Z","end":"2026-07-02T05:03:25.863843Z","steps":["trace[905543104] 'agreement among raft nodes before linearized reading' (duration: 223.624898ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:25.863854Z","caller":"traceutil/trace.go:171","msg":"trace[1993434642] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"145.690953ms","start":"2026-07-02T05:03:25.718159Z","end":"2026-07-02T05:03:25.86385Z","steps":["trace[1993434642] 'agreement among raft nodes before linearized reading' (duration: 145.6459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.863881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.10416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.863908Z","caller":"traceutil/trace.go:171","msg":"trace[1061772019] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"121.155683ms","start":"2026-07-02T05:03:25.742746Z","end":"2026-07-02T05:03:25.863902Z","steps":["trace[1061772019] 'agreement among raft nodes before linearized reading' (duration: 121.11905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.863603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.73768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:25.864023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.657746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:25.863939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.775249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.864083Z","caller":"traceutil/trace.go:171","msg":"trace[312417387] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"145.93959ms","start":"2026-07-02T05:03:25.718137Z","end":"2026-07-02T05:03:25.864076Z","steps":["trace[312417387] 'agreement among raft nodes before linearized reading' (duration: 145.784809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.86379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.183265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.864126Z","caller":"traceutil/trace.go:171","msg":"trace[1696427484] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"212.54675ms","start":"2026-07-02T05:03:25.651573Z","end":"2026-07-02T05:03:25.86412Z","steps":["trace[1696427484] 'agreement among raft nodes before linearized reading' (duration: 212.197526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.864186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.446279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.86421Z","caller":"traceutil/trace.go:171","msg":"trace[1344889466] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"156.485782ms","start":"2026-07-02T05:03:25.707719Z","end":"2026-07-02T05:03:25.864205Z","steps":["trace[1344889466] 'agreement among raft nodes before linearized reading' (duration: 156.44718ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:25.863791Z","caller":"traceutil/trace.go:171","msg":"trace[1400958442] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"133.66627ms","start":"2026-07-02T05:03:25.730119Z","end":"2026-07-02T05:03:25.863786Z","steps":["trace[1400958442] 'agreement among raft nodes before linearized reading' (duration: 133.628217ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:25.864037Z","caller":"traceutil/trace.go:171","msg":"trace[236000191] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"202.198081ms","start":"2026-07-02T05:03:25.66181Z","end":"2026-07-02T05:03:25.864008Z","steps":["trace[236000191] 'agreement among raft nodes before linearized reading' (duration: 201.581789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.864326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.469825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.864349Z","caller":"traceutil/trace.go:171","msg":"trace[1510574162] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"179.505568ms","start":"2026-07-02T05:03:25.684839Z","end":"2026-07-02T05:03:25.864344Z","steps":["trace[1510574162] 'agreement among raft nodes before linearized reading' (duration: 179.472486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.864593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.692954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.864617Z","caller":"traceutil/trace.go:171","msg":"trace[263391902] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"202.752819ms","start":"2026-07-02T05:03:25.661859Z","end":"2026-07-02T05:03:25.864612Z","steps":["trace[263391902] 'agreement among raft nodes before linearized reading' (duration: 202.718447ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.864652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.805928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:25.86467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.233548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.864674Z","caller":"traceutil/trace.go:171","msg":"trace[1359086957] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"192.83317ms","start":"2026-07-02T05:03:25.671835Z","end":"2026-07-02T05:03:25.864669Z","steps":["trace[1359086957] 'agreement among raft nodes before linearized reading' (duration: 192.796407ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:25.864685Z","caller":"traceutil/trace.go:171","msg":"trace[1960914609] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"193.27091ms","start":"2026-07-02T05:03:25.671408Z","end":"2026-07-02T05:03:25.864679Z","steps":["trace[1960914609] 'agreement among raft nodes before linearized reading' (duration: 193.244278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:25.864299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.567917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:25.864776Z","caller":"traceutil/trace.go:171","msg":"trace[371409097] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"157.05226ms","start":"2026-07-02T05:03:25.707683Z","end":"2026-07-02T05:03:25.864735Z","steps":["trace[371409097] 'agreement among raft nodes before linearized reading' (duration: 156.60332ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:25.864051Z","caller":"traceutil/trace.go:171","msg":"trace[1071143187] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"259.496033ms","start":"2026-07-02T05:03:25.604548Z","end":"2026-07-02T05:03:25.864044Z","steps":["trace[1071143187] 'agreement among raft nodes before linearized reading' (duration: 258.596292ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.199242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.629039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.199261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.447328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.199323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.827874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.199342Z","caller":"traceutil/trace.go:171","msg":"trace[1125601717] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"188.870896ms","start":"2026-07-02T05:03:26.010466Z","end":"2026-07-02T05:03:26.199337Z","steps":["trace[1125601717] 'range keys from in-memory index tree' (duration: 188.756089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.199374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.852218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.199457Z","caller":"traceutil/trace.go:171","msg":"trace[243720957] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"150.954895ms","start":"2026-07-02T05:03:26.048487Z","end":"2026-07-02T05:03:26.199442Z","steps":["trace[243720957] 'count revisions from in-memory index tree' (duration: 150.801604ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.199588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.918608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.199758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.070133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.199794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.020752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.199807Z","caller":"traceutil/trace.go:171","msg":"trace[44739560] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"136.128647ms","start":"2026-07-02T05:03:26.063666Z","end":"2026-07-02T05:03:26.199795Z","steps":["trace[44739560] 'count revisions from in-memory index tree' (duration: 136.018948ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.19979Z","caller":"traceutil/trace.go:171","msg":"trace[1209274431] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"211.546295ms","start":"2026-07-02T05:03:25.987776Z","end":"2026-07-02T05:03:26.199322Z","steps":["trace[1209274431] 'range keys from in-memory index tree' (duration: 211.377263ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.199842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.339587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.199905Z","caller":"traceutil/trace.go:171","msg":"trace[1627685269] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"240.412511ms","start":"2026-07-02T05:03:25.959488Z","end":"2026-07-02T05:03:26.1999Z","steps":["trace[1627685269] 'count revisions from in-memory index tree' (duration: 240.309354ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.199761Z","caller":"traceutil/trace.go:171","msg":"trace[648717958] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"240.170505ms","start":"2026-07-02T05:03:25.959557Z","end":"2026-07-02T05:03:26.199727Z","steps":["trace[648717958] 'range keys from in-memory index tree' (duration: 239.82039ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.200125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.3342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.200198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.627217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.200198Z","caller":"traceutil/trace.go:171","msg":"trace[1120329290] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1; }","duration":"136.438767ms","start":"2026-07-02T05:03:26.063745Z","end":"2026-07-02T05:03:26.200183Z","steps":["trace[1120329290] 'range keys from in-memory index tree' (duration: 136.302478ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.200229Z","caller":"traceutil/trace.go:171","msg":"trace[1374996] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"110.685751ms","start":"2026-07-02T05:03:26.089536Z","end":"2026-07-02T05:03:26.200222Z","steps":["trace[1374996] 'range keys from in-memory index tree' (duration: 110.53726ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.200345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.735099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.199199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.473382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.200385Z","caller":"traceutil/trace.go:171","msg":"trace[108432093] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"101.801574ms","start":"2026-07-02T05:03:26.098573Z","end":"2026-07-02T05:03:26.200375Z","steps":["trace[108432093] 'range keys from in-memory index tree' (duration: 101.702837ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.200422Z","caller":"traceutil/trace.go:171","msg":"trace[1447388814] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"165.714579ms","start":"2026-07-02T05:03:26.034689Z","end":"2026-07-02T05:03:26.200403Z","steps":["trace[1447388814] 'count revisions from in-memory index tree' (duration: 164.428969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.200459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.738647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.200526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.675295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.200535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.315437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.200562Z","caller":"traceutil/trace.go:171","msg":"trace[518641204] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"123.346329ms","start":"2026-07-02T05:03:26.077209Z","end":"2026-07-02T05:03:26.200555Z","steps":["trace[518641204] 'range keys from in-memory index tree' (duration: 123.127824ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.200544Z","caller":"traceutil/trace.go:171","msg":"trace[2014124384] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1; }","duration":"212.858315ms","start":"2026-07-02T05:03:25.987672Z","end":"2026-07-02T05:03:26.20053Z","steps":["trace[2014124384] 'count revisions from in-memory index tree' (duration: 212.703105ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.200346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.742636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.199227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.507951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.20068Z","caller":"traceutil/trace.go:171","msg":"trace[629778758] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"227.124062ms","start":"2026-07-02T05:03:25.973547Z","end":"2026-07-02T05:03:26.200671Z","steps":["trace[629778758] 'range keys from in-memory index tree' (duration: 226.65445ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.2007Z","caller":"traceutil/trace.go:171","msg":"trace[423378626] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"200.983763ms","start":"2026-07-02T05:03:25.999703Z","end":"2026-07-02T05:03:26.200687Z","steps":["trace[423378626] 'count revisions from in-memory index tree' (duration: 199.48347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.200734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.458386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.200799Z","caller":"traceutil/trace.go:171","msg":"trace[406186043] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1; }","duration":"123.546762ms","start":"2026-07-02T05:03:26.077245Z","end":"2026-07-02T05:03:26.200792Z","steps":["trace[406186043] 'count revisions from in-memory index tree' (duration: 123.418604ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.200427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.66456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.199296Z","caller":"traceutil/trace.go:171","msg":"trace[2091166948] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1; }","duration":"199.675112ms","start":"2026-07-02T05:03:25.999606Z","end":"2026-07-02T05:03:26.199281Z","steps":["trace[2091166948] 'range keys from in-memory index tree' (duration: 199.437736ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.20085Z","caller":"traceutil/trace.go:171","msg":"trace[1101279667] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1; }","duration":"227.119042ms","start":"2026-07-02T05:03:25.973722Z","end":"2026-07-02T05:03:26.200841Z","steps":["trace[1101279667] 'count revisions from in-memory index tree' (duration: 226.612106ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.199749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.097668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.200889Z","caller":"traceutil/trace.go:171","msg":"trace[1761040967] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"255.254958ms","start":"2026-07-02T05:03:25.945626Z","end":"2026-07-02T05:03:26.200881Z","steps":["trace[1761040967] 'range keys from in-memory index tree' (duration: 254.052294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.200976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.38531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.201035Z","caller":"traceutil/trace.go:171","msg":"trace[814315409] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1; }","duration":"111.480776ms","start":"2026-07-02T05:03:26.089547Z","end":"2026-07-02T05:03:26.201028Z","steps":["trace[814315409] 'count revisions from in-memory index tree' (duration: 111.319135ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.200557Z","caller":"traceutil/trace.go:171","msg":"trace[276104604] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1; }","duration":"101.717178ms","start":"2026-07-02T05:03:26.098831Z","end":"2026-07-02T05:03:26.200548Z","steps":["trace[276104604] 'count revisions from in-memory index tree' (duration: 101.646343ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.199819Z","caller":"traceutil/trace.go:171","msg":"trace[1011458300] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"254.065766ms","start":"2026-07-02T05:03:25.945746Z","end":"2026-07-02T05:03:26.199811Z","steps":["trace[1011458300] 'count revisions from in-memory index tree' (duration: 253.951748ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.19966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.136007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.201298Z","caller":"traceutil/trace.go:171","msg":"trace[1878263742] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1; }","duration":"152.775681ms","start":"2026-07-02T05:03:26.048475Z","end":"2026-07-02T05:03:26.20125Z","steps":["trace[1878263742] 'range keys from in-memory index tree' (duration: 151.081574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.201362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.55056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-02T05:03:26.201424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.675498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.201451Z","caller":"traceutil/trace.go:171","msg":"trace[168760216] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"177.668028ms","start":"2026-07-02T05:03:26.023771Z","end":"2026-07-02T05:03:26.201439Z","steps":["trace[168760216] 'range keys from in-memory index tree' (duration: 177.464994ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.201498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.815314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.20154Z","caller":"traceutil/trace.go:171","msg":"trace[2118219179] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1; }","duration":"166.862967ms","start":"2026-07-02T05:03:26.034667Z","end":"2026-07-02T05:03:26.20153Z","steps":["trace[2118219179] 'range keys from in-memory index tree' (duration: 166.755991ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.201461Z","caller":"traceutil/trace.go:171","msg":"trace[876645098] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1; }","duration":"177.738223ms","start":"2026-07-02T05:03:26.023713Z","end":"2026-07-02T05:03:26.201451Z","steps":["trace[876645098] 'count revisions from in-memory index tree' (duration: 177.623085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.199675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.124804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:26.201882Z","caller":"traceutil/trace.go:171","msg":"trace[216044994] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1; }","duration":"191.373949ms","start":"2026-07-02T05:03:26.010499Z","end":"2026-07-02T05:03:26.201873Z","steps":["trace[216044994] 'count revisions from in-memory index tree' (duration: 189.057479ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:20.088734Z","caller":"traceutil/trace.go:171","msg":"trace[1930207764] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"107.620704ms","start":"2026-07-02T05:04:19.98108Z","end":"2026-07-02T05:04:20.088701Z","steps":["trace[1930207764] 'process raft request' (duration: 107.328947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:21.894572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.345808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:21.894704Z","caller":"traceutil/trace.go:171","msg":"trace[1549527841] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"611.307719ms","start":"2026-07-02T05:04:21.283365Z","end":"2026-07-02T05:04:21.894673Z","steps":["trace[1549527841] 'read index received' (duration: 361.249755ms)","trace[1549527841] 'applied index is now lower than readState.Index' (duration: 250.056904ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:21.894776Z","caller":"traceutil/trace.go:171","msg":"trace[714753144] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"671.437723ms","start":"2026-07-02T05:04:21.223328Z","end":"2026-07-02T05:04:21.894766Z","steps":["trace[714753144] 'process raft request' (duration: 421.270777ms)","trace[714753144] 'compare' (duration: 248.976994ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:21.894832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:21.223287Z","time spent":"671.51308ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:21.895044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.64257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:21.895169Z","caller":"traceutil/trace.go:171","msg":"trace[1340877245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"611.828557ms","start":"2026-07-02T05:04:21.283314Z","end":"2026-07-02T05:04:21.895142Z","steps":["trace[1340877245] 'agreement among raft nodes before linearized reading' (duration: 611.614977ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:21.895232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:21.283297Z","time spent":"611.915415ms","remote":"127.0.0.1:40534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T05:04:21.905771Z","caller":"traceutil/trace.go:171","msg":"trace[1396983072] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"264.78704ms","start":"2026-07-02T05:04:21.640972Z","end":"2026-07-02T05:04:21.905759Z","steps":["trace[1396983072] 'process raft request' (duration: 264.497093ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:21.905983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.174013ms","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-07-02T05:04:21.906013Z","caller":"traceutil/trace.go:171","msg":"trace[1908449207] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"455.268202ms","start":"2026-07-02T05:04:21.450737Z","end":"2026-07-02T05:04:21.906005Z","steps":["trace[1908449207] 'agreement among raft nodes before linearized reading' (duration: 455.163502ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:21.906038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:21.450705Z","time spent":"455.327188ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T05:04:26.246714Z","caller":"traceutil/trace.go:171","msg":"trace[1022108047] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"239.099448ms","start":"2026-07-02T05:04:26.007591Z","end":"2026-07-02T05:04:26.24669Z","steps":["trace[1022108047] 'read index received' (duration: 238.961335ms)","trace[1022108047] 'applied index is now lower than readState.Index' (duration: 137.123µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:26.247015Z","caller":"traceutil/trace.go:171","msg":"trace[1242928935] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"254.146052ms","start":"2026-07-02T05:04:25.992807Z","end":"2026-07-02T05:04:26.246953Z","steps":["trace[1242928935] 'process raft request' (duration: 253.739444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:26.247083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.468624ms","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-07-02T05:04:26.24716Z","caller":"traceutil/trace.go:171","msg":"trace[967085343] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"239.572553ms","start":"2026-07-02T05:04:26.007568Z","end":"2026-07-02T05:04:26.24714Z","steps":["trace[967085343] 'agreement among raft nodes before linearized reading' (duration: 239.373934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:26.746974Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186176225316428,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T05:04:26.856848Z","caller":"traceutil/trace.go:171","msg":"trace[1748479835] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"745.210682ms","start":"2026-07-02T05:04:26.111613Z","end":"2026-07-02T05:04:26.856823Z","steps":["trace[1748479835] 'process raft request' (duration: 743.667146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:26.856999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:26.111584Z","time spent":"745.331764ms","remote":"127.0.0.1:40630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:26.863621Z","caller":"traceutil/trace.go:171","msg":"trace[156253376] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:664; }","duration":"616.749144ms","start":"2026-07-02T05:04:26.246791Z","end":"2026-07-02T05:04:26.86354Z","steps":["trace[156253376] 'read index received' (duration: 607.788171ms)","trace[156253376] 'applied index is now lower than readState.Index' (duration: 8.958563ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:26.863784Z","caller":"traceutil/trace.go:171","msg":"trace[1719689403] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"612.438057ms","start":"2026-07-02T05:04:26.251309Z","end":"2026-07-02T05:04:26.863747Z","steps":["trace[1719689403] 'process raft request' (duration: 610.65308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:26.863955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:26.251291Z","time spent":"612.579981ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:26.864024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.54119ms","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-07-02T05:04:26.864097Z","caller":"traceutil/trace.go:171","msg":"trace[1495408342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"617.645179ms","start":"2026-07-02T05:04:26.246417Z","end":"2026-07-02T05:04:26.864062Z","steps":["trace[1495408342] 'agreement among raft nodes before linearized reading' (duration: 617.384493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:26.864141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:26.246398Z","time spent":"617.733407ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T05:04:26.864325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.186891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jq9jt\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-02T05:04:26.864374Z","caller":"traceutil/trace.go:171","msg":"trace[2141833350] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jq9jt; range_end:; response_count:1; response_revision:641; }","duration":"628.258558ms","start":"2026-07-02T05:04:26.236093Z","end":"2026-07-02T05:04:26.864352Z","steps":["trace[2141833350] 'agreement among raft nodes before linearized reading' (duration: 628.17524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:26.864404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:26.236075Z","time spent":"628.321864ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-jq9jt\" "} {"level":"warn","ts":"2026-07-02T05:04:26.864741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.966989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:26.864831Z","caller":"traceutil/trace.go:171","msg":"trace[1705571639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"579.127834ms","start":"2026-07-02T05:04:26.285688Z","end":"2026-07-02T05:04:26.864815Z","steps":["trace[1705571639] 'agreement among raft nodes before linearized reading' (duration: 578.970549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:26.864886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:26.285673Z","time spent":"579.19403ms","remote":"127.0.0.1:40538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T05:04:27.772828Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186176225316431,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:04:28.273705Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186176225316431,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:04:28.584261Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.695925122s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T05:04:28.723205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.61305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:28.723317Z","caller":"traceutil/trace.go:171","msg":"trace[719056294] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.846144324s","start":"2026-07-02T05:04:26.877151Z","end":"2026-07-02T05:04:28.723295Z","steps":["trace[719056294] 'process raft request' (duration: 1.707360208s)","trace[719056294] 'compare' (duration: 138.494649ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:28.723382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:26.87713Z","time spent":"1.846221422s","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:28.724567Z","caller":"traceutil/trace.go:171","msg":"trace[638108945] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"1.45220449s","start":"2026-07-02T05:04:27.272343Z","end":"2026-07-02T05:04:28.724547Z","steps":["trace[638108945] 'read index received' (duration: 1.312176756s)","trace[638108945] 'applied index is now lower than readState.Index' (duration: 140.026884ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:28.724662Z","caller":"traceutil/trace.go:171","msg":"trace[666648150] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"178.608785ms","start":"2026-07-02T05:04:28.546044Z","end":"2026-07-02T05:04:28.724653Z","steps":["trace[666648150] 'process raft request' (duration: 178.45126ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:28.724763Z","caller":"traceutil/trace.go:171","msg":"trace[1184950899] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.810730883s","start":"2026-07-02T05:04:26.914015Z","end":"2026-07-02T05:04:28.724746Z","steps":["trace[1184950899] 'process raft request' (duration: 1.809932517s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:28.724828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:26.913992Z","time spent":"1.81080597s","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:04:28.724931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.452591517s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-02T05:04:28.725031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.441214075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:28.725061Z","caller":"traceutil/trace.go:171","msg":"trace[348643173] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"1.4412798s","start":"2026-07-02T05:04:27.283773Z","end":"2026-07-02T05:04:28.725052Z","steps":["trace[348643173] 'agreement among raft nodes before linearized reading' (duration: 1.441234156s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:28.725088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:27.283749Z","time spent":"1.441333285s","remote":"127.0.0.1:40534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T05:04:28.725262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.847332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-02T05:04:28.725288Z","caller":"traceutil/trace.go:171","msg":"trace[1477103914] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:645; }","duration":"138.902028ms","start":"2026-07-02T05:04:28.586378Z","end":"2026-07-02T05:04:28.72528Z","steps":["trace[1477103914] 'agreement among raft nodes before linearized reading' (duration: 138.82071ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:28.725441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.832448ms","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-07-02T05:04:28.725478Z","caller":"traceutil/trace.go:171","msg":"trace[912482963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"474.94918ms","start":"2026-07-02T05:04:28.250521Z","end":"2026-07-02T05:04:28.72547Z","steps":["trace[912482963] 'agreement among raft nodes before linearized reading' (duration: 474.863922ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:28.725503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:28.250495Z","time spent":"475.002594ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T05:04:28.724963Z","caller":"traceutil/trace.go:171","msg":"trace[1987650248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"1.452657673s","start":"2026-07-02T05:04:27.272295Z","end":"2026-07-02T05:04:28.724953Z","steps":["trace[1987650248] 'agreement among raft nodes before linearized reading' (duration: 1.452528541s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:28.727872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:27.272278Z","time spent":"1.455399121s","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-02T05:04:28.931661Z","caller":"traceutil/trace.go:171","msg":"trace[51554191] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"148.068662ms","start":"2026-07-02T05:04:28.783573Z","end":"2026-07-02T05:04:28.931642Z","steps":["trace[51554191] 'process raft request' (duration: 147.063127ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:28.931896Z","caller":"traceutil/trace.go:171","msg":"trace[494332605] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"148.25338ms","start":"2026-07-02T05:04:28.783618Z","end":"2026-07-02T05:04:28.931871Z","steps":["trace[494332605] 'process raft request' (duration: 147.986635ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:28.931962Z","caller":"traceutil/trace.go:171","msg":"trace[318437823] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"147.146645ms","start":"2026-07-02T05:04:28.784763Z","end":"2026-07-02T05:04:28.93191Z","steps":["trace[318437823] 'process raft request' (duration: 147.039545ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:30.685906Z","caller":"traceutil/trace.go:171","msg":"trace[793846613] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"304.60147ms","start":"2026-07-02T05:04:30.381276Z","end":"2026-07-02T05:04:30.685877Z","steps":["trace[793846613] 'process raft request' (duration: 285.491722ms)","trace[793846613] 'compare' (duration: 18.989587ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:30.68607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:30.381248Z","time spent":"304.732642ms","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:30.690514Z","caller":"traceutil/trace.go:171","msg":"trace[833600904] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"308.264976ms","start":"2026-07-02T05:04:30.382235Z","end":"2026-07-02T05:04:30.6905Z","steps":["trace[833600904] 'process raft request' (duration: 308.134413ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:30.690496Z","caller":"traceutil/trace.go:171","msg":"trace[338910281] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:706; }","duration":"146.431814ms","start":"2026-07-02T05:04:30.544038Z","end":"2026-07-02T05:04:30.69047Z","steps":["trace[338910281] 'read index received' (duration: 122.740243ms)","trace[338910281] 'applied index is now lower than readState.Index' (duration: 23.690661ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:30.690655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:30.38222Z","time spent":"308.346804ms","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4165,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:30.690699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.653725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:30.690773Z","caller":"traceutil/trace.go:171","msg":"trace[2021553961] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:681; }","duration":"146.772876ms","start":"2026-07-02T05:04:30.543978Z","end":"2026-07-02T05:04:30.690751Z","steps":["trace[2021553961] 'agreement among raft nodes before linearized reading' (duration: 146.659916ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:32.385925Z","caller":"traceutil/trace.go:171","msg":"trace[1060967698] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"131.065261ms","start":"2026-07-02T05:04:32.254838Z","end":"2026-07-02T05:04:32.385903Z","steps":["trace[1060967698] 'process raft request' (duration: 130.96002ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:32.386133Z","caller":"traceutil/trace.go:171","msg":"trace[3390298] linearizableReadLoop","detail":"{readStateIndex:736; appliedIndex:734; }","duration":"113.64854ms","start":"2026-07-02T05:04:32.272465Z","end":"2026-07-02T05:04:32.386113Z","steps":["trace[3390298] 'read index received' (duration: 77.459798ms)","trace[3390298] 'applied index is now lower than readState.Index' (duration: 36.187712ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:32.386357Z","caller":"traceutil/trace.go:171","msg":"trace[982659744] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"111.175795ms","start":"2026-07-02T05:04:32.27517Z","end":"2026-07-02T05:04:32.386346Z","steps":["trace[982659744] 'process raft request' (duration: 110.689969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:32.386471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.647831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:32.386519Z","caller":"traceutil/trace.go:171","msg":"trace[656269298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:710; }","duration":"103.796195ms","start":"2026-07-02T05:04:32.282712Z","end":"2026-07-02T05:04:32.386508Z","steps":["trace[656269298] 'agreement among raft nodes before linearized reading' (duration: 103.658411ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:32.386761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.296271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jq9jt\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-07-02T05:04:32.386817Z","caller":"traceutil/trace.go:171","msg":"trace[68079632] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jq9jt; range_end:; response_count:1; response_revision:710; }","duration":"114.377419ms","start":"2026-07-02T05:04:32.27243Z","end":"2026-07-02T05:04:32.386808Z","steps":["trace[68079632] 'agreement among raft nodes before linearized reading' (duration: 114.225604ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:32.386153Z","caller":"traceutil/trace.go:171","msg":"trace[726812367] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"138.111431ms","start":"2026-07-02T05:04:32.24803Z","end":"2026-07-02T05:04:32.386142Z","steps":["trace[726812367] 'process raft request' (duration: 101.882094ms)","trace[726812367] 'compare' (duration: 35.754021ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:32.533984Z","caller":"traceutil/trace.go:171","msg":"trace[1163660911] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"141.786138ms","start":"2026-07-02T05:04:32.392176Z","end":"2026-07-02T05:04:32.533963Z","steps":["trace[1163660911] 'process raft request' (duration: 141.379919ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:32.544446Z","caller":"traceutil/trace.go:171","msg":"trace[1832707182] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"140.152694ms","start":"2026-07-02T05:04:32.404277Z","end":"2026-07-02T05:04:32.544429Z","steps":["trace[1832707182] 'process raft request' (duration: 140.01365ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:33.566969Z","caller":"traceutil/trace.go:171","msg":"trace[1841637440] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"267.142887ms","start":"2026-07-02T05:04:33.299796Z","end":"2026-07-02T05:04:33.566939Z","steps":["trace[1841637440] 'process raft request' (duration: 266.899654ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:33.567026Z","caller":"traceutil/trace.go:171","msg":"trace[881216121] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"266.892024ms","start":"2026-07-02T05:04:33.300112Z","end":"2026-07-02T05:04:33.567004Z","steps":["trace[881216121] 'process raft request' (duration: 266.754101ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:33.567218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.435281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T05:04:33.567282Z","caller":"traceutil/trace.go:171","msg":"trace[1463689252] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:723; }","duration":"236.558103ms","start":"2026-07-02T05:04:33.330708Z","end":"2026-07-02T05:04:33.567266Z","steps":["trace[1463689252] 'agreement among raft nodes before linearized reading' (duration: 236.418579ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:33.56694Z","caller":"traceutil/trace.go:171","msg":"trace[339430219] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:748; }","duration":"236.175617ms","start":"2026-07-02T05:04:33.330744Z","end":"2026-07-02T05:04:33.566919Z","steps":["trace[339430219] 'read index received' (duration: 236.024723ms)","trace[339430219] 'applied index is now lower than readState.Index' (duration: 150.114µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:33.604725Z","caller":"traceutil/trace.go:171","msg":"trace[1371788076] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"232.760454ms","start":"2026-07-02T05:04:33.371941Z","end":"2026-07-02T05:04:33.604702Z","steps":["trace[1371788076] 'process raft request' (duration: 232.552644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.058108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.764009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:34.058216Z","caller":"traceutil/trace.go:171","msg":"trace[686488889] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"301.168974ms","start":"2026-07-02T05:04:33.757027Z","end":"2026-07-02T05:04:34.058196Z","steps":["trace[686488889] 'process raft request' (duration: 54.2422ms)","trace[686488889] 'compare' (duration: 246.615384ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:34.058272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:33.756983Z","time spent":"301.268494ms","remote":"127.0.0.1:40616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:04:34.468247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.258468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:34.469937Z","caller":"traceutil/trace.go:171","msg":"trace[801112761] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"668.969815ms","start":"2026-07-02T05:04:33.800928Z","end":"2026-07-02T05:04:34.469898Z","steps":["trace[801112761] 'process raft request' (duration: 397.992774ms)","trace[801112761] 'compare' (duration: 269.085121ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:34.470043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:33.800905Z","time spent":"669.069895ms","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:04:34.486445Z","caller":"traceutil/trace.go:171","msg":"trace[350167739] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"664.142289ms","start":"2026-07-02T05:04:33.822275Z","end":"2026-07-02T05:04:34.486417Z","steps":["trace[350167739] 'process raft request' (duration: 663.762383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.486589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:33.822253Z","time spent":"664.25361ms","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:34.53789Z","caller":"traceutil/trace.go:171","msg":"trace[1690131051] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:753; }","duration":"593.772202ms","start":"2026-07-02T05:04:33.944062Z","end":"2026-07-02T05:04:34.537834Z","steps":["trace[1690131051] 'read index received' (duration: 254.880044ms)","trace[1690131051] 'applied index is now lower than readState.Index' (duration: 338.891168ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:34.538031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.9602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-07-02T05:04:34.538081Z","caller":"traceutil/trace.go:171","msg":"trace[1947264077] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:729; }","duration":"594.052118ms","start":"2026-07-02T05:04:33.944019Z","end":"2026-07-02T05:04:34.538071Z","steps":["trace[1947264077] 'agreement among raft nodes before linearized reading' (duration: 593.884032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.538107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:33.944002Z","time spent":"594.099363ms","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4355,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-07-02T05:04:34.53787Z","caller":"traceutil/trace.go:171","msg":"trace[1849047349] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"446.41597ms","start":"2026-07-02T05:04:34.091429Z","end":"2026-07-02T05:04:34.537845Z","steps":["trace[1849047349] 'process raft request' (duration: 446.250524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.538428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:34.091402Z","time spent":"446.894446ms","remote":"127.0.0.1:40616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:04:34.54523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.139334ms","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-07-02T05:04:34.545277Z","caller":"traceutil/trace.go:171","msg":"trace[2061091363] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:730; }","duration":"162.205691ms","start":"2026-07-02T05:04:34.38306Z","end":"2026-07-02T05:04:34.545266Z","steps":["trace[2061091363] 'agreement among raft nodes before linearized reading' (duration: 162.133884ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.546219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.440658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T05:04:34.546285Z","caller":"traceutil/trace.go:171","msg":"trace[107562479] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:730; }","duration":"238.55271ms","start":"2026-07-02T05:04:34.307719Z","end":"2026-07-02T05:04:34.546272Z","steps":["trace[107562479] 'agreement among raft nodes before linearized reading' (duration: 238.458241ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.546467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.094385ms","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-07-02T05:04:34.546504Z","caller":"traceutil/trace.go:171","msg":"trace[2112738215] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:730; }","duration":"163.175263ms","start":"2026-07-02T05:04:34.383321Z","end":"2026-07-02T05:04:34.546496Z","steps":["trace[2112738215] 'agreement among raft nodes before linearized reading' (duration: 163.120638ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.546677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.76458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jq9jt\" ","response":"range_response_count:1 size:18337"} {"level":"info","ts":"2026-07-02T05:04:34.546703Z","caller":"traceutil/trace.go:171","msg":"trace[522175161] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jq9jt; range_end:; response_count:1; response_revision:730; }","duration":"250.818105ms","start":"2026-07-02T05:04:34.295879Z","end":"2026-07-02T05:04:34.546697Z","steps":["trace[522175161] 'agreement among raft nodes before linearized reading' (duration: 250.724306ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.547371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.72098ms","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":"info","ts":"2026-07-02T05:04:34.547425Z","caller":"traceutil/trace.go:171","msg":"trace[1427126263] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:730; }","duration":"164.792407ms","start":"2026-07-02T05:04:34.38262Z","end":"2026-07-02T05:04:34.547412Z","steps":["trace[1427126263] 'agreement among raft nodes before linearized reading' (duration: 164.692357ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.547891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.798498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-07-02T05:04:34.547924Z","caller":"traceutil/trace.go:171","msg":"trace[614156202] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:730; }","duration":"403.875846ms","start":"2026-07-02T05:04:34.144041Z","end":"2026-07-02T05:04:34.547917Z","steps":["trace[614156202] 'agreement among raft nodes before linearized reading' (duration: 403.797528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.547945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:34.14402Z","time spent":"403.92059ms","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13251,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-07-02T05:04:34.549261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.890537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:34.549307Z","caller":"traceutil/trace.go:171","msg":"trace[1449081766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:730; }","duration":"263.972355ms","start":"2026-07-02T05:04:34.285326Z","end":"2026-07-02T05:04:34.549298Z","steps":["trace[1449081766] 'agreement among raft nodes before linearized reading' (duration: 263.902588ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:34.549311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.531775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-07-02T05:04:34.549357Z","caller":"traceutil/trace.go:171","msg":"trace[1941167496] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:730; }","duration":"204.602931ms","start":"2026-07-02T05:04:34.344746Z","end":"2026-07-02T05:04:34.549349Z","steps":["trace[1941167496] 'agreement among raft nodes before linearized reading' (duration: 204.490281ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:35.430727Z","caller":"traceutil/trace.go:171","msg":"trace[846179114] linearizableReadLoop","detail":"{readStateIndex:766; appliedIndex:764; }","duration":"101.663886ms","start":"2026-07-02T05:04:35.329044Z","end":"2026-07-02T05:04:35.430708Z","steps":["trace[846179114] 'read index received' (duration: 9.232019ms)","trace[846179114] 'applied index is now lower than readState.Index' (duration: 92.431206ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:35.430837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.767535ms","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-07-02T05:04:35.430863Z","caller":"traceutil/trace.go:171","msg":"trace[196427951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:738; }","duration":"101.829721ms","start":"2026-07-02T05:04:35.329028Z","end":"2026-07-02T05:04:35.430858Z","steps":["trace[196427951] 'agreement among raft nodes before linearized reading' (duration: 101.761904ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:35.430799Z","caller":"traceutil/trace.go:171","msg":"trace[2030804449] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"112.382345ms","start":"2026-07-02T05:04:35.318383Z","end":"2026-07-02T05:04:35.430766Z","steps":["trace[2030804449] 'process raft request' (duration: 112.22145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:35.44959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.243743ms","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-07-02T05:04:35.449646Z","caller":"traceutil/trace.go:171","msg":"trace[1199678725] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:739; }","duration":"120.322261ms","start":"2026-07-02T05:04:35.329311Z","end":"2026-07-02T05:04:35.449633Z","steps":["trace[1199678725] 'agreement among raft nodes before linearized reading' (duration: 120.234753ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:42.671994Z","caller":"traceutil/trace.go:171","msg":"trace[1932264714] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"180.117384ms","start":"2026-07-02T05:04:42.491846Z","end":"2026-07-02T05:04:42.671964Z","steps":["trace[1932264714] 'process raft request' (duration: 179.923827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:45.493617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.199619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:45.494444Z","caller":"traceutil/trace.go:171","msg":"trace[589282589] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"621.170706ms","start":"2026-07-02T05:04:44.873241Z","end":"2026-07-02T05:04:45.494412Z","steps":["trace[589282589] 'process raft request' (duration: 35.075948ms)","trace[589282589] 'compare' (duration: 585.063588ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:45.494989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:44.873222Z","time spent":"621.692276ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:45.4954Z","caller":"traceutil/trace.go:171","msg":"trace[524580968] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:846; }","duration":"419.229958ms","start":"2026-07-02T05:04:45.076144Z","end":"2026-07-02T05:04:45.495374Z","steps":["trace[524580968] 'read index received' (duration: 419.057808ms)","trace[524580968] 'applied index is now lower than readState.Index' (duration: 170.9µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:45.495592Z","caller":"traceutil/trace.go:171","msg":"trace[484622191] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"619.364546ms","start":"2026-07-02T05:04:44.876208Z","end":"2026-07-02T05:04:45.495572Z","steps":["trace[484622191] 'process raft request' (duration: 619.076773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:45.495708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:44.87619Z","time spent":"619.451331ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:45.495879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.658336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fm5bj\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-02T05:04:45.49654Z","caller":"traceutil/trace.go:171","msg":"trace[1389480568] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fm5bj; range_end:; response_count:1; response_revision:815; }","duration":"142.346686ms","start":"2026-07-02T05:04:45.354168Z","end":"2026-07-02T05:04:45.496515Z","steps":["trace[1389480568] 'agreement among raft nodes before linearized reading' (duration: 141.545772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:45.495914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.010631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-02T05:04:45.496807Z","caller":"traceutil/trace.go:171","msg":"trace[1856205056] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"399.869052ms","start":"2026-07-02T05:04:45.096857Z","end":"2026-07-02T05:04:45.496726Z","steps":["trace[1856205056] 'agreement among raft nodes before linearized reading' (duration: 398.762585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:45.497077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:45.096845Z","time spent":"400.008764ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T05:04:45.495944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.787866ms","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-07-02T05:04:45.49726Z","caller":"traceutil/trace.go:171","msg":"trace[1901115011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"421.156997ms","start":"2026-07-02T05:04:45.076086Z","end":"2026-07-02T05:04:45.497243Z","steps":["trace[1901115011] 'agreement among raft nodes before linearized reading' (duration: 419.503902ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:45.497318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:45.076066Z","time spent":"421.234063ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-02T05:04:45.910748Z","caller":"traceutil/trace.go:171","msg":"trace[672026626] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"410.213747ms","start":"2026-07-02T05:04:45.500479Z","end":"2026-07-02T05:04:45.910692Z","steps":["trace[672026626] 'process raft request' (duration: 329.575623ms)","trace[672026626] 'compare' (duration: 80.35274ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:45.910985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:45.500464Z","time spent":"410.385387ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:45.914133Z","caller":"traceutil/trace.go:171","msg":"trace[526152120] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"412.711364ms","start":"2026-07-02T05:04:45.50141Z","end":"2026-07-02T05:04:45.914121Z","steps":["trace[526152120] 'process raft request' (duration: 412.355664ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:45.914193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:45.501402Z","time spent":"412.762261ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:45.914301Z","caller":"traceutil/trace.go:171","msg":"trace[2050472564] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"411.676382ms","start":"2026-07-02T05:04:45.502604Z","end":"2026-07-02T05:04:45.91428Z","steps":["trace[2050472564] 'process raft request' (duration: 411.454935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:45.914465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:45.502596Z","time spent":"411.813495ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:49.790371Z","caller":"traceutil/trace.go:171","msg":"trace[1701087042] linearizableReadLoop","detail":"{readStateIndex:872; appliedIndex:871; }","duration":"282.023738ms","start":"2026-07-02T05:04:49.508304Z","end":"2026-07-02T05:04:49.790327Z","steps":["trace[1701087042] 'read index received' (duration: 281.511503ms)","trace[1701087042] 'applied index is now lower than readState.Index' (duration: 511.155µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:49.790498Z","caller":"traceutil/trace.go:171","msg":"trace[1616500858] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"358.109528ms","start":"2026-07-02T05:04:49.432353Z","end":"2026-07-02T05:04:49.790462Z","steps":["trace[1616500858] 'process raft request' (duration: 357.502627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:49.790684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:49.432338Z","time spent":"358.26407ms","remote":"127.0.0.1:40898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1116,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:04:49.790816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.896692ms","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-07-02T05:04:49.790914Z","caller":"traceutil/trace.go:171","msg":"trace[182190941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:839; }","duration":"280.038965ms","start":"2026-07-02T05:04:49.510856Z","end":"2026-07-02T05:04:49.790895Z","steps":["trace[182190941] 'agreement among raft nodes before linearized reading' (duration: 279.786198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:49.791119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.756271ms","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-07-02T05:04:49.791183Z","caller":"traceutil/trace.go:171","msg":"trace[1606656157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:839; }","duration":"282.930733ms","start":"2026-07-02T05:04:49.50824Z","end":"2026-07-02T05:04:49.791171Z","steps":["trace[1606656157] 'agreement among raft nodes before linearized reading' (duration: 282.283935ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:50.364697Z","caller":"traceutil/trace.go:171","msg":"trace[2032685370] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"459.540155ms","start":"2026-07-02T05:04:49.905123Z","end":"2026-07-02T05:04:50.364663Z","steps":["trace[2032685370] 'process raft request' (duration: 459.355833ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:50.365017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:49.905101Z","time spent":"459.693307ms","remote":"127.0.0.1:40616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:04:50.565262Z","caller":"traceutil/trace.go:171","msg":"trace[1574200007] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"659.315487ms","start":"2026-07-02T05:04:49.905922Z","end":"2026-07-02T05:04:50.565237Z","steps":["trace[1574200007] 'process raft request' (duration: 629.658146ms)","trace[1574200007] 'compare' (duration: 29.377675ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:50.565404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:49.905897Z","time spent":"659.423432ms","remote":"127.0.0.1:41024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5251,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:50.565653Z","caller":"traceutil/trace.go:171","msg":"trace[1251225141] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"659.186725ms","start":"2026-07-02T05:04:49.906445Z","end":"2026-07-02T05:04:50.565632Z","steps":["trace[1251225141] 'process raft request' (duration: 658.721617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:50.565759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:49.906428Z","time spent":"659.269431ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4434,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:04:50.567599Z","caller":"traceutil/trace.go:171","msg":"trace[1840141261] linearizableReadLoop","detail":"{readStateIndex:885; appliedIndex:882; }","duration":"644.189845ms","start":"2026-07-02T05:04:49.923383Z","end":"2026-07-02T05:04:50.567573Z","steps":["trace[1840141261] 'read index received' (duration: 441.173288ms)","trace[1840141261] 'applied index is now lower than readState.Index' (duration: 203.015307ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:50.56775Z","caller":"traceutil/trace.go:171","msg":"trace[1855258014] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"320.23017ms","start":"2026-07-02T05:04:50.247511Z","end":"2026-07-02T05:04:50.567741Z","steps":["trace[1855258014] 'process raft request' (duration: 318.461944ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:50.567848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:50.247458Z","time spent":"320.319017ms","remote":"127.0.0.1:40630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036286,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:50.567918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.454961ms","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-07-02T05:04:50.567971Z","caller":"traceutil/trace.go:171","msg":"trace[1275315610] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:853; }","duration":"641.535837ms","start":"2026-07-02T05:04:49.92642Z","end":"2026-07-02T05:04:50.567956Z","steps":["trace[1275315610] 'agreement among raft nodes before linearized reading' (duration: 641.362795ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:50.568007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:49.926411Z","time spent":"641.587974ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T05:04:50.568216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.166618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:50.568257Z","caller":"traceutil/trace.go:171","msg":"trace[43448905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:853; }","duration":"283.248354ms","start":"2026-07-02T05:04:50.284998Z","end":"2026-07-02T05:04:50.568246Z","steps":["trace[43448905] 'agreement among raft nodes before linearized reading' (duration: 283.188447ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:50.569524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.137815ms","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-07-02T05:04:50.569588Z","caller":"traceutil/trace.go:171","msg":"trace[1941406738] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:853; }","duration":"646.233879ms","start":"2026-07-02T05:04:49.923337Z","end":"2026-07-02T05:04:50.569571Z","steps":["trace[1941406738] 'agreement among raft nodes before linearized reading' (duration: 644.739929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:50.569683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:49.923324Z","time spent":"646.345984ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-02T05:04:50.787532Z","caller":"traceutil/trace.go:171","msg":"trace[1173608477] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"138.017073ms","start":"2026-07-02T05:04:50.649492Z","end":"2026-07-02T05:04:50.787509Z","steps":["trace[1173608477] 'process raft request' (duration: 76.478584ms)","trace[1173608477] 'compare' (duration: 61.419525ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:50.788053Z","caller":"traceutil/trace.go:171","msg":"trace[878464903] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"132.234035ms","start":"2026-07-02T05:04:50.6558Z","end":"2026-07-02T05:04:50.788034Z","steps":["trace[878464903] 'process raft request' (duration: 132.085382ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:50.788055Z","caller":"traceutil/trace.go:171","msg":"trace[1718127139] linearizableReadLoop","detail":"{readStateIndex:895; appliedIndex:893; }","duration":"120.943728ms","start":"2026-07-02T05:04:50.667078Z","end":"2026-07-02T05:04:50.788022Z","steps":["trace[1718127139] 'read index received' (duration: 58.898613ms)","trace[1718127139] 'applied index is now lower than readState.Index' (duration: 62.043525ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:50.788943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.828075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-07-02T05:04:50.789014Z","caller":"traceutil/trace.go:171","msg":"trace[534442954] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:862; }","duration":"121.961139ms","start":"2026-07-02T05:04:50.667036Z","end":"2026-07-02T05:04:50.788997Z","steps":["trace[534442954] 'agreement among raft nodes before linearized reading' (duration: 121.09638ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:04.674984Z","caller":"traceutil/trace.go:171","msg":"trace[555064095] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"106.115347ms","start":"2026-07-02T05:05:04.568843Z","end":"2026-07-02T05:05:04.674958Z","steps":["trace[555064095] 'process raft request' (duration: 105.836363ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:39.065238Z","caller":"traceutil/trace.go:171","msg":"trace[895884929] linearizableReadLoop","detail":"{readStateIndex:1524; appliedIndex:1523; }","duration":"106.856662ms","start":"2026-07-02T05:05:38.958346Z","end":"2026-07-02T05:05:39.065203Z","steps":["trace[895884929] 'read index received' (duration: 105.670677ms)","trace[895884929] 'applied index is now lower than readState.Index' (duration: 1.184125ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:39.065393Z","caller":"traceutil/trace.go:171","msg":"trace[772429349] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"446.505858ms","start":"2026-07-02T05:05:38.618875Z","end":"2026-07-02T05:05:39.065381Z","steps":["trace[772429349] 'process raft request' (duration: 445.16366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:39.065519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:05:38.618863Z","time spent":"446.560109ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:05:39.065592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.62866ms","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-07-02T05:05:39.06569Z","caller":"traceutil/trace.go:171","msg":"trace[145391235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1474; }","duration":"102.795483ms","start":"2026-07-02T05:05:38.962874Z","end":"2026-07-02T05:05:39.065669Z","steps":["trace[145391235] 'agreement among raft nodes before linearized reading' (duration: 102.569208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:39.065687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.342052ms","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-07-02T05:05:39.065744Z","caller":"traceutil/trace.go:171","msg":"trace[2007270783] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1474; }","duration":"107.444344ms","start":"2026-07-02T05:05:38.958285Z","end":"2026-07-02T05:05:39.06573Z","steps":["trace[2007270783] 'agreement among raft nodes before linearized reading' (duration: 107.306231ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.636817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.560163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-02T05:06:03.637006Z","caller":"traceutil/trace.go:171","msg":"trace[1972764237] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea; range_end:; response_count:1; response_revision:1877; }","duration":"437.759691ms","start":"2026-07-02T05:06:03.199222Z","end":"2026-07-02T05:06:03.636982Z","steps":["trace[1972764237] 'range keys from in-memory index tree' (duration: 437.343084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.63709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.199085Z","time spent":"437.990729ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea\" "} {"level":"warn","ts":"2026-07-02T05:06:03.637214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.814652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-02T05:06:03.637258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090296737s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-02T05:06:03.637306Z","caller":"traceutil/trace.go:171","msg":"trace[1808092637] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1877; }","duration":"1.090397641s","start":"2026-07-02T05:06:02.546893Z","end":"2026-07-02T05:06:03.637291Z","steps":["trace[1808092637] 'range keys from in-memory index tree' (duration: 1.090116669s)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:03.637307Z","caller":"traceutil/trace.go:171","msg":"trace[2107741984] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1877; }","duration":"427.971928ms","start":"2026-07-02T05:06:03.209314Z","end":"2026-07-02T05:06:03.637286Z","steps":["trace[2107741984] 'range keys from in-memory index tree' (duration: 427.389446ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.637336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:02.546865Z","time spent":"1.090464603s","remote":"127.0.0.1:35434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-07-02T05:06:03.637376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.209291Z","time spent":"428.048391ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T05:06:03.63737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.636345ms","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-07-02T05:06:03.637468Z","caller":"traceutil/trace.go:171","msg":"trace[543231589] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1877; }","duration":"426.772051ms","start":"2026-07-02T05:06:03.210675Z","end":"2026-07-02T05:06:03.637447Z","steps":["trace[543231589] 'range keys from in-memory index tree' (duration: 426.431858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.63751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184621703s","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-07-02T05:06:03.637552Z","caller":"traceutil/trace.go:171","msg":"trace[498808512] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1877; }","duration":"1.184690606s","start":"2026-07-02T05:06:02.452851Z","end":"2026-07-02T05:06:03.637541Z","steps":["trace[498808512] 'count revisions from in-memory index tree' (duration: 1.184575852s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.637583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:02.45284Z","time spent":"1.184734589s","remote":"127.0.0.1:37296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-02T05:06:03.637599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.418059ms","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-07-02T05:06:03.637627Z","caller":"traceutil/trace.go:171","msg":"trace[1147025162] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1877; }","duration":"424.471571ms","start":"2026-07-02T05:06:03.213147Z","end":"2026-07-02T05:06:03.637619Z","steps":["trace[1147025162] 'range keys from in-memory index tree' (duration: 424.302334ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.637658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.213135Z","time spent":"424.517153ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T05:06:03.637748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.434138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:03.63786Z","caller":"traceutil/trace.go:171","msg":"trace[127219434] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1877; }","duration":"393.596094ms","start":"2026-07-02T05:06:03.244245Z","end":"2026-07-02T05:06:03.637841Z","steps":["trace[127219434] 'count revisions from in-memory index tree' (duration: 393.314853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.637944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.244222Z","time spent":"393.707188ms","remote":"127.0.0.1:37444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-02T05:06:03.637514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.210659Z","time spent":"426.846034ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T05:06:03.638092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.607967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-02T05:06:03.638205Z","caller":"traceutil/trace.go:171","msg":"trace[85424938] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea; range_end:; response_count:1; response_revision:1877; }","duration":"910.773474ms","start":"2026-07-02T05:06:02.727405Z","end":"2026-07-02T05:06:03.638178Z","steps":["trace[85424938] 'range keys from in-memory index tree' (duration: 910.42575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.63826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:02.727381Z","time spent":"910.867298ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea\" "} {"level":"info","ts":"2026-07-02T05:06:03.657553Z","caller":"traceutil/trace.go:171","msg":"trace[515484580] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"316.73476ms","start":"2026-07-02T05:06:03.340792Z","end":"2026-07-02T05:06:03.657527Z","steps":["trace[515484580] 'process raft request' (duration: 316.566564ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.657719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.34077Z","time spent":"316.862376ms","remote":"127.0.0.1:40718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7741,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:06:03.713425Z","caller":"traceutil/trace.go:171","msg":"trace[442643231] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"339.616885ms","start":"2026-07-02T05:06:03.373776Z","end":"2026-07-02T05:06:03.713393Z","steps":["trace[442643231] 'process raft request' (duration: 339.444068ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:03.713708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.373749Z","time spent":"339.853834ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:06:03.713787Z","caller":"traceutil/trace.go:171","msg":"trace[1987733979] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"126.108179ms","start":"2026-07-02T05:06:03.587626Z","end":"2026-07-02T05:06:03.713734Z","steps":["trace[1987733979] 'process raft request' (duration: 125.710124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:04.006897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.991235ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-02T05:06:04.007292Z","caller":"traceutil/trace.go:171","msg":"trace[1328980041] linearizableReadLoop","detail":"{readStateIndex:1954; appliedIndex:1952; }","duration":"605.213168ms","start":"2026-07-02T05:06:03.402056Z","end":"2026-07-02T05:06:04.007269Z","steps":["trace[1328980041] 'read index received' (duration: 255.234576ms)","trace[1328980041] 'applied index is now lower than readState.Index' (duration: 349.974032ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:04.007607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.5059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-02T05:06:04.007645Z","caller":"traceutil/trace.go:171","msg":"trace[320300020] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1884; }","duration":"605.582803ms","start":"2026-07-02T05:06:03.40205Z","end":"2026-07-02T05:06:04.007633Z","steps":["trace[320300020] 'agreement among raft nodes before linearized reading' (duration: 605.385485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:04.007728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.402009Z","time spent":"605.702838ms","remote":"127.0.0.1:35434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-07-02T05:06:04.008831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.46113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-07-02T05:06:04.008917Z","caller":"traceutil/trace.go:171","msg":"trace[1301025032] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1886; }","duration":"484.648747ms","start":"2026-07-02T05:06:03.524246Z","end":"2026-07-02T05:06:04.008895Z","steps":["trace[1301025032] 'agreement among raft nodes before linearized reading' (duration: 484.451789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:04.009044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:03.524217Z","time spent":"484.72762ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-07-02T05:06:04.388843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.874225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:04.389428Z","caller":"traceutil/trace.go:171","msg":"trace[2136349873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1887; }","duration":"104.48439ms","start":"2026-07-02T05:06:04.284926Z","end":"2026-07-02T05:06:04.38941Z","steps":["trace[2136349873] 'range keys from in-memory index tree' (duration: 103.766971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:04.388999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.047208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:04.389649Z","caller":"traceutil/trace.go:171","msg":"trace[273968822] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1887; }","duration":"220.748306ms","start":"2026-07-02T05:06:04.168891Z","end":"2026-07-02T05:06:04.38964Z","steps":["trace[273968822] 'count revisions from in-memory index tree' (duration: 219.928713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:04.389246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.243479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-02T05:06:04.389723Z","caller":"traceutil/trace.go:171","msg":"trace[1435599615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1887; }","duration":"177.76449ms","start":"2026-07-02T05:06:04.211936Z","end":"2026-07-02T05:06:04.3897Z","steps":["trace[1435599615] 'range keys from in-memory index tree' (duration: 177.04393ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:04.389352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.912495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18be60a408b891e4\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-07-02T05:06:04.389858Z","caller":"traceutil/trace.go:171","msg":"trace[1569759348] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18be60a408b891e4; range_end:; response_count:1; response_revision:1887; }","duration":"250.450947ms","start":"2026-07-02T05:06:04.139376Z","end":"2026-07-02T05:06:04.389827Z","steps":["trace[1569759348] 'range keys from in-memory index tree' (duration: 249.565941ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:05.003496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.348046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:06:05.003734Z","caller":"traceutil/trace.go:171","msg":"trace[1003363982] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1964; }","duration":"358.921033ms","start":"2026-07-02T05:06:04.644794Z","end":"2026-07-02T05:06:05.003715Z","steps":["trace[1003363982] 'read index received' (duration: 87.871359ms)","trace[1003363982] 'applied index is now lower than readState.Index' (duration: 271.048554ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:05.003817Z","caller":"traceutil/trace.go:171","msg":"trace[34556755] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"609.960852ms","start":"2026-07-02T05:06:04.393815Z","end":"2026-07-02T05:06:05.003775Z","steps":["trace[34556755] 'process raft request' (duration: 338.906658ms)","trace[34556755] 'compare' (duration: 270.233992ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:05.003915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.122912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-07-02T05:06:05.003915Z","caller":"traceutil/trace.go:171","msg":"trace[2013516493] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"609.268806ms","start":"2026-07-02T05:06:04.394615Z","end":"2026-07-02T05:06:05.003883Z","steps":["trace[2013516493] 'process raft request' (duration: 608.998125ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:05.003994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:04.393798Z","time spent":"610.108159ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:06:05.004083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:04.394594Z","time spent":"609.401201ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:06:05.003953Z","caller":"traceutil/trace.go:171","msg":"trace[1438441167] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea; range_end:; response_count:1; response_revision:1890; }","duration":"359.204895ms","start":"2026-07-02T05:06:04.644737Z","end":"2026-07-02T05:06:05.003942Z","steps":["trace[1438441167] 'agreement among raft nodes before linearized reading' (duration: 359.034788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:05.004245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:04.644718Z","time spent":"359.515957ms","remote":"127.0.0.1:40730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f019937-6e23-47d4-ba8c-bb2615da44ea\" "} {"level":"info","ts":"2026-07-02T05:06:11.934177Z","caller":"traceutil/trace.go:171","msg":"trace[607094507] linearizableReadLoop","detail":"{readStateIndex:2033; appliedIndex:2031; }","duration":"186.67623ms","start":"2026-07-02T05:06:11.747468Z","end":"2026-07-02T05:06:11.934144Z","steps":["trace[607094507] 'read index received' (duration: 41.936917ms)","trace[607094507] 'applied index is now lower than readState.Index' (duration: 144.738113ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:11.934387Z","caller":"traceutil/trace.go:171","msg":"trace[840411867] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"192.297796ms","start":"2026-07-02T05:06:11.742038Z","end":"2026-07-02T05:06:11.934336Z","steps":["trace[840411867] 'process raft request' (duration: 176.573237ms)","trace[840411867] 'compare' (duration: 15.375134ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:11.934468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.979534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-02T05:06:11.934503Z","caller":"traceutil/trace.go:171","msg":"trace[895745430] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1956; }","duration":"187.077328ms","start":"2026-07-02T05:06:11.747416Z","end":"2026-07-02T05:06:11.934493Z","steps":["trace[895745430] 'agreement among raft nodes before linearized reading' (duration: 186.900701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:11.934634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.85519ms","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-07-02T05:06:11.934737Z","caller":"traceutil/trace.go:171","msg":"trace[1172113118] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1956; }","duration":"185.022038ms","start":"2026-07-02T05:06:11.749684Z","end":"2026-07-02T05:06:11.934706Z","steps":["trace[1172113118] 'agreement among raft nodes before linearized reading' (duration: 184.704224ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:11.934627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.240538ms","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-07-02T05:06:11.934932Z","caller":"traceutil/trace.go:171","msg":"trace[1735792890] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1956; }","duration":"180.589153ms","start":"2026-07-02T05:06:11.754326Z","end":"2026-07-02T05:06:11.934915Z","steps":["trace[1735792890] 'agreement among raft nodes before linearized reading' (duration: 180.082531ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:16.058237Z","caller":"traceutil/trace.go:171","msg":"trace[111746248] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"111.018532ms","start":"2026-07-02T05:06:15.94719Z","end":"2026-07-02T05:06:16.058209Z","steps":["trace[111746248] 'process raft request' (duration: 109.408497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:38.627067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.578698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:06:38.627259Z","caller":"traceutil/trace.go:171","msg":"trace[72126188] linearizableReadLoop","detail":"{readStateIndex:2204; appliedIndex:2203; }","duration":"431.256952ms","start":"2026-07-02T05:06:38.195984Z","end":"2026-07-02T05:06:38.627241Z","steps":["trace[72126188] 'read index received' (duration: 142.41941ms)","trace[72126188] 'applied index is now lower than readState.Index' (duration: 288.836322ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:38.627404Z","caller":"traceutil/trace.go:171","msg":"trace[1569459677] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"442.807488ms","start":"2026-07-02T05:06:38.184582Z","end":"2026-07-02T05:06:38.62739Z","steps":["trace[1569459677] 'process raft request' (duration: 153.821548ms)","trace[1569459677] 'compare' (duration: 288.464041ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:38.62757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:38.184569Z","time spent":"442.952417ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:06:38.62782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.802662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-07-02T05:06:38.627907Z","caller":"traceutil/trace.go:171","msg":"trace[326243496] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2121; }","duration":"431.929199ms","start":"2026-07-02T05:06:38.195955Z","end":"2026-07-02T05:06:38.627885Z","steps":["trace[326243496] 'agreement among raft nodes before linearized reading' (duration: 431.579389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:38.627987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:38.195942Z","time spent":"432.033115ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-07-02T05:06:38.631256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.506764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T05:06:38.631281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.972537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-02T05:06:38.63134Z","caller":"traceutil/trace.go:171","msg":"trace[1858494192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2122; }","duration":"346.597419ms","start":"2026-07-02T05:06:38.284722Z","end":"2026-07-02T05:06:38.63132Z","steps":["trace[1858494192] 'agreement among raft nodes before linearized reading' (duration: 346.464511ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:38.631401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:38.284635Z","time spent":"346.747007ms","remote":"127.0.0.1:40534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T05:06:38.631473Z","caller":"traceutil/trace.go:171","msg":"trace[1214222602] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2122; }","duration":"393.085544ms","start":"2026-07-02T05:06:38.238263Z","end":"2026-07-02T05:06:38.631348Z","steps":["trace[1214222602] 'agreement among raft nodes before linearized reading' (duration: 392.814778ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:38.631523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:38.238223Z","time spent":"393.290045ms","remote":"127.0.0.1:35434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-02T05:08:13.908007Z","caller":"traceutil/trace.go:171","msg":"trace[1823330603] linearizableReadLoop","detail":"{readStateIndex:2843; appliedIndex:2842; }","duration":"216.75625ms","start":"2026-07-02T05:08:13.691188Z","end":"2026-07-02T05:08:13.907944Z","steps":["trace[1823330603] 'read index received' (duration: 216.202949ms)","trace[1823330603] 'applied index is now lower than readState.Index' (duration: 551.99µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:08:13.909804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.596605ms","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-07-02T05:08:13.909942Z","caller":"traceutil/trace.go:171","msg":"trace[391874331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2739; }","duration":"218.765116ms","start":"2026-07-02T05:08:13.691123Z","end":"2026-07-02T05:08:13.909888Z","steps":["trace[391874331] 'agreement among raft nodes before linearized reading' (duration: 217.99641ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:13.909883Z","caller":"traceutil/trace.go:171","msg":"trace[887870728] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"244.289623ms","start":"2026-07-02T05:08:13.665575Z","end":"2026-07-02T05:08:13.909865Z","steps":["trace[887870728] 'process raft request' (duration: 242.053488ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:14.063989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.506608ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-02T05:08:14.064775Z","caller":"traceutil/trace.go:171","msg":"trace[1328358554] linearizableReadLoop","detail":"{readStateIndex:2844; appliedIndex:2843; }","duration":"156.573476ms","start":"2026-07-02T05:08:13.908166Z","end":"2026-07-02T05:08:14.064739Z","steps":["trace[1328358554] 'read index received' (duration: 2.278108ms)","trace[1328358554] 'applied index is now lower than readState.Index' (duration: 154.292658ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:08:14.065299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.050278ms","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-07-02T05:08:14.065366Z","caller":"traceutil/trace.go:171","msg":"trace[832776948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2739; }","duration":"369.123145ms","start":"2026-07-02T05:08:13.69622Z","end":"2026-07-02T05:08:14.065344Z","steps":["trace[832776948] 'agreement among raft nodes before linearized reading' (duration: 368.627498ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:14.065588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:08:13.69616Z","time spent":"369.356941ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T05:08:14.066089Z","caller":"traceutil/trace.go:171","msg":"trace[583119565] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"148.607098ms","start":"2026-07-02T05:08:13.917419Z","end":"2026-07-02T05:08:14.066026Z","steps":["trace[583119565] 'process raft request' (duration: 146.703227ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:11:50.392227Z","caller":"traceutil/trace.go:171","msg":"trace[829978719] transaction","detail":"{read_only:false; response_revision:4513; number_of_response:1; }","duration":"104.859523ms","start":"2026-07-02T05:11:50.287348Z","end":"2026-07-02T05:11:50.392207Z","steps":["trace[829978719] 'process raft request' (duration: 104.722348ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:11:50.398897Z","caller":"traceutil/trace.go:171","msg":"trace[1076321055] transaction","detail":"{read_only:false; response_revision:4514; number_of_response:1; }","duration":"111.45398ms","start":"2026-07-02T05:11:50.287413Z","end":"2026-07-02T05:11:50.398867Z","steps":["trace[1076321055] 'process raft request' (duration: 111.279873ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:11:50.597894Z","caller":"traceutil/trace.go:171","msg":"trace[5149904] transaction","detail":"{read_only:false; response_revision:4516; number_of_response:1; }","duration":"118.043929ms","start":"2026-07-02T05:11:50.479825Z","end":"2026-07-02T05:11:50.597869Z","steps":["trace[5149904] 'process raft request' (duration: 117.130375ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:10.538471Z","caller":"traceutil/trace.go:171","msg":"trace[509955240] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"146.984424ms","start":"2026-07-02T05:12:10.391461Z","end":"2026-07-02T05:12:10.538445Z","steps":["trace[509955240] 'process raft request' (duration: 146.815687ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:12:10.876973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.17298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T05:12:10.877041Z","caller":"traceutil/trace.go:171","msg":"trace[1096896208] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4859; }","duration":"234.272875ms","start":"2026-07-02T05:12:10.642754Z","end":"2026-07-02T05:12:10.877027Z","steps":["trace[1096896208] 'range keys from in-memory index tree' (duration: 234.052755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:12:10.877278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.7542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-07-02T05:12:10.877304Z","caller":"traceutil/trace.go:171","msg":"trace[729204473] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4859; }","duration":"256.806532ms","start":"2026-07-02T05:12:10.620491Z","end":"2026-07-02T05:12:10.877298Z","steps":["trace[729204473] 'range keys from in-memory index tree' (duration: 256.683407ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:12:10.877303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.768237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-07-02T05:12:10.877365Z","caller":"traceutil/trace.go:171","msg":"trace[843540573] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4859; }","duration":"200.867341ms","start":"2026-07-02T05:12:10.676482Z","end":"2026-07-02T05:12:10.87735Z","steps":["trace[843540573] 'range keys from in-memory index tree' (duration: 200.637163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:12:10.877447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.696147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-02T05:12:10.877473Z","caller":"traceutil/trace.go:171","msg":"trace[1322363526] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4859; }","duration":"254.747209ms","start":"2026-07-02T05:12:10.622719Z","end":"2026-07-02T05:12:10.877466Z","steps":["trace[1322363526] 'range keys from in-memory index tree' (duration: 254.615754ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:12:10.877607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.554306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T05:12:10.877668Z","caller":"traceutil/trace.go:171","msg":"trace[1659582766] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4859; }","duration":"188.64758ms","start":"2026-07-02T05:12:10.689005Z","end":"2026-07-02T05:12:10.877653Z","steps":["trace[1659582766] 'count revisions from in-memory index tree' (duration: 188.479134ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.017138Z","caller":"traceutil/trace.go:171","msg":"trace[302625218] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"134.994204ms","start":"2026-07-02T05:12:10.882115Z","end":"2026-07-02T05:12:11.017109Z","steps":["trace[302625218] 'process raft request' (duration: 134.744994ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.017336Z","caller":"traceutil/trace.go:171","msg":"trace[1151067267] linearizableReadLoop","detail":"{readStateIndex:5042; appliedIndex:5040; }","duration":"132.118659ms","start":"2026-07-02T05:12:10.885195Z","end":"2026-07-02T05:12:11.017313Z","steps":["trace[1151067267] 'read index received' (duration: 88.590704ms)","trace[1151067267] 'applied index is now lower than readState.Index' (duration: 43.527015ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:12:11.017425Z","caller":"traceutil/trace.go:171","msg":"trace[1447254167] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"129.465012ms","start":"2026-07-02T05:12:10.887928Z","end":"2026-07-02T05:12:11.017393Z","steps":["trace[1447254167] 'process raft request' (duration: 129.105057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:12:11.017532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.322257ms","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-07-02T05:12:11.017567Z","caller":"traceutil/trace.go:171","msg":"trace[184689480] 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:4862; }","duration":"132.38942ms","start":"2026-07-02T05:12:10.885166Z","end":"2026-07-02T05:12:11.017556Z","steps":["trace[184689480] 'agreement among raft nodes before linearized reading' (duration: 132.224383ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.128783Z","caller":"traceutil/trace.go:171","msg":"trace[2127096586] linearizableReadLoop","detail":"{readStateIndex:5044; appliedIndex:5043; }","duration":"105.783665ms","start":"2026-07-02T05:12:11.022975Z","end":"2026-07-02T05:12:11.128758Z","steps":["trace[2127096586] 'read index received' (duration: 95.840293ms)","trace[2127096586] 'applied index is now lower than readState.Index' (duration: 9.942282ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:12:11.128931Z","caller":"traceutil/trace.go:171","msg":"trace[1311772209] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"105.991234ms","start":"2026-07-02T05:12:11.02289Z","end":"2026-07-02T05:12:11.128881Z","steps":["trace[1311772209] 'process raft request' (duration: 96.010121ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:12:11.129268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.260626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17206"} {"level":"info","ts":"2026-07-02T05:12:11.12934Z","caller":"traceutil/trace.go:171","msg":"trace[1623600679] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4863; }","duration":"106.39288ms","start":"2026-07-02T05:12:11.022928Z","end":"2026-07-02T05:12:11.12932Z","steps":["trace[1623600679] 'agreement among raft nodes before linearized reading' (duration: 105.954162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:12:11.139663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.586052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-6c9be319-28f4-4d1f-9f55-7ca3b2b9a0c0\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-07-02T05:12:11.139749Z","caller":"traceutil/trace.go:171","msg":"trace[757615016] range","detail":"{range_begin:/registry/persistentvolumes/pvc-6c9be319-28f4-4d1f-9f55-7ca3b2b9a0c0; range_end:; response_count:1; response_revision:4867; }","duration":"116.718837ms","start":"2026-07-02T05:12:11.023014Z","end":"2026-07-02T05:12:11.139733Z","steps":["trace[757615016] 'agreement among raft nodes before linearized reading' (duration: 116.54241ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.139952Z","caller":"traceutil/trace.go:171","msg":"trace[716187780] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"116.908605ms","start":"2026-07-02T05:12:11.023028Z","end":"2026-07-02T05:12:11.139936Z","steps":["trace[716187780] 'process raft request' (duration: 116.30516ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.13998Z","caller":"traceutil/trace.go:171","msg":"trace[70108577] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"116.80587ms","start":"2026-07-02T05:12:11.023149Z","end":"2026-07-02T05:12:11.139955Z","steps":["trace[70108577] 'process raft request' (duration: 116.28597ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.139994Z","caller":"traceutil/trace.go:171","msg":"trace[682926834] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"116.739248ms","start":"2026-07-02T05:12:11.02323Z","end":"2026-07-02T05:12:11.13997Z","steps":["trace[682926834] 'process raft request' (duration: 116.227757ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.271117Z","caller":"traceutil/trace.go:171","msg":"trace[141888232] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"114.614793ms","start":"2026-07-02T05:12:11.156464Z","end":"2026-07-02T05:12:11.271079Z","steps":["trace[141888232] 'process raft request' (duration: 78.578226ms)","trace[141888232] 'compare' (duration: 35.8692ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:12:11.275263Z","caller":"traceutil/trace.go:171","msg":"trace[528089232] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"101.957901ms","start":"2026-07-02T05:12:11.17328Z","end":"2026-07-02T05:12:11.275238Z","steps":["trace[528089232] 'process raft request' (duration: 101.782084ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.275177Z","caller":"traceutil/trace.go:171","msg":"trace[1030645163] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"104.225704ms","start":"2026-07-02T05:12:11.170928Z","end":"2026-07-02T05:12:11.275153Z","steps":["trace[1030645163] 'process raft request' (duration: 104.013665ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.275809Z","caller":"traceutil/trace.go:171","msg":"trace[2129947180] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"102.440331ms","start":"2026-07-02T05:12:11.173356Z","end":"2026-07-02T05:12:11.275797Z","steps":["trace[2129947180] 'process raft request' (duration: 101.743613ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.276483Z","caller":"traceutil/trace.go:171","msg":"trace[1701932137] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"102.913299ms","start":"2026-07-02T05:12:11.173552Z","end":"2026-07-02T05:12:11.276466Z","steps":["trace[1701932137] 'process raft request' (duration: 102.195281ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:12:11.276996Z","caller":"traceutil/trace.go:171","msg":"trace[1848887626] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"102.038454ms","start":"2026-07-02T05:12:11.174946Z","end":"2026-07-02T05:12:11.276984Z","steps":["trace[1848887626] 'process raft request' (duration: 101.19174ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:13:25.586111Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2804} {"level":"info","ts":"2026-07-02T05:13:25.665345Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2804,"took":"77.869851ms","hash":3211952073,"current-db-size-bytes":54042624,"current-db-size":"54 MB","current-db-size-in-use-bytes":29175808,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-02T05:13:25.665411Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3211952073,"revision":2804,"compact-revision":-1} {"level":"info","ts":"2026-07-02T05:18:25.59683Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5479} {"level":"info","ts":"2026-07-02T05:18:25.677077Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5479,"took":"77.657571ms","hash":1519162183,"current-db-size-bytes":54042624,"current-db-size":"54 MB","current-db-size-in-use-bytes":18223104,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-02T05:18:25.677135Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1519162183,"revision":5479,"compact-revision":2804}