{"level":"warn","ts":"2026-07-28T06:01:04.544833Z","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-28T06:01:04.544914Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.225:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.225:2380","--initial-cluster=instance=https://199.19.213.225:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.225:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.225: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-28T06:01:04.544978Z","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-28T06:01:04.54499Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.225:2380"]} {"level":"info","ts":"2026-07-28T06:01:04.54501Z","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-28T06:01:04.545778Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.225:2379"]} {"level":"info","ts":"2026-07-28T06:01:04.545862Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.225:2380"],"listen-peer-urls":["https://199.19.213.225:2380"],"advertise-client-urls":["https://199.19.213.225:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.225:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.225: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-28T06:01:04.549747Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.669403ms"} {"level":"info","ts":"2026-07-28T06:01:04.560303Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b7b89c171c5fe95c","cluster-id":"5746414c29a21eae"} {"level":"info","ts":"2026-07-28T06:01:04.560419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c switched to configuration voters=()"} {"level":"info","ts":"2026-07-28T06:01:04.560491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became follower at term 0"} {"level":"info","ts":"2026-07-28T06:01:04.560506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b7b89c171c5fe95c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-28T06:01:04.560518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became follower at term 1"} {"level":"info","ts":"2026-07-28T06:01:04.560576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c switched to configuration voters=(13238502727729801564)"} {"level":"warn","ts":"2026-07-28T06:01:04.567095Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-28T06:01:04.568677Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-28T06:01:04.569988Z","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-28T06:01:04.572008Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b7b89c171c5fe95c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-28T06:01:04.572369Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b7b89c171c5fe95c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-28T06:01:04.572518Z","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-28T06:01:04.572559Z","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-28T06:01:04.572574Z","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-28T06:01:04.573119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c switched to configuration voters=(13238502727729801564)"} {"level":"info","ts":"2026-07-28T06:01:04.573234Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5746414c29a21eae","local-member-id":"b7b89c171c5fe95c","added-peer-id":"b7b89c171c5fe95c","added-peer-peer-urls":["https://199.19.213.225:2380"]} {"level":"info","ts":"2026-07-28T06:01:04.576447Z","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-28T06:01:04.576637Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b7b89c171c5fe95c","initial-advertise-peer-urls":["https://199.19.213.225:2380"],"listen-peer-urls":["https://199.19.213.225:2380"],"advertise-client-urls":["https://199.19.213.225:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.225:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-28T06:01:04.576664Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-28T06:01:04.577065Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.225:2380"} {"level":"info","ts":"2026-07-28T06:01:04.577097Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.225:2380"} {"level":"info","ts":"2026-07-28T06:01:05.26168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c is starting a new election at term 1"} {"level":"info","ts":"2026-07-28T06:01:05.261741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became pre-candidate at term 1"} {"level":"info","ts":"2026-07-28T06:01:05.261779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c received MsgPreVoteResp from b7b89c171c5fe95c at term 1"} {"level":"info","ts":"2026-07-28T06:01:05.261798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became candidate at term 2"} {"level":"info","ts":"2026-07-28T06:01:05.26181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c received MsgVoteResp from b7b89c171c5fe95c at term 2"} {"level":"info","ts":"2026-07-28T06:01:05.261825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became leader at term 2"} {"level":"info","ts":"2026-07-28T06:01:05.261838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b7b89c171c5fe95c elected leader b7b89c171c5fe95c at term 2"} {"level":"info","ts":"2026-07-28T06:01:05.26292Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b7b89c171c5fe95c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.225:2379]}","request-path":"/0/members/b7b89c171c5fe95c/attributes","cluster-id":"5746414c29a21eae","publish-timeout":"7s"} {"level":"info","ts":"2026-07-28T06:01:05.263174Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T06:01:05.263934Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T06:01:05.264289Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T06:01:05.264521Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-28T06:01:05.264544Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-28T06:01:05.266118Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.225:2379"} {"level":"info","ts":"2026-07-28T06:01:05.266259Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5746414c29a21eae","local-member-id":"b7b89c171c5fe95c","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T06:01:05.266319Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T06:01:05.266342Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T06:01:05.266545Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-28T06:01:45.259594Z","caller":"traceutil/trace.go:171","msg":"trace[630484115] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"166.605062ms","start":"2026-07-28T06:01:45.092974Z","end":"2026-07-28T06:01:45.259579Z","steps":["trace[630484115] 'process raft request' (duration: 166.51899ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275392Z","caller":"traceutil/trace.go:171","msg":"trace[1276366176] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"178.666914ms","start":"2026-07-28T06:01:45.096697Z","end":"2026-07-28T06:01:45.275364Z","steps":["trace[1276366176] 'process raft request' (duration: 178.453458ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275586Z","caller":"traceutil/trace.go:171","msg":"trace[1014955659] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"173.430465ms","start":"2026-07-28T06:01:45.102131Z","end":"2026-07-28T06:01:45.275562Z","steps":["trace[1014955659] 'process raft request' (duration: 173.176188ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275719Z","caller":"traceutil/trace.go:171","msg":"trace[672644647] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"167.550778ms","start":"2026-07-28T06:01:45.10816Z","end":"2026-07-28T06:01:45.275711Z","steps":["trace[672644647] 'process raft request' (duration: 167.28834ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275715Z","caller":"traceutil/trace.go:171","msg":"trace[271900740] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"167.97621ms","start":"2026-07-28T06:01:45.107717Z","end":"2026-07-28T06:01:45.275693Z","steps":["trace[271900740] 'process raft request' (duration: 167.697412ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275741Z","caller":"traceutil/trace.go:171","msg":"trace[797847515] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"178.953093ms","start":"2026-07-28T06:01:45.096762Z","end":"2026-07-28T06:01:45.275715Z","steps":["trace[797847515] 'process raft request' (duration: 178.50483ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275776Z","caller":"traceutil/trace.go:171","msg":"trace[129348111] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"168.102614ms","start":"2026-07-28T06:01:45.107668Z","end":"2026-07-28T06:01:45.27577Z","steps":["trace[129348111] 'process raft request' (duration: 167.693393ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275804Z","caller":"traceutil/trace.go:171","msg":"trace[121726285] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"167.013392ms","start":"2026-07-28T06:01:45.10875Z","end":"2026-07-28T06:01:45.275764Z","steps":["trace[121726285] 'process raft request' (duration: 166.814436ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275853Z","caller":"traceutil/trace.go:171","msg":"trace[1514367837] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"162.755872ms","start":"2026-07-28T06:01:45.113086Z","end":"2026-07-28T06:01:45.275842Z","steps":["trace[1514367837] 'process raft request' (duration: 162.518486ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.275923Z","caller":"traceutil/trace.go:171","msg":"trace[106648577] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"139.029677ms","start":"2026-07-28T06:01:45.136887Z","end":"2026-07-28T06:01:45.275917Z","steps":["trace[106648577] 'process raft request' (duration: 138.832522ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.276117Z","caller":"traceutil/trace.go:171","msg":"trace[259850104] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"124.194927ms","start":"2026-07-28T06:01:45.151908Z","end":"2026-07-28T06:01:45.276103Z","steps":["trace[259850104] 'process raft request' (duration: 124.005051ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:45.276124Z","caller":"traceutil/trace.go:171","msg":"trace[1936415387] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:509; }","duration":"150.293007ms","start":"2026-07-28T06:01:45.125806Z","end":"2026-07-28T06:01:45.276099Z","steps":["trace[1936415387] 'read index received' (duration: 134.450688ms)","trace[1936415387] 'applied index is now lower than readState.Index' (duration: 15.841399ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T06:01:45.276366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.533565ms","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-28T06:01:45.276449Z","caller":"traceutil/trace.go:171","msg":"trace[151341330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:502; }","duration":"150.667959ms","start":"2026-07-28T06:01:45.125767Z","end":"2026-07-28T06:01:45.276435Z","steps":["trace[151341330] 'agreement among raft nodes before linearized reading' (duration: 150.475503ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:01:45.277269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.695525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T06:01:45.277314Z","caller":"traceutil/trace.go:171","msg":"trace[474696725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:504; }","duration":"115.788458ms","start":"2026-07-28T06:01:45.161517Z","end":"2026-07-28T06:01:45.277305Z","steps":["trace[474696725] 'agreement among raft nodes before linearized reading' (duration: 115.692676ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:51.434578Z","caller":"traceutil/trace.go:171","msg":"trace[446119547] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"115.683019ms","start":"2026-07-28T06:01:51.318871Z","end":"2026-07-28T06:01:51.434554Z","steps":["trace[446119547] 'read index received' (duration: 114.843936ms)","trace[446119547] 'applied index is now lower than readState.Index' (duration: 838.153µs)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:01:51.434706Z","caller":"traceutil/trace.go:171","msg":"trace[789704134] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"178.347931ms","start":"2026-07-28T06:01:51.25634Z","end":"2026-07-28T06:01:51.434688Z","steps":["trace[789704134] 'process raft request' (duration: 177.612641ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:01:51.434759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.864474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-28T06:01:51.434792Z","caller":"traceutil/trace.go:171","msg":"trace[1113560382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"115.943307ms","start":"2026-07-28T06:01:51.318838Z","end":"2026-07-28T06:01:51.434782Z","steps":["trace[1113560382] 'agreement among raft nodes before linearized reading' (duration: 115.811433ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:01:51.924354Z","caller":"traceutil/trace.go:171","msg":"trace[1188064073] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"324.218138ms","start":"2026-07-28T06:01:51.600111Z","end":"2026-07-28T06:01:51.924329Z","steps":["trace[1188064073] 'read index received' (duration: 324.063734ms)","trace[1188064073] 'applied index is now lower than readState.Index' (duration: 153.184µs)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:01:51.924491Z","caller":"traceutil/trace.go:171","msg":"trace[2013123914] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"432.230643ms","start":"2026-07-28T06:01:51.492205Z","end":"2026-07-28T06:01:51.924435Z","steps":["trace[2013123914] 'process raft request' (duration: 432.011437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:01:51.924573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.427564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T06:01:51.924647Z","caller":"traceutil/trace.go:171","msg":"trace[2045116186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"324.551887ms","start":"2026-07-28T06:01:51.600062Z","end":"2026-07-28T06:01:51.924614Z","steps":["trace[2045116186] 'agreement among raft nodes before linearized reading' (duration: 324.378822ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:01:51.92463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.599245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-28T06:01:51.924699Z","caller":"traceutil/trace.go:171","msg":"trace[1940866497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"305.720208ms","start":"2026-07-28T06:01:51.618961Z","end":"2026-07-28T06:01:51.924681Z","steps":["trace[1940866497] 'agreement among raft nodes before linearized reading' (duration: 305.531373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:01:51.924686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:01:51.600042Z","time spent":"324.63525ms","remote":"127.0.0.1:59282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-28T06:01:51.924753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:01:51.618948Z","time spent":"305.796571ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-28T06:01:51.924849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.611723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bdjpx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-28T06:01:51.924912Z","caller":"traceutil/trace.go:171","msg":"trace[1615453340] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bdjpx; range_end:; response_count:1; response_revision:602; }","duration":"112.700066ms","start":"2026-07-28T06:01:51.812193Z","end":"2026-07-28T06:01:51.924893Z","steps":["trace[1615453340] 'agreement among raft nodes before linearized reading' (duration: 112.297415ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:01:51.925067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:01:51.492179Z","time spent":"432.397108ms","remote":"127.0.0.1:59514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-28T06:01:53.021479Z","caller":"traceutil/trace.go:171","msg":"trace[1609013973] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"100.064484ms","start":"2026-07-28T06:01:52.92139Z","end":"2026-07-28T06:01:53.021454Z","steps":["trace[1609013973] 'process raft request' (duration: 99.442557ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:02:07.131117Z","caller":"traceutil/trace.go:171","msg":"trace[1828708108] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"218.373119ms","start":"2026-07-28T06:02:06.912715Z","end":"2026-07-28T06:02:07.131088Z","steps":["trace[1828708108] 'process raft request' (duration: 218.226935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:20.831402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.092672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-28T06:03:20.83157Z","caller":"traceutil/trace.go:171","msg":"trace[896092619] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"144.046182ms","start":"2026-07-28T06:03:20.687488Z","end":"2026-07-28T06:03:20.831534Z","steps":["trace[896092619] 'process raft request' (duration: 20.497608ms)","trace[896092619] 'compare' (duration: 122.962289ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:03:21.25133Z","caller":"traceutil/trace.go:171","msg":"trace[2123923496] linearizableReadLoop","detail":"{readStateIndex:1898; appliedIndex:1897; }","duration":"109.787434ms","start":"2026-07-28T06:03:21.141517Z","end":"2026-07-28T06:03:21.251304Z","steps":["trace[2123923496] 'read index received' (duration: 99.035484ms)","trace[2123923496] 'applied index is now lower than readState.Index' (duration: 10.7511ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T06:03:21.251554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.024171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-47c00c63-a227-4577-9ce3-7377faae0588\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-28T06:03:21.251626Z","caller":"traceutil/trace.go:171","msg":"trace[320224519] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-47c00c63-a227-4577-9ce3-7377faae0588; range_end:; response_count:1; response_revision:1825; }","duration":"110.149884ms","start":"2026-07-28T06:03:21.141457Z","end":"2026-07-28T06:03:21.251607Z","steps":["trace[320224519] 'agreement among raft nodes before linearized reading' (duration: 109.969139ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:21.25151Z","caller":"traceutil/trace.go:171","msg":"trace[138239280] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"336.838948ms","start":"2026-07-28T06:03:20.914523Z","end":"2026-07-28T06:03:21.251362Z","steps":["trace[138239280] 'process raft request' (duration: 326.096889ms)","trace[138239280] 'compare' (duration: 10.459093ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T06:03:21.251941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:20.914495Z","time spent":"337.294669ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:21.396616Z","caller":"traceutil/trace.go:171","msg":"trace[571087708] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"138.333527ms","start":"2026-07-28T06:03:21.258254Z","end":"2026-07-28T06:03:21.396587Z","steps":["trace[571087708] 'process raft request' (duration: 138.125072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:21.628997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.691671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-28T06:03:21.629014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.84974ms","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-28T06:03:21.629101Z","caller":"traceutil/trace.go:171","msg":"trace[641930882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1827; }","duration":"130.851865ms","start":"2026-07-28T06:03:21.498227Z","end":"2026-07-28T06:03:21.629079Z","steps":["trace[641930882] 'range keys from in-memory index tree' (duration: 130.417515ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:21.629118Z","caller":"traceutil/trace.go:171","msg":"trace[68637370] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1827; }","duration":"111.016563ms","start":"2026-07-28T06:03:21.518084Z","end":"2026-07-28T06:03:21.629101Z","steps":["trace[68637370] 'range keys from in-memory index tree' (duration: 110.612634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:26.78643Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:27.286578Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:27.78789Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:28.288703Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:28.789675Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:29.29041Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:29.599882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000232509s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-28T06:03:29.599969Z","caller":"traceutil/trace.go:171","msg":"trace[2028203769] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000364572s","start":"2026-07-28T06:03:27.599583Z","end":"2026-07-28T06:03:29.599947Z","steps":["trace[2028203769] 'agreement among raft nodes before linearized reading' (duration: 2.00025226s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:29.60002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:27.599567Z","time spent":"2.000442314s","remote":"127.0.0.1:59274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-28T06:03:29.791564Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:30.29228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:30.793575Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16815490649644809941,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T06:03:30.886083Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.784847209s","expected-duration":"1s"} {"level":"info","ts":"2026-07-28T06:03:30.886478Z","caller":"traceutil/trace.go:171","msg":"trace[1444537089] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"4.785357991s","start":"2026-07-28T06:03:26.101101Z","end":"2026-07-28T06:03:30.886459Z","steps":["trace[1444537089] 'process raft request' (duration: 4.785143116s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:30.886592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:26.101079Z","time spent":"4.785451793s","remote":"127.0.0.1:59456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10359,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:31.03061Z","caller":"traceutil/trace.go:171","msg":"trace[485684297] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"4.542871957s","start":"2026-07-28T06:03:26.487713Z","end":"2026-07-28T06:03:31.030585Z","steps":["trace[485684297] 'process raft request' (duration: 4.542792595s)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:31.03065Z","caller":"traceutil/trace.go:171","msg":"trace[483946613] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"4.764710992s","start":"2026-07-28T06:03:26.265907Z","end":"2026-07-28T06:03:31.030618Z","steps":["trace[483946613] 'process raft request' (duration: 4.764444676s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.030765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:26.487686Z","time spent":"4.54300019s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T06:03:31.030957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:26.265886Z","time spent":"4.764839096s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:31.030952Z","caller":"traceutil/trace.go:171","msg":"trace[1114129007] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"4.177075954s","start":"2026-07-28T06:03:26.853805Z","end":"2026-07-28T06:03:31.030881Z","steps":["trace[1114129007] 'process raft request' (duration: 4.176743206s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.031243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:26.85377Z","time spent":"4.177306549s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:31.031723Z","caller":"traceutil/trace.go:171","msg":"trace[629627751] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"3.116347129s","start":"2026-07-28T06:03:27.915355Z","end":"2026-07-28T06:03:31.031702Z","steps":["trace[629627751] 'process raft request' (duration: 3.116239226s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.031864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:27.915331Z","time spent":"3.116462971s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:31.031956Z","caller":"traceutil/trace.go:171","msg":"trace[247683841] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"1.68167636s","start":"2026-07-28T06:03:29.350265Z","end":"2026-07-28T06:03:31.031941Z","steps":["trace[247683841] 'process raft request' (duration: 1.681402713s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.032045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:29.350245Z","time spent":"1.681756871s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:31.032102Z","caller":"traceutil/trace.go:171","msg":"trace[1353024492] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1947; }","duration":"4.745750766s","start":"2026-07-28T06:03:26.286333Z","end":"2026-07-28T06:03:31.032084Z","steps":["trace[1353024492] 'read index received' (duration: 4.599964694s)","trace[1353024492] 'applied index is now lower than readState.Index' (duration: 145.784582ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:03:31.031768Z","caller":"traceutil/trace.go:171","msg":"trace[1288138810] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"3.762021363s","start":"2026-07-28T06:03:27.269723Z","end":"2026-07-28T06:03:31.031745Z","steps":["trace[1288138810] 'process raft request' (duration: 3.761060539s)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:31.0322Z","caller":"traceutil/trace.go:171","msg":"trace[553687346] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"1.486204779s","start":"2026-07-28T06:03:29.545981Z","end":"2026-07-28T06:03:31.032185Z","steps":["trace[553687346] 'process raft request' (duration: 1.485903192s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.03255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:27.269699Z","time spent":"3.762795311s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T06:03:31.032697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:29.545954Z","time spent":"1.486648449s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T06:03:31.032908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.746569405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:11079"} {"level":"info","ts":"2026-07-28T06:03:31.032958Z","caller":"traceutil/trace.go:171","msg":"trace[610172111] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1881; }","duration":"4.746650917s","start":"2026-07-28T06:03:26.286295Z","end":"2026-07-28T06:03:31.032946Z","steps":["trace[610172111] 'agreement among raft nodes before linearized reading' (duration: 4.746438142s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.032997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:26.286278Z","time spent":"4.746710898s","remote":"127.0.0.1:59456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":11102,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-07-28T06:03:31.121868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.729931919s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-28T06:03:31.121936Z","caller":"traceutil/trace.go:171","msg":"trace[319169182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1882; }","duration":"4.730010031s","start":"2026-07-28T06:03:26.39191Z","end":"2026-07-28T06:03:31.12192Z","steps":["trace[319169182] 'agreement among raft nodes before linearized reading' (duration: 4.729770085s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.121974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:26.391897Z","time spent":"4.730068533s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-28T06:03:31.122118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.559511538s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T06:03:31.122184Z","caller":"traceutil/trace.go:171","msg":"trace[1833504279] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1882; }","duration":"2.55961919s","start":"2026-07-28T06:03:28.56255Z","end":"2026-07-28T06:03:31.122169Z","steps":["trace[1833504279] 'agreement among raft nodes before linearized reading' (duration: 2.559477327s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.122246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.95672896s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T06:03:31.122313Z","caller":"traceutil/trace.go:171","msg":"trace[1258868445] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1882; }","duration":"2.956846253s","start":"2026-07-28T06:03:28.165454Z","end":"2026-07-28T06:03:31.1223Z","steps":["trace[1258868445] 'agreement among raft nodes before linearized reading' (duration: 2.956746531s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.122353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:28.165432Z","time spent":"2.956910975s","remote":"127.0.0.1:41836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-28T06:03:31.1224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206043121s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:10374"} {"level":"info","ts":"2026-07-28T06:03:31.122438Z","caller":"traceutil/trace.go:171","msg":"trace[1978198712] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1882; }","duration":"1.206079052s","start":"2026-07-28T06:03:29.916349Z","end":"2026-07-28T06:03:31.122428Z","steps":["trace[1978198712] 'agreement among raft nodes before linearized reading' (duration: 1.205929088s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.122471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:29.916251Z","time spent":"1.206214675s","remote":"127.0.0.1:59456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":10397,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-28T06:03:31.122529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.013763157s","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":"warn","ts":"2026-07-28T06:03:31.122509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.819893142s","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-28T06:03:31.122571Z","caller":"traceutil/trace.go:171","msg":"trace[1056792308] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1882; }","duration":"4.013838179s","start":"2026-07-28T06:03:27.108721Z","end":"2026-07-28T06:03:31.12256Z","steps":["trace[1056792308] 'agreement among raft nodes before linearized reading' (duration: 4.013779738s)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:31.122583Z","caller":"traceutil/trace.go:171","msg":"trace[2008703207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1882; }","duration":"3.820008374s","start":"2026-07-28T06:03:27.302558Z","end":"2026-07-28T06:03:31.122567Z","steps":["trace[2008703207] 'agreement among raft nodes before linearized reading' (duration: 3.81984183s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.122579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.521998051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-28T06:03:31.122607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:27.108704Z","time spent":"4.013894091s","remote":"127.0.0.1:49844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-28T06:03:31.122626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:27.302541Z","time spent":"3.820076507s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-28T06:03:31.122646Z","caller":"traceutil/trace.go:171","msg":"trace[2100463867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1882; }","duration":"1.522098424s","start":"2026-07-28T06:03:29.60053Z","end":"2026-07-28T06:03:31.122628Z","steps":["trace[2100463867] 'agreement among raft nodes before linearized reading' (duration: 1.521979471s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.122693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:29.600515Z","time spent":"1.522171285s","remote":"127.0.0.1:59282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-28T06:03:31.122707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.934158879s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-28T06:03:31.122742Z","caller":"traceutil/trace.go:171","msg":"trace[527475928] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1882; }","duration":"1.934240191s","start":"2026-07-28T06:03:29.18849Z","end":"2026-07-28T06:03:31.122731Z","steps":["trace[527475928] 'agreement among raft nodes before linearized reading' (duration: 1.93417487s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.122775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:29.188448Z","time spent":"1.934319193s","remote":"127.0.0.1:49822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":12,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-28T06:03:31.122828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.221753194s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-07-28T06:03:31.123823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.603514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-07-28T06:03:31.123921Z","caller":"traceutil/trace.go:171","msg":"trace[894166112] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1882; }","duration":"4.222863522s","start":"2026-07-28T06:03:26.901029Z","end":"2026-07-28T06:03:31.123893Z","steps":["trace[894166112] 'agreement among raft nodes before linearized reading' (duration: 4.221708003s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.12287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.001964667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.225\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-28T06:03:31.124005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:26.901007Z","time spent":"4.222974445s","remote":"127.0.0.1:37426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-28T06:03:31.124241Z","caller":"traceutil/trace.go:171","msg":"trace[1450445393] range","detail":"{range_begin:/registry/masterleases/199.19.213.225; range_end:; response_count:1; response_revision:1882; }","duration":"3.003188517s","start":"2026-07-28T06:03:28.120859Z","end":"2026-07-28T06:03:31.124048Z","steps":["trace[1450445393] 'agreement among raft nodes before linearized reading' (duration: 3.001944297s)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:31.124365Z","caller":"traceutil/trace.go:171","msg":"trace[1457084513] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1882; }","duration":"145.747408ms","start":"2026-07-28T06:03:30.978154Z","end":"2026-07-28T06:03:31.123902Z","steps":["trace[1457084513] 'agreement among raft nodes before linearized reading' (duration: 143.923484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.12432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:28.12084Z","time spent":"3.003460673s","remote":"127.0.0.1:59316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.225\" "} {"level":"warn","ts":"2026-07-28T06:03:31.123016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.407864109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-28T06:03:31.12486Z","caller":"traceutil/trace.go:171","msg":"trace[1491510983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1882; }","duration":"3.409732254s","start":"2026-07-28T06:03:27.71511Z","end":"2026-07-28T06:03:31.124842Z","steps":["trace[1491510983] 'agreement among raft nodes before linearized reading' (duration: 3.407856199s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.124912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:27.715094Z","time spent":"3.409803025s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-28T06:03:31.123118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.410480532s","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-28T06:03:31.122255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:28.562537Z","time spent":"2.559687442s","remote":"127.0.0.1:59514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-07-28T06:03:31.123366Z","caller":"traceutil/trace.go:171","msg":"trace[350716935] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"232.312532ms","start":"2026-07-28T06:03:30.891036Z","end":"2026-07-28T06:03:31.123349Z","steps":["trace[350716935] 'process raft request' (duration: 224.159927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.122948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.167241879s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-28T06:03:31.12753Z","caller":"traceutil/trace.go:171","msg":"trace[133319355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1882; }","duration":"3.171886391s","start":"2026-07-28T06:03:27.955628Z","end":"2026-07-28T06:03:31.127514Z","steps":["trace[133319355] 'agreement among raft nodes before linearized reading' (duration: 3.16726318s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.127686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:27.955606Z","time spent":"3.172061515s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-28T06:03:31.125096Z","caller":"traceutil/trace.go:171","msg":"trace[1383896968] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1882; }","duration":"3.41248095s","start":"2026-07-28T06:03:27.712603Z","end":"2026-07-28T06:03:31.125084Z","steps":["trace[1383896968] 'agreement among raft nodes before linearized reading' (duration: 3.410455701s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.128204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:27.712585Z","time spent":"3.415592184s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-28T06:03:31.155932Z","caller":"traceutil/trace.go:171","msg":"trace[528550611] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"110.968625ms","start":"2026-07-28T06:03:31.044935Z","end":"2026-07-28T06:03:31.155904Z","steps":["trace[528550611] 'process raft request' (duration: 110.76201ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:31.302235Z","caller":"traceutil/trace.go:171","msg":"trace[958660465] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1964; }","duration":"113.246709ms","start":"2026-07-28T06:03:31.188964Z","end":"2026-07-28T06:03:31.302211Z","steps":["trace[958660465] 'read index received' (duration: 48.888499ms)","trace[958660465] 'applied index is now lower than readState.Index' (duration: 64.35695ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:03:31.302296Z","caller":"traceutil/trace.go:171","msg":"trace[366405751] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"114.435448ms","start":"2026-07-28T06:03:31.187833Z","end":"2026-07-28T06:03:31.302269Z","steps":["trace[366405751] 'process raft request' (duration: 50.006647ms)","trace[366405751] 'compare' (duration: 64.270057ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T06:03:31.302427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.447073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T06:03:31.302497Z","caller":"traceutil/trace.go:171","msg":"trace[1778420143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1890; }","duration":"113.544856ms","start":"2026-07-28T06:03:31.188939Z","end":"2026-07-28T06:03:31.302484Z","steps":["trace[1778420143] 'agreement among raft nodes before linearized reading' (duration: 113.390243ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:31.308566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.295956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T06:03:31.308819Z","caller":"traceutil/trace.go:171","msg":"trace[634549618] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"110.565556ms","start":"2026-07-28T06:03:31.198237Z","end":"2026-07-28T06:03:31.308802Z","steps":["trace[634549618] 'process raft request' (duration: 110.019292ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:31.308677Z","caller":"traceutil/trace.go:171","msg":"trace[1999634799] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:1891; }","duration":"117.414349ms","start":"2026-07-28T06:03:31.191216Z","end":"2026-07-28T06:03:31.30863Z","steps":["trace[1999634799] 'agreement among raft nodes before linearized reading' (duration: 117.286116ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:43.328569Z","caller":"traceutil/trace.go:171","msg":"trace[1645467462] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"205.410681ms","start":"2026-07-28T06:03:43.123129Z","end":"2026-07-28T06:03:43.32854Z","steps":["trace[1645467462] 'process raft request' (duration: 205.115334ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:44.190767Z","caller":"traceutil/trace.go:171","msg":"trace[1385460846] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"988.67562ms","start":"2026-07-28T06:03:43.202069Z","end":"2026-07-28T06:03:44.190744Z","steps":["trace[1385460846] 'process raft request' (duration: 988.406564ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:44.190764Z","caller":"traceutil/trace.go:171","msg":"trace[1516720335] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"983.505349ms","start":"2026-07-28T06:03:43.207235Z","end":"2026-07-28T06:03:44.19074Z","steps":["trace[1516720335] 'process raft request' (duration: 983.391957ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:44.190984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.207212Z","time spent":"983.620421ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T06:03:44.191006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.20205Z","time spent":"988.769983ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:44.191329Z","caller":"traceutil/trace.go:171","msg":"trace[1105484849] linearizableReadLoop","detail":"{readStateIndex:2054; appliedIndex:2050; }","duration":"939.415912ms","start":"2026-07-28T06:03:43.251904Z","end":"2026-07-28T06:03:44.19132Z","steps":["trace[1105484849] 'read index received' (duration: 76.388417ms)","trace[1105484849] 'applied index is now lower than readState.Index' (duration: 863.026625ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:03:44.191427Z","caller":"traceutil/trace.go:171","msg":"trace[2126581187] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"976.076744ms","start":"2026-07-28T06:03:43.215336Z","end":"2026-07-28T06:03:44.191413Z","steps":["trace[2126581187] 'process raft request' (duration: 975.389388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:44.191496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.597955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-07-28T06:03:44.191556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.215311Z","time spent":"976.153346ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:44.191576Z","caller":"traceutil/trace.go:171","msg":"trace[1975648973] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1977; }","duration":"939.650057ms","start":"2026-07-28T06:03:43.25186Z","end":"2026-07-28T06:03:44.19151Z","steps":["trace[1975648973] 'agreement among raft nodes before linearized reading' (duration: 939.510054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:44.191715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.251843Z","time spent":"939.863071ms","remote":"127.0.0.1:37426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-28T06:03:44.368106Z","caller":"traceutil/trace.go:171","msg":"trace[612801197] linearizableReadLoop","detail":"{readStateIndex:2055; appliedIndex:2054; }","duration":"176.734482ms","start":"2026-07-28T06:03:44.191348Z","end":"2026-07-28T06:03:44.368082Z","steps":["trace[612801197] 'read index received' (duration: 118.562036ms)","trace[612801197] 'applied index is now lower than readState.Index' (duration: 58.171406ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:03:44.368227Z","caller":"traceutil/trace.go:171","msg":"trace[907733350] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"430.510794ms","start":"2026-07-28T06:03:43.937684Z","end":"2026-07-28T06:03:44.368194Z","steps":["trace[907733350] 'process raft request' (duration: 372.292108ms)","trace[907733350] 'compare' (duration: 58.002131ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T06:03:44.368289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.934518ms","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-28T06:03:44.368308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.591891ms","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-28T06:03:44.368307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.139208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-28T06:03:44.368312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.694463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-28T06:03:44.368351Z","caller":"traceutil/trace.go:171","msg":"trace[1867164608] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1978; }","duration":"911.685614ms","start":"2026-07-28T06:03:43.456648Z","end":"2026-07-28T06:03:44.368334Z","steps":["trace[1867164608] 'agreement among raft nodes before linearized reading' (duration: 911.555031ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:44.368355Z","caller":"traceutil/trace.go:171","msg":"trace[1507208643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1978; }","duration":"916.241251ms","start":"2026-07-28T06:03:43.452101Z","end":"2026-07-28T06:03:44.368342Z","steps":["trace[1507208643] 'agreement among raft nodes before linearized reading' (duration: 916.040326ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:44.368363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.937651Z","time spent":"430.645638ms","remote":"127.0.0.1:59440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8133,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T06:03:44.368382Z","caller":"traceutil/trace.go:171","msg":"trace[182294978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1978; }","duration":"911.819266ms","start":"2026-07-28T06:03:43.456546Z","end":"2026-07-28T06:03:44.368365Z","steps":["trace[182294978] 'agreement among raft nodes before linearized reading' (duration: 911.568651ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:44.368339Z","caller":"traceutil/trace.go:171","msg":"trace[170851986] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1978; }","duration":"994.04335ms","start":"2026-07-28T06:03:43.374282Z","end":"2026-07-28T06:03:44.368326Z","steps":["trace[170851986] 'agreement among raft nodes before linearized reading' (duration: 993.866556ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:44.368823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.374262Z","time spent":"994.514163ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-28T06:03:44.368378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.456622Z","time spent":"911.751125ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-28T06:03:44.3683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097683118s","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-28T06:03:44.369014Z","caller":"traceutil/trace.go:171","msg":"trace[1019997476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1978; }","duration":"1.098437117s","start":"2026-07-28T06:03:43.270558Z","end":"2026-07-28T06:03:44.368995Z","steps":["trace[1019997476] 'agreement among raft nodes before linearized reading' (duration: 1.097655228s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:03:44.36909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.270536Z","time spent":"1.098537789s","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-28T06:03:44.368391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.452051Z","time spent":"916.330513ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-28T06:03:44.368434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T06:03:43.456526Z","time spent":"911.897709ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-28T06:03:44.625395Z","caller":"traceutil/trace.go:171","msg":"trace[569625949] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"251.944678ms","start":"2026-07-28T06:03:44.37341Z","end":"2026-07-28T06:03:44.625354Z","steps":["trace[569625949] 'process raft request' (duration: 251.788405ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:44.62541Z","caller":"traceutil/trace.go:171","msg":"trace[984291061] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"251.401266ms","start":"2026-07-28T06:03:44.373979Z","end":"2026-07-28T06:03:44.625381Z","steps":["trace[984291061] 'process raft request' (duration: 251.284173ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:44.625419Z","caller":"traceutil/trace.go:171","msg":"trace[1914282537] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"251.326313ms","start":"2026-07-28T06:03:44.374072Z","end":"2026-07-28T06:03:44.625398Z","steps":["trace[1914282537] 'process raft request' (duration: 251.222591ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:03:44.625491Z","caller":"traceutil/trace.go:171","msg":"trace[1666321784] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"252.311117ms","start":"2026-07-28T06:03:44.373142Z","end":"2026-07-28T06:03:44.625453Z","steps":["trace[1666321784] 'process raft request' (duration: 168.034477ms)","trace[1666321784] 'compare' (duration: 83.540133ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T06:04:10.861757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.827899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-28T06:04:10.861875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.800185ms","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-28T06:04:10.862044Z","caller":"traceutil/trace.go:171","msg":"trace[1137728973] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2126; }","duration":"111.03665ms","start":"2026-07-28T06:04:10.75099Z","end":"2026-07-28T06:04:10.862027Z","steps":["trace[1137728973] 'range keys from in-memory index tree' (duration: 110.652211ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:04:10.862551Z","caller":"traceutil/trace.go:171","msg":"trace[1936826539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2126; }","duration":"109.086935ms","start":"2026-07-28T06:04:10.752883Z","end":"2026-07-28T06:04:10.86197Z","steps":["trace[1936826539] 'range keys from in-memory index tree' (duration: 108.535543ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:04:12.114099Z","caller":"traceutil/trace.go:171","msg":"trace[1554034548] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"276.218807ms","start":"2026-07-28T06:04:11.83785Z","end":"2026-07-28T06:04:12.114068Z","steps":["trace[1554034548] 'process raft request' (duration: 276.033352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:04:12.269846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.453342ms","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-28T06:04:12.269952Z","caller":"traceutil/trace.go:171","msg":"trace[1788028463] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2132; }","duration":"111.690327ms","start":"2026-07-28T06:04:12.158242Z","end":"2026-07-28T06:04:12.269932Z","steps":["trace[1788028463] 'count revisions from in-memory index tree' (duration: 111.347459ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:04:12.487981Z","caller":"traceutil/trace.go:171","msg":"trace[1230495497] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"100.361572ms","start":"2026-07-28T06:04:12.387291Z","end":"2026-07-28T06:04:12.487653Z","steps":["trace[1230495497] 'process raft request' (duration: 100.179238ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:04:12.505247Z","caller":"traceutil/trace.go:171","msg":"trace[1358346710] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"110.531851ms","start":"2026-07-28T06:04:12.394438Z","end":"2026-07-28T06:04:12.50497Z","steps":["trace[1358346710] 'process raft request' (duration: 110.323376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:06:05.520167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.071359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-28T06:06:05.520544Z","caller":"traceutil/trace.go:171","msg":"trace[103212269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2846; }","duration":"102.451537ms","start":"2026-07-28T06:06:05.418074Z","end":"2026-07-28T06:06:05.520525Z","steps":["trace[103212269] 'range keys from in-memory index tree' (duration: 101.966447ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:06:05.520552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.62136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-28T06:06:05.520913Z","caller":"traceutil/trace.go:171","msg":"trace[591534960] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2846; }","duration":"104.956047ms","start":"2026-07-28T06:06:05.415852Z","end":"2026-07-28T06:06:05.520808Z","steps":["trace[591534960] 'range keys from in-memory index tree' (duration: 104.487328ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:06:05.64765Z","caller":"traceutil/trace.go:171","msg":"trace[856221581] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"123.248733ms","start":"2026-07-28T06:06:05.524382Z","end":"2026-07-28T06:06:05.647631Z","steps":["trace[856221581] 'process raft request' (duration: 123.141841ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:06:05.699504Z","caller":"traceutil/trace.go:171","msg":"trace[705881197] transaction","detail":"{read_only:false; response_revision:2849; number_of_response:1; }","duration":"174.985256ms","start":"2026-07-28T06:06:05.5245Z","end":"2026-07-28T06:06:05.699485Z","steps":["trace[705881197] 'process raft request' (duration: 174.929885ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:06:05.699555Z","caller":"traceutil/trace.go:171","msg":"trace[1470688346] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"175.089407ms","start":"2026-07-28T06:06:05.524435Z","end":"2026-07-28T06:06:05.699525Z","steps":["trace[1470688346] 'process raft request' (duration: 174.909024ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:06:05.699723Z","caller":"traceutil/trace.go:171","msg":"trace[1099379537] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"175.18395ms","start":"2026-07-28T06:06:05.524529Z","end":"2026-07-28T06:06:05.699713Z","steps":["trace[1099379537] 'process raft request' (duration: 174.930565ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:09:40.53995Z","caller":"traceutil/trace.go:171","msg":"trace[346269555] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"130.21996ms","start":"2026-07-28T06:09:40.409713Z","end":"2026-07-28T06:09:40.539933Z","steps":["trace[346269555] 'process raft request' (duration: 130.106838ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:09:47.560884Z","caller":"traceutil/trace.go:171","msg":"trace[947489448] linearizableReadLoop","detail":"{readStateIndex:4937; appliedIndex:4936; }","duration":"273.734353ms","start":"2026-07-28T06:09:47.287133Z","end":"2026-07-28T06:09:47.560867Z","steps":["trace[947489448] 'read index received' (duration: 273.57602ms)","trace[947489448] 'applied index is now lower than readState.Index' (duration: 157.393µs)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:09:47.560989Z","caller":"traceutil/trace.go:171","msg":"trace[353570206] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"282.393062ms","start":"2026-07-28T06:09:47.278567Z","end":"2026-07-28T06:09:47.56096Z","steps":["trace[353570206] 'process raft request' (duration: 282.183508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:09:47.561043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.365036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T06:09:47.56107Z","caller":"traceutil/trace.go:171","msg":"trace[1477558245] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:4755; }","duration":"259.440257ms","start":"2026-07-28T06:09:47.301622Z","end":"2026-07-28T06:09:47.561062Z","steps":["trace[1477558245] 'agreement among raft nodes before linearized reading' (duration: 259.358526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:09:47.561215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.062638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-07-28T06:09:47.561308Z","caller":"traceutil/trace.go:171","msg":"trace[1007750530] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4755; }","duration":"274.185541ms","start":"2026-07-28T06:09:47.287091Z","end":"2026-07-28T06:09:47.561276Z","steps":["trace[1007750530] 'agreement among raft nodes before linearized reading' (duration: 273.884806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:09:47.856116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.470408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-28T06:09:47.856449Z","caller":"traceutil/trace.go:171","msg":"trace[1823118516] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"172.113223ms","start":"2026-07-28T06:09:47.684307Z","end":"2026-07-28T06:09:47.85642Z","steps":["trace[1823118516] 'process raft request' (duration: 171.91006ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:09:47.856591Z","caller":"traceutil/trace.go:171","msg":"trace[1856523987] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"171.179508ms","start":"2026-07-28T06:09:47.685397Z","end":"2026-07-28T06:09:47.856576Z","steps":["trace[1856523987] 'process raft request' (duration: 170.901493ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:09:47.856724Z","caller":"traceutil/trace.go:171","msg":"trace[1772753017] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"178.549965ms","start":"2026-07-28T06:09:47.678157Z","end":"2026-07-28T06:09:47.856707Z","steps":["trace[1772753017] 'process raft request' (duration: 55.411885ms)","trace[1772753017] 'compare' (duration: 122.284714ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:09:47.856839Z","caller":"traceutil/trace.go:171","msg":"trace[846638466] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"149.015867ms","start":"2026-07-28T06:09:47.707797Z","end":"2026-07-28T06:09:47.856813Z","steps":["trace[846638466] 'process raft request' (duration: 148.715361ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:09:47.856895Z","caller":"traceutil/trace.go:171","msg":"trace[1986805579] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"154.39851ms","start":"2026-07-28T06:09:47.702484Z","end":"2026-07-28T06:09:47.856882Z","steps":["trace[1986805579] 'process raft request' (duration: 153.935461ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:09:47.85692Z","caller":"traceutil/trace.go:171","msg":"trace[1927432207] linearizableReadLoop","detail":"{readStateIndex:4950; appliedIndex:4947; }","duration":"161.081933ms","start":"2026-07-28T06:09:47.695829Z","end":"2026-07-28T06:09:47.856911Z","steps":["trace[1927432207] 'read index received' (duration: 37.553915ms)","trace[1927432207] 'applied index is now lower than readState.Index' (duration: 123.526998ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T06:09:47.857173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.964302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60647"} {"level":"info","ts":"2026-07-28T06:09:47.856888Z","caller":"traceutil/trace.go:171","msg":"trace[870203425] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"156.961693ms","start":"2026-07-28T06:09:47.699917Z","end":"2026-07-28T06:09:47.856878Z","steps":["trace[870203425] 'process raft request' (duration: 156.420693ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:09:47.85722Z","caller":"traceutil/trace.go:171","msg":"trace[1050291305] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4771; }","duration":"186.025963ms","start":"2026-07-28T06:09:47.671184Z","end":"2026-07-28T06:09:47.85721Z","steps":["trace[1050291305] 'agreement among raft nodes before linearized reading' (duration: 185.778069ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:09:47.857396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.242667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-07-28T06:09:47.85744Z","caller":"traceutil/trace.go:171","msg":"trace[1407397666] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4771; }","duration":"186.314318ms","start":"2026-07-28T06:09:47.671115Z","end":"2026-07-28T06:09:47.85743Z","steps":["trace[1407397666] 'agreement among raft nodes before linearized reading' (duration: 186.197926ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:09:47.859408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.710152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b34f194a-3c6e-44b4-8621-86a3a0835c64\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-28T06:09:47.85956Z","caller":"traceutil/trace.go:171","msg":"trace[2047208219] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b34f194a-3c6e-44b4-8621-86a3a0835c64; range_end:; response_count:1; response_revision:4772; }","duration":"158.901226ms","start":"2026-07-28T06:09:47.700637Z","end":"2026-07-28T06:09:47.859538Z","steps":["trace[2047208219] 'agreement among raft nodes before linearized reading' (duration: 158.545719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:09:47.860154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.389988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-07-28T06:09:47.860301Z","caller":"traceutil/trace.go:171","msg":"trace[693100658] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4772; }","duration":"158.55105ms","start":"2026-07-28T06:09:47.701736Z","end":"2026-07-28T06:09:47.860287Z","steps":["trace[693100658] 'agreement among raft nodes before linearized reading' (duration: 158.347997ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:09:48.191564Z","caller":"traceutil/trace.go:171","msg":"trace[1613861753] linearizableReadLoop","detail":"{readStateIndex:4963; appliedIndex:4962; }","duration":"103.796116ms","start":"2026-07-28T06:09:48.087749Z","end":"2026-07-28T06:09:48.191545Z","steps":["trace[1613861753] 'read index received' (duration: 22.08422ms)","trace[1613861753] 'applied index is now lower than readState.Index' (duration: 81.710756ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T06:09:48.191832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.044558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-75b2b\" ","response":"range_response_count:1 size:9674"} {"level":"info","ts":"2026-07-28T06:09:48.191867Z","caller":"traceutil/trace.go:171","msg":"trace[1138465699] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-75b2b; range_end:; response_count:1; response_revision:4779; }","duration":"155.104469ms","start":"2026-07-28T06:09:48.03675Z","end":"2026-07-28T06:09:48.191855Z","steps":["trace[1138465699] 'agreement among raft nodes before linearized reading' (duration: 154.932036ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:09:48.409395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.653288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-07-28T06:09:48.409466Z","caller":"traceutil/trace.go:171","msg":"trace[965319683] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4783; }","duration":"116.752089ms","start":"2026-07-28T06:09:48.292695Z","end":"2026-07-28T06:09:48.409447Z","steps":["trace[965319683] 'range keys from in-memory index tree' (duration: 116.504595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T06:09:48.409659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.539712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-07-28T06:09:48.410091Z","caller":"traceutil/trace.go:171","msg":"trace[303003134] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4783; }","duration":"117.9896ms","start":"2026-07-28T06:09:48.292083Z","end":"2026-07-28T06:09:48.410072Z","steps":["trace[303003134] 'range keys from in-memory index tree' (duration: 117.436481ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:10:00.339094Z","caller":"traceutil/trace.go:171","msg":"trace[1472411384] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"134.087375ms","start":"2026-07-28T06:10:00.20495Z","end":"2026-07-28T06:10:00.339037Z","steps":["trace[1472411384] 'process raft request' (duration: 133.850821ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T06:10:00.464317Z","caller":"traceutil/trace.go:171","msg":"trace[346108962] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"103.344219ms","start":"2026-07-28T06:10:00.360934Z","end":"2026-07-28T06:10:00.464279Z","steps":["trace[346108962] 'process raft request' (duration: 62.505309ms)","trace[346108962] 'compare' (duration: 40.205819ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T06:11:05.307382Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2845} {"level":"info","ts":"2026-07-28T06:11:05.420117Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2845,"took":"111.093263ms","hash":2645002794,"current-db-size-bytes":54861824,"current-db-size":"55 MB","current-db-size-in-use-bytes":29421568,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-28T06:11:05.420166Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2645002794,"revision":2845,"compact-revision":-1} {"level":"info","ts":"2026-07-28T06:16:05.314037Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5527} {"level":"info","ts":"2026-07-28T06:16:05.421706Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5527,"took":"105.748267ms","hash":206715152,"current-db-size-bytes":54861824,"current-db-size":"55 MB","current-db-size-in-use-bytes":18685952,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-28T06:16:05.421789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":206715152,"revision":5527,"compact-revision":2845}