{"level":"warn","ts":"2026-04-09T02:05:53.301515Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T02:05:53.301692Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-09T02:05:53.301826Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T02:05:53.301853Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-04-09T02:05:53.301902Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-09T02:05:53.303271Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-04-09T02:05:53.303428Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-09T02:05:53.308893Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.24628ms"} {"level":"info","ts":"2026-04-09T02:05:53.320488Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-04-09T02:05:53.320661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T02:05:53.320714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-04-09T02:05:53.320738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T02:05:53.32076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-04-09T02:05:53.320833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-04-09T02:05:53.328477Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T02:05:53.331531Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T02:05:53.334232Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-09T02:05:53.337358Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T02:05:53.337665Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T02:05:53.337757Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T02:05:53.337971Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T02:05:53.337986Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T02:05:53.339019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-04-09T02:05:53.339163Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-04-09T02:05:53.341355Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-09T02:05:53.341469Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-04-09T02:05:53.3415Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-04-09T02:05:53.341675Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T02:05:53.34171Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T02:05:53.622109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T02:05:53.622212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T02:05:53.622249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-04-09T02:05:53.622271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-04-09T02:05:53.622283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-04-09T02:05:53.622324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-04-09T02:05:53.622339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-04-09T02:05:53.623206Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T02:05:53.624183Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T02:05:53.624174Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T02:05:53.624252Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T02:05:53.624462Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T02:05:53.624699Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T02:05:53.624703Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T02:05:53.624738Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T02:05:53.624792Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T02:05:53.627366Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T02:05:53.627363Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-04-09T02:05:58.247474Z","caller":"traceutil/trace.go:171","msg":"trace[616486034] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"125.422522ms","start":"2026-04-09T02:05:58.122028Z","end":"2026-04-09T02:05:58.24745Z","steps":["trace[616486034] 'process raft request' (duration: 125.232827ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:06:09.271598Z","caller":"traceutil/trace.go:171","msg":"trace[326728890] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"100.012892ms","start":"2026-04-09T02:06:09.171546Z","end":"2026-04-09T02:06:09.271559Z","steps":["trace[326728890] 'process raft request' (duration: 99.735146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:06:09.572867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.985393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-09T02:06:09.573004Z","caller":"traceutil/trace.go:171","msg":"trace[1967970983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:406; }","duration":"168.134057ms","start":"2026-04-09T02:06:09.404848Z","end":"2026-04-09T02:06:09.572982Z","steps":["trace[1967970983] 'range keys from in-memory index tree' (duration: 167.86258ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:06:09.768127Z","caller":"traceutil/trace.go:171","msg":"trace[444185248] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"190.413521ms","start":"2026-04-09T02:06:09.577681Z","end":"2026-04-09T02:06:09.768095Z","steps":["trace[444185248] 'process raft request' (duration: 165.421873ms)","trace[444185248] 'compare' (duration: 24.69925ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:06:09.993838Z","caller":"traceutil/trace.go:171","msg":"trace[170925293] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"144.708286ms","start":"2026-04-09T02:06:09.849109Z","end":"2026-04-09T02:06:09.993817Z","steps":["trace[170925293] 'read index received' (duration: 144.465751ms)","trace[170925293] 'applied index is now lower than readState.Index' (duration: 241.665µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:06:09.993941Z","caller":"traceutil/trace.go:171","msg":"trace[257861922] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"163.067707ms","start":"2026-04-09T02:06:09.830832Z","end":"2026-04-09T02:06:09.9939Z","steps":["trace[257861922] 'process raft request' (duration: 162.820421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:06:09.994047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.91024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-09T02:06:09.994112Z","caller":"traceutil/trace.go:171","msg":"trace[1847171265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:409; }","duration":"145.028313ms","start":"2026-04-09T02:06:09.84907Z","end":"2026-04-09T02:06:09.994099Z","steps":["trace[1847171265] 'agreement among raft nodes before linearized reading' (duration: 144.838838ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:06:26.466859Z","caller":"traceutil/trace.go:171","msg":"trace[1048627298] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"259.100327ms","start":"2026-04-09T02:06:26.207708Z","end":"2026-04-09T02:06:26.466808Z","steps":["trace[1048627298] 'process raft request' (duration: 221.672877ms)","trace[1048627298] 'compare' (duration: 37.135184ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:06:26.46733Z","caller":"traceutil/trace.go:171","msg":"trace[525082206] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"244.843853ms","start":"2026-04-09T02:06:26.222426Z","end":"2026-04-09T02:06:26.46727Z","steps":["trace[525082206] 'process raft request' (duration: 244.420532ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:06:26.467431Z","caller":"traceutil/trace.go:171","msg":"trace[586894551] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"236.854485ms","start":"2026-04-09T02:06:26.230544Z","end":"2026-04-09T02:06:26.467399Z","steps":["trace[586894551] 'process raft request' (duration: 236.585349ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:06:26.467567Z","caller":"traceutil/trace.go:171","msg":"trace[1847583569] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:579; }","duration":"204.737498ms","start":"2026-04-09T02:06:26.262807Z","end":"2026-04-09T02:06:26.467545Z","steps":["trace[1847583569] 'read index received' (duration: 166.673542ms)","trace[1847583569] 'applied index is now lower than readState.Index' (duration: 38.062696ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:06:26.46761Z","caller":"traceutil/trace.go:171","msg":"trace[1150814196] transaction","detail":"{read_only:false; number_of_response:1; response_revision:562; }","duration":"208.59066ms","start":"2026-04-09T02:06:26.25897Z","end":"2026-04-09T02:06:26.467561Z","steps":["trace[1150814196] 'process raft request' (duration: 208.355764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:06:26.467677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.850431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T02:06:26.467715Z","caller":"traceutil/trace.go:171","msg":"trace[1804005939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:562; }","duration":"204.926763ms","start":"2026-04-09T02:06:26.262777Z","end":"2026-04-09T02:06:26.467704Z","steps":["trace[1804005939] 'agreement among raft nodes before linearized reading' (duration: 204.849581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:06:32.620539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.282667ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-09T02:06:32.962233Z","caller":"traceutil/trace.go:171","msg":"trace[455026320] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"294.89814ms","start":"2026-04-09T02:06:32.667312Z","end":"2026-04-09T02:06:32.96221Z","steps":["trace[455026320] 'read index received' (duration: 294.013239ms)","trace[455026320] 'applied index is now lower than readState.Index' (duration: 884.141µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:06:32.962291Z","caller":"traceutil/trace.go:171","msg":"trace[1527589667] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"574.259153ms","start":"2026-04-09T02:06:32.388008Z","end":"2026-04-09T02:06:32.962267Z","steps":["trace[1527589667] 'process raft request' (duration: 573.605728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:06:32.962583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.224758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-09T02:06:32.962777Z","caller":"traceutil/trace.go:171","msg":"trace[1028041360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"295.469094ms","start":"2026-04-09T02:06:32.667246Z","end":"2026-04-09T02:06:32.962715Z","steps":["trace[1028041360] 'agreement among raft nodes before linearized reading' (duration: 295.078495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:06:32.963121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T02:06:32.387966Z","time spent":"574.381086ms","remote":"127.0.0.1:52112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T02:06:33.589543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.353851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T02:06:33.589581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T02:06:33.221712Z","time spent":"367.856311ms","remote":"127.0.0.1:52548","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-09T02:06:33.589645Z","caller":"traceutil/trace.go:171","msg":"trace[1625155999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"326.541316ms","start":"2026-04-09T02:06:33.263083Z","end":"2026-04-09T02:06:33.589624Z","steps":["trace[1625155999] 'range keys from in-memory index tree' (duration: 326.235219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:06:33.589712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T02:06:33.263059Z","time spent":"326.643408ms","remote":"127.0.0.1:52018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-09T02:06:33.592954Z","caller":"traceutil/trace.go:171","msg":"trace[297387082] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"118.146398ms","start":"2026-04-09T02:06:33.474778Z","end":"2026-04-09T02:06:33.592924Z","steps":["trace[297387082] 'process raft request' (duration: 117.396841ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:06:47.011236Z","caller":"traceutil/trace.go:171","msg":"trace[2114863146] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"101.730051ms","start":"2026-04-09T02:06:46.909474Z","end":"2026-04-09T02:06:47.011204Z","steps":["trace[2114863146] 'process raft request' (duration: 101.456514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:06:49.534628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.081591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T02:06:49.534743Z","caller":"traceutil/trace.go:171","msg":"trace[68731010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:783; }","duration":"272.259105ms","start":"2026-04-09T02:06:49.26246Z","end":"2026-04-09T02:06:49.534719Z","steps":["trace[68731010] 'range keys from in-memory index tree' (duration: 271.980039ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:07:26.556275Z","caller":"traceutil/trace.go:171","msg":"trace[977579146] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"127.885088ms","start":"2026-04-09T02:07:26.428352Z","end":"2026-04-09T02:07:26.556237Z","steps":["trace[977579146] 'process raft request' (duration: 127.556511ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:08:13.122681Z","caller":"traceutil/trace.go:171","msg":"trace[488248702] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1964; }","duration":"212.612472ms","start":"2026-04-09T02:08:12.91003Z","end":"2026-04-09T02:08:13.122642Z","steps":["trace[488248702] 'read index received' (duration: 212.311105ms)","trace[488248702] 'applied index is now lower than readState.Index' (duration: 300.267µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:08:13.122842Z","caller":"traceutil/trace.go:171","msg":"trace[114918571] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"299.155283ms","start":"2026-04-09T02:08:12.823634Z","end":"2026-04-09T02:08:13.12279Z","steps":["trace[114918571] 'process raft request' (duration: 298.793244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:08:13.123753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.690968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8adbb10b-0e27-4c46-bd17-f97644da746a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-09T02:08:13.123896Z","caller":"traceutil/trace.go:171","msg":"trace[822801463] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8adbb10b-0e27-4c46-bd17-f97644da746a; range_end:; response_count:1; response_revision:1891; }","duration":"213.907384ms","start":"2026-04-09T02:08:12.909961Z","end":"2026-04-09T02:08:13.123868Z","steps":["trace[822801463] 'agreement among raft nodes before linearized reading' (duration: 212.833298ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:08:13.663037Z","caller":"traceutil/trace.go:171","msg":"trace[597148275] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"203.006415ms","start":"2026-04-09T02:08:13.460002Z","end":"2026-04-09T02:08:13.663008Z","steps":["trace[597148275] 'process raft request' (duration: 202.80405ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:08:13.663684Z","caller":"traceutil/trace.go:171","msg":"trace[313431711] linearizableReadLoop","detail":"{readStateIndex:1967; appliedIndex:1965; }","duration":"180.436673ms","start":"2026-04-09T02:08:13.483211Z","end":"2026-04-09T02:08:13.663647Z","steps":["trace[313431711] 'read index received' (duration: 179.590973ms)","trace[313431711] 'applied index is now lower than readState.Index' (duration: 844.23µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:08:13.66384Z","caller":"traceutil/trace.go:171","msg":"trace[1448947968] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"190.955301ms","start":"2026-04-09T02:08:13.472834Z","end":"2026-04-09T02:08:13.66379Z","steps":["trace[1448947968] 'process raft request' (duration: 190.596143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:08:13.66413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.829813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-09T02:08:13.664229Z","caller":"traceutil/trace.go:171","msg":"trace[285398464] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1893; }","duration":"181.038787ms","start":"2026-04-09T02:08:13.483174Z","end":"2026-04-09T02:08:13.664213Z","steps":["trace[285398464] 'agreement among raft nodes before linearized reading' (duration: 180.646358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:08:13.664326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.816678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-09T02:08:13.664431Z","caller":"traceutil/trace.go:171","msg":"trace[1417448205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1893; }","duration":"106.992103ms","start":"2026-04-09T02:08:13.557416Z","end":"2026-04-09T02:08:13.664408Z","steps":["trace[1417448205] 'agreement among raft nodes before linearized reading' (duration: 106.497131ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:08:30.537948Z","caller":"traceutil/trace.go:171","msg":"trace[1672598809] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"275.748381ms","start":"2026-04-09T02:08:30.262148Z","end":"2026-04-09T02:08:30.537896Z","steps":["trace[1672598809] 'process raft request' (duration: 275.498895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:08:30.538079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.562168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T02:08:30.538152Z","caller":"traceutil/trace.go:171","msg":"trace[3393996] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2030; }","duration":"144.710052ms","start":"2026-04-09T02:08:30.393431Z","end":"2026-04-09T02:08:30.538141Z","steps":["trace[3393996] 'agreement among raft nodes before linearized reading' (duration: 144.545498ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:08:30.537923Z","caller":"traceutil/trace.go:171","msg":"trace[1488928862] linearizableReadLoop","detail":"{readStateIndex:2108; appliedIndex:2107; }","duration":"144.359754ms","start":"2026-04-09T02:08:30.393485Z","end":"2026-04-09T02:08:30.537845Z","steps":["trace[1488928862] 'read index received' (duration: 144.155199ms)","trace[1488928862] 'applied index is now lower than readState.Index' (duration: 202.795µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:09:03.222064Z","caller":"traceutil/trace.go:171","msg":"trace[1417852155] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"127.564393ms","start":"2026-04-09T02:09:03.094458Z","end":"2026-04-09T02:09:03.222022Z","steps":["trace[1417852155] 'process raft request' (duration: 127.290606ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:09:09.677501Z","caller":"traceutil/trace.go:171","msg":"trace[665451547] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"172.113917ms","start":"2026-04-09T02:09:09.505356Z","end":"2026-04-09T02:09:09.67747Z","steps":["trace[665451547] 'process raft request' (duration: 171.916693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:09:10.036684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.848137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T02:09:10.036793Z","caller":"traceutil/trace.go:171","msg":"trace[324272941] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2246; }","duration":"133.051232ms","start":"2026-04-09T02:09:09.903724Z","end":"2026-04-09T02:09:10.036775Z","steps":["trace[324272941] 'count revisions from in-memory index tree' (duration: 132.705834ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:09:53.165213Z","caller":"traceutil/trace.go:171","msg":"trace[1005361007] linearizableReadLoop","detail":"{readStateIndex:2754; appliedIndex:2753; }","duration":"235.753705ms","start":"2026-04-09T02:09:52.929427Z","end":"2026-04-09T02:09:53.165181Z","steps":["trace[1005361007] 'read index received' (duration: 235.453918ms)","trace[1005361007] 'applied index is now lower than readState.Index' (duration: 298.307µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:09:53.165412Z","caller":"traceutil/trace.go:171","msg":"trace[557462968] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"240.149358ms","start":"2026-04-09T02:09:52.925247Z","end":"2026-04-09T02:09:53.165396Z","steps":["trace[557462968] 'process raft request' (duration: 239.727828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:09:53.165541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.388446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-09T02:09:53.16563Z","caller":"traceutil/trace.go:171","msg":"trace[325730237] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2652; }","duration":"202.506489ms","start":"2026-04-09T02:09:52.963104Z","end":"2026-04-09T02:09:53.165611Z","steps":["trace[325730237] 'agreement among raft nodes before linearized reading' (duration: 202.301434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:09:53.165988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.563063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-09T02:09:53.166027Z","caller":"traceutil/trace.go:171","msg":"trace[128890994] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2652; }","duration":"236.643346ms","start":"2026-04-09T02:09:52.929373Z","end":"2026-04-09T02:09:53.166016Z","steps":["trace[128890994] 'agreement among raft nodes before linearized reading' (duration: 236.36963ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:10:25.522832Z","caller":"traceutil/trace.go:171","msg":"trace[1357362679] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"132.231069ms","start":"2026-04-09T02:10:25.390557Z","end":"2026-04-09T02:10:25.522788Z","steps":["trace[1357362679] 'process raft request' (duration: 108.536935ms)","trace[1357362679] 'compare' (duration: 23.243914ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T02:10:25.523161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.322276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-09T02:10:25.523294Z","caller":"traceutil/trace.go:171","msg":"trace[936009552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2851; }","duration":"125.498581ms","start":"2026-04-09T02:10:25.397765Z","end":"2026-04-09T02:10:25.523264Z","steps":["trace[936009552] 'agreement among raft nodes before linearized reading' (duration: 125.122292ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:10:25.523227Z","caller":"traceutil/trace.go:171","msg":"trace[677134012] linearizableReadLoop","detail":"{readStateIndex:2960; appliedIndex:2959; }","duration":"124.901287ms","start":"2026-04-09T02:10:25.397792Z","end":"2026-04-09T02:10:25.522693Z","steps":["trace[677134012] 'read index received' (duration: 101.250404ms)","trace[677134012] 'applied index is now lower than readState.Index' (duration: 23.649953ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:10:31.152396Z","caller":"traceutil/trace.go:171","msg":"trace[639607960] transaction","detail":"{read_only:false; response_revision:2881; number_of_response:1; }","duration":"117.785401ms","start":"2026-04-09T02:10:31.03458Z","end":"2026-04-09T02:10:31.152365Z","steps":["trace[639607960] 'process raft request' (duration: 117.611377ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:10:31.182805Z","caller":"traceutil/trace.go:171","msg":"trace[1968331497] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"140.90123ms","start":"2026-04-09T02:10:31.041872Z","end":"2026-04-09T02:10:31.182773Z","steps":["trace[1968331497] 'process raft request' (duration: 140.550932ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:10:31.443514Z","caller":"traceutil/trace.go:171","msg":"trace[190580786] transaction","detail":"{read_only:false; response_revision:2883; number_of_response:1; }","duration":"109.734123ms","start":"2026-04-09T02:10:31.333753Z","end":"2026-04-09T02:10:31.443487Z","steps":["trace[190580786] 'process raft request' (duration: 109.571359ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:27.671044Z","caller":"traceutil/trace.go:171","msg":"trace[1951224479] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4869; }","duration":"101.196385ms","start":"2026-04-09T02:14:27.569824Z","end":"2026-04-09T02:14:27.671021Z","steps":["trace[1951224479] 'compare' (duration: 87.229135ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:29.850502Z","caller":"traceutil/trace.go:171","msg":"trace[1147397256] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"129.762243ms","start":"2026-04-09T02:14:29.720702Z","end":"2026-04-09T02:14:29.850464Z","steps":["trace[1147397256] 'process raft request' (duration: 128.891652ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:29.878628Z","caller":"traceutil/trace.go:171","msg":"trace[2024698073] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"151.588739ms","start":"2026-04-09T02:14:29.726993Z","end":"2026-04-09T02:14:29.878582Z","steps":["trace[2024698073] 'process raft request' (duration: 151.298842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:14:29.898943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.227794ms","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-04-09T02:14:29.899034Z","caller":"traceutil/trace.go:171","msg":"trace[129579566] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4941; }","duration":"103.385368ms","start":"2026-04-09T02:14:29.795628Z","end":"2026-04-09T02:14:29.899014Z","steps":["trace[129579566] 'agreement among raft nodes before linearized reading' (duration: 103.092341ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:30.00595Z","caller":"traceutil/trace.go:171","msg":"trace[2015188313] linearizableReadLoop","detail":"{readStateIndex:5130; appliedIndex:5129; }","duration":"107.225718ms","start":"2026-04-09T02:14:29.898691Z","end":"2026-04-09T02:14:30.005916Z","steps":["trace[2015188313] 'read index received' (duration: 106.916431ms)","trace[2015188313] 'applied index is now lower than readState.Index' (duration: 307.707µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:14:30.006014Z","caller":"traceutil/trace.go:171","msg":"trace[109833480] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"122.56694ms","start":"2026-04-09T02:14:29.883402Z","end":"2026-04-09T02:14:30.005969Z","steps":["trace[109833480] 'process raft request' (duration: 122.187282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:14:30.006238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.410065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-09T02:14:30.006289Z","caller":"traceutil/trace.go:171","msg":"trace[940249809] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4942; }","duration":"116.494677ms","start":"2026-04-09T02:14:29.889776Z","end":"2026-04-09T02:14:30.006271Z","steps":["trace[940249809] 'agreement among raft nodes before linearized reading' (duration: 116.286873ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:30.013092Z","caller":"traceutil/trace.go:171","msg":"trace[1984630706] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"109.706497ms","start":"2026-04-09T02:14:29.903367Z","end":"2026-04-09T02:14:30.013073Z","steps":["trace[1984630706] 'process raft request' (duration: 109.475192ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:30.013317Z","caller":"traceutil/trace.go:171","msg":"trace[1516989072] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"101.509342ms","start":"2026-04-09T02:14:29.911796Z","end":"2026-04-09T02:14:30.013306Z","steps":["trace[1516989072] 'process raft request' (duration: 101.198335ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:35.065331Z","caller":"traceutil/trace.go:171","msg":"trace[1303573607] linearizableReadLoop","detail":"{readStateIndex:5277; appliedIndex:5276; }","duration":"183.049743ms","start":"2026-04-09T02:14:34.882254Z","end":"2026-04-09T02:14:35.065303Z","steps":["trace[1303573607] 'read index received' (duration: 182.853618ms)","trace[1303573607] 'applied index is now lower than readState.Index' (duration: 194.695µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:14:35.065388Z","caller":"traceutil/trace.go:171","msg":"trace[557214041] transaction","detail":"{read_only:false; response_revision:5085; number_of_response:1; }","duration":"191.468122ms","start":"2026-04-09T02:14:34.87388Z","end":"2026-04-09T02:14:35.065348Z","steps":["trace[557214041] 'process raft request' (duration: 191.222956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:14:35.065684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.409361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-09T02:14:35.06571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.673504ms","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-04-09T02:14:35.065759Z","caller":"traceutil/trace.go:171","msg":"trace[137230201] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5085; }","duration":"182.771616ms","start":"2026-04-09T02:14:34.882975Z","end":"2026-04-09T02:14:35.065747Z","steps":["trace[137230201] 'agreement among raft nodes before linearized reading' (duration: 182.52382ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:35.065757Z","caller":"traceutil/trace.go:171","msg":"trace[1207655255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5085; }","duration":"183.553575ms","start":"2026-04-09T02:14:34.882187Z","end":"2026-04-09T02:14:35.065741Z","steps":["trace[1207655255] 'agreement among raft nodes before linearized reading' (duration: 183.252378ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:35.488161Z","caller":"traceutil/trace.go:171","msg":"trace[1030860018] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"221.349459ms","start":"2026-04-09T02:14:35.266776Z","end":"2026-04-09T02:14:35.488125Z","steps":["trace[1030860018] 'process raft request' (duration: 221.113654ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:35.522509Z","caller":"traceutil/trace.go:171","msg":"trace[1814999588] transaction","detail":"{read_only:false; response_revision:5097; number_of_response:1; }","duration":"246.629138ms","start":"2026-04-09T02:14:35.275863Z","end":"2026-04-09T02:14:35.522492Z","steps":["trace[1814999588] 'process raft request' (duration: 246.002623ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:46.506483Z","caller":"traceutil/trace.go:171","msg":"trace[233207345] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"112.215017ms","start":"2026-04-09T02:14:46.394226Z","end":"2026-04-09T02:14:46.506441Z","steps":["trace[233207345] 'process raft request' (duration: 60.834121ms)","trace[233207345] 'compare' (duration: 51.206932ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:14:47.06735Z","caller":"traceutil/trace.go:171","msg":"trace[1240635384] linearizableReadLoop","detail":"{readStateIndex:5527; appliedIndex:5526; }","duration":"117.513391ms","start":"2026-04-09T02:14:46.94981Z","end":"2026-04-09T02:14:47.067324Z","steps":["trace[1240635384] 'read index received' (duration: 117.393978ms)","trace[1240635384] 'applied index is now lower than readState.Index' (duration: 118.303µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:14:47.067402Z","caller":"traceutil/trace.go:171","msg":"trace[617967007] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"320.422405ms","start":"2026-04-09T02:14:46.746943Z","end":"2026-04-09T02:14:47.067365Z","steps":["trace[617967007] 'process raft request' (duration: 320.20538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:14:47.067751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T02:14:46.746921Z","time spent":"320.716273ms","remote":"127.0.0.1:52186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8038,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T02:14:47.067807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.976963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-09T02:14:47.067934Z","caller":"traceutil/trace.go:171","msg":"trace[2146480504] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:5328; }","duration":"118.158047ms","start":"2026-04-09T02:14:46.949756Z","end":"2026-04-09T02:14:47.067914Z","steps":["trace[2146480504] 'agreement among raft nodes before linearized reading' (duration: 117.681586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:14:54.834323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.940046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T02:14:54.834511Z","caller":"traceutil/trace.go:171","msg":"trace[1761211719] linearizableReadLoop","detail":"{readStateIndex:5697; appliedIndex:5696; }","duration":"273.465522ms","start":"2026-04-09T02:14:54.561018Z","end":"2026-04-09T02:14:54.834484Z","steps":["trace[1761211719] 'read index received' (duration: 50.164787ms)","trace[1761211719] 'applied index is now lower than readState.Index' (duration: 223.298885ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:14:54.83455Z","caller":"traceutil/trace.go:171","msg":"trace[1846630171] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"291.021509ms","start":"2026-04-09T02:14:54.543488Z","end":"2026-04-09T02:14:54.834509Z","steps":["trace[1846630171] 'process raft request' (duration: 67.733134ms)","trace[1846630171] 'compare' (duration: 222.619399ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T02:14:54.834904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.856902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9mb4v\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-09T02:14:54.835011Z","caller":"traceutil/trace.go:171","msg":"trace[1727858305] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9mb4v; range_end:; response_count:1; response_revision:5493; }","duration":"274.015246ms","start":"2026-04-09T02:14:54.560973Z","end":"2026-04-09T02:14:54.834988Z","steps":["trace[1727858305] 'agreement among raft nodes before linearized reading' (duration: 273.671048ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:54.972756Z","caller":"traceutil/trace.go:171","msg":"trace[736555347] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"126.71659ms","start":"2026-04-09T02:14:54.846013Z","end":"2026-04-09T02:14:54.97273Z","steps":["trace[736555347] 'process raft request' (duration: 123.329279ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:55.10789Z","caller":"traceutil/trace.go:171","msg":"trace[3493893] transaction","detail":"{read_only:false; response_revision:5496; number_of_response:1; }","duration":"127.527849ms","start":"2026-04-09T02:14:54.980335Z","end":"2026-04-09T02:14:55.107863Z","steps":["trace[3493893] 'process raft request' (duration: 110.576618ms)","trace[3493893] 'compare' (duration: 16.718205ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:14:55.108207Z","caller":"traceutil/trace.go:171","msg":"trace[503643267] transaction","detail":"{read_only:false; response_revision:5497; number_of_response:1; }","duration":"127.758865ms","start":"2026-04-09T02:14:54.980403Z","end":"2026-04-09T02:14:55.108162Z","steps":["trace[503643267] 'process raft request' (duration: 127.377386ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:55.10842Z","caller":"traceutil/trace.go:171","msg":"trace[1451069680] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"127.978469ms","start":"2026-04-09T02:14:54.980411Z","end":"2026-04-09T02:14:55.10839Z","steps":["trace[1451069680] 'process raft request' (duration: 127.700273ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:55.108686Z","caller":"traceutil/trace.go:171","msg":"trace[1687891624] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"128.265126ms","start":"2026-04-09T02:14:54.980393Z","end":"2026-04-09T02:14:55.108658Z","steps":["trace[1687891624] 'process raft request' (duration: 127.901498ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:55.10878Z","caller":"traceutil/trace.go:171","msg":"trace[1547210050] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"127.9653ms","start":"2026-04-09T02:14:54.980788Z","end":"2026-04-09T02:14:55.108754Z","steps":["trace[1547210050] 'process raft request' (duration: 127.786945ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:55.109134Z","caller":"traceutil/trace.go:171","msg":"trace[2043420212] transaction","detail":"{read_only:false; response_revision:5501; number_of_response:1; }","duration":"125.158222ms","start":"2026-04-09T02:14:54.983953Z","end":"2026-04-09T02:14:55.109111Z","steps":["trace[2043420212] 'process raft request' (duration: 124.740592ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:14:55.290003Z","caller":"traceutil/trace.go:171","msg":"trace[817036384] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"111.904139ms","start":"2026-04-09T02:14:55.178058Z","end":"2026-04-09T02:14:55.289962Z","steps":["trace[817036384] 'process raft request' (duration: 69.340292ms)","trace[817036384] 'compare' (duration: 42.065156ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:15:53.79563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3006} {"level":"info","ts":"2026-04-09T02:15:53.884221Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3006,"took":"86.479221ms","hash":3761206593,"current-db-size-bytes":57741312,"current-db-size":"58 MB","current-db-size-in-use-bytes":31109120,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-09T02:15:53.884305Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3761206593,"revision":3006,"compact-revision":-1} {"level":"info","ts":"2026-04-09T02:20:53.801162Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6058} {"level":"info","ts":"2026-04-09T02:20:53.903335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6058,"took":"99.692996ms","hash":3034924210,"current-db-size-bytes":57741312,"current-db-size":"58 MB","current-db-size-in-use-bytes":21729280,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-09T02:20:53.903414Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3034924210,"revision":6058,"compact-revision":3006} {"level":"info","ts":"2026-04-09T02:21:05.225687Z","caller":"traceutil/trace.go:171","msg":"trace[1802268063] transaction","detail":"{read_only:false; response_revision:8344; number_of_response:1; }","duration":"183.111602ms","start":"2026-04-09T02:21:05.042538Z","end":"2026-04-09T02:21:05.22565Z","steps":["trace[1802268063] 'process raft request' (duration: 182.856056ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:05.455905Z","caller":"traceutil/trace.go:171","msg":"trace[993857148] linearizableReadLoop","detail":"{readStateIndex:8641; appliedIndex:8639; }","duration":"295.909847ms","start":"2026-04-09T02:21:05.159966Z","end":"2026-04-09T02:21:05.455875Z","steps":["trace[993857148] 'read index received' (duration: 65.422261ms)","trace[993857148] 'applied index is now lower than readState.Index' (duration: 230.486386ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:21:05.456094Z","caller":"traceutil/trace.go:171","msg":"trace[1741893278] transaction","detail":"{read_only:false; response_revision:8345; number_of_response:1; }","duration":"392.943102ms","start":"2026-04-09T02:21:05.063078Z","end":"2026-04-09T02:21:05.456021Z","steps":["trace[1741893278] 'process raft request' (duration: 372.376338ms)","trace[1741893278] 'compare' (duration: 19.741445ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T02:21:05.45653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T02:21:05.063056Z","time spent":"393.358291ms","remote":"127.0.0.1:52270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T02:21:05.456218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.190145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T02:21:05.457038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.907468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T02:21:05.457127Z","caller":"traceutil/trace.go:171","msg":"trace[322432595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8345; }","duration":"192.002231ms","start":"2026-04-09T02:21:05.265085Z","end":"2026-04-09T02:21:05.457087Z","steps":["trace[322432595] 'agreement among raft nodes before linearized reading' (duration: 191.912308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:05.457159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.06947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T02:21:05.457172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.53445ms","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-04-09T02:21:05.457225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.096644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9mb4v\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-09T02:21:05.457245Z","caller":"traceutil/trace.go:171","msg":"trace[1630025668] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8345; }","duration":"146.636894ms","start":"2026-04-09T02:21:05.310588Z","end":"2026-04-09T02:21:05.457225Z","steps":["trace[1630025668] 'agreement among raft nodes before linearized reading' (duration: 146.437068ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:05.45725Z","caller":"traceutil/trace.go:171","msg":"trace[1614619724] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:8345; }","duration":"290.144422ms","start":"2026-04-09T02:21:05.167067Z","end":"2026-04-09T02:21:05.457211Z","steps":["trace[1614619724] 'agreement among raft nodes before linearized reading' (duration: 289.911256ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:05.457288Z","caller":"traceutil/trace.go:171","msg":"trace[1240895562] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9mb4v; range_end:; response_count:1; response_revision:8345; }","duration":"274.192576ms","start":"2026-04-09T02:21:05.183081Z","end":"2026-04-09T02:21:05.457274Z","steps":["trace[1240895562] 'agreement among raft nodes before linearized reading' (duration: 274.013771ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:05.456854Z","caller":"traceutil/trace.go:171","msg":"trace[1273650080] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8345; }","duration":"296.905801ms","start":"2026-04-09T02:21:05.159897Z","end":"2026-04-09T02:21:05.456803Z","steps":["trace[1273650080] 'agreement among raft nodes before linearized reading' (duration: 296.144733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:05.457846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.543073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T02:21:05.457915Z","caller":"traceutil/trace.go:171","msg":"trace[859498758] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:8345; }","duration":"183.629654ms","start":"2026-04-09T02:21:05.274267Z","end":"2026-04-09T02:21:05.457897Z","steps":["trace[859498758] 'agreement among raft nodes before linearized reading' (duration: 183.415849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:05.458131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.578802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-09T02:21:05.45827Z","caller":"traceutil/trace.go:171","msg":"trace[499968609] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8345; }","duration":"146.792907ms","start":"2026-04-09T02:21:05.311448Z","end":"2026-04-09T02:21:05.458241Z","steps":["trace[499968609] 'agreement among raft nodes before linearized reading' (duration: 146.312016ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:18.138148Z","caller":"traceutil/trace.go:171","msg":"trace[1358539261] transaction","detail":"{read_only:false; response_revision:8413; number_of_response:1; }","duration":"164.344729ms","start":"2026-04-09T02:21:17.973755Z","end":"2026-04-09T02:21:18.1381Z","steps":["trace[1358539261] 'process raft request' (duration: 109.071288ms)","trace[1358539261] 'compare' (duration: 55.073247ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:21:18.176855Z","caller":"traceutil/trace.go:171","msg":"trace[1645310417] transaction","detail":"{read_only:false; response_revision:8414; number_of_response:1; }","duration":"163.953141ms","start":"2026-04-09T02:21:18.012849Z","end":"2026-04-09T02:21:18.176802Z","steps":["trace[1645310417] 'process raft request' (duration: 163.791517ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:18.939757Z","caller":"traceutil/trace.go:171","msg":"trace[215936017] transaction","detail":"{read_only:false; response_revision:8417; number_of_response:1; }","duration":"390.292769ms","start":"2026-04-09T02:21:18.549443Z","end":"2026-04-09T02:21:18.939735Z","steps":["trace[215936017] 'process raft request' (duration: 389.613453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:18.940103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T02:21:18.549412Z","time spent":"390.597306ms","remote":"127.0.0.1:52270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T02:21:46.302394Z","caller":"traceutil/trace.go:171","msg":"trace[1426911222] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"182.783314ms","start":"2026-04-09T02:21:46.119582Z","end":"2026-04-09T02:21:46.302365Z","steps":["trace[1426911222] 'process raft request' (duration: 182.61473ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:46.456313Z","caller":"traceutil/trace.go:171","msg":"trace[207568736] linearizableReadLoop","detail":"{readStateIndex:8925; appliedIndex:8924; }","duration":"143.085149ms","start":"2026-04-09T02:21:46.3132Z","end":"2026-04-09T02:21:46.456285Z","steps":["trace[207568736] 'read index received' (duration: 140.986679ms)","trace[207568736] 'applied index is now lower than readState.Index' (duration: 2.09741ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:21:46.456489Z","caller":"traceutil/trace.go:171","msg":"trace[1328081170] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"216.034187ms","start":"2026-04-09T02:21:46.24042Z","end":"2026-04-09T02:21:46.456454Z","steps":["trace[1328081170] 'process raft request' (duration: 213.738732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:46.4566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.466467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-09T02:21:46.456641Z","caller":"traceutil/trace.go:171","msg":"trace[1705717250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8619; }","duration":"143.5631ms","start":"2026-04-09T02:21:46.313066Z","end":"2026-04-09T02:21:46.456629Z","steps":["trace[1705717250] 'agreement among raft nodes before linearized reading' (duration: 143.380045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:46.456788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.491156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T02:21:46.456828Z","caller":"traceutil/trace.go:171","msg":"trace[1132944720] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8619; }","duration":"134.575908ms","start":"2026-04-09T02:21:46.322238Z","end":"2026-04-09T02:21:46.456814Z","steps":["trace[1132944720] 'agreement among raft nodes before linearized reading' (duration: 134.513357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:58.932155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.952235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-9s7b8\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-09T02:21:58.932276Z","caller":"traceutil/trace.go:171","msg":"trace[949341552] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-9s7b8; range_end:; response_count:1; response_revision:8726; }","duration":"298.16304ms","start":"2026-04-09T02:21:58.634089Z","end":"2026-04-09T02:21:58.932252Z","steps":["trace[949341552] 'range keys from in-memory index tree' (duration: 297.795681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:58.932233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.115185ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T02:21:58.932379Z","caller":"traceutil/trace.go:171","msg":"trace[977650876] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8726; }","duration":"142.281719ms","start":"2026-04-09T02:21:58.790075Z","end":"2026-04-09T02:21:58.932356Z","steps":["trace[977650876] 'range keys from in-memory index tree' (duration: 142.086845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:58.932645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.165842ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-09T02:21:58.93279Z","caller":"traceutil/trace.go:171","msg":"trace[358491002] linearizableReadLoop","detail":"{readStateIndex:9039; appliedIndex:9038; }","duration":"242.604413ms","start":"2026-04-09T02:21:58.690167Z","end":"2026-04-09T02:21:58.932771Z","steps":["trace[358491002] 'read index received' (duration: 90.147372ms)","trace[358491002] 'applied index is now lower than readState.Index' (duration: 152.455121ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:21:58.93291Z","caller":"traceutil/trace.go:171","msg":"trace[1091636988] transaction","detail":"{read_only:false; response_revision:8727; number_of_response:1; }","duration":"297.267431ms","start":"2026-04-09T02:21:58.635629Z","end":"2026-04-09T02:21:58.932896Z","steps":["trace[1091636988] 'process raft request' (duration: 144.747799ms)","trace[1091636988] 'compare' (duration: 151.63699ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T02:21:58.933038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.944059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T02:21:58.933092Z","caller":"traceutil/trace.go:171","msg":"trace[82955354] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:8727; }","duration":"203.038911ms","start":"2026-04-09T02:21:58.730036Z","end":"2026-04-09T02:21:58.933075Z","steps":["trace[82955354] 'agreement among raft nodes before linearized reading' (duration: 202.894117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:21:58.933069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.877399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T02:21:58.93319Z","caller":"traceutil/trace.go:171","msg":"trace[403670815] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8727; }","duration":"243.062963ms","start":"2026-04-09T02:21:58.690099Z","end":"2026-04-09T02:21:58.933162Z","steps":["trace[403670815] 'agreement among raft nodes before linearized reading' (duration: 242.845158ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:59.07187Z","caller":"traceutil/trace.go:171","msg":"trace[824111381] linearizableReadLoop","detail":"{readStateIndex:9040; appliedIndex:9039; }","duration":"130.077102ms","start":"2026-04-09T02:21:58.941757Z","end":"2026-04-09T02:21:59.071834Z","steps":["trace[824111381] 'read index received' (duration: 108.804562ms)","trace[824111381] 'applied index is now lower than readState.Index' (duration: 21.27073ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:21:59.071948Z","caller":"traceutil/trace.go:171","msg":"trace[372801513] transaction","detail":"{read_only:false; response_revision:8728; number_of_response:1; }","duration":"130.378419ms","start":"2026-04-09T02:21:58.941526Z","end":"2026-04-09T02:21:59.071905Z","steps":["trace[372801513] 'process raft request' (duration: 109.108679ms)","trace[372801513] 'compare' (duration: 20.640345ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T02:21:59.072212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.43594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-09T02:21:59.072278Z","caller":"traceutil/trace.go:171","msg":"trace[1058262194] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8728; }","duration":"130.558543ms","start":"2026-04-09T02:21:58.941706Z","end":"2026-04-09T02:21:59.072264Z","steps":["trace[1058262194] 'agreement among raft nodes before linearized reading' (duration: 130.297677ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:21:59.649271Z","caller":"traceutil/trace.go:171","msg":"trace[1173527991] transaction","detail":"{read_only:false; response_revision:8731; number_of_response:1; }","duration":"130.568404ms","start":"2026-04-09T02:21:59.518675Z","end":"2026-04-09T02:21:59.649244Z","steps":["trace[1173527991] 'process raft request' (duration: 130.40334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:22:00.002349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.758163ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T02:22:00.002516Z","caller":"traceutil/trace.go:171","msg":"trace[650759044] linearizableReadLoop","detail":"{readStateIndex:9045; appliedIndex:9044; }","duration":"260.021251ms","start":"2026-04-09T02:21:59.742473Z","end":"2026-04-09T02:22:00.002494Z","steps":["trace[650759044] 'read index received' (duration: 25.905219ms)","trace[650759044] 'applied index is now lower than readState.Index' (duration: 234.114112ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:22:00.002547Z","caller":"traceutil/trace.go:171","msg":"trace[902998756] transaction","detail":"{read_only:false; response_revision:8733; number_of_response:1; }","duration":"263.304679ms","start":"2026-04-09T02:21:59.739208Z","end":"2026-04-09T02:22:00.002513Z","steps":["trace[902998756] 'process raft request' (duration: 29.244879ms)","trace[902998756] 'compare' (duration: 233.132509ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T02:22:00.002831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.378535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-09T02:22:00.002875Z","caller":"traceutil/trace.go:171","msg":"trace[1629019045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8733; }","duration":"244.459397ms","start":"2026-04-09T02:21:59.758404Z","end":"2026-04-09T02:22:00.002864Z","steps":["trace[1629019045] 'agreement among raft nodes before linearized reading' (duration: 244.21881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:22:00.002917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.25615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T02:22:00.002942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.35011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4726"} {"level":"info","ts":"2026-04-09T02:22:00.003081Z","caller":"traceutil/trace.go:171","msg":"trace[488769444] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:8733; }","duration":"260.659527ms","start":"2026-04-09T02:21:59.742406Z","end":"2026-04-09T02:22:00.003065Z","steps":["trace[488769444] 'agreement among raft nodes before linearized reading' (duration: 260.224946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:22:00.003244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.533026ms","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-04-09T02:22:00.003323Z","caller":"traceutil/trace.go:171","msg":"trace[165229866] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8733; }","duration":"235.631798ms","start":"2026-04-09T02:21:59.767672Z","end":"2026-04-09T02:22:00.003304Z","steps":["trace[165229866] 'agreement among raft nodes before linearized reading' (duration: 235.414813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T02:22:00.003103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.299919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9mb4v\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-09T02:22:00.003439Z","caller":"traceutil/trace.go:171","msg":"trace[940038053] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9mb4v; range_end:; response_count:1; response_revision:8733; }","duration":"195.648837ms","start":"2026-04-09T02:21:59.80778Z","end":"2026-04-09T02:22:00.003428Z","steps":["trace[940038053] 'agreement among raft nodes before linearized reading' (duration: 195.237217ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:22:00.002988Z","caller":"traceutil/trace.go:171","msg":"trace[1035306682] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:8733; }","duration":"111.379973ms","start":"2026-04-09T02:21:59.89159Z","end":"2026-04-09T02:22:00.00297Z","steps":["trace[1035306682] 'agreement among raft nodes before linearized reading' (duration: 111.26264ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:22:33.248133Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024a1.wal"} {"level":"info","ts":"2026-04-09T02:23:06.445186Z","caller":"traceutil/trace.go:171","msg":"trace[621581977] transaction","detail":"{read_only:false; response_revision:9419; number_of_response:1; }","duration":"129.825338ms","start":"2026-04-09T02:23:06.315307Z","end":"2026-04-09T02:23:06.445132Z","steps":["trace[621581977] 'process raft request' (duration: 129.572582ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T02:23:18.81464Z","caller":"traceutil/trace.go:171","msg":"trace[1495047413] transaction","detail":"{read_only:false; response_revision:9492; number_of_response:1; }","duration":"120.951369ms","start":"2026-04-09T02:23:18.693648Z","end":"2026-04-09T02:23:18.814599Z","steps":["trace[1495047413] 'process raft request' (duration: 71.096115ms)","trace[1495047413] 'compare' (duration: 49.606408ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:23:19.004114Z","caller":"traceutil/trace.go:171","msg":"trace[1035749491] transaction","detail":"{read_only:false; response_revision:9493; number_of_response:1; }","duration":"137.228332ms","start":"2026-04-09T02:23:18.86682Z","end":"2026-04-09T02:23:19.004049Z","steps":["trace[1035749491] 'process raft request' (duration: 78.907099ms)","trace[1035749491] 'compare' (duration: 58.103578ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T02:23:39.726929Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e98569549cc430c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-09T02:23:39.733875Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-09T02:23:39.734011Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-09T02:25:53.808635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8150} {"level":"info","ts":"2026-04-09T02:25:53.872919Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8150,"took":"61.004036ms","hash":3144171289,"current-db-size-bytes":57741312,"current-db-size":"58 MB","current-db-size-in-use-bytes":29011968,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-09T02:25:53.872996Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3144171289,"revision":8150,"compact-revision":6058} {"level":"info","ts":"2026-04-09T02:30:53.815645Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10672} {"level":"info","ts":"2026-04-09T02:30:53.897424Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10672,"took":"78.848753ms","hash":3616218639,"current-db-size-bytes":57741312,"current-db-size":"58 MB","current-db-size-in-use-bytes":21372928,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-09T02:30:53.897493Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3616218639,"revision":10672,"compact-revision":8150}