{"level":"warn","ts":"2026-07-08T05:09:21.311838Z","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-08T05:09:21.311925Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-08T05:09:21.311992Z","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-08T05:09:21.312002Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-07-08T05:09:21.312017Z","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-08T05:09:21.313274Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-07-08T05:09:21.313357Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-08T05:09:21.321201Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.368202ms"} {"level":"info","ts":"2026-07-08T05:09:21.333581Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-07-08T05:09:21.333677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T05:09:21.333702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-07-08T05:09:21.333715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T05:09:21.333728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-07-08T05:09:21.33377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-07-08T05:09:21.340443Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T05:09:21.341644Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T05:09:21.342691Z","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-08T05:09:21.344935Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T05:09:21.347469Z","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-08T05:09:21.347642Z","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-08T05:09:21.34772Z","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-08T05:09:21.34757Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T05:09:21.348357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-07-08T05:09:21.348525Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-07-08T05:09:21.351192Z","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-08T05:09:21.35169Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-07-08T05:09:21.351728Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-07-08T05:09:21.352363Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T05:09:21.352402Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T05:09:21.934283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T05:09:21.934366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T05:09:21.934399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-07-08T05:09:21.934649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-07-08T05:09:21.934674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-07-08T05:09:21.934692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-07-08T05:09:21.934785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-07-08T05:09:22.599718Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T05:09:22.599822Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T05:09:22.599705Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T05:09:22.600014Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T05:09:22.600194Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T05:09:22.600283Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T05:09:22.603962Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T05:09:22.605246Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-07-08T05:09:22.864031Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T05:09:22.864206Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T05:09:22.864279Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-08T05:09:22.8645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.187176ms","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-08T05:09:22.864596Z","caller":"traceutil/trace.go:171","msg":"trace[1565448720] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"216.328209ms","start":"2026-07-08T05:09:22.648257Z","end":"2026-07-08T05:09:22.864585Z","steps":["trace[1565448720] 'agreement among raft nodes before linearized reading' (duration: 216.096553ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:22.864297Z","caller":"traceutil/trace.go:171","msg":"trace[1069355962] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"215.976901ms","start":"2026-07-08T05:09:22.648271Z","end":"2026-07-08T05:09:22.864248Z","steps":["trace[1069355962] 'read index received' (duration: 215.451347ms)","trace[1069355962] 'applied index is now lower than readState.Index' (duration: 524.164µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:09:22.865166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.42146ms","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-08T05:09:22.865238Z","caller":"traceutil/trace.go:171","msg":"trace[1572322382] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"136.514282ms","start":"2026-07-08T05:09:22.728706Z","end":"2026-07-08T05:09:22.86522Z","steps":["trace[1572322382] 'agreement among raft nodes before linearized reading' (duration: 136.401209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.865282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.848967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T05:09:22.865376Z","caller":"traceutil/trace.go:171","msg":"trace[1241789307] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"113.00736ms","start":"2026-07-08T05:09:22.752348Z","end":"2026-07-08T05:09:22.865355Z","steps":["trace[1241789307] 'agreement among raft nodes before linearized reading' (duration: 112.801065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.865557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.208496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T05:09:22.865603Z","caller":"traceutil/trace.go:171","msg":"trace[1828965265] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"113.282578ms","start":"2026-07-08T05:09:22.752309Z","end":"2026-07-08T05:09:22.865592Z","steps":["trace[1828965265] 'agreement among raft nodes before linearized reading' (duration: 113.209876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.865709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.746272ms","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-08T05:09:22.865743Z","caller":"traceutil/trace.go:171","msg":"trace[1193434473] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"125.817754ms","start":"2026-07-08T05:09:22.739915Z","end":"2026-07-08T05:09:22.865733Z","steps":["trace[1193434473] 'agreement among raft nodes before linearized reading' (duration: 125.761373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.865955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.950871ms","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":"info","ts":"2026-07-08T05:09:22.866038Z","caller":"traceutil/trace.go:171","msg":"trace[1057355965] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"148.068913ms","start":"2026-07-08T05:09:22.717952Z","end":"2026-07-08T05:09:22.866021Z","steps":["trace[1057355965] 'agreement among raft nodes before linearized reading' (duration: 147.929099ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.866221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.667743ms","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":"info","ts":"2026-07-08T05:09:22.866273Z","caller":"traceutil/trace.go:171","msg":"trace[54808316] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"137.734184ms","start":"2026-07-08T05:09:22.728532Z","end":"2026-07-08T05:09:22.866267Z","steps":["trace[54808316] 'agreement among raft nodes before linearized reading' (duration: 137.668242ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.865994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.167054ms","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":"info","ts":"2026-07-08T05:09:22.866376Z","caller":"traceutil/trace.go:171","msg":"trace[447699173] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"126.578615ms","start":"2026-07-08T05:09:22.739782Z","end":"2026-07-08T05:09:22.86636Z","steps":["trace[447699173] 'agreement among raft nodes before linearized reading' (duration: 126.184534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.866396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.085146ms","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":"warn","ts":"2026-07-08T05:09:22.866391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.68762ms","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":"info","ts":"2026-07-08T05:09:22.866434Z","caller":"traceutil/trace.go:171","msg":"trace[1188081540] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"173.765672ms","start":"2026-07-08T05:09:22.692657Z","end":"2026-07-08T05:09:22.866423Z","steps":["trace[1188081540] 'agreement among raft nodes before linearized reading' (duration: 173.69247ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:22.866436Z","caller":"traceutil/trace.go:171","msg":"trace[1439413482] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"160.138117ms","start":"2026-07-08T05:09:22.706279Z","end":"2026-07-08T05:09:22.866417Z","steps":["trace[1439413482] 'agreement among raft nodes before linearized reading' (duration: 160.075455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.866317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.058325ms","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":"warn","ts":"2026-07-08T05:09:22.866531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.351041ms","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-08T05:09:22.866561Z","caller":"traceutil/trace.go:171","msg":"trace[387683139] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"148.415773ms","start":"2026-07-08T05:09:22.718136Z","end":"2026-07-08T05:09:22.866552Z","steps":["trace[387683139] 'agreement among raft nodes before linearized reading' (duration: 148.366561ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:22.866582Z","caller":"traceutil/trace.go:171","msg":"trace[979650273] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"160.446505ms","start":"2026-07-08T05:09:22.706126Z","end":"2026-07-08T05:09:22.866573Z","steps":["trace[979650273] 'agreement among raft nodes before linearized reading' (duration: 160.100626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:22.866967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.75517ms","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":"info","ts":"2026-07-08T05:09:22.86703Z","caller":"traceutil/trace.go:171","msg":"trace[1650530209] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"218.695741ms","start":"2026-07-08T05:09:22.648323Z","end":"2026-07-08T05:09:22.867019Z","steps":["trace[1650530209] 'agreement among raft nodes before linearized reading' (duration: 216.722379ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:23.073571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.017397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T05:09:23.073653Z","caller":"traceutil/trace.go:171","msg":"trace[722955111] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"129.14733ms","start":"2026-07-08T05:09:22.94449Z","end":"2026-07-08T05:09:23.073637Z","steps":["trace[722955111] 'count revisions from in-memory index tree' (duration: 128.944386ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:23.074311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.136882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T05:09:23.074395Z","caller":"traceutil/trace.go:171","msg":"trace[1695602437] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"116.267155ms","start":"2026-07-08T05:09:22.958105Z","end":"2026-07-08T05:09:23.074372Z","steps":["trace[1695602437] 'range keys from in-memory index tree' (duration: 116.06637ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:23.074467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.348967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-08T05:09:23.074552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.096259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T05:09:23.074567Z","caller":"traceutil/trace.go:171","msg":"trace[1688289096] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"116.535843ms","start":"2026-07-08T05:09:22.958009Z","end":"2026-07-08T05:09:23.074545Z","steps":["trace[1688289096] 'count revisions from in-memory index tree' (duration: 116.298896ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:23.07445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.781721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T05:09:23.074638Z","caller":"traceutil/trace.go:171","msg":"trace[388913457] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"104.13922ms","start":"2026-07-08T05:09:22.970445Z","end":"2026-07-08T05:09:23.074584Z","steps":["trace[388913457] 'range keys from in-memory index tree' (duration: 104.038427ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:23.074654Z","caller":"traceutil/trace.go:171","msg":"trace[1784792452] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"104.063158ms","start":"2026-07-08T05:09:22.970574Z","end":"2026-07-08T05:09:23.074637Z","steps":["trace[1784792452] 'count revisions from in-memory index tree' (duration: 103.673348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:23.075258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.270634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T05:09:23.075337Z","caller":"traceutil/trace.go:171","msg":"trace[518881683] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"130.730892ms","start":"2026-07-08T05:09:22.94459Z","end":"2026-07-08T05:09:23.075321Z","steps":["trace[518881683] 'range keys from in-memory index tree' (duration: 129.142031ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:30.184625Z","caller":"traceutil/trace.go:171","msg":"trace[1619905983] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"117.580669ms","start":"2026-07-08T05:09:30.067019Z","end":"2026-07-08T05:09:30.1846Z","steps":["trace[1619905983] 'process raft request' (duration: 117.414135ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:30.231686Z","caller":"traceutil/trace.go:171","msg":"trace[1485307714] linearizableReadLoop","detail":"{readStateIndex:300; appliedIndex:298; }","duration":"163.419453ms","start":"2026-07-08T05:09:30.068247Z","end":"2026-07-08T05:09:30.231667Z","steps":["trace[1485307714] 'read index received' (duration: 116.247945ms)","trace[1485307714] 'applied index is now lower than readState.Index' (duration: 47.170228ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:09:30.231972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.69519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-08T05:09:30.231981Z","caller":"traceutil/trace.go:171","msg":"trace[1420139009] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"164.51011ms","start":"2026-07-08T05:09:30.06741Z","end":"2026-07-08T05:09:30.23192Z","steps":["trace[1420139009] 'process raft request' (duration: 155.738882ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:30.232072Z","caller":"traceutil/trace.go:171","msg":"trace[1637680774] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:287; }","duration":"163.822793ms","start":"2026-07-08T05:09:30.068232Z","end":"2026-07-08T05:09:30.232055Z","steps":["trace[1637680774] 'agreement among raft nodes before linearized reading' (duration: 163.611347ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:50.627604Z","caller":"traceutil/trace.go:171","msg":"trace[53698731] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:450; }","duration":"283.894737ms","start":"2026-07-08T05:09:50.343657Z","end":"2026-07-08T05:09:50.627552Z","steps":["trace[53698731] 'read index received' (duration: 191.127923ms)","trace[53698731] 'applied index is now lower than readState.Index' (duration: 92.765184ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:09:50.627652Z","caller":"traceutil/trace.go:171","msg":"trace[155068035] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"308.022355ms","start":"2026-07-08T05:09:50.319598Z","end":"2026-07-08T05:09:50.62762Z","steps":["trace[155068035] 'process raft request' (duration: 215.280031ms)","trace[155068035] 'compare' (duration: 92.528008ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:09:50.627731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.066561ms","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-08T05:09:50.627791Z","caller":"traceutil/trace.go:171","msg":"trace[671628449] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:432; }","duration":"284.178504ms","start":"2026-07-08T05:09:50.343595Z","end":"2026-07-08T05:09:50.627774Z","steps":["trace[671628449] 'agreement among raft nodes before linearized reading' (duration: 284.084621ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:50.628388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:50.31958Z","time spent":"308.143547ms","remote":"127.0.0.1:45738","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-08T05:09:59.742701Z","caller":"traceutil/trace.go:171","msg":"trace[406248989] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"407.966146ms","start":"2026-07-08T05:09:59.334707Z","end":"2026-07-08T05:09:59.742673Z","steps":["trace[406248989] 'process raft request' (duration: 407.751771ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:59.742862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.334688Z","time spent":"408.103919ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T05:09:59.751095Z","caller":"traceutil/trace.go:171","msg":"trace[1269774170] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"416.104488ms","start":"2026-07-08T05:09:59.334946Z","end":"2026-07-08T05:09:59.751051Z","steps":["trace[1269774170] 'process raft request' (duration: 415.936953ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:59.751126Z","caller":"traceutil/trace.go:171","msg":"trace[1243575992] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"407.246758ms","start":"2026-07-08T05:09:59.343841Z","end":"2026-07-08T05:09:59.751088Z","steps":["trace[1243575992] 'process raft request' (duration: 407.155895ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:59.751167Z","caller":"traceutil/trace.go:171","msg":"trace[846185338] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"407.222007ms","start":"2026-07-08T05:09:59.343907Z","end":"2026-07-08T05:09:59.751129Z","steps":["trace[846185338] 'process raft request' (duration: 407.117054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:59.751366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.334938Z","time spent":"416.247192ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:09:59.751292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.343825Z","time spent":"407.36113ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T05:09:59.751455Z","caller":"traceutil/trace.go:171","msg":"trace[1961572644] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"396.081187ms","start":"2026-07-08T05:09:59.35532Z","end":"2026-07-08T05:09:59.751401Z","steps":["trace[1961572644] 'process raft request' (duration: 395.757978ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:59.751505Z","caller":"traceutil/trace.go:171","msg":"trace[1004610251] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"394.007793ms","start":"2026-07-08T05:09:59.357485Z","end":"2026-07-08T05:09:59.751493Z","steps":["trace[1004610251] 'process raft request' (duration: 393.629753ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:59.751541Z","caller":"traceutil/trace.go:171","msg":"trace[1975233983] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"391.322713ms","start":"2026-07-08T05:09:59.360207Z","end":"2026-07-08T05:09:59.75153Z","steps":["trace[1975233983] 'process raft request' (duration: 390.952973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:59.751601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.357461Z","time spent":"394.081074ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:09:59.751492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.343901Z","time spent":"407.465723ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:09:59.751631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.355279Z","time spent":"396.263211ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T05:09:59.751242Z","caller":"traceutil/trace.go:171","msg":"trace[1888421946] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"396.322073ms","start":"2026-07-08T05:09:59.354886Z","end":"2026-07-08T05:09:59.751208Z","steps":["trace[1888421946] 'process raft request' (duration: 396.167169ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:59.751669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.360193Z","time spent":"391.387024ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:09:59.75172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.354829Z","time spent":"396.868057ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T05:09:59.751748Z","caller":"traceutil/trace.go:171","msg":"trace[723043415] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"386.377734ms","start":"2026-07-08T05:09:59.365357Z","end":"2026-07-08T05:09:59.751734Z","steps":["trace[723043415] 'process raft request' (duration: 386.117718ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:09:59.751822Z","caller":"traceutil/trace.go:171","msg":"trace[1581539292] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"369.613448ms","start":"2026-07-08T05:09:59.3822Z","end":"2026-07-08T05:09:59.751813Z","steps":["trace[1581539292] 'process raft request' (duration: 369.396933ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:59.751827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.365344Z","time spent":"386.436926ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:09:59.751868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.382156Z","time spent":"369.69351ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T05:09:59.751782Z","caller":"traceutil/trace.go:171","msg":"trace[1138666194] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"416.766685ms","start":"2026-07-08T05:09:59.334986Z","end":"2026-07-08T05:09:59.751753Z","steps":["trace[1138666194] 'process raft request' (duration: 415.984374ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:09:59.751962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:09:59.334982Z","time spent":"416.95983ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T05:09:59.752095Z","caller":"traceutil/trace.go:171","msg":"trace[1699112349] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"259.814521ms","start":"2026-07-08T05:09:59.492262Z","end":"2026-07-08T05:09:59.752076Z","steps":["trace[1699112349] 'process raft request' (duration: 259.535124ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:10:06.135503Z","caller":"traceutil/trace.go:171","msg":"trace[607524661] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"508.672526ms","start":"2026-07-08T05:10:05.626803Z","end":"2026-07-08T05:10:06.135476Z","steps":["trace[607524661] 'process raft request' (duration: 507.63704ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:06.135683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:05.626767Z","time spent":"508.82449ms","remote":"127.0.0.1:45576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:10:06.18444Z","caller":"traceutil/trace.go:171","msg":"trace[1787554181] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:617; }","duration":"217.89633ms","start":"2026-07-08T05:10:05.966527Z","end":"2026-07-08T05:10:06.184423Z","steps":["trace[1787554181] 'read index received' (duration: 167.663713ms)","trace[1787554181] 'applied index is now lower than readState.Index' (duration: 50.231277ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:10:06.184518Z","caller":"traceutil/trace.go:171","msg":"trace[353512038] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"453.701117ms","start":"2026-07-08T05:10:05.730811Z","end":"2026-07-08T05:10:06.184512Z","steps":["trace[353512038] 'process raft request' (duration: 452.903616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:06.184593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:05.730772Z","time spent":"453.762548ms","remote":"127.0.0.1:45506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:10:06.184866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.300651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:10:06.185082Z","caller":"traceutil/trace.go:171","msg":"trace[1750457317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"218.464395ms","start":"2026-07-08T05:10:05.966482Z","end":"2026-07-08T05:10:06.184947Z","steps":["trace[1750457317] 'agreement among raft nodes before linearized reading' (duration: 218.28497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:06.703678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.076011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:10:06.703861Z","caller":"traceutil/trace.go:171","msg":"trace[24571525] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"504.791566ms","start":"2026-07-08T05:10:06.199053Z","end":"2026-07-08T05:10:06.703844Z","steps":["trace[24571525] 'process raft request' (duration: 504.729875ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:10:06.703843Z","caller":"traceutil/trace.go:171","msg":"trace[1667281545] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"515.964997ms","start":"2026-07-08T05:10:06.187831Z","end":"2026-07-08T05:10:06.703796Z","steps":["trace[1667281545] 'process raft request' (duration: 129.87147ms)","trace[1667281545] 'compare' (duration: 384.731711ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:10:06.703908Z","caller":"traceutil/trace.go:171","msg":"trace[1748441131] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"515.230398ms","start":"2026-07-08T05:10:06.188654Z","end":"2026-07-08T05:10:06.703885Z","steps":["trace[1748441131] 'read index received' (duration: 129.149611ms)","trace[1748441131] 'applied index is now lower than readState.Index' (duration: 386.078347ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:10:06.703922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.199047Z","time spent":"504.849918ms","remote":"127.0.0.1:45988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:10:06.704007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.187822Z","time spent":"516.09326ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:10:06.704209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.11661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bfwk2\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-08T05:10:06.704302Z","caller":"traceutil/trace.go:171","msg":"trace[1703842495] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bfwk2; range_end:; response_count:1; response_revision:596; }","duration":"232.197723ms","start":"2026-07-08T05:10:06.472051Z","end":"2026-07-08T05:10:06.704249Z","steps":["trace[1703842495] 'agreement among raft nodes before linearized reading' (duration: 232.041069ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:06.704406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.479422ms","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-08T05:10:06.70446Z","caller":"traceutil/trace.go:171","msg":"trace[1478079112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"327.560854ms","start":"2026-07-08T05:10:06.376886Z","end":"2026-07-08T05:10:06.704447Z","steps":["trace[1478079112] 'agreement among raft nodes before linearized reading' (duration: 327.141303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:06.704496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.37685Z","time spent":"327.638006ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T05:10:06.704679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.015209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-08T05:10:06.704719Z","caller":"traceutil/trace.go:171","msg":"trace[440001639] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:596; }","duration":"516.06615ms","start":"2026-07-08T05:10:06.188644Z","end":"2026-07-08T05:10:06.70471Z","steps":["trace[440001639] 'agreement among raft nodes before linearized reading' (duration: 515.32162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:06.704741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.18864Z","time spent":"516.09472ms","remote":"127.0.0.1:45506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-07-08T05:10:07.219215Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398341899362581031,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T05:10:07.734398Z","caller":"traceutil/trace.go:171","msg":"trace[1370572387] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.022464567s","start":"2026-07-08T05:10:06.711352Z","end":"2026-07-08T05:10:07.733817Z","steps":["trace[1370572387] 'process raft request' (duration: 925.813102ms)","trace[1370572387] 'compare' (duration: 96.331897ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:10:07.734617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.711329Z","time spent":"1.023176645s","remote":"127.0.0.1:45738","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-08T05:10:08.220394Z","caller":"traceutil/trace.go:171","msg":"trace[1961914223] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"1.501661236s","start":"2026-07-08T05:10:06.718705Z","end":"2026-07-08T05:10:08.220366Z","steps":["trace[1961914223] 'read index received' (duration: 918.47381ms)","trace[1961914223] 'applied index is now lower than readState.Index' (duration: 583.185826ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:10:08.220465Z","caller":"traceutil/trace.go:171","msg":"trace[1649335961] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.498577076s","start":"2026-07-08T05:10:06.721853Z","end":"2026-07-08T05:10:08.22043Z","steps":["trace[1649335961] 'process raft request' (duration: 1.497736454s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:08.220557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.50183503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:10:08.2206Z","caller":"traceutil/trace.go:171","msg":"trace[605001179] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:598; }","duration":"1.501925093s","start":"2026-07-08T05:10:06.718663Z","end":"2026-07-08T05:10:08.220588Z","steps":["trace[605001179] 'agreement among raft nodes before linearized reading' (duration: 1.501839171s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:08.220639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.718644Z","time spent":"1.501986515s","remote":"127.0.0.1:45712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-07-08T05:10:08.22065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.72184Z","time spent":"1.4987068s","remote":"127.0.0.1:45668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:10:08.220762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.457831926s","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-08T05:10:08.220859Z","caller":"traceutil/trace.go:171","msg":"trace[1574008883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"1.457966029s","start":"2026-07-08T05:10:06.762871Z","end":"2026-07-08T05:10:08.220837Z","steps":["trace[1574008883] 'agreement among raft nodes before linearized reading' (duration: 1.457811535s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:08.220941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.762858Z","time spent":"1.458069682s","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T05:10:08.220979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.254095904s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:10:08.221014Z","caller":"traceutil/trace.go:171","msg":"trace[923922711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"1.254130595s","start":"2026-07-08T05:10:06.966874Z","end":"2026-07-08T05:10:08.221004Z","steps":["trace[923922711] 'agreement among raft nodes before linearized reading' (duration: 1.254076573s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:08.221054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.966811Z","time spent":"1.254236468s","remote":"127.0.0.1:45468","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-08T05:10:08.221136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.402723352s","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-08T05:10:08.221193Z","caller":"traceutil/trace.go:171","msg":"trace[1259906410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"1.402863285s","start":"2026-07-08T05:10:06.818314Z","end":"2026-07-08T05:10:08.221177Z","steps":["trace[1259906410] 'agreement among raft nodes before linearized reading' (duration: 1.402715731s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:08.221249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:06.818291Z","time spent":"1.402943838s","remote":"127.0.0.1:45738","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-08T05:10:09.819519Z","caller":"traceutil/trace.go:171","msg":"trace[2088486926] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"183.269899ms","start":"2026-07-08T05:10:09.636219Z","end":"2026-07-08T05:10:09.819489Z","steps":["trace[2088486926] 'process raft request' (duration: 182.92412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:12.924235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.751916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:10:12.924407Z","caller":"traceutil/trace.go:171","msg":"trace[1177065558] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"410.43681ms","start":"2026-07-08T05:10:12.513946Z","end":"2026-07-08T05:10:12.924382Z","steps":["trace[1177065558] 'process raft request' (duration: 227.443678ms)","trace[1177065558] 'compare' (duration: 182.53712ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:10:12.924493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:12.51392Z","time spent":"410.538403ms","remote":"127.0.0.1:45558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T05:10:12.9481Z","caller":"traceutil/trace.go:171","msg":"trace[2146419834] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"414.004163ms","start":"2026-07-08T05:10:12.534045Z","end":"2026-07-08T05:10:12.948049Z","steps":["trace[2146419834] 'process raft request' (duration: 413.239293ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:12.948287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:12.533987Z","time spent":"414.219969ms","remote":"127.0.0.1:45668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18322,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:10:12.948816Z","caller":"traceutil/trace.go:171","msg":"trace[210197211] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:696; }","duration":"175.579349ms","start":"2026-07-08T05:10:12.773149Z","end":"2026-07-08T05:10:12.948728Z","steps":["trace[210197211] 'read index received' (duration: 173.884825ms)","trace[210197211] 'applied index is now lower than readState.Index' (duration: 1.605761ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:10:12.94895Z","caller":"traceutil/trace.go:171","msg":"trace[107741749] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"285.847218ms","start":"2026-07-08T05:10:12.662886Z","end":"2026-07-08T05:10:12.948734Z","steps":["trace[107741749] 'process raft request' (duration: 285.088488ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:12.949436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.271996ms","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-08T05:10:12.949492Z","caller":"traceutil/trace.go:171","msg":"trace[1674544042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:673; }","duration":"176.369589ms","start":"2026-07-08T05:10:12.773097Z","end":"2026-07-08T05:10:12.949466Z","steps":["trace[1674544042] 'agreement among raft nodes before linearized reading' (duration: 176.142133ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:12.949553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.652534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-07-08T05:10:12.949608Z","caller":"traceutil/trace.go:171","msg":"trace[556653681] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:673; }","duration":"114.725936ms","start":"2026-07-08T05:10:12.834856Z","end":"2026-07-08T05:10:12.949582Z","steps":["trace[556653681] 'agreement among raft nodes before linearized reading' (duration: 114.401188ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:10:12.954409Z","caller":"traceutil/trace.go:171","msg":"trace[246343454] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"416.929159ms","start":"2026-07-08T05:10:12.530513Z","end":"2026-07-08T05:10:12.947442Z","steps":["trace[246343454] 'process raft request' (duration: 416.623761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:12.954585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:12.530489Z","time spent":"423.985622ms","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:10:16.512641Z","caller":"traceutil/trace.go:171","msg":"trace[686961596] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"109.430068ms","start":"2026-07-08T05:10:16.403186Z","end":"2026-07-08T05:10:16.512616Z","steps":["trace[686961596] 'process raft request' (duration: 109.303124ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:10:17.61878Z","caller":"traceutil/trace.go:171","msg":"trace[1230160884] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"108.718809ms","start":"2026-07-08T05:10:17.510035Z","end":"2026-07-08T05:10:17.618754Z","steps":["trace[1230160884] 'process raft request' (duration: 108.522334ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:10:18.483628Z","caller":"traceutil/trace.go:171","msg":"trace[1474932215] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"392.005291ms","start":"2026-07-08T05:10:18.091591Z","end":"2026-07-08T05:10:18.483596Z","steps":["trace[1474932215] 'process raft request' (duration: 391.803626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:18.483837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:18.091565Z","time spent":"392.142525ms","remote":"127.0.0.1:45668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:10:18.595309Z","caller":"traceutil/trace.go:171","msg":"trace[247302301] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"100.188837ms","start":"2026-07-08T05:10:18.495088Z","end":"2026-07-08T05:10:18.595277Z","steps":["trace[247302301] 'process raft request' (duration: 71.256974ms)","trace[247302301] 'compare' (duration: 28.500822ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:10:23.898539Z","caller":"traceutil/trace.go:171","msg":"trace[1188683213] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"128.860783ms","start":"2026-07-08T05:10:23.769648Z","end":"2026-07-08T05:10:23.898509Z","steps":["trace[1188683213] 'process raft request' (duration: 128.608116ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:10:24.017853Z","caller":"traceutil/trace.go:171","msg":"trace[628685723] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"111.476001ms","start":"2026-07-08T05:10:23.906282Z","end":"2026-07-08T05:10:24.017758Z","steps":["trace[628685723] 'process raft request' (duration: 89.52923ms)","trace[628685723] 'compare' (duration: 21.705875ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:10:24.978093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.40341ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:10:24.978283Z","caller":"traceutil/trace.go:171","msg":"trace[1167328459] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:761; }","duration":"393.577815ms","start":"2026-07-08T05:10:24.584654Z","end":"2026-07-08T05:10:24.978232Z","steps":["trace[1167328459] 'range keys from in-memory index tree' (duration: 393.38542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:24.978158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.445862ms","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-08T05:10:24.978544Z","caller":"traceutil/trace.go:171","msg":"trace[119124306] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:761; }","duration":"428.876804ms","start":"2026-07-08T05:10:24.549652Z","end":"2026-07-08T05:10:24.978528Z","steps":["trace[119124306] 'range keys from in-memory index tree' (duration: 428.228436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:24.978599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:24.54962Z","time spent":"428.961706ms","remote":"127.0.0.1:45738","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-08T05:10:25.078649Z","caller":"traceutil/trace.go:171","msg":"trace[1453436272] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"488.933999ms","start":"2026-07-08T05:10:24.589701Z","end":"2026-07-08T05:10:25.078636Z","steps":["trace[1453436272] 'process raft request' (duration: 488.60867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:25.078851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:24.589675Z","time spent":"489.033681ms","remote":"127.0.0.1:45712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:10:25.078992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.548763ms","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-08T05:10:25.079101Z","caller":"traceutil/trace.go:171","msg":"trace[213674429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:762; }","duration":"422.702687ms","start":"2026-07-08T05:10:24.656375Z","end":"2026-07-08T05:10:25.079077Z","steps":["trace[213674429] 'agreement among raft nodes before linearized reading' (duration: 422.400049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:25.079151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:10:24.65635Z","time spent":"422.7889ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T05:10:25.078581Z","caller":"traceutil/trace.go:171","msg":"trace[1071657221] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:790; }","duration":"422.137052ms","start":"2026-07-08T05:10:24.656421Z","end":"2026-07-08T05:10:25.078558Z","steps":["trace[1071657221] 'read index received' (duration: 422.02855ms)","trace[1071657221] 'applied index is now lower than readState.Index' (duration: 107.752µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:10:25.079737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.011466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:10:25.07988Z","caller":"traceutil/trace.go:171","msg":"trace[1052652635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"114.18549ms","start":"2026-07-08T05:10:24.965669Z","end":"2026-07-08T05:10:25.079855Z","steps":["trace[1052652635] 'agreement among raft nodes before linearized reading' (duration: 113.995115ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:10:29.067384Z","caller":"traceutil/trace.go:171","msg":"trace[1460073338] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"167.782802ms","start":"2026-07-08T05:10:28.899576Z","end":"2026-07-08T05:10:29.067358Z","steps":["trace[1460073338] 'process raft request' (duration: 150.358053ms)","trace[1460073338] 'compare' (duration: 16.957896ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:10:29.067423Z","caller":"traceutil/trace.go:171","msg":"trace[197747705] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:841; }","duration":"115.506446ms","start":"2026-07-08T05:10:28.951891Z","end":"2026-07-08T05:10:29.067397Z","steps":["trace[197747705] 'read index received' (duration: 98.157389ms)","trace[197747705] 'applied index is now lower than readState.Index' (duration: 17.348077ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:10:29.067577Z","caller":"traceutil/trace.go:171","msg":"trace[1713692018] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"144.30131ms","start":"2026-07-08T05:10:28.923266Z","end":"2026-07-08T05:10:29.067567Z","steps":["trace[1713692018] 'process raft request' (duration: 144.015423ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:29.067854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.964185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:10:29.067903Z","caller":"traceutil/trace.go:171","msg":"trace[1795217409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"104.061248ms","start":"2026-07-08T05:10:28.963829Z","end":"2026-07-08T05:10:29.06789Z","steps":["trace[1795217409] 'agreement among raft nodes before linearized reading' (duration: 103.977456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:10:29.068162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.253967ms","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:1050268"} {"level":"info","ts":"2026-07-08T05:10:29.068235Z","caller":"traceutil/trace.go:171","msg":"trace[765592362] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:812; }","duration":"116.36837ms","start":"2026-07-08T05:10:28.951849Z","end":"2026-07-08T05:10:29.068217Z","steps":["trace[765592362] 'agreement among raft nodes before linearized reading' (duration: 115.829455ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:00.367214Z","caller":"traceutil/trace.go:171","msg":"trace[1962677810] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"289.29569ms","start":"2026-07-08T05:11:00.077878Z","end":"2026-07-08T05:11:00.367174Z","steps":["trace[1962677810] 'process raft request' (duration: 289.166807ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:01.203044Z","caller":"traceutil/trace.go:171","msg":"trace[1109753402] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1024; }","duration":"236.909471ms","start":"2026-07-08T05:11:00.966108Z","end":"2026-07-08T05:11:01.203017Z","steps":["trace[1109753402] 'read index received' (duration: 230.234682ms)","trace[1109753402] 'applied index is now lower than readState.Index' (duration: 6.673579ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:01.203237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.082986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:11:01.203399Z","caller":"traceutil/trace.go:171","msg":"trace[1200920649] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:986; }","duration":"237.291822ms","start":"2026-07-08T05:11:00.966078Z","end":"2026-07-08T05:11:01.20337Z","steps":["trace[1200920649] 'agreement among raft nodes before linearized reading' (duration: 237.023574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:24.359453Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398341899362582030,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T05:11:24.860222Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398341899362582030,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T05:11:24.949221Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.193422535s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T05:11:24.949569Z","caller":"traceutil/trace.go:171","msg":"trace[975453575] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1104; }","duration":"1.090431795s","start":"2026-07-08T05:11:23.859114Z","end":"2026-07-08T05:11:24.949546Z","steps":["trace[975453575] 'read index received' (duration: 1.09025029s)","trace[975453575] 'applied index is now lower than readState.Index' (duration: 180.654µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:24.949706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090586119s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:11:24.949696Z","caller":"traceutil/trace.go:171","msg":"trace[916834360] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"1.193985109s","start":"2026-07-08T05:11:23.755671Z","end":"2026-07-08T05:11:24.949656Z","steps":["trace[916834360] 'process raft request' (duration: 1.193765724s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:24.949914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.407143ms","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-08T05:11:24.949949Z","caller":"traceutil/trace.go:171","msg":"trace[1446835727] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1062; }","duration":"379.475255ms","start":"2026-07-08T05:11:24.570465Z","end":"2026-07-08T05:11:24.94994Z","steps":["trace[1446835727] 'agreement among raft nodes before linearized reading' (duration: 379.420954ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:24.949999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:24.570445Z","time spent":"379.545197ms","remote":"127.0.0.1:45672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":29,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-07-08T05:11:24.949983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.950518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-08T05:11:24.950034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.611052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T05:11:24.949865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.44556ms","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-08T05:11:24.95008Z","caller":"traceutil/trace.go:171","msg":"trace[1253429420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1062; }","duration":"983.695324ms","start":"2026-07-08T05:11:23.966371Z","end":"2026-07-08T05:11:24.950066Z","steps":["trace[1253429420] 'agreement among raft nodes before linearized reading' (duration: 983.627943ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:24.95008Z","caller":"traceutil/trace.go:171","msg":"trace[599770456] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1062; }","duration":"805.102722ms","start":"2026-07-08T05:11:24.144948Z","end":"2026-07-08T05:11:24.950051Z","steps":["trace[599770456] 'agreement among raft nodes before linearized reading' (duration: 804.854575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:24.950111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:23.96635Z","time spent":"983.754626ms","remote":"127.0.0.1:45468","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-08T05:11:24.950129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:24.144924Z","time spent":"805.195264ms","remote":"127.0.0.1:45992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":94,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-07-08T05:11:24.950152Z","caller":"traceutil/trace.go:171","msg":"trace[556223789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1062; }","duration":"474.731157ms","start":"2026-07-08T05:11:24.475379Z","end":"2026-07-08T05:11:24.95011Z","steps":["trace[556223789] 'agreement among raft nodes before linearized reading' (duration: 474.396788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:24.950191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.48544ms","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":"warn","ts":"2026-07-08T05:11:24.950286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:24.475359Z","time spent":"474.879151ms","remote":"127.0.0.1:45738","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-08T05:11:24.950306Z","caller":"traceutil/trace.go:171","msg":"trace[136649279] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1062; }","duration":"886.666555ms","start":"2026-07-08T05:11:24.063614Z","end":"2026-07-08T05:11:24.95028Z","steps":["trace[136649279] 'agreement among raft nodes before linearized reading' (duration: 886.277075ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:24.94975Z","caller":"traceutil/trace.go:171","msg":"trace[1052905306] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1062; }","duration":"1.090698742s","start":"2026-07-08T05:11:23.859039Z","end":"2026-07-08T05:11:24.949738Z","steps":["trace[1052905306] 'agreement among raft nodes before linearized reading' (duration: 1.090595549s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:24.950368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:24.06359Z","time spent":"886.765698ms","remote":"127.0.0.1:45738","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-08T05:11:24.950495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:23.755646Z","time spent":"1.194269327s","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:11:24.950536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:23.859003Z","time spent":"1.09136591s","remote":"127.0.0.1:56850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-08T05:11:25.582273Z","caller":"traceutil/trace.go:171","msg":"trace[1668827021] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"166.725604ms","start":"2026-07-08T05:11:25.415518Z","end":"2026-07-08T05:11:25.582244Z","steps":["trace[1668827021] 'process raft request' (duration: 166.537918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:26.039252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.461643ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:11:26.039384Z","caller":"traceutil/trace.go:171","msg":"trace[769298058] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"419.539833ms","start":"2026-07-08T05:11:25.619826Z","end":"2026-07-08T05:11:26.039366Z","steps":["trace[769298058] 'read index received' (duration: 48.833743ms)","trace[769298058] 'applied index is now lower than readState.Index' (duration: 370.70474ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:26.03948Z","caller":"traceutil/trace.go:171","msg":"trace[1641467816] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"422.496473ms","start":"2026-07-08T05:11:25.616969Z","end":"2026-07-08T05:11:26.039465Z","steps":["trace[1641467816] 'process raft request' (duration: 51.68113ms)","trace[1641467816] 'compare' (duration: 370.310769ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:26.039548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:25.616951Z","time spent":"422.564974ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:11:26.039701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.30167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-08T05:11:26.039767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.930633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-08T05:11:26.039778Z","caller":"traceutil/trace.go:171","msg":"trace[81830955] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1066; }","duration":"315.425683ms","start":"2026-07-08T05:11:25.724332Z","end":"2026-07-08T05:11:26.039758Z","steps":["trace[81830955] 'agreement among raft nodes before linearized reading' (duration: 315.28968ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:26.039815Z","caller":"traceutil/trace.go:171","msg":"trace[1649986968] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:1066; }","duration":"420.020686ms","start":"2026-07-08T05:11:25.619781Z","end":"2026-07-08T05:11:26.039801Z","steps":["trace[1649986968] 'agreement among raft nodes before linearized reading' (duration: 419.837571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:26.03982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:25.72431Z","time spent":"315.499255ms","remote":"127.0.0.1:46006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-07-08T05:11:26.039783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.05676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-08T05:11:26.039858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:25.619753Z","time spent":"420.096978ms","remote":"127.0.0.1:45506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.156\" "} {"level":"info","ts":"2026-07-08T05:11:26.039888Z","caller":"traceutil/trace.go:171","msg":"trace[1646000878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1066; }","duration":"374.205043ms","start":"2026-07-08T05:11:25.665661Z","end":"2026-07-08T05:11:26.039866Z","steps":["trace[1646000878] 'agreement among raft nodes before linearized reading' (duration: 373.882945ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:26.039955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:25.665648Z","time spent":"374.296576ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T05:11:26.266111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.200893ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-07-08T05:11:26.266464Z","caller":"traceutil/trace.go:171","msg":"trace[792307528] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"221.037514ms","start":"2026-07-08T05:11:26.045401Z","end":"2026-07-08T05:11:26.266439Z","steps":["trace[792307528] 'process raft request' (duration: 220.829459ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:27.142885Z","caller":"traceutil/trace.go:171","msg":"trace[1694777712] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1112; }","duration":"165.85993ms","start":"2026-07-08T05:11:26.977003Z","end":"2026-07-08T05:11:27.142863Z","steps":["trace[1694777712] 'read index received' (duration: 165.599693ms)","trace[1694777712] 'applied index is now lower than readState.Index' (duration: 259.147µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:27.142921Z","caller":"traceutil/trace.go:171","msg":"trace[1550313247] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"186.689911ms","start":"2026-07-08T05:11:26.956201Z","end":"2026-07-08T05:11:27.14289Z","steps":["trace[1550313247] 'process raft request' (duration: 186.483606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:27.143135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.101358ms","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-08T05:11:27.143175Z","caller":"traceutil/trace.go:171","msg":"trace[1953445970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1069; }","duration":"166.20939ms","start":"2026-07-08T05:11:26.976956Z","end":"2026-07-08T05:11:27.143165Z","steps":["trace[1953445970] 'agreement among raft nodes before linearized reading' (duration: 166.039565ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:27.143666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.492787ms","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-08T05:11:27.143826Z","caller":"traceutil/trace.go:171","msg":"trace[1937025246] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1069; }","duration":"147.709183ms","start":"2026-07-08T05:11:26.996093Z","end":"2026-07-08T05:11:27.143802Z","steps":["trace[1937025246] 'agreement among raft nodes before linearized reading' (duration: 147.023184ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.470023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.858843ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:11:28.47015Z","caller":"traceutil/trace.go:171","msg":"trace[1460429952] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"1.322937915s","start":"2026-07-08T05:11:27.14719Z","end":"2026-07-08T05:11:28.470127Z","steps":["trace[1460429952] 'process raft request' (duration: 532.859189ms)","trace[1460429952] 'compare' (duration: 788.533555ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:28.470227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:27.147169Z","time spent":"1.323014828s","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:11:28.543843Z","caller":"traceutil/trace.go:171","msg":"trace[1976539324] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1113; }","duration":"1.075176104s","start":"2026-07-08T05:11:27.468644Z","end":"2026-07-08T05:11:28.54382Z","steps":["trace[1976539324] 'read index received' (duration: 211.433056ms)","trace[1976539324] 'applied index is now lower than readState.Index' (duration: 863.741858ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:28.543862Z","caller":"traceutil/trace.go:171","msg":"trace[1331295317] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"1.396174776s","start":"2026-07-08T05:11:27.147656Z","end":"2026-07-08T05:11:28.543831Z","steps":["trace[1331295317] 'process raft request' (duration: 1.395992051s)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:28.543916Z","caller":"traceutil/trace.go:171","msg":"trace[17551079] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"1.075528943s","start":"2026-07-08T05:11:27.468365Z","end":"2026-07-08T05:11:28.543894Z","steps":["trace[17551079] 'process raft request' (duration: 1.07541342s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.544008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:27.147639Z","time spent":"1.396293658s","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:11:28.544054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:27.468343Z","time spent":"1.075635817s","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:11:28.544085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.07539088s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T05:11:28.544177Z","caller":"traceutil/trace.go:171","msg":"trace[1155887767] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1072; }","duration":"1.075545504s","start":"2026-07-08T05:11:27.468617Z","end":"2026-07-08T05:11:28.544162Z","steps":["trace[1155887767] 'agreement among raft nodes before linearized reading' (duration: 1.075324598s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.544278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:27.468607Z","time spent":"1.075627987s","remote":"127.0.0.1:45522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-07-08T05:11:28.544499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.025243ms","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-08T05:11:28.544551Z","caller":"traceutil/trace.go:171","msg":"trace[2130658293] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1072; }","duration":"501.109556ms","start":"2026-07-08T05:11:28.043431Z","end":"2026-07-08T05:11:28.54454Z","steps":["trace[2130658293] 'agreement among raft nodes before linearized reading' (duration: 500.963182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.544582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:28.043415Z","time spent":"501.160338ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T05:11:28.544577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.499877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:11:28.544633Z","caller":"traceutil/trace.go:171","msg":"trace[43257181] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1072; }","duration":"578.585269ms","start":"2026-07-08T05:11:27.966033Z","end":"2026-07-08T05:11:28.544618Z","steps":["trace[43257181] 'agreement among raft nodes before linearized reading' (duration: 578.489686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.544685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:27.966016Z","time spent":"578.655701ms","remote":"127.0.0.1:45474","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-08T05:11:28.544677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.450705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:11:28.544751Z","caller":"traceutil/trace.go:171","msg":"trace[621121570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1072; }","duration":"810.562188ms","start":"2026-07-08T05:11:27.734169Z","end":"2026-07-08T05:11:28.544731Z","steps":["trace[621121570] 'agreement among raft nodes before linearized reading' (duration: 810.452365ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.544741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.325331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-08T05:11:28.54481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:27.734149Z","time spent":"810.651411ms","remote":"127.0.0.1:45468","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-08T05:11:28.544879Z","caller":"traceutil/trace.go:171","msg":"trace[1169283499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1072; }","duration":"273.562537ms","start":"2026-07-08T05:11:28.271286Z","end":"2026-07-08T05:11:28.544849Z","steps":["trace[1169283499] 'agreement among raft nodes before linearized reading' (duration: 273.195547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.544987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.086075ms","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-08T05:11:28.545173Z","caller":"traceutil/trace.go:171","msg":"trace[2023954322] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1072; }","duration":"958.752733ms","start":"2026-07-08T05:11:27.586388Z","end":"2026-07-08T05:11:28.54514Z","steps":["trace[2023954322] 'agreement among raft nodes before linearized reading' (duration: 957.991902ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.54633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:27.586338Z","time spent":"959.952845ms","remote":"127.0.0.1:45738","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-08T05:11:28.760059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.788869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:11:28.760268Z","caller":"traceutil/trace.go:171","msg":"trace[394211800] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"210.091898ms","start":"2026-07-08T05:11:28.550148Z","end":"2026-07-08T05:11:28.76024Z","steps":["trace[394211800] 'process raft request' (duration: 99.976441ms)","trace[394211800] 'compare' (duration: 109.398498ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:28.939637Z","caller":"traceutil/trace.go:171","msg":"trace[374234965] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"388.140601ms","start":"2026-07-08T05:11:28.551472Z","end":"2026-07-08T05:11:28.939613Z","steps":["trace[374234965] 'process raft request' (duration: 388.09977ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:28.939755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:28.551463Z","time spent":"388.230774ms","remote":"127.0.0.1:45738","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-08T05:11:28.939955Z","caller":"traceutil/trace.go:171","msg":"trace[2122005769] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"389.495398ms","start":"2026-07-08T05:11:28.550428Z","end":"2026-07-08T05:11:28.939923Z","steps":["trace[2122005769] 'process raft request' (duration: 370.366145ms)","trace[2122005769] 'compare' (duration: 18.424214ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:28.940116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:28.550404Z","time spent":"389.624302ms","remote":"127.0.0.1:45738","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-08T05:11:30.724925Z","caller":"traceutil/trace.go:171","msg":"trace[279196741] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"175.350728ms","start":"2026-07-08T05:11:30.54955Z","end":"2026-07-08T05:11:30.724901Z","steps":["trace[279196741] 'read index received' (duration: 175.137113ms)","trace[279196741] 'applied index is now lower than readState.Index' (duration: 212.715µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:30.725121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.552824ms","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-08T05:11:30.725157Z","caller":"traceutil/trace.go:171","msg":"trace[959292581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1078; }","duration":"175.648157ms","start":"2026-07-08T05:11:30.549499Z","end":"2026-07-08T05:11:30.725147Z","steps":["trace[959292581] 'agreement among raft nodes before linearized reading' (duration: 175.489953ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:30.725282Z","caller":"traceutil/trace.go:171","msg":"trace[1247266038] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"247.083928ms","start":"2026-07-08T05:11:30.478174Z","end":"2026-07-08T05:11:30.725257Z","steps":["trace[1247266038] 'process raft request' (duration: 246.593065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:31.26485Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398341899362582071,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T05:11:31.363394Z","caller":"traceutil/trace.go:171","msg":"trace[561728745] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"634.154908ms","start":"2026-07-08T05:11:30.729216Z","end":"2026-07-08T05:11:31.363371Z","steps":["trace[561728745] 'process raft request' (duration: 633.924392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:31.363547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:30.729197Z","time spent":"634.276221ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:11:31.648921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.910664ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-08T05:11:31.64926Z","caller":"traceutil/trace.go:171","msg":"trace[1468222692] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"477.235863ms","start":"2026-07-08T05:11:31.172003Z","end":"2026-07-08T05:11:31.649239Z","steps":["trace[1468222692] 'process raft request' (duration: 477.003477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:31.649386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:31.171986Z","time spent":"477.321926ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:11:31.649284Z","caller":"traceutil/trace.go:171","msg":"trace[2003507530] linearizableReadLoop","detail":"{readStateIndex:1125; appliedIndex:1122; }","duration":"884.536327ms","start":"2026-07-08T05:11:30.764727Z","end":"2026-07-08T05:11:31.649264Z","steps":["trace[2003507530] 'read index received' (duration: 598.31373ms)","trace[2003507530] 'applied index is now lower than readState.Index' (duration: 286.221127ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:31.949047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004214235s","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-08T05:11:31.949155Z","caller":"traceutil/trace.go:171","msg":"trace[2048959348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1080; }","duration":"1.004343408s","start":"2026-07-08T05:11:30.944781Z","end":"2026-07-08T05:11:31.949125Z","steps":["trace[2048959348] 'agreement among raft nodes before linearized reading' (duration: 705.229579ms)","trace[2048959348] 'range keys from in-memory index tree' (duration: 298.848692ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:31.949219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:30.944773Z","time spent":"1.004435421s","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T05:11:31.949242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.390758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:11:31.949302Z","caller":"traceutil/trace.go:171","msg":"trace[1255939905] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1080; }","duration":"789.503581ms","start":"2026-07-08T05:11:31.159782Z","end":"2026-07-08T05:11:31.949286Z","steps":["trace[1255939905] 'agreement among raft nodes before linearized reading' (duration: 490.215578ms)","trace[1255939905] 'count revisions from in-memory index tree' (duration: 299.201311ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:31.949314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004804981s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-08T05:11:31.94935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:31.159763Z","time spent":"789.573542ms","remote":"127.0.0.1:44572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-08T05:11:31.9494Z","caller":"traceutil/trace.go:171","msg":"trace[1757150426] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1080; }","duration":"1.004894513s","start":"2026-07-08T05:11:30.94448Z","end":"2026-07-08T05:11:31.949375Z","steps":["trace[1757150426] 'agreement among raft nodes before linearized reading' (duration: 705.488097ms)","trace[1757150426] 'range keys from in-memory index tree' (duration: 299.219372ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:31.949428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184681253s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-08T05:11:31.949461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:30.94442Z","time spent":"1.005027746s","remote":"127.0.0.1:45738","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-08T05:11:31.949427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.65621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:11:31.949597Z","caller":"traceutil/trace.go:171","msg":"trace[267448910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1080; }","duration":"984.893687ms","start":"2026-07-08T05:11:30.964682Z","end":"2026-07-08T05:11:31.949576Z","steps":["trace[267448910] 'agreement among raft nodes before linearized reading' (duration: 685.325886ms)","trace[267448910] 'range keys from in-memory index tree' (duration: 299.308714ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:31.949678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:30.964669Z","time spent":"984.99768ms","remote":"127.0.0.1:45468","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-08T05:11:31.949504Z","caller":"traceutil/trace.go:171","msg":"trace[343929588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1080; }","duration":"1.184809526s","start":"2026-07-08T05:11:30.764674Z","end":"2026-07-08T05:11:31.949484Z","steps":["trace[343929588] 'agreement among raft nodes before linearized reading' (duration: 884.835324ms)","trace[343929588] 'range keys from in-memory index tree' (duration: 299.764636ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:31.949823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:30.764652Z","time spent":"1.185145336s","remote":"127.0.0.1:45738","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-08T05:11:32.066821Z","caller":"traceutil/trace.go:171","msg":"trace[21731568] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"112.07206ms","start":"2026-07-08T05:11:31.95472Z","end":"2026-07-08T05:11:32.066792Z","steps":["trace[21731568] 'process raft request' (duration: 111.880595ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:32.110685Z","caller":"traceutil/trace.go:171","msg":"trace[1767582725] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"155.472955ms","start":"2026-07-08T05:11:31.955187Z","end":"2026-07-08T05:11:32.11066Z","steps":["trace[1767582725] 'process raft request' (duration: 155.427834ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:32.110772Z","caller":"traceutil/trace.go:171","msg":"trace[266047764] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"155.841756ms","start":"2026-07-08T05:11:31.954887Z","end":"2026-07-08T05:11:32.110729Z","steps":["trace[266047764] 'process raft request' (duration: 155.602339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:34.488474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.697734ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:11:34.488829Z","caller":"traceutil/trace.go:171","msg":"trace[164814525] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"358.209582ms","start":"2026-07-08T05:11:34.13037Z","end":"2026-07-08T05:11:34.48858Z","steps":["trace[164814525] 'process raft request' (duration: 125.105847ms)","trace[164814525] 'compare' (duration: 232.581321ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:34.488925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:34.130354Z","time spent":"358.52736ms","remote":"127.0.0.1:45738","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-08T05:11:38.888097Z","caller":"traceutil/trace.go:171","msg":"trace[1286461123] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"101.605715ms","start":"2026-07-08T05:11:38.786459Z","end":"2026-07-08T05:11:38.888065Z","steps":["trace[1286461123] 'process raft request' (duration: 101.447651ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:39.037345Z","caller":"traceutil/trace.go:171","msg":"trace[862432008] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"141.428812ms","start":"2026-07-08T05:11:38.895886Z","end":"2026-07-08T05:11:39.037314Z","steps":["trace[862432008] 'process raft request' (duration: 75.584994ms)","trace[862432008] 'compare' (duration: 65.648403ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:45.992152Z","caller":"traceutil/trace.go:171","msg":"trace[16714645] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"166.072895ms","start":"2026-07-08T05:11:45.826046Z","end":"2026-07-08T05:11:45.992119Z","steps":["trace[16714645] 'process raft request' (duration: 135.274634ms)","trace[16714645] 'compare' (duration: 30.616266ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:46.172945Z","caller":"traceutil/trace.go:171","msg":"trace[1302813791] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"110.184719ms","start":"2026-07-08T05:11:46.062729Z","end":"2026-07-08T05:11:46.172914Z","steps":["trace[1302813791] 'process raft request' (duration: 109.993324ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:46.421005Z","caller":"traceutil/trace.go:171","msg":"trace[434246202] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"160.983976ms","start":"2026-07-08T05:11:46.259984Z","end":"2026-07-08T05:11:46.420968Z","steps":["trace[434246202] 'process raft request' (duration: 139.762367ms)","trace[434246202] 'compare' (duration: 21.050405ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:46.421106Z","caller":"traceutil/trace.go:171","msg":"trace[194386356] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"101.528742ms","start":"2026-07-08T05:11:46.319557Z","end":"2026-07-08T05:11:46.421086Z","steps":["trace[194386356] 'process raft request' (duration: 101.489601ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:46.421322Z","caller":"traceutil/trace.go:171","msg":"trace[620775279] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"108.456192ms","start":"2026-07-08T05:11:46.312859Z","end":"2026-07-08T05:11:46.421315Z","steps":["trace[620775279] 'process raft request' (duration: 108.106352ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:46.421485Z","caller":"traceutil/trace.go:171","msg":"trace[1338482809] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"107.811484ms","start":"2026-07-08T05:11:46.31366Z","end":"2026-07-08T05:11:46.421472Z","steps":["trace[1338482809] 'process raft request' (duration: 107.337071ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:46.421518Z","caller":"traceutil/trace.go:171","msg":"trace[1337346028] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"157.369338ms","start":"2026-07-08T05:11:46.264141Z","end":"2026-07-08T05:11:46.421511Z","steps":["trace[1337346028] 'process raft request' (duration: 156.766552ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:46.421605Z","caller":"traceutil/trace.go:171","msg":"trace[491157557] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1217; }","duration":"114.99425ms","start":"2026-07-08T05:11:46.306597Z","end":"2026-07-08T05:11:46.421591Z","steps":["trace[491157557] 'read index received' (duration: 93.028611ms)","trace[491157557] 'applied index is now lower than readState.Index' (duration: 21.964879ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:46.421753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.566919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:9311"} {"level":"info","ts":"2026-07-08T05:11:46.421769Z","caller":"traceutil/trace.go:171","msg":"trace[872242240] range","detail":"{range_begin:/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:1172; }","duration":"162.616541ms","start":"2026-07-08T05:11:46.259148Z","end":"2026-07-08T05:11:46.421764Z","steps":["trace[872242240] 'agreement among raft nodes before linearized reading' (duration: 162.533879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:46.421796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.937012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T05:11:46.421856Z","caller":"traceutil/trace.go:171","msg":"trace[126979637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1172; }","duration":"162.015525ms","start":"2026-07-08T05:11:46.259816Z","end":"2026-07-08T05:11:46.421831Z","steps":["trace[126979637] 'agreement among raft nodes before linearized reading' (duration: 161.849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:46.421886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.189982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j9jnm\" ","response":"range_response_count:1 size:10774"} {"level":"info","ts":"2026-07-08T05:11:46.421904Z","caller":"traceutil/trace.go:171","msg":"trace[939750674] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j9jnm; range_end:; response_count:1; response_revision:1172; }","duration":"109.245004ms","start":"2026-07-08T05:11:46.312653Z","end":"2026-07-08T05:11:46.421898Z","steps":["trace[939750674] 'agreement among raft nodes before linearized reading' (duration: 109.183722ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:46.685598Z","caller":"traceutil/trace.go:171","msg":"trace[443057011] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"253.501093ms","start":"2026-07-08T05:11:46.432086Z","end":"2026-07-08T05:11:46.685587Z","steps":["trace[443057011] 'process raft request' (duration: 253.38966ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:46.685583Z","caller":"traceutil/trace.go:171","msg":"trace[2020413308] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1224; }","duration":"169.714075ms","start":"2026-07-08T05:11:46.515843Z","end":"2026-07-08T05:11:46.685557Z","steps":["trace[2020413308] 'read index received' (duration: 168.233215ms)","trace[2020413308] 'applied index is now lower than readState.Index' (duration: 1.47979ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:46.685599Z","caller":"traceutil/trace.go:171","msg":"trace[205451197] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"253.924125ms","start":"2026-07-08T05:11:46.431641Z","end":"2026-07-08T05:11:46.685565Z","steps":["trace[205451197] 'process raft request' (duration: 252.444554ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:46.685813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.8933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-07-08T05:11:46.685884Z","caller":"traceutil/trace.go:171","msg":"trace[1045191323] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:1176; }","duration":"169.982493ms","start":"2026-07-08T05:11:46.515883Z","end":"2026-07-08T05:11:46.685866Z","steps":["trace[1045191323] 'agreement among raft nodes before linearized reading' (duration: 169.819678ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:46.685928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.205115ms","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-08T05:11:46.68595Z","caller":"traceutil/trace.go:171","msg":"trace[1007746337] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1176; }","duration":"119.260407ms","start":"2026-07-08T05:11:46.566683Z","end":"2026-07-08T05:11:46.685943Z","steps":["trace[1007746337] 'agreement among raft nodes before linearized reading' (duration: 119.218696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:46.685952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.617613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:754"} {"level":"info","ts":"2026-07-08T05:11:46.686009Z","caller":"traceutil/trace.go:171","msg":"trace[1961995072] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:1176; }","duration":"169.683254ms","start":"2026-07-08T05:11:46.516312Z","end":"2026-07-08T05:11:46.685995Z","steps":["trace[1961995072] 'agreement among raft nodes before linearized reading' (duration: 169.566771ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:46.685889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.53675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-07-08T05:11:46.686092Z","caller":"traceutil/trace.go:171","msg":"trace[830816481] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:1176; }","duration":"169.740376ms","start":"2026-07-08T05:11:46.516338Z","end":"2026-07-08T05:11:46.686079Z","steps":["trace[830816481] 'agreement among raft nodes before linearized reading' (duration: 169.510269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:46.685833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.969622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:754"} {"level":"info","ts":"2026-07-08T05:11:46.686184Z","caller":"traceutil/trace.go:171","msg":"trace[612423188] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:1176; }","duration":"170.374083ms","start":"2026-07-08T05:11:46.515803Z","end":"2026-07-08T05:11:46.686177Z","steps":["trace[612423188] 'agreement among raft nodes before linearized reading' (duration: 169.88506ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:46.87174Z","caller":"traceutil/trace.go:171","msg":"trace[1777574888] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"181.967729ms","start":"2026-07-08T05:11:46.689749Z","end":"2026-07-08T05:11:46.871717Z","steps":["trace[1777574888] 'process raft request' (duration: 96.576507ms)","trace[1777574888] 'compare' (duration: 85.282099ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:47.147493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.652644ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:11:47.147645Z","caller":"traceutil/trace.go:171","msg":"trace[400436336] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"226.536927ms","start":"2026-07-08T05:11:46.92107Z","end":"2026-07-08T05:11:47.147607Z","steps":["trace[400436336] 'process raft request' (duration: 75.693137ms)","trace[400436336] 'compare' (duration: 150.49648ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:47.703962Z","caller":"traceutil/trace.go:171","msg":"trace[957732925] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1229; }","duration":"203.643041ms","start":"2026-07-08T05:11:47.500286Z","end":"2026-07-08T05:11:47.703929Z","steps":["trace[957732925] 'read index received' (duration: 203.448296ms)","trace[957732925] 'applied index is now lower than readState.Index' (duration: 193.335µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:47.704302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.988431ms","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-08T05:11:47.704341Z","caller":"traceutil/trace.go:171","msg":"trace[1888848079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1180; }","duration":"204.078873ms","start":"2026-07-08T05:11:47.500249Z","end":"2026-07-08T05:11:47.704328Z","steps":["trace[1888848079] 'agreement among raft nodes before linearized reading' (duration: 203.808626ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:47.704706Z","caller":"traceutil/trace.go:171","msg":"trace[2123311185] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"278.197538ms","start":"2026-07-08T05:11:47.426496Z","end":"2026-07-08T05:11:47.704693Z","steps":["trace[2123311185] 'process raft request' (duration: 277.268983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:47.968002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.195016ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:11:47.968166Z","caller":"traceutil/trace.go:171","msg":"trace[756881362] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"228.356227ms","start":"2026-07-08T05:11:47.739791Z","end":"2026-07-08T05:11:47.968147Z","steps":["trace[756881362] 'process raft request' (duration: 228.305085ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:47.968509Z","caller":"traceutil/trace.go:171","msg":"trace[1026301986] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"259.561368ms","start":"2026-07-08T05:11:47.708933Z","end":"2026-07-08T05:11:47.968494Z","steps":["trace[1026301986] 'process raft request' (duration: 91.801877ms)","trace[1026301986] 'compare' (duration: 167.088703ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:47.968673Z","caller":"traceutil/trace.go:171","msg":"trace[1866221990] linearizableReadLoop","detail":"{readStateIndex:1231; appliedIndex:1230; }","duration":"235.879142ms","start":"2026-07-08T05:11:47.732781Z","end":"2026-07-08T05:11:47.96866Z","steps":["trace[1866221990] 'read index received' (duration: 67.973796ms)","trace[1866221990] 'applied index is now lower than readState.Index' (duration: 167.904296ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:47.968866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.078587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:11:47.968903Z","caller":"traceutil/trace.go:171","msg":"trace[1146296366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1182; }","duration":"236.140729ms","start":"2026-07-08T05:11:47.732751Z","end":"2026-07-08T05:11:47.968892Z","steps":["trace[1146296366] 'agreement among raft nodes before linearized reading' (duration: 236.083557ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:48.586417Z","caller":"traceutil/trace.go:171","msg":"trace[1471369142] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"148.345681ms","start":"2026-07-08T05:11:48.438045Z","end":"2026-07-08T05:11:48.586391Z","steps":["trace[1471369142] 'process raft request' (duration: 148.208267ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:48.760286Z","caller":"traceutil/trace.go:171","msg":"trace[751201642] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"167.734609ms","start":"2026-07-08T05:11:48.592525Z","end":"2026-07-08T05:11:48.760259Z","steps":["trace[751201642] 'process raft request' (duration: 131.14162ms)","trace[751201642] 'compare' (duration: 36.472346ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:11:49.085447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.479423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:11:49.085508Z","caller":"traceutil/trace.go:171","msg":"trace[2066167115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1185; }","duration":"119.583365ms","start":"2026-07-08T05:11:48.965913Z","end":"2026-07-08T05:11:49.085496Z","steps":["trace[2066167115] 'range keys from in-memory index tree' (duration: 119.419681ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:49.086475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.843978ms","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-08T05:11:49.086605Z","caller":"traceutil/trace.go:171","msg":"trace[214861551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1185; }","duration":"211.025523ms","start":"2026-07-08T05:11:48.875554Z","end":"2026-07-08T05:11:49.08658Z","steps":["trace[214861551] 'range keys from in-memory index tree' (duration: 210.625742ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:49.220504Z","caller":"traceutil/trace.go:171","msg":"trace[407632884] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"127.734279ms","start":"2026-07-08T05:11:49.092743Z","end":"2026-07-08T05:11:49.220477Z","steps":["trace[407632884] 'process raft request' (duration: 121.969351ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:49.765374Z","caller":"traceutil/trace.go:171","msg":"trace[1359122778] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"233.948499ms","start":"2026-07-08T05:11:49.531404Z","end":"2026-07-08T05:11:49.765352Z","steps":["trace[1359122778] 'process raft request' (duration: 233.830796ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:51.479727Z","caller":"traceutil/trace.go:171","msg":"trace[184635122] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1245; }","duration":"249.295558ms","start":"2026-07-08T05:11:51.230412Z","end":"2026-07-08T05:11:51.479708Z","steps":["trace[184635122] 'read index received' (duration: 249.199256ms)","trace[184635122] 'applied index is now lower than readState.Index' (duration: 95.522µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:51.479842Z","caller":"traceutil/trace.go:171","msg":"trace[1801894632] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"250.556023ms","start":"2026-07-08T05:11:51.229256Z","end":"2026-07-08T05:11:51.479812Z","steps":["trace[1801894632] 'process raft request' (duration: 250.337497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:51.479874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.455192ms","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-08T05:11:51.480055Z","caller":"traceutil/trace.go:171","msg":"trace[1994231372] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1195; }","duration":"249.684638ms","start":"2026-07-08T05:11:51.230361Z","end":"2026-07-08T05:11:51.480045Z","steps":["trace[1994231372] 'agreement among raft nodes before linearized reading' (duration: 249.415271ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:11:52.804416Z","caller":"traceutil/trace.go:171","msg":"trace[2115033142] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1249; }","duration":"198.935353ms","start":"2026-07-08T05:11:52.605458Z","end":"2026-07-08T05:11:52.804393Z","steps":["trace[2115033142] 'read index received' (duration: 198.741158ms)","trace[2115033142] 'applied index is now lower than readState.Index' (duration: 193.235µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:52.804528Z","caller":"traceutil/trace.go:171","msg":"trace[1777313709] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"462.636335ms","start":"2026-07-08T05:11:52.341851Z","end":"2026-07-08T05:11:52.804488Z","steps":["trace[1777313709] 'process raft request' (duration: 462.373818ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:52.804611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.140959ms","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-08T05:11:52.804643Z","caller":"traceutil/trace.go:171","msg":"trace[14000798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1199; }","duration":"199.218041ms","start":"2026-07-08T05:11:52.605415Z","end":"2026-07-08T05:11:52.804633Z","steps":["trace[14000798] 'agreement among raft nodes before linearized reading' (duration: 199.066537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:52.804731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:52.341833Z","time spent":"462.801849ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:11:53.946387Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.136181109s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T05:11:53.946735Z","caller":"traceutil/trace.go:171","msg":"trace[1797051146] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"461.948996ms","start":"2026-07-08T05:11:53.484762Z","end":"2026-07-08T05:11:53.946711Z","steps":["trace[1797051146] 'read index received' (duration: 461.815102ms)","trace[1797051146] 'applied index is now lower than readState.Index' (duration: 132.664µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:11:53.946813Z","caller":"traceutil/trace.go:171","msg":"trace[211078626] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"1.136769476s","start":"2026-07-08T05:11:52.810034Z","end":"2026-07-08T05:11:53.946804Z","steps":["trace[211078626] 'process raft request' (duration: 1.136537559s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:53.946912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:52.810002Z","time spent":"1.136829376s","remote":"127.0.0.1:45738","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-08T05:11:53.947061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.427934ms","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-08T05:11:53.947107Z","caller":"traceutil/trace.go:171","msg":"trace[1574615472] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1200; }","duration":"445.498607ms","start":"2026-07-08T05:11:53.501596Z","end":"2026-07-08T05:11:53.947094Z","steps":["trace[1574615472] 'agreement among raft nodes before linearized reading' (duration: 445.329292ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:53.947141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:53.501585Z","time spent":"445.548648ms","remote":"127.0.0.1:45738","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-08T05:11:53.947159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.400498ms","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-08T05:11:53.947182Z","caller":"traceutil/trace.go:171","msg":"trace[1803815114] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1200; }","duration":"462.46928ms","start":"2026-07-08T05:11:53.484706Z","end":"2026-07-08T05:11:53.947175Z","steps":["trace[1803815114] 'agreement among raft nodes before linearized reading' (duration: 462.415358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:11:53.9472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:11:53.484682Z","time spent":"462.514021ms","remote":"127.0.0.1:45738","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-08T05:12:05.020389Z","caller":"traceutil/trace.go:171","msg":"trace[1720891204] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"152.878665ms","start":"2026-07-08T05:12:04.867485Z","end":"2026-07-08T05:12:05.020364Z","steps":["trace[1720891204] 'process raft request' (duration: 152.752372ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:07.23468Z","caller":"traceutil/trace.go:171","msg":"trace[707512091] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"206.49706ms","start":"2026-07-08T05:12:07.028158Z","end":"2026-07-08T05:12:07.234655Z","steps":["trace[707512091] 'process raft request' (duration: 206.309915ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.52501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.543085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T05:12:08.525066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027211953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:12:08.525101Z","caller":"traceutil/trace.go:171","msg":"trace[1766320714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1245; }","duration":"792.695129ms","start":"2026-07-08T05:12:07.732377Z","end":"2026-07-08T05:12:08.525072Z","steps":["trace[1766320714] 'range keys from in-memory index tree' (duration: 792.448542ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:08.525125Z","caller":"traceutil/trace.go:171","msg":"trace[746299473] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1245; }","duration":"1.027319736s","start":"2026-07-08T05:12:07.497791Z","end":"2026-07-08T05:12:08.52511Z","steps":["trace[746299473] 'count revisions from in-memory index tree' (duration: 1.027133932s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.525153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:07.497768Z","time spent":"1.027379268s","remote":"127.0.0.1:37068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-07-08T05:12:08.525157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:07.732357Z","time spent":"792.788081ms","remote":"127.0.0.1:45468","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-08T05:12:08.525217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.549026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-08T05:12:08.525273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104081372s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T05:12:08.525271Z","caller":"traceutil/trace.go:171","msg":"trace[72917867] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1245; }","duration":"505.645329ms","start":"2026-07-08T05:12:08.01961Z","end":"2026-07-08T05:12:08.525256Z","steps":["trace[72917867] 'range keys from in-memory index tree' (duration: 505.370312ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.525319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:08.019589Z","time spent":"505.719551ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T05:12:08.525319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"999.575178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:12:08.525409Z","caller":"traceutil/trace.go:171","msg":"trace[846981174] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1245; }","duration":"999.698242ms","start":"2026-07-08T05:12:07.525698Z","end":"2026-07-08T05:12:08.525397Z","steps":["trace[846981174] 'count revisions from in-memory index tree' (duration: 999.528517ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.525442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:07.525687Z","time spent":"999.745923ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-07-08T05:12:08.525502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.012331ms","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-08T05:12:08.525519Z","caller":"traceutil/trace.go:171","msg":"trace[102305757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1245; }","duration":"498.057402ms","start":"2026-07-08T05:12:08.027457Z","end":"2026-07-08T05:12:08.525514Z","steps":["trace[102305757] 'range keys from in-memory index tree' (duration: 497.914178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.525532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:08.027442Z","time spent":"498.087073ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T05:12:08.52529Z","caller":"traceutil/trace.go:171","msg":"trace[1528124499] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1245; }","duration":"1.104139705s","start":"2026-07-08T05:12:07.421146Z","end":"2026-07-08T05:12:08.525286Z","steps":["trace[1528124499] 'count revisions from in-memory index tree' (duration: 1.104006861s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.525733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:07.42112Z","time spent":"1.104607487s","remote":"127.0.0.1:45908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-08T05:12:08.525747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.535194ms","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-08T05:12:08.525786Z","caller":"traceutil/trace.go:171","msg":"trace[959158531] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1245; }","duration":"491.595146ms","start":"2026-07-08T05:12:08.03418Z","end":"2026-07-08T05:12:08.525775Z","steps":["trace[959158531] 'range keys from in-memory index tree' (duration: 491.421971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.525816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:08.034169Z","time spent":"491.639447ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-08T05:12:08.542612Z","caller":"traceutil/trace.go:171","msg":"trace[970338939] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"499.043068ms","start":"2026-07-08T05:12:08.043551Z","end":"2026-07-08T05:12:08.542594Z","steps":["trace[970338939] 'process raft request' (duration: 498.926875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.542745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.904006ms","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-08T05:12:08.542773Z","caller":"traceutil/trace.go:171","msg":"trace[2089403391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1246; }","duration":"468.971488ms","start":"2026-07-08T05:12:08.073795Z","end":"2026-07-08T05:12:08.542766Z","steps":["trace[2089403391] 'agreement among raft nodes before linearized reading' (duration: 468.869605ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.542791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:08.073772Z","time spent":"469.014189ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T05:12:08.542738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:08.043535Z","time spent":"499.138522ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:12:08.542646Z","caller":"traceutil/trace.go:171","msg":"trace[333748642] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1300; }","duration":"468.790173ms","start":"2026-07-08T05:12:08.073847Z","end":"2026-07-08T05:12:08.542637Z","steps":["trace[333748642] 'read index received' (duration: 468.785013ms)","trace[333748642] 'applied index is now lower than readState.Index' (duration: 4µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:12:08.722209Z","caller":"traceutil/trace.go:171","msg":"trace[1938465110] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"175.312878ms","start":"2026-07-08T05:12:08.546874Z","end":"2026-07-08T05:12:08.722187Z","steps":["trace[1938465110] 'process raft request' (duration: 175.274777ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:08.72246Z","caller":"traceutil/trace.go:171","msg":"trace[1742955388] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"192.530127ms","start":"2026-07-08T05:12:08.529895Z","end":"2026-07-08T05:12:08.722425Z","steps":["trace[1742955388] 'process raft request' (duration: 192.172838ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:08.722525Z","caller":"traceutil/trace.go:171","msg":"trace[1462685938] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"191.790838ms","start":"2026-07-08T05:12:08.530718Z","end":"2026-07-08T05:12:08.722509Z","steps":["trace[1462685938] 'process raft request' (duration: 191.388717ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:08.72274Z","caller":"traceutil/trace.go:171","msg":"trace[1944228167] linearizableReadLoop","detail":"{readStateIndex:1303; appliedIndex:1300; }","duration":"179.864822ms","start":"2026-07-08T05:12:08.542858Z","end":"2026-07-08T05:12:08.722723Z","steps":["trace[1944228167] 'read index received' (duration: 100.624358ms)","trace[1944228167] 'applied index is now lower than readState.Index' (duration: 79.237794ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:12:08.722804Z","caller":"traceutil/trace.go:171","msg":"trace[974821870] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"193.288748ms","start":"2026-07-08T05:12:08.52942Z","end":"2026-07-08T05:12:08.722709Z","steps":["trace[974821870] 'process raft request' (duration: 113.991443ms)","trace[974821870] 'compare' (duration: 78.536684ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:12:08.722862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.81675ms","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-08T05:12:08.722931Z","caller":"traceutil/trace.go:171","msg":"trace[2020291104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1250; }","duration":"603.905563ms","start":"2026-07-08T05:12:08.119008Z","end":"2026-07-08T05:12:08.722913Z","steps":["trace[2020291104] 'agreement among raft nodes before linearized reading' (duration: 603.782329ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:08.722987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:08.118944Z","time spent":"604.026875ms","remote":"127.0.0.1:56902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-07-08T05:12:10.886938Z","caller":"traceutil/trace.go:171","msg":"trace[1967800853] linearizableReadLoop","detail":"{readStateIndex:1330; appliedIndex:1328; }","duration":"155.027184ms","start":"2026-07-08T05:12:10.731885Z","end":"2026-07-08T05:12:10.886913Z","steps":["trace[1967800853] 'read index received' (duration: 80.127468ms)","trace[1967800853] 'applied index is now lower than readState.Index' (duration: 74.898596ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:12:10.887075Z","caller":"traceutil/trace.go:171","msg":"trace[1559230431] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"156.065932ms","start":"2026-07-08T05:12:10.730996Z","end":"2026-07-08T05:12:10.887062Z","steps":["trace[1559230431] 'process raft request' (duration: 120.250754ms)","trace[1559230431] 'compare' (duration: 35.5241ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:12:10.887254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.737295ms","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-08T05:12:10.887354Z","caller":"traceutil/trace.go:171","msg":"trace[626685636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1275; }","duration":"154.862649ms","start":"2026-07-08T05:12:10.732472Z","end":"2026-07-08T05:12:10.887335Z","steps":["trace[626685636] 'agreement among raft nodes before linearized reading' (duration: 154.654024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:10.887555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.649501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T05:12:10.887601Z","caller":"traceutil/trace.go:171","msg":"trace[342945697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1275; }","duration":"155.730193ms","start":"2026-07-08T05:12:10.73186Z","end":"2026-07-08T05:12:10.88759Z","steps":["trace[342945697] 'agreement among raft nodes before linearized reading' (duration: 155.582519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:11.378703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.030338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:12:11.378787Z","caller":"traceutil/trace.go:171","msg":"trace[444273911] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1278; }","duration":"220.132851ms","start":"2026-07-08T05:12:11.158636Z","end":"2026-07-08T05:12:11.378768Z","steps":["trace[444273911] 'count revisions from in-memory index tree' (duration: 219.954447ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:11.379217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.686556ms","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-08T05:12:11.379263Z","caller":"traceutil/trace.go:171","msg":"trace[1200501862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1278; }","duration":"131.773498ms","start":"2026-07-08T05:12:11.247477Z","end":"2026-07-08T05:12:11.37925Z","steps":["trace[1200501862] 'range keys from in-memory index tree' (duration: 131.523412ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:11.610903Z","caller":"traceutil/trace.go:171","msg":"trace[2012929770] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"227.986646ms","start":"2026-07-08T05:12:11.38289Z","end":"2026-07-08T05:12:11.610876Z","steps":["trace[2012929770] 'process raft request' (duration: 227.851003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:11.835997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.994142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T05:12:11.836084Z","caller":"traceutil/trace.go:171","msg":"trace[1614117428] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1279; }","duration":"133.143236ms","start":"2026-07-08T05:12:11.702921Z","end":"2026-07-08T05:12:11.836065Z","steps":["trace[1614117428] 'count revisions from in-memory index tree' (duration: 132.909409ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:12.784553Z","caller":"traceutil/trace.go:171","msg":"trace[1081465633] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"231.216495ms","start":"2026-07-08T05:12:12.553309Z","end":"2026-07-08T05:12:12.784525Z","steps":["trace[1081465633] 'process raft request' (duration: 231.071751ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:13.121083Z","caller":"traceutil/trace.go:171","msg":"trace[1778455781] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"302.140421ms","start":"2026-07-08T05:12:12.81892Z","end":"2026-07-08T05:12:13.12106Z","steps":["trace[1778455781] 'process raft request' (duration: 213.404408ms)","trace[1778455781] 'compare' (duration: 88.486686ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:12:13.121031Z","caller":"traceutil/trace.go:171","msg":"trace[1361388485] linearizableReadLoop","detail":"{readStateIndex:1337; appliedIndex:1336; }","duration":"230.372972ms","start":"2026-07-08T05:12:12.890633Z","end":"2026-07-08T05:12:13.121006Z","steps":["trace[1361388485] 'read index received' (duration: 141.719801ms)","trace[1361388485] 'applied index is now lower than readState.Index' (duration: 88.651951ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:12:13.121319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:12.818909Z","time spent":"302.336126ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:12:13.121476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.798153ms","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-08T05:12:13.12155Z","caller":"traceutil/trace.go:171","msg":"trace[2129101859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1282; }","duration":"204.864195ms","start":"2026-07-08T05:12:12.91666Z","end":"2026-07-08T05:12:13.121525Z","steps":["trace[2129101859] 'agreement among raft nodes before linearized reading' (duration: 204.715201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:13.121756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.114962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-08T05:12:13.12176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.430989ms","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-08T05:12:13.121799Z","caller":"traceutil/trace.go:171","msg":"trace[1916558148] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1282; }","duration":"231.214515ms","start":"2026-07-08T05:12:12.890574Z","end":"2026-07-08T05:12:13.121788Z","steps":["trace[1916558148] 'agreement among raft nodes before linearized reading' (duration: 230.64825ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:13.121816Z","caller":"traceutil/trace.go:171","msg":"trace[477528100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1282; }","duration":"172.526461ms","start":"2026-07-08T05:12:12.949274Z","end":"2026-07-08T05:12:13.1218Z","steps":["trace[477528100] 'agreement among raft nodes before linearized reading' (duration: 172.357777ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:13.591039Z","caller":"traceutil/trace.go:171","msg":"trace[418670338] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"275.35106ms","start":"2026-07-08T05:12:13.315664Z","end":"2026-07-08T05:12:13.591015Z","steps":["trace[418670338] 'process raft request' (duration: 275.189125ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:13.722058Z","caller":"traceutil/trace.go:171","msg":"trace[2091823107] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1343; }","duration":"241.598847ms","start":"2026-07-08T05:12:13.480437Z","end":"2026-07-08T05:12:13.722036Z","steps":["trace[2091823107] 'read index received' (duration: 110.434956ms)","trace[2091823107] 'applied index is now lower than readState.Index' (duration: 131.162951ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:12:13.722187Z","caller":"traceutil/trace.go:171","msg":"trace[483913794] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"374.112236ms","start":"2026-07-08T05:12:13.348063Z","end":"2026-07-08T05:12:13.722175Z","steps":["trace[483913794] 'process raft request' (duration: 373.787567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:13.722294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:13.348043Z","time spent":"374.184648ms","remote":"127.0.0.1:45558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:12:13.722721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.193936ms","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-08T05:12:13.722767Z","caller":"traceutil/trace.go:171","msg":"trace[539341393] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1291; }","duration":"107.279239ms","start":"2026-07-08T05:12:13.615477Z","end":"2026-07-08T05:12:13.722756Z","steps":["trace[539341393] 'agreement among raft nodes before linearized reading' (duration: 107.117114ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:13.722954Z","caller":"traceutil/trace.go:171","msg":"trace[1309079781] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"372.542173ms","start":"2026-07-08T05:12:13.350401Z","end":"2026-07-08T05:12:13.722943Z","steps":["trace[1309079781] 'process raft request' (duration: 371.577476ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:13.723031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:13.350392Z","time spent":"372.597995ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:12:13.723162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.678326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T05:12:13.723238Z","caller":"traceutil/trace.go:171","msg":"trace[1254807009] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1291; }","duration":"242.81915ms","start":"2026-07-08T05:12:13.480402Z","end":"2026-07-08T05:12:13.723221Z","steps":["trace[1254807009] 'agreement among raft nodes before linearized reading' (duration: 242.664586ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:14.329116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.142176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:12:14.329206Z","caller":"traceutil/trace.go:171","msg":"trace[2022482776] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1346; }","duration":"364.215416ms","start":"2026-07-08T05:12:13.964976Z","end":"2026-07-08T05:12:14.329191Z","steps":["trace[2022482776] 'read index received' (duration: 234.918005ms)","trace[2022482776] 'applied index is now lower than readState.Index' (duration: 129.296251ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:12:14.32926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.287349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:12:14.329283Z","caller":"traceutil/trace.go:171","msg":"trace[602983180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1292; }","duration":"364.32909ms","start":"2026-07-08T05:12:13.964945Z","end":"2026-07-08T05:12:14.329274Z","steps":["trace[602983180] 'agreement among raft nodes before linearized reading' (duration: 364.287148ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:14.329277Z","caller":"traceutil/trace.go:171","msg":"trace[883259860] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"602.770742ms","start":"2026-07-08T05:12:13.726477Z","end":"2026-07-08T05:12:14.329248Z","steps":["trace[883259860] 'process raft request' (duration: 473.403209ms)","trace[883259860] 'compare' (duration: 129.054174ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:12:14.329311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:13.964931Z","time spent":"364.374011ms","remote":"127.0.0.1:45468","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-08T05:12:14.329405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:13.726455Z","time spent":"602.876785ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:12:21.152379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.768024ms","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-08T05:12:21.152449Z","caller":"traceutil/trace.go:171","msg":"trace[2008413436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1326; }","duration":"798.891007ms","start":"2026-07-08T05:12:20.353543Z","end":"2026-07-08T05:12:21.152434Z","steps":["trace[2008413436] 'range keys from in-memory index tree' (duration: 798.607419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:21.152477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:20.353522Z","time spent":"798.949308ms","remote":"127.0.0.1:45738","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-08T05:12:21.152574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.189031552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:12:21.152667Z","caller":"traceutil/trace.go:171","msg":"trace[1030241502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1326; }","duration":"1.189159825s","start":"2026-07-08T05:12:19.963485Z","end":"2026-07-08T05:12:21.152645Z","steps":["trace[1030241502] 'range keys from in-memory index tree' (duration: 1.18897038s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:21.152721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.920376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T05:12:21.152728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:19.963465Z","time spent":"1.189250028s","remote":"127.0.0.1:45468","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-08T05:12:21.152751Z","caller":"traceutil/trace.go:171","msg":"trace[1512872513] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1326; }","duration":"561.997528ms","start":"2026-07-08T05:12:20.590747Z","end":"2026-07-08T05:12:21.152744Z","steps":["trace[1512872513] 'count revisions from in-memory index tree' (duration: 561.693249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:21.152776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:20.590688Z","time spent":"562.082479ms","remote":"127.0.0.1:45628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-07-08T05:12:21.255155Z","caller":"traceutil/trace.go:171","msg":"trace[1107029050] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"377.657763ms","start":"2026-07-08T05:12:20.877465Z","end":"2026-07-08T05:12:21.255123Z","steps":["trace[1107029050] 'process raft request' (duration: 377.428487ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:12:21.255163Z","caller":"traceutil/trace.go:171","msg":"trace[750751887] linearizableReadLoop","detail":"{readStateIndex:1384; appliedIndex:1382; }","duration":"174.6484ms","start":"2026-07-08T05:12:21.080461Z","end":"2026-07-08T05:12:21.255109Z","steps":["trace[750751887] 'read index received' (duration: 103.643931ms)","trace[750751887] 'applied index is now lower than readState.Index' (duration: 71.003099ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:12:21.255364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:12:20.877445Z","time spent":"377.794177ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:12:21.255436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.953578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-08T05:12:21.255612Z","caller":"traceutil/trace.go:171","msg":"trace[129601541] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1328; }","duration":"175.185204ms","start":"2026-07-08T05:12:21.080412Z","end":"2026-07-08T05:12:21.255597Z","steps":["trace[129601541] 'agreement among raft nodes before linearized reading' (duration: 174.809684ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:12:21.255467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.203683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:12:21.255785Z","caller":"traceutil/trace.go:171","msg":"trace[166285698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1328; }","duration":"101.567574ms","start":"2026-07-08T05:12:21.154199Z","end":"2026-07-08T05:12:21.255767Z","steps":["trace[166285698] 'agreement among raft nodes before linearized reading' (duration: 101.218724ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:14:19.200501Z","caller":"traceutil/trace.go:171","msg":"trace[570955234] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"101.743227ms","start":"2026-07-08T05:14:19.098725Z","end":"2026-07-08T05:14:19.200468Z","steps":["trace[570955234] 'process raft request' (duration: 60.871587ms)","trace[570955234] 'compare' (duration: 40.657574ms)"],"step_count":2}