{"level":"warn","ts":"2026-07-14T06:33:19.017766Z","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-14T06:33:19.017845Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.3: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.3:2380","--initial-cluster=instance=https://199.19.213.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.3: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-14T06:33:19.017924Z","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-14T06:33:19.017954Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-07-14T06:33:19.017984Z","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-14T06:33:19.018712Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"]} {"level":"info","ts":"2026-07-14T06:33:19.018833Z","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.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.3: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-14T06:33:19.023156Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.115654ms"} {"level":"info","ts":"2026-07-14T06:33:19.030041Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cf904ec39d3e333","cluster-id":"7b1ae51097bedd0e"} {"level":"info","ts":"2026-07-14T06:33:19.030212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T06:33:19.030276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 0"} {"level":"info","ts":"2026-07-14T06:33:19.030312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cf904ec39d3e333 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T06:33:19.030353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 1"} {"level":"info","ts":"2026-07-14T06:33:19.030469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"warn","ts":"2026-07-14T06:33:19.036791Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T06:33:19.038596Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T06:33:19.039899Z","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-14T06:33:19.04225Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cf904ec39d3e333","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T06:33:19.043169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"info","ts":"2026-07-14T06:33:19.043297Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","added-peer-id":"3cf904ec39d3e333","added-peer-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-07-14T06:33:19.043471Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cf904ec39d3e333","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T06:33:19.043529Z","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-14T06:33:19.046909Z","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-14T06:33:19.047014Z","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-14T06:33:19.048928Z","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-14T06:33:19.049077Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-07-14T06:33:19.049122Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-07-14T06:33:19.04929Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cf904ec39d3e333","initial-advertise-peer-urls":["https://199.19.213.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T06:33:19.049323Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T06:33:19.63142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T06:33:19.631482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T06:33:19.631502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgPreVoteResp from 3cf904ec39d3e333 at term 1"} {"level":"info","ts":"2026-07-14T06:33:19.631516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became candidate at term 2"} {"level":"info","ts":"2026-07-14T06:33:19.631523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgVoteResp from 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-07-14T06:33:19.631533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became leader at term 2"} {"level":"info","ts":"2026-07-14T06:33:19.631542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cf904ec39d3e333 elected leader 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-07-14T06:33:19.632893Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cf904ec39d3e333","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.3:2379]}","request-path":"/0/members/3cf904ec39d3e333/attributes","cluster-id":"7b1ae51097bedd0e","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T06:33:19.632938Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T06:33:19.632924Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T06:33:19.633011Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T06:33:19.633526Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T06:33:19.63357Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-14T06:33:19.633957Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T06:33:19.634062Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T06:33:19.634095Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T06:33:19.635704Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.3:2379"} {"level":"info","ts":"2026-07-14T06:33:19.635816Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-14T06:33:24.181496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.518925ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-07-14T06:33:24.181736Z","caller":"traceutil/trace.go:171","msg":"trace[797695265] linearizableReadLoop","detail":"{readStateIndex:217; appliedIndex:215; }","duration":"442.690446ms","start":"2026-07-14T06:33:23.739028Z","end":"2026-07-14T06:33:24.181719Z","steps":["trace[797695265] 'read index received' (duration: 162.747278ms)","trace[797695265] 'applied index is now lower than readState.Index' (duration: 279.942298ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T06:33:24.181793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:33:23.731569Z","time spent":"450.22024ms","remote":"127.0.0.1:60306","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-14T06:33:24.181855Z","caller":"traceutil/trace.go:171","msg":"trace[508234972] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"448.719931ms","start":"2026-07-14T06:33:23.733102Z","end":"2026-07-14T06:33:24.181822Z","steps":["trace[508234972] 'process raft request' (duration: 448.525332ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:33:24.181945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.835856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3707"} {"level":"info","ts":"2026-07-14T06:33:24.181981Z","caller":"traceutil/trace.go:171","msg":"trace[676771471] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:211; }","duration":"273.939572ms","start":"2026-07-14T06:33:23.908031Z","end":"2026-07-14T06:33:24.181971Z","steps":["trace[676771471] 'agreement among raft nodes before linearized reading' (duration: 273.814036ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:33:24.181981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.930198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T06:33:24.182226Z","caller":"traceutil/trace.go:171","msg":"trace[994763851] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:0; response_revision:211; }","duration":"443.032193ms","start":"2026-07-14T06:33:23.738994Z","end":"2026-07-14T06:33:24.182026Z","steps":["trace[994763851] 'agreement among raft nodes before linearized reading' (duration: 442.846924ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:33:24.182273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:33:23.738985Z","time spent":"443.276356ms","remote":"127.0.0.1:60438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" "} {"level":"warn","ts":"2026-07-14T06:33:24.182478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:33:23.733079Z","time spent":"448.852228ms","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T06:33:24.28939Z","caller":"traceutil/trace.go:171","msg":"trace[1562678509] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"103.397431ms","start":"2026-07-14T06:33:24.18595Z","end":"2026-07-14T06:33:24.289347Z","steps":["trace[1562678509] 'process raft request' (duration: 102.795579ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.552401Z","caller":"traceutil/trace.go:171","msg":"trace[472490682] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"218.633738ms","start":"2026-07-14T06:33:58.333743Z","end":"2026-07-14T06:33:58.552377Z","steps":["trace[472490682] 'process raft request' (duration: 218.479768ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.55842Z","caller":"traceutil/trace.go:171","msg":"trace[1781277061] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"148.985375ms","start":"2026-07-14T06:33:58.409406Z","end":"2026-07-14T06:33:58.558391Z","steps":["trace[1781277061] 'process raft request' (duration: 148.934704ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.558459Z","caller":"traceutil/trace.go:171","msg":"trace[1015346551] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"145.609465ms","start":"2026-07-14T06:33:58.412812Z","end":"2026-07-14T06:33:58.558422Z","steps":["trace[1015346551] 'process raft request' (duration: 145.543065ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.558528Z","caller":"traceutil/trace.go:171","msg":"trace[1883214593] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"136.289541ms","start":"2026-07-14T06:33:58.422204Z","end":"2026-07-14T06:33:58.558494Z","steps":["trace[1883214593] 'process raft request' (duration: 136.208181ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.558542Z","caller":"traceutil/trace.go:171","msg":"trace[1077807435] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"137.323131ms","start":"2026-07-14T06:33:58.421152Z","end":"2026-07-14T06:33:58.558475Z","steps":["trace[1077807435] 'process raft request' (duration: 137.21952ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.558666Z","caller":"traceutil/trace.go:171","msg":"trace[941902635] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"130.918552ms","start":"2026-07-14T06:33:58.427718Z","end":"2026-07-14T06:33:58.558636Z","steps":["trace[941902635] 'process raft request' (duration: 130.743362ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.558719Z","caller":"traceutil/trace.go:171","msg":"trace[576499740] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"122.959032ms","start":"2026-07-14T06:33:58.435751Z","end":"2026-07-14T06:33:58.55871Z","steps":["trace[576499740] 'process raft request' (duration: 122.809361ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.55872Z","caller":"traceutil/trace.go:171","msg":"trace[202035428] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"132.216524ms","start":"2026-07-14T06:33:58.426493Z","end":"2026-07-14T06:33:58.558709Z","steps":["trace[202035428] 'process raft request' (duration: 131.948182ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.558787Z","caller":"traceutil/trace.go:171","msg":"trace[140480183] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"122.223435ms","start":"2026-07-14T06:33:58.436549Z","end":"2026-07-14T06:33:58.558773Z","steps":["trace[140480183] 'process raft request' (duration: 122.057663ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.558808Z","caller":"traceutil/trace.go:171","msg":"trace[653939115] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"130.917613ms","start":"2026-07-14T06:33:58.427807Z","end":"2026-07-14T06:33:58.558725Z","steps":["trace[653939115] 'process raft request' (duration: 130.724181ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:33:58.558939Z","caller":"traceutil/trace.go:171","msg":"trace[518444740] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"149.55486ms","start":"2026-07-14T06:33:58.409349Z","end":"2026-07-14T06:33:58.558903Z","steps":["trace[518444740] 'process raft request' (duration: 148.898585ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:34:04.839622Z","caller":"traceutil/trace.go:171","msg":"trace[1283382360] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"263.771116ms","start":"2026-07-14T06:34:04.57583Z","end":"2026-07-14T06:34:04.839601Z","steps":["trace[1283382360] 'read index received' (duration: 262.964846ms)","trace[1283382360] 'applied index is now lower than readState.Index' (duration: 803.17µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T06:34:04.839651Z","caller":"traceutil/trace.go:171","msg":"trace[659051413] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"394.833533ms","start":"2026-07-14T06:34:04.444787Z","end":"2026-07-14T06:34:04.83962Z","steps":["trace[659051413] 'process raft request' (duration: 394.248266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:34:04.839828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:34:04.444758Z","time spent":"394.986714ms","remote":"127.0.0.1:60330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T06:34:04.839859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.007458ms","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-14T06:34:04.839894Z","caller":"traceutil/trace.go:171","msg":"trace[226220075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"264.08614ms","start":"2026-07-14T06:34:04.575796Z","end":"2026-07-14T06:34:04.839882Z","steps":["trace[226220075] 'agreement among raft nodes before linearized reading' (duration: 263.940228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:34:04.840175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.254171ms","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-14T06:34:04.840204Z","caller":"traceutil/trace.go:171","msg":"trace[1573582495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"228.312812ms","start":"2026-07-14T06:34:04.611883Z","end":"2026-07-14T06:34:04.840195Z","steps":["trace[1573582495] 'agreement among raft nodes before linearized reading' (duration: 228.230971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:34:05.492206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.577455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T06:34:05.492529Z","caller":"traceutil/trace.go:171","msg":"trace[138938094] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"632.891782ms","start":"2026-07-14T06:34:04.859609Z","end":"2026-07-14T06:34:05.492501Z","steps":["trace[138938094] 'process raft request' (duration: 632.729629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:34:05.49273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:34:04.859601Z","time spent":"632.997023ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T06:34:05.492903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.259971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T06:34:05.492746Z","caller":"traceutil/trace.go:171","msg":"trace[1704634795] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:624; }","duration":"539.041138ms","start":"2026-07-14T06:34:04.95359Z","end":"2026-07-14T06:34:05.492631Z","steps":["trace[1704634795] 'read index received' (duration: 148.937278ms)","trace[1704634795] 'applied index is now lower than readState.Index' (duration: 390.10289ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T06:34:05.492959Z","caller":"traceutil/trace.go:171","msg":"trace[1453207964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"539.391383ms","start":"2026-07-14T06:34:04.953555Z","end":"2026-07-14T06:34:05.492947Z","steps":["trace[1453207964] 'agreement among raft nodes before linearized reading' (duration: 539.234591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:34:05.493016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:34:04.95354Z","time spent":"539.465844ms","remote":"127.0.0.1:60212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T06:34:05.493185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.923715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-14T06:34:05.493228Z","caller":"traceutil/trace.go:171","msg":"trace[81855422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"109.999175ms","start":"2026-07-14T06:34:05.383216Z","end":"2026-07-14T06:34:05.493215Z","steps":["trace[81855422] 'agreement among raft nodes before linearized reading' (duration: 109.838754ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:34:05.493427Z","caller":"traceutil/trace.go:171","msg":"trace[1748795887] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"568.214963ms","start":"2026-07-14T06:34:04.925127Z","end":"2026-07-14T06:34:05.493342Z","steps":["trace[1748795887] 'process raft request' (duration: 567.288801ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:34:05.493428Z","caller":"traceutil/trace.go:171","msg":"trace[1735746820] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"644.676199ms","start":"2026-07-14T06:34:04.8487Z","end":"2026-07-14T06:34:05.493376Z","steps":["trace[1735746820] 'process raft request' (duration: 253.816717ms)","trace[1735746820] 'compare' (duration: 389.404642ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T06:34:05.493501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:34:04.925109Z","time spent":"568.356445ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T06:34:05.493608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:34:04.848676Z","time spent":"644.841872ms","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T06:34:20.154895Z","caller":"traceutil/trace.go:171","msg":"trace[424038925] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:789; }","duration":"199.08506ms","start":"2026-07-14T06:34:19.955787Z","end":"2026-07-14T06:34:20.154872Z","steps":["trace[424038925] 'read index received' (duration: 198.967767ms)","trace[424038925] 'applied index is now lower than readState.Index' (duration: 116.343µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T06:34:20.155022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.213622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T06:34:20.155053Z","caller":"traceutil/trace.go:171","msg":"trace[1152760296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"199.289783ms","start":"2026-07-14T06:34:19.955753Z","end":"2026-07-14T06:34:20.155043Z","steps":["trace[1152760296] 'agreement among raft nodes before linearized reading' (duration: 199.218421ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:34:20.15534Z","caller":"traceutil/trace.go:171","msg":"trace[1392852518] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"230.720092ms","start":"2026-07-14T06:34:19.92461Z","end":"2026-07-14T06:34:20.15533Z","steps":["trace[1392852518] 'process raft request' (duration: 230.098799ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:35:15.392298Z","caller":"traceutil/trace.go:171","msg":"trace[191231321] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"155.044239ms","start":"2026-07-14T06:35:15.237225Z","end":"2026-07-14T06:35:15.392269Z","steps":["trace[191231321] 'process raft request' (duration: 154.894074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:35:40.559947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.609553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-282d8c08-3566-4086-9652-fd3b8df4f288\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-07-14T06:35:40.560018Z","caller":"traceutil/trace.go:171","msg":"trace[1463284109] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-282d8c08-3566-4086-9652-fd3b8df4f288; range_end:; response_count:1; response_revision:1854; }","duration":"302.733658ms","start":"2026-07-14T06:35:40.25727Z","end":"2026-07-14T06:35:40.560003Z","steps":["trace[1463284109] 'range keys from in-memory index tree' (duration: 302.452527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:35:40.560051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:35:40.257248Z","time spent":"302.792301ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3647,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-282d8c08-3566-4086-9652-fd3b8df4f288\" "} {"level":"warn","ts":"2026-07-14T06:35:40.560279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.794624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-282d8c08-3566-4086-9652-fd3b8df4f288\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-07-14T06:35:40.560465Z","caller":"traceutil/trace.go:171","msg":"trace[151048001] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-282d8c08-3566-4086-9652-fd3b8df4f288; range_end:; response_count:1; response_revision:1854; }","duration":"249.000452ms","start":"2026-07-14T06:35:40.311431Z","end":"2026-07-14T06:35:40.560431Z","steps":["trace[151048001] 'range keys from in-memory index tree' (duration: 248.509203ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:35:40.621391Z","caller":"traceutil/trace.go:171","msg":"trace[1866682195] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"136.845373ms","start":"2026-07-14T06:35:40.484519Z","end":"2026-07-14T06:35:40.621365Z","steps":["trace[1866682195] 'process raft request' (duration: 136.704558ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:35:40.730065Z","caller":"traceutil/trace.go:171","msg":"trace[1163763758] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"163.371483ms","start":"2026-07-14T06:35:40.566668Z","end":"2026-07-14T06:35:40.73004Z","steps":["trace[1163763758] 'process raft request' (duration: 136.077073ms)","trace[1163763758] 'compare' (duration: 26.844762ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T06:35:41.158027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.175204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T06:35:41.158124Z","caller":"traceutil/trace.go:171","msg":"trace[350714269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1856; }","duration":"202.30375ms","start":"2026-07-14T06:35:40.955799Z","end":"2026-07-14T06:35:41.158102Z","steps":["trace[350714269] 'range keys from in-memory index tree' (duration: 202.107512ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:35:41.158037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.012551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T06:35:41.158901Z","caller":"traceutil/trace.go:171","msg":"trace[890770535] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1856; }","duration":"211.966779ms","start":"2026-07-14T06:35:40.946912Z","end":"2026-07-14T06:35:41.158879Z","steps":["trace[890770535] 'count revisions from in-memory index tree' (duration: 210.915948ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:35:51.811681Z","caller":"traceutil/trace.go:171","msg":"trace[922111190] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"101.178293ms","start":"2026-07-14T06:35:51.710483Z","end":"2026-07-14T06:35:51.811662Z","steps":["trace[922111190] 'process raft request' (duration: 100.925093ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:35:52.261581Z","caller":"traceutil/trace.go:171","msg":"trace[559910470] linearizableReadLoop","detail":"{readStateIndex:2031; appliedIndex:2029; }","duration":"145.767111ms","start":"2026-07-14T06:35:52.115788Z","end":"2026-07-14T06:35:52.261555Z","steps":["trace[559910470] 'read index received' (duration: 21.306027ms)","trace[559910470] 'applied index is now lower than readState.Index' (duration: 124.459894ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T06:35:52.261634Z","caller":"traceutil/trace.go:171","msg":"trace[211717624] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"158.803984ms","start":"2026-07-14T06:35:52.102779Z","end":"2026-07-14T06:35:52.261583Z","steps":["trace[211717624] 'process raft request' (duration: 158.601436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:35:52.261893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.089634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-14T06:35:52.261963Z","caller":"traceutil/trace.go:171","msg":"trace[1193340227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1953; }","duration":"146.199098ms","start":"2026-07-14T06:35:52.115753Z","end":"2026-07-14T06:35:52.261952Z","steps":["trace[1193340227] 'agreement among raft nodes before linearized reading' (duration: 145.918147ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:35:52.26216Z","caller":"traceutil/trace.go:171","msg":"trace[688433902] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"132.903606ms","start":"2026-07-14T06:35:52.128721Z","end":"2026-07-14T06:35:52.261625Z","steps":["trace[688433902] 'process raft request' (duration: 132.791721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:36:14.102462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.359618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-14T06:36:14.102554Z","caller":"traceutil/trace.go:171","msg":"trace[1933617858] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2089; }","duration":"102.503994ms","start":"2026-07-14T06:36:14.000032Z","end":"2026-07-14T06:36:14.102536Z","steps":["trace[1933617858] 'count revisions from in-memory index tree' (duration: 102.274754ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:36:14.855793Z","caller":"traceutil/trace.go:171","msg":"trace[465675856] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"128.484696ms","start":"2026-07-14T06:36:14.727282Z","end":"2026-07-14T06:36:14.855767Z","steps":["trace[465675856] 'process raft request' (duration: 128.288737ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:36:14.866489Z","caller":"traceutil/trace.go:171","msg":"trace[1351020217] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"136.371449ms","start":"2026-07-14T06:36:14.730093Z","end":"2026-07-14T06:36:14.866465Z","steps":["trace[1351020217] 'process raft request' (duration: 136.235944ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:36:15.183267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.687055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-14T06:36:15.183356Z","caller":"traceutil/trace.go:171","msg":"trace[347398280] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2096; }","duration":"209.819722ms","start":"2026-07-14T06:36:14.973514Z","end":"2026-07-14T06:36:15.183334Z","steps":["trace[347398280] 'range keys from in-memory index tree' (duration: 209.449435ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:36:15.54022Z","caller":"traceutil/trace.go:171","msg":"trace[53456641] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"126.485727ms","start":"2026-07-14T06:36:15.413709Z","end":"2026-07-14T06:36:15.540194Z","steps":["trace[53456641] 'process raft request' (duration: 126.31897ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:36:15.842492Z","caller":"traceutil/trace.go:171","msg":"trace[1972033946] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"151.144683ms","start":"2026-07-14T06:36:15.691323Z","end":"2026-07-14T06:36:15.842467Z","steps":["trace[1972033946] 'process raft request' (duration: 150.990796ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:37:25.250228Z","caller":"traceutil/trace.go:171","msg":"trace[916106674] transaction","detail":"{read_only:false; response_revision:2573; number_of_response:1; }","duration":"142.297309ms","start":"2026-07-14T06:37:25.107909Z","end":"2026-07-14T06:37:25.250206Z","steps":["trace[916106674] 'process raft request' (duration: 142.162812ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:37:56.495027Z","caller":"traceutil/trace.go:171","msg":"trace[298937689] linearizableReadLoop","detail":"{readStateIndex:2850; appliedIndex:2849; }","duration":"144.025042ms","start":"2026-07-14T06:37:56.350964Z","end":"2026-07-14T06:37:56.494989Z","steps":["trace[298937689] 'read index received' (duration: 113.868097ms)","trace[298937689] 'applied index is now lower than readState.Index' (duration: 30.154955ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T06:37:56.495404Z","caller":"traceutil/trace.go:171","msg":"trace[1694002173] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"181.906462ms","start":"2026-07-14T06:37:56.313478Z","end":"2026-07-14T06:37:56.495384Z","steps":["trace[1694002173] 'process raft request' (duration: 151.429422ms)","trace[1694002173] 'compare' (duration: 29.64801ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T06:37:56.49575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.089753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T06:37:56.495897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.899894ms","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-14T06:37:56.495862Z","caller":"traceutil/trace.go:171","msg":"trace[673172747] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2743; }","duration":"134.267252ms","start":"2026-07-14T06:37:56.361571Z","end":"2026-07-14T06:37:56.495838Z","steps":["trace[673172747] 'agreement among raft nodes before linearized reading' (duration: 134.065222ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:37:56.496023Z","caller":"traceutil/trace.go:171","msg":"trace[1009045566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2743; }","duration":"145.073911ms","start":"2026-07-14T06:37:56.350905Z","end":"2026-07-14T06:37:56.495979Z","steps":["trace[1009045566] 'agreement among raft nodes before linearized reading' (duration: 144.768098ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:40:47.5607Z","caller":"traceutil/trace.go:171","msg":"trace[114307871] linearizableReadLoop","detail":"{readStateIndex:3887; appliedIndex:3886; }","duration":"176.679629ms","start":"2026-07-14T06:40:47.383981Z","end":"2026-07-14T06:40:47.560661Z","steps":["trace[114307871] 'read index received' (duration: 176.535576ms)","trace[114307871] 'applied index is now lower than readState.Index' (duration: 142.133µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T06:40:47.560746Z","caller":"traceutil/trace.go:171","msg":"trace[1059378710] transaction","detail":"{read_only:false; response_revision:3741; number_of_response:1; }","duration":"457.554428ms","start":"2026-07-14T06:40:47.103142Z","end":"2026-07-14T06:40:47.560697Z","steps":["trace[1059378710] 'process raft request' (duration: 457.306911ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:47.561011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.993118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-14T06:40:47.560963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.103104Z","time spent":"457.727862ms","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T06:40:47.561062Z","caller":"traceutil/trace.go:171","msg":"trace[244952892] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3741; }","duration":"177.124312ms","start":"2026-07-14T06:40:47.383924Z","end":"2026-07-14T06:40:47.561048Z","steps":["trace[244952892] 'agreement among raft nodes before linearized reading' (duration: 176.875896ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:48.226427Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371604302209734471,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T06:40:48.727349Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371604302209734471,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T06:40:48.966259Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.405689733s","expected-duration":"1s"} {"level":"info","ts":"2026-07-14T06:40:48.968713Z","caller":"traceutil/trace.go:171","msg":"trace[1842279879] transaction","detail":"{read_only:false; response_revision:3743; number_of_response:1; }","duration":"1.445119548s","start":"2026-07-14T06:40:47.52356Z","end":"2026-07-14T06:40:48.968679Z","steps":["trace[1842279879] 'process raft request' (duration: 1.444949783s)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:40:48.968709Z","caller":"traceutil/trace.go:171","msg":"trace[1449116228] transaction","detail":"{read_only:false; response_revision:3742; number_of_response:1; }","duration":"1.445855988s","start":"2026-07-14T06:40:47.522816Z","end":"2026-07-14T06:40:48.968672Z","steps":["trace[1449116228] 'process raft request' (duration: 1.444666056s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:48.96906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.523543Z","time spent":"1.445276023s","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T06:40:48.969348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.522781Z","time spent":"1.446294698s","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T06:40:48.971102Z","caller":"traceutil/trace.go:171","msg":"trace[1763873442] transaction","detail":"{read_only:false; response_revision:3744; number_of_response:1; }","duration":"1.405994442s","start":"2026-07-14T06:40:47.56509Z","end":"2026-07-14T06:40:48.971085Z","steps":["trace[1763873442] 'process raft request' (duration: 1.405696264s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:48.971197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.565059Z","time spent":"1.406101975s","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T06:40:48.9711Z","caller":"traceutil/trace.go:171","msg":"trace[1007808258] transaction","detail":"{read_only:false; response_revision:3745; number_of_response:1; }","duration":"944.166541ms","start":"2026-07-14T06:40:48.02689Z","end":"2026-07-14T06:40:48.971057Z","steps":["trace[1007808258] 'process raft request' (duration: 944.047228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:48.971612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:48.026862Z","time spent":"944.668084ms","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T06:40:48.976924Z","caller":"traceutil/trace.go:171","msg":"trace[213437621] linearizableReadLoop","detail":"{readStateIndex:3892; appliedIndex:3887; }","duration":"1.25111877s","start":"2026-07-14T06:40:47.725721Z","end":"2026-07-14T06:40:48.97684Z","steps":["trace[213437621] 'read index received' (duration: 1.241082888s)","trace[213437621] 'applied index is now lower than readState.Index' (duration: 10.033652ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T06:40:48.977157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156403638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T06:40:48.977213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.25147526s","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-14T06:40:48.977245Z","caller":"traceutil/trace.go:171","msg":"trace[750448306] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:3745; }","duration":"1.156568332s","start":"2026-07-14T06:40:47.820653Z","end":"2026-07-14T06:40:48.977221Z","steps":["trace[750448306] 'agreement among raft nodes before linearized reading' (duration: 1.156410818s)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:40:48.977252Z","caller":"traceutil/trace.go:171","msg":"trace[119293985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3745; }","duration":"1.251566651s","start":"2026-07-14T06:40:47.725674Z","end":"2026-07-14T06:40:48.97724Z","steps":["trace[119293985] 'agreement among raft nodes before linearized reading' (duration: 1.251366125s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:48.977293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.725658Z","time spent":"1.251627633s","remote":"127.0.0.1:60490","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-14T06:40:48.977299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.820624Z","time spent":"1.156658345s","remote":"127.0.0.1:39020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-14T06:40:48.977755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155998398s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-14T06:40:48.977786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022038478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T06:40:48.977825Z","caller":"traceutil/trace.go:171","msg":"trace[592410553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3745; }","duration":"1.156055949s","start":"2026-07-14T06:40:47.821724Z","end":"2026-07-14T06:40:48.97778Z","steps":["trace[592410553] 'agreement among raft nodes before linearized reading' (duration: 1.155959716s)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:40:48.977837Z","caller":"traceutil/trace.go:171","msg":"trace[404774249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3745; }","duration":"1.022147891s","start":"2026-07-14T06:40:47.955673Z","end":"2026-07-14T06:40:48.977821Z","steps":["trace[404774249] 'agreement among raft nodes before linearized reading' (duration: 1.02207786s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:48.977865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.955639Z","time spent":"1.022219593s","remote":"127.0.0.1:60228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T06:40:48.977863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.821713Z","time spent":"1.156139313s","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-14T06:40:48.977906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.563296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-07-14T06:40:48.977966Z","caller":"traceutil/trace.go:171","msg":"trace[121908403] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3745; }","duration":"825.68488ms","start":"2026-07-14T06:40:48.152268Z","end":"2026-07-14T06:40:48.977953Z","steps":["trace[121908403] 'agreement among raft nodes before linearized reading' (duration: 825.458064ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:48.977999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:48.152244Z","time spent":"825.74667ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-14T06:40:48.978176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.157404145s","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-14T06:40:48.978212Z","caller":"traceutil/trace.go:171","msg":"trace[1691012993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3745; }","duration":"1.157465557s","start":"2026-07-14T06:40:47.820733Z","end":"2026-07-14T06:40:48.978198Z","steps":["trace[1691012993] 'agreement among raft nodes before linearized reading' (duration: 1.157375274s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:40:48.978241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T06:40:47.820699Z","time spent":"1.157535528s","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-14T06:41:49.414174Z","caller":"traceutil/trace.go:171","msg":"trace[1998918071] linearizableReadLoop","detail":"{readStateIndex:4799; appliedIndex:4798; }","duration":"152.405881ms","start":"2026-07-14T06:41:49.261751Z","end":"2026-07-14T06:41:49.414157Z","steps":["trace[1998918071] 'read index received' (duration: 119.584796ms)","trace[1998918071] 'applied index is now lower than readState.Index' (duration: 32.819405ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T06:41:49.414539Z","caller":"traceutil/trace.go:171","msg":"trace[1220463888] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"147.02836ms","start":"2026-07-14T06:41:49.267498Z","end":"2026-07-14T06:41:49.414527Z","steps":["trace[1220463888] 'process raft request' (duration: 146.548155ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:41:49.414708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.928688ms","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-14T06:41:49.414775Z","caller":"traceutil/trace.go:171","msg":"trace[1864898507] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4622; }","duration":"153.044651ms","start":"2026-07-14T06:41:49.261713Z","end":"2026-07-14T06:41:49.414757Z","steps":["trace[1864898507] 'agreement among raft nodes before linearized reading' (duration: 152.576846ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:41:49.414122Z","caller":"traceutil/trace.go:171","msg":"trace[969277953] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"188.973935ms","start":"2026-07-14T06:41:49.225111Z","end":"2026-07-14T06:41:49.414085Z","steps":["trace[969277953] 'process raft request' (duration: 156.035606ms)","trace[969277953] 'compare' (duration: 32.709232ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T06:41:49.415021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.964138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9938bf5f-e13b-4736-9f3a-79e0e3541ba1\" ","response":"range_response_count:1 size:3772"} {"level":"info","ts":"2026-07-14T06:41:49.415159Z","caller":"traceutil/trace.go:171","msg":"trace[184176264] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9938bf5f-e13b-4736-9f3a-79e0e3541ba1; range_end:; response_count:1; response_revision:4622; }","duration":"126.203747ms","start":"2026-07-14T06:41:49.28893Z","end":"2026-07-14T06:41:49.415133Z","steps":["trace[184176264] 'agreement among raft nodes before linearized reading' (duration: 125.618039ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:41:51.624837Z","caller":"traceutil/trace.go:171","msg":"trace[2031801075] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"202.33661ms","start":"2026-07-14T06:41:51.422472Z","end":"2026-07-14T06:41:51.624809Z","steps":["trace[2031801075] 'process raft request' (duration: 202.146714ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:41:51.625058Z","caller":"traceutil/trace.go:171","msg":"trace[1007863442] linearizableReadLoop","detail":"{readStateIndex:4824; appliedIndex:4822; }","duration":"199.994625ms","start":"2026-07-14T06:41:51.425031Z","end":"2026-07-14T06:41:51.625026Z","steps":["trace[1007863442] 'read index received' (duration: 61.191056ms)","trace[1007863442] 'applied index is now lower than readState.Index' (duration: 138.802439ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T06:41:51.625249Z","caller":"traceutil/trace.go:171","msg":"trace[287262535] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"200.092769ms","start":"2026-07-14T06:41:51.425144Z","end":"2026-07-14T06:41:51.625237Z","steps":["trace[287262535] 'process raft request' (duration: 199.620493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:41:51.625533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.46809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9938bf5f-e13b-4736-9f3a-79e0e3541ba1\" ","response":"range_response_count:1 size:4065"} {"level":"info","ts":"2026-07-14T06:41:51.625624Z","caller":"traceutil/trace.go:171","msg":"trace[74536374] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9938bf5f-e13b-4736-9f3a-79e0e3541ba1; range_end:; response_count:1; response_revision:4645; }","duration":"200.624966ms","start":"2026-07-14T06:41:51.424978Z","end":"2026-07-14T06:41:51.625603Z","steps":["trace[74536374] 'agreement among raft nodes before linearized reading' (duration: 200.333936ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:41:51.625885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.750646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-14T06:41:51.62593Z","caller":"traceutil/trace.go:171","msg":"trace[2058563980] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4645; }","duration":"132.835027ms","start":"2026-07-14T06:41:51.493085Z","end":"2026-07-14T06:41:51.62592Z","steps":["trace[2058563980] 'agreement among raft nodes before linearized reading' (duration: 132.686123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:41:51.625925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.285705ms","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-14T06:41:51.62605Z","caller":"traceutil/trace.go:171","msg":"trace[36315939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4645; }","duration":"195.510132ms","start":"2026-07-14T06:41:51.430525Z","end":"2026-07-14T06:41:51.626035Z","steps":["trace[36315939] 'agreement among raft nodes before linearized reading' (duration: 194.945914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:41:51.626222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.97203ms","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-14T06:41:51.626284Z","caller":"traceutil/trace.go:171","msg":"trace[1351949422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4645; }","duration":"147.065732ms","start":"2026-07-14T06:41:51.479197Z","end":"2026-07-14T06:41:51.626262Z","steps":["trace[1351949422] 'agreement among raft nodes before linearized reading' (duration: 146.957708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:41:51.626265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.686293ms","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-14T06:41:51.626041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.40748ms","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-14T06:41:51.626432Z","caller":"traceutil/trace.go:171","msg":"trace[73810251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4645; }","duration":"142.852918ms","start":"2026-07-14T06:41:51.483553Z","end":"2026-07-14T06:41:51.626406Z","steps":["trace[73810251] 'agreement among raft nodes before linearized reading' (duration: 142.485376ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:41:51.626482Z","caller":"traceutil/trace.go:171","msg":"trace[127543168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4645; }","duration":"145.939336ms","start":"2026-07-14T06:41:51.480525Z","end":"2026-07-14T06:41:51.626465Z","steps":["trace[127543168] 'agreement among raft nodes before linearized reading' (duration: 145.285716ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:41:55.401005Z","caller":"traceutil/trace.go:171","msg":"trace[732077349] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"103.517419ms","start":"2026-07-14T06:41:55.297433Z","end":"2026-07-14T06:41:55.40095Z","steps":["trace[732077349] 'process raft request' (duration: 103.165268ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:42:09.736383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.449789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T06:42:09.736693Z","caller":"traceutil/trace.go:171","msg":"trace[1340011371] linearizableReadLoop","detail":"{readStateIndex:5146; appliedIndex:5145; }","duration":"120.829429ms","start":"2026-07-14T06:42:09.615831Z","end":"2026-07-14T06:42:09.73666Z","steps":["trace[1340011371] 'read index received' (duration: 9.042649ms)","trace[1340011371] 'applied index is now lower than readState.Index' (duration: 111.78418ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T06:42:09.736763Z","caller":"traceutil/trace.go:171","msg":"trace[1918365786] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"120.864701ms","start":"2026-07-14T06:42:09.615792Z","end":"2026-07-14T06:42:09.736657Z","steps":["trace[1918365786] 'compare' (duration: 111.259372ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:42:09.736822Z","caller":"traceutil/trace.go:171","msg":"trace[1661755867] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"119.371752ms","start":"2026-07-14T06:42:09.617434Z","end":"2026-07-14T06:42:09.736806Z","steps":["trace[1661755867] 'process raft request' (duration: 119.136934ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:42:09.736849Z","caller":"traceutil/trace.go:171","msg":"trace[69689589] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"119.532427ms","start":"2026-07-14T06:42:09.617274Z","end":"2026-07-14T06:42:09.736807Z","steps":["trace[69689589] 'process raft request' (duration: 119.214167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:42:09.737219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.363167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9938bf5f-e13b-4736-9f3a-79e0e3541ba1\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-07-14T06:42:09.737253Z","caller":"traceutil/trace.go:171","msg":"trace[439886700] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9938bf5f-e13b-4736-9f3a-79e0e3541ba1; range_end:; response_count:1; response_revision:4957; }","duration":"121.437051ms","start":"2026-07-14T06:42:09.615807Z","end":"2026-07-14T06:42:09.737244Z","steps":["trace[439886700] 'agreement among raft nodes before linearized reading' (duration: 120.995876ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:42:09.737529Z","caller":"traceutil/trace.go:171","msg":"trace[1507034455] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"118.401309ms","start":"2026-07-14T06:42:09.619117Z","end":"2026-07-14T06:42:09.737518Z","steps":["trace[1507034455] 'process raft request' (duration: 117.659765ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:42:09.737598Z","caller":"traceutil/trace.go:171","msg":"trace[1967194415] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"111.553313ms","start":"2026-07-14T06:42:09.626026Z","end":"2026-07-14T06:42:09.737579Z","steps":["trace[1967194415] 'process raft request' (duration: 111.270413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T06:42:09.755745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.903783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61819"} {"level":"info","ts":"2026-07-14T06:42:09.755873Z","caller":"traceutil/trace.go:171","msg":"trace[1212950294] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4961; }","duration":"137.017237ms","start":"2026-07-14T06:42:09.618799Z","end":"2026-07-14T06:42:09.755817Z","steps":["trace[1212950294] 'agreement among raft nodes before linearized reading' (duration: 136.760848ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:43:19.885014Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2870} {"level":"info","ts":"2026-07-14T06:43:19.957878Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2870,"took":"71.402111ms","hash":425754964,"current-db-size-bytes":53358592,"current-db-size":"53 MB","current-db-size-in-use-bytes":29044736,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-14T06:43:19.957972Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":425754964,"revision":2870,"compact-revision":-1} {"level":"info","ts":"2026-07-14T06:45:59.161135Z","caller":"traceutil/trace.go:171","msg":"trace[170727362] transaction","detail":"{read_only:false; response_revision:6599; number_of_response:1; }","duration":"100.548308ms","start":"2026-07-14T06:45:59.060541Z","end":"2026-07-14T06:45:59.161089Z","steps":["trace[170727362] 'process raft request' (duration: 93.591981ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T06:48:19.890079Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5533} {"level":"info","ts":"2026-07-14T06:48:20.009195Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5533,"took":"117.091912ms","hash":3726236371,"current-db-size-bytes":53358592,"current-db-size":"53 MB","current-db-size-in-use-bytes":18444288,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-14T06:48:20.009265Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3726236371,"revision":5533,"compact-revision":2870}