{"level":"warn","ts":"2026-04-08T04:11:28.063063Z","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-08T04:11:28.063135Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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://162.253.55.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-08T04:11:28.063187Z","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-08T04:11:28.063195Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-04-08T04:11:28.06321Z","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-08T04:11:28.06378Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]} {"level":"info","ts":"2026-04-08T04:11:28.063858Z","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://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-08T04:11:28.067642Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.594387ms"} {"level":"info","ts":"2026-04-08T04:11:28.076178Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"} {"level":"info","ts":"2026-04-08T04:11:28.076264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T04:11:28.076387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"} {"level":"info","ts":"2026-04-08T04:11:28.076409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T04:11:28.076422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"} {"level":"info","ts":"2026-04-08T04:11:28.076494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"warn","ts":"2026-04-08T04:11:28.083622Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T04:11:28.084869Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T04:11:28.085628Z","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-08T04:11:28.087609Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T04:11:28.08786Z","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-08T04:11:28.087857Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T04:11:28.087945Z","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-08T04:11:28.087997Z","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-08T04:11:28.088982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"info","ts":"2026-04-08T04:11:28.08929Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-04-08T04:11:28.091707Z","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-08T04:11:28.091815Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-04-08T04:11:28.092527Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-04-08T04:11:28.09196Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T04:11:28.091982Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T04:11:28.578198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T04:11:28.578251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T04:11:28.578265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"} {"level":"info","ts":"2026-04-08T04:11:28.578277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"} {"level":"info","ts":"2026-04-08T04:11:28.578283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-04-08T04:11:28.57829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"} {"level":"info","ts":"2026-04-08T04:11:28.578298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-04-08T04:11:28.586333Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T04:11:28.59183Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T04:11:28.591925Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T04:11:28.59195Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T04:11:28.591984Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T04:11:28.592008Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T04:11:28.59269Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T04:11:28.592742Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T04:11:28.59295Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T04:11:28.596476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"} {"level":"info","ts":"2026-04-08T04:11:28.598885Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T04:11:34.687685Z","caller":"traceutil/trace.go:171","msg":"trace[1979529364] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"125.83741ms","start":"2026-04-08T04:11:34.561824Z","end":"2026-04-08T04:11:34.687661Z","steps":["trace[1979529364] 'process raft request' (duration: 125.714977ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:35.033053Z","caller":"traceutil/trace.go:171","msg":"trace[1766293518] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"321.575161ms","start":"2026-04-08T04:11:34.711427Z","end":"2026-04-08T04:11:35.033002Z","steps":["trace[1766293518] 'process raft request' (duration: 319.726427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:11:35.03372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:11:34.711416Z","time spent":"321.708374ms","remote":"127.0.0.1:34148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T04:11:35.355738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.137554ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T04:11:35.356276Z","caller":"traceutil/trace.go:171","msg":"trace[2060328964] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:338; }","duration":"318.065869ms","start":"2026-04-08T04:11:35.038186Z","end":"2026-04-08T04:11:35.356252Z","steps":["trace[2060328964] 'read index received' (duration: 148.038933ms)","trace[2060328964] 'applied index is now lower than readState.Index' (duration: 170.023076ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:11:35.356358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.160811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:11:35.356386Z","caller":"traceutil/trace.go:171","msg":"trace[558797162] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:327; }","duration":"318.251004ms","start":"2026-04-08T04:11:35.038126Z","end":"2026-04-08T04:11:35.356377Z","steps":["trace[558797162] 'agreement among raft nodes before linearized reading' (duration: 318.191193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:11:35.356426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:11:35.038116Z","time spent":"318.301405ms","remote":"127.0.0.1:34148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"info","ts":"2026-04-08T04:11:35.356549Z","caller":"traceutil/trace.go:171","msg":"trace[980959827] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"318.650014ms","start":"2026-04-08T04:11:35.037882Z","end":"2026-04-08T04:11:35.356532Z","steps":["trace[980959827] 'process raft request' (duration: 148.408353ms)","trace[980959827] 'compare' (duration: 169.010361ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:11:35.356623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:11:35.037859Z","time spent":"318.727345ms","remote":"127.0.0.1:34198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:11:56.511856Z","caller":"traceutil/trace.go:171","msg":"trace[2097686252] transaction","detail":"{read_only:false; number_of_response:0; response_revision:524; }","duration":"241.567687ms","start":"2026-04-08T04:11:56.270276Z","end":"2026-04-08T04:11:56.511844Z","steps":["trace[2097686252] 'process raft request' (duration: 241.513606ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.512043Z","caller":"traceutil/trace.go:171","msg":"trace[391965047] transaction","detail":"{read_only:false; number_of_response:0; response_revision:524; }","duration":"241.827624ms","start":"2026-04-08T04:11:56.270207Z","end":"2026-04-08T04:11:56.512034Z","steps":["trace[391965047] 'process raft request' (duration: 233.829255ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.512207Z","caller":"traceutil/trace.go:171","msg":"trace[1607824071] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"241.902507ms","start":"2026-04-08T04:11:56.270296Z","end":"2026-04-08T04:11:56.512198Z","steps":["trace[1607824071] 'process raft request' (duration: 241.511916ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.512329Z","caller":"traceutil/trace.go:171","msg":"trace[1609965112] transaction","detail":"{read_only:false; number_of_response:0; response_revision:525; }","duration":"241.980759ms","start":"2026-04-08T04:11:56.270345Z","end":"2026-04-08T04:11:56.512326Z","steps":["trace[1609965112] 'process raft request' (duration: 241.689731ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.514419Z","caller":"traceutil/trace.go:171","msg":"trace[666093085] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"243.785563ms","start":"2026-04-08T04:11:56.27052Z","end":"2026-04-08T04:11:56.514305Z","steps":["trace[666093085] 'process raft request' (duration: 241.65635ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.516323Z","caller":"traceutil/trace.go:171","msg":"trace[1348555872] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"241.819225ms","start":"2026-04-08T04:11:56.270496Z","end":"2026-04-08T04:11:56.512315Z","steps":["trace[1348555872] 'process raft request' (duration: 241.598398ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.516543Z","caller":"traceutil/trace.go:171","msg":"trace[1046996795] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"241.777794ms","start":"2026-04-08T04:11:56.270558Z","end":"2026-04-08T04:11:56.512336Z","steps":["trace[1046996795] 'process raft request' (duration: 241.673242ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.5203Z","caller":"traceutil/trace.go:171","msg":"trace[1529112352] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"247.291881ms","start":"2026-04-08T04:11:56.270609Z","end":"2026-04-08T04:11:56.517901Z","steps":["trace[1529112352] 'process raft request' (duration: 241.701722ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.5227Z","caller":"traceutil/trace.go:171","msg":"trace[773051097] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"250.372926ms","start":"2026-04-08T04:11:56.272312Z","end":"2026-04-08T04:11:56.522685Z","steps":["trace[773051097] 'process raft request' (duration: 249.910345ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.524085Z","caller":"traceutil/trace.go:171","msg":"trace[1456321643] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"246.931982ms","start":"2026-04-08T04:11:56.277143Z","end":"2026-04-08T04:11:56.524075Z","steps":["trace[1456321643] 'process raft request' (duration: 245.188148ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.524633Z","caller":"traceutil/trace.go:171","msg":"trace[1808414213] transaction","detail":"{read_only:false; number_of_response:1; response_revision:531; }","duration":"221.455507ms","start":"2026-04-08T04:11:56.303168Z","end":"2026-04-08T04:11:56.524624Z","steps":["trace[1808414213] 'process raft request' (duration: 219.236871ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:11:56.525156Z","caller":"traceutil/trace.go:171","msg":"trace[314041471] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"155.420531ms","start":"2026-04-08T04:11:56.369727Z","end":"2026-04-08T04:11:56.525148Z","steps":["trace[314041471] 'process raft request' (duration: 155.283917ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:12:02.377503Z","caller":"traceutil/trace.go:171","msg":"trace[1242795810] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"192.074899ms","start":"2026-04-08T04:12:02.18539Z","end":"2026-04-08T04:12:02.377465Z","steps":["trace[1242795810] 'process raft request' (duration: 191.203498ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:12:02.510436Z","caller":"traceutil/trace.go:171","msg":"trace[1477656894] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"120.690822ms","start":"2026-04-08T04:12:02.389718Z","end":"2026-04-08T04:12:02.510409Z","steps":["trace[1477656894] 'read index received' (duration: 116.977128ms)","trace[1477656894] 'applied index is now lower than readState.Index' (duration: 3.712534ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:12:02.510563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.825036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:12:02.510598Z","caller":"traceutil/trace.go:171","msg":"trace[2065398911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"120.892057ms","start":"2026-04-08T04:12:02.389693Z","end":"2026-04-08T04:12:02.510585Z","steps":["trace[2065398911] 'agreement among raft nodes before linearized reading' (duration: 120.818655ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:12:02.510767Z","caller":"traceutil/trace.go:171","msg":"trace[1837983453] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"128.724083ms","start":"2026-04-08T04:12:02.382011Z","end":"2026-04-08T04:12:02.510735Z","steps":["trace[1837983453] 'process raft request' (duration: 124.67188ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:12:02.528748Z","caller":"traceutil/trace.go:171","msg":"trace[1806607815] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"118.173119ms","start":"2026-04-08T04:12:02.410559Z","end":"2026-04-08T04:12:02.528732Z","steps":["trace[1806607815] 'process raft request' (duration: 117.745678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:12:03.167375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.027419ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T04:12:03.167448Z","caller":"traceutil/trace.go:171","msg":"trace[891197360] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"594.711715ms","start":"2026-04-08T04:12:02.572724Z","end":"2026-04-08T04:12:03.167436Z","steps":["trace[891197360] 'process raft request' (duration: 345.564253ms)","trace[891197360] 'compare' (duration: 248.923786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:12:03.167484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:12:02.572698Z","time spent":"594.770176ms","remote":"127.0.0.1:34198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:12:03.174687Z","caller":"traceutil/trace.go:171","msg":"trace[831341265] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"253.308256ms","start":"2026-04-08T04:12:02.921358Z","end":"2026-04-08T04:12:03.174666Z","steps":["trace[831341265] 'process raft request' (duration: 252.336231ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:12:04.583364Z","caller":"traceutil/trace.go:171","msg":"trace[931758265] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"101.884346ms","start":"2026-04-08T04:12:04.481441Z","end":"2026-04-08T04:12:04.583326Z","steps":["trace[931758265] 'process raft request' (duration: 101.555568ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:12:51.55434Z","caller":"traceutil/trace.go:171","msg":"trace[1217511651] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"138.735921ms","start":"2026-04-08T04:12:51.415581Z","end":"2026-04-08T04:12:51.554317Z","steps":["trace[1217511651] 'process raft request' (duration: 138.473445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:13:36.869922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.650169ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-08T04:13:36.870361Z","caller":"traceutil/trace.go:171","msg":"trace[1849180498] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"125.648954ms","start":"2026-04-08T04:13:36.744692Z","end":"2026-04-08T04:13:36.870341Z","steps":["trace[1849180498] 'process raft request' (duration: 125.544311ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:36.87036Z","caller":"traceutil/trace.go:171","msg":"trace[1177064610] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"128.052354ms","start":"2026-04-08T04:13:36.742279Z","end":"2026-04-08T04:13:36.870331Z","steps":["trace[1177064610] 'process raft request' (duration: 127.786818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:13:37.354122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.667601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T04:13:37.354273Z","caller":"traceutil/trace.go:171","msg":"trace[1473263898] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"350.373548ms","start":"2026-04-08T04:13:37.003881Z","end":"2026-04-08T04:13:37.354255Z","steps":["trace[1473263898] 'read index received' (duration: 173.480941ms)","trace[1473263898] 'applied index is now lower than readState.Index' (duration: 176.891027ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:13:37.354363Z","caller":"traceutil/trace.go:171","msg":"trace[418356834] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"474.543705ms","start":"2026-04-08T04:13:36.879807Z","end":"2026-04-08T04:13:37.354351Z","steps":["trace[418356834] 'process raft request' (duration: 297.552426ms)","trace[418356834] 'compare' (duration: 176.397444ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:13:37.354429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:13:36.879714Z","time spent":"474.681409ms","remote":"127.0.0.1:34144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T04:13:37.354676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.799728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-08T04:13:37.354713Z","caller":"traceutil/trace.go:171","msg":"trace[1960725431] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1867; }","duration":"350.876681ms","start":"2026-04-08T04:13:37.003827Z","end":"2026-04-08T04:13:37.354703Z","steps":["trace[1960725431] 'agreement among raft nodes before linearized reading' (duration: 350.738287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:13:37.354749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:13:37.003809Z","time spent":"350.933312ms","remote":"127.0.0.1:34198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T04:13:37.354915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.653394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9645cb7c-2fc1-469f-9712-c1a63959a29e\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-08T04:13:37.355061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.552821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T04:13:37.355105Z","caller":"traceutil/trace.go:171","msg":"trace[786822292] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1867; }","duration":"121.599502ms","start":"2026-04-08T04:13:37.233495Z","end":"2026-04-08T04:13:37.355095Z","steps":["trace[786822292] 'agreement among raft nodes before linearized reading' (duration: 121.533781ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:37.355153Z","caller":"traceutil/trace.go:171","msg":"trace[1008388124] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9645cb7c-2fc1-469f-9712-c1a63959a29e; range_end:; response_count:1; response_revision:1867; }","duration":"278.93796ms","start":"2026-04-08T04:13:37.07606Z","end":"2026-04-08T04:13:37.354998Z","steps":["trace[1008388124] 'agreement among raft nodes before linearized reading' (duration: 278.51227ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:37.53993Z","caller":"traceutil/trace.go:171","msg":"trace[533173765] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"178.62353ms","start":"2026-04-08T04:13:37.361281Z","end":"2026-04-08T04:13:37.539904Z","steps":["trace[533173765] 'process raft request' (duration: 108.910156ms)","trace[533173765] 'compare' (duration: 69.52872ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:13:37.540167Z","caller":"traceutil/trace.go:171","msg":"trace[2055056305] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"178.785974ms","start":"2026-04-08T04:13:37.361358Z","end":"2026-04-08T04:13:37.540144Z","steps":["trace[2055056305] 'process raft request' (duration: 178.472396ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:37.540632Z","caller":"traceutil/trace.go:171","msg":"trace[186461044] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"178.037455ms","start":"2026-04-08T04:13:37.36255Z","end":"2026-04-08T04:13:37.540588Z","steps":["trace[186461044] 'process raft request' (duration: 177.881341ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:37.541105Z","caller":"traceutil/trace.go:171","msg":"trace[659052944] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"179.679318ms","start":"2026-04-08T04:13:37.36141Z","end":"2026-04-08T04:13:37.541089Z","steps":["trace[659052944] 'process raft request' (duration: 178.673732ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:37.549677Z","caller":"traceutil/trace.go:171","msg":"trace[1671807992] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1945; }","duration":"119.346227ms","start":"2026-04-08T04:13:37.430309Z","end":"2026-04-08T04:13:37.549656Z","steps":["trace[1671807992] 'read index received' (duration: 39.893669ms)","trace[1671807992] 'applied index is now lower than readState.Index' (duration: 79.451798ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:13:37.549796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.47423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T04:13:37.54985Z","caller":"traceutil/trace.go:171","msg":"trace[1279603056] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1873; }","duration":"119.546072ms","start":"2026-04-08T04:13:37.430295Z","end":"2026-04-08T04:13:37.549842Z","steps":["trace[1279603056] 'agreement among raft nodes before linearized reading' (duration: 119.44221ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:37.549728Z","caller":"traceutil/trace.go:171","msg":"trace[905070528] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"126.470206ms","start":"2026-04-08T04:13:37.423237Z","end":"2026-04-08T04:13:37.549707Z","steps":["trace[905070528] 'process raft request' (duration: 126.312252ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:53.044061Z","caller":"traceutil/trace.go:171","msg":"trace[35082279] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"113.281046ms","start":"2026-04-08T04:13:52.930757Z","end":"2026-04-08T04:13:53.044038Z","steps":["trace[35082279] 'process raft request' (duration: 113.136442ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:53.045473Z","caller":"traceutil/trace.go:171","msg":"trace[1237138074] linearizableReadLoop","detail":"{readStateIndex:2074; appliedIndex:2072; }","duration":"103.94641ms","start":"2026-04-08T04:13:52.941509Z","end":"2026-04-08T04:13:53.045456Z","steps":["trace[1237138074] 'read index received' (duration: 102.395731ms)","trace[1237138074] 'applied index is now lower than readState.Index' (duration: 1.549949ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:13:53.045623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.105894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T04:13:53.04564Z","caller":"traceutil/trace.go:171","msg":"trace[1471658123] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1993; }","duration":"104.166386ms","start":"2026-04-08T04:13:52.941468Z","end":"2026-04-08T04:13:53.045634Z","steps":["trace[1471658123] 'agreement among raft nodes before linearized reading' (duration: 104.051473ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:13:53.045877Z","caller":"traceutil/trace.go:171","msg":"trace[256103926] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"114.566027ms","start":"2026-04-08T04:13:52.931304Z","end":"2026-04-08T04:13:53.04587Z","steps":["trace[256103926] 'process raft request' (duration: 114.060714ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:14:11.239728Z","caller":"traceutil/trace.go:171","msg":"trace[509811219] linearizableReadLoop","detail":"{readStateIndex:2192; appliedIndex:2190; }","duration":"122.20444ms","start":"2026-04-08T04:14:11.117501Z","end":"2026-04-08T04:14:11.239706Z","steps":["trace[509811219] 'read index received' (duration: 51.890038ms)","trace[509811219] 'applied index is now lower than readState.Index' (duration: 70.313442ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:14:11.239974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.458466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-08T04:14:11.240056Z","caller":"traceutil/trace.go:171","msg":"trace[908243418] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2108; }","duration":"122.602329ms","start":"2026-04-08T04:14:11.117439Z","end":"2026-04-08T04:14:11.240042Z","steps":["trace[908243418] 'agreement among raft nodes before linearized reading' (duration: 122.356063ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:14:11.239767Z","caller":"traceutil/trace.go:171","msg":"trace[735083800] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"137.798412ms","start":"2026-04-08T04:14:11.101942Z","end":"2026-04-08T04:14:11.23974Z","steps":["trace[735083800] 'process raft request' (duration: 137.634938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:14:11.555113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.784397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:14:11.555206Z","caller":"traceutil/trace.go:171","msg":"trace[146363461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2109; }","duration":"169.920271ms","start":"2026-04-08T04:14:11.385264Z","end":"2026-04-08T04:14:11.555184Z","steps":["trace[146363461] 'range keys from in-memory index tree' (duration: 169.693955ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:14:11.859469Z","caller":"traceutil/trace.go:171","msg":"trace[115988177] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"225.581493ms","start":"2026-04-08T04:14:11.633862Z","end":"2026-04-08T04:14:11.859444Z","steps":["trace[115988177] 'process raft request' (duration: 195.489474ms)","trace[115988177] 'compare' (duration: 29.841863ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:14:11.859666Z","caller":"traceutil/trace.go:171","msg":"trace[1425453566] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"223.84068ms","start":"2026-04-08T04:14:11.635793Z","end":"2026-04-08T04:14:11.859634Z","steps":["trace[1425453566] 'process raft request' (duration: 223.524642ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:14:12.392622Z","caller":"traceutil/trace.go:171","msg":"trace[2144752206] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"190.49669ms","start":"2026-04-08T04:14:12.202103Z","end":"2026-04-08T04:14:12.392599Z","steps":["trace[2144752206] 'process raft request' (duration: 155.174651ms)","trace[2144752206] 'compare' (duration: 35.226317ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:14:12.397348Z","caller":"traceutil/trace.go:171","msg":"trace[1749692806] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"193.417954ms","start":"2026-04-08T04:14:12.20374Z","end":"2026-04-08T04:14:12.397158Z","steps":["trace[1749692806] 'process raft request' (duration: 193.151168ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:14:58.715211Z","caller":"traceutil/trace.go:171","msg":"trace[1444360710] transaction","detail":"{read_only:false; response_revision:2412; number_of_response:1; }","duration":"110.715794ms","start":"2026-04-08T04:14:58.604468Z","end":"2026-04-08T04:14:58.715184Z","steps":["trace[1444360710] 'process raft request' (duration: 22.50856ms)","trace[1444360710] 'compare' (duration: 88.015009ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:14:58.715436Z","caller":"traceutil/trace.go:171","msg":"trace[587919051] linearizableReadLoop","detail":"{readStateIndex:2509; appliedIndex:2507; }","duration":"103.840879ms","start":"2026-04-08T04:14:58.611571Z","end":"2026-04-08T04:14:58.715412Z","steps":["trace[587919051] 'read index received' (duration: 15.38895ms)","trace[587919051] 'applied index is now lower than readState.Index' (duration: 88.451049ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:14:58.715547Z","caller":"traceutil/trace.go:171","msg":"trace[991593720] transaction","detail":"{read_only:false; response_revision:2413; number_of_response:1; }","duration":"110.846036ms","start":"2026-04-08T04:14:58.604637Z","end":"2026-04-08T04:14:58.715484Z","steps":["trace[991593720] 'process raft request' (duration: 110.503358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:14:58.71582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.221059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:14:58.715958Z","caller":"traceutil/trace.go:171","msg":"trace[2031210730] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:2414; }","duration":"104.386253ms","start":"2026-04-08T04:14:58.611556Z","end":"2026-04-08T04:14:58.715942Z","steps":["trace[2031210730] 'agreement among raft nodes before linearized reading' (duration: 103.940041ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:15:06.963036Z","caller":"traceutil/trace.go:171","msg":"trace[1343602377] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"218.590188ms","start":"2026-04-08T04:15:06.744425Z","end":"2026-04-08T04:15:06.963015Z","steps":["trace[1343602377] 'process raft request' (duration: 218.477155ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:15:06.963151Z","caller":"traceutil/trace.go:171","msg":"trace[2011113817] linearizableReadLoop","detail":"{readStateIndex:2607; appliedIndex:2607; }","duration":"208.85711ms","start":"2026-04-08T04:15:06.754251Z","end":"2026-04-08T04:15:06.963108Z","steps":["trace[2011113817] 'read index received' (duration: 208.84175ms)","trace[2011113817] 'applied index is now lower than readState.Index' (duration: 13.05µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:15:06.963438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.159328ms","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-08T04:15:06.963479Z","caller":"traceutil/trace.go:171","msg":"trace[1311444393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2510; }","duration":"209.2497ms","start":"2026-04-08T04:15:06.754218Z","end":"2026-04-08T04:15:06.963468Z","steps":["trace[1311444393] 'agreement among raft nodes before linearized reading' (duration: 209.040305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:15:06.9661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.767924ms","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-04-08T04:15:06.966205Z","caller":"traceutil/trace.go:171","msg":"trace[130196912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2510; }","duration":"211.903467ms","start":"2026-04-08T04:15:06.754284Z","end":"2026-04-08T04:15:06.966188Z","steps":["trace[130196912] 'agreement among raft nodes before linearized reading' (duration: 211.62552ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:15:40.213501Z","caller":"traceutil/trace.go:171","msg":"trace[71292723] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"192.980627ms","start":"2026-04-08T04:15:40.020496Z","end":"2026-04-08T04:15:40.213476Z","steps":["trace[71292723] 'process raft request' (duration: 192.834433ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:15:40.638614Z","caller":"traceutil/trace.go:171","msg":"trace[1662429063] linearizableReadLoop","detail":"{readStateIndex:2804; appliedIndex:2803; }","duration":"136.323419ms","start":"2026-04-08T04:15:40.502257Z","end":"2026-04-08T04:15:40.63858Z","steps":["trace[1662429063] 'read index received' (duration: 53.405986ms)","trace[1662429063] 'applied index is now lower than readState.Index' (duration: 82.915643ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:15:40.639347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.069729ms","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-04-08T04:15:40.639583Z","caller":"traceutil/trace.go:171","msg":"trace[481079380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2699; }","duration":"137.343396ms","start":"2026-04-08T04:15:40.502222Z","end":"2026-04-08T04:15:40.639565Z","steps":["trace[481079380] 'agreement among raft nodes before linearized reading' (duration: 136.900484ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:15:40.899785Z","caller":"traceutil/trace.go:171","msg":"trace[17983336] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"256.091209ms","start":"2026-04-08T04:15:40.643668Z","end":"2026-04-08T04:15:40.899759Z","steps":["trace[17983336] 'process raft request' (duration: 256.024497ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:15:40.899884Z","caller":"traceutil/trace.go:171","msg":"trace[1704809514] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"259.627089ms","start":"2026-04-08T04:15:40.640182Z","end":"2026-04-08T04:15:40.899809Z","steps":["trace[1704809514] 'process raft request' (duration: 174.459197ms)","trace[1704809514] 'compare' (duration: 84.885804ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:19:22.518868Z","caller":"traceutil/trace.go:171","msg":"trace[1372898013] linearizableReadLoop","detail":"{readStateIndex:4808; appliedIndex:4807; }","duration":"204.768067ms","start":"2026-04-08T04:19:22.314076Z","end":"2026-04-08T04:19:22.518845Z","steps":["trace[1372898013] 'read index received' (duration: 177.112401ms)","trace[1372898013] 'applied index is now lower than readState.Index' (duration: 27.654726ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:19:22.518953Z","caller":"traceutil/trace.go:171","msg":"trace[340629149] transaction","detail":"{read_only:false; response_revision:4629; number_of_response:1; }","duration":"237.523251ms","start":"2026-04-08T04:19:22.281421Z","end":"2026-04-08T04:19:22.518945Z","steps":["trace[340629149] 'process raft request' (duration: 209.756183ms)","trace[340629149] 'compare' (duration: 27.568854ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:19:22.519132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.712332ms","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:4849"} {"level":"info","ts":"2026-04-08T04:19:22.519198Z","caller":"traceutil/trace.go:171","msg":"trace[1030378172] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4629; }","duration":"234.802745ms","start":"2026-04-08T04:19:22.284386Z","end":"2026-04-08T04:19:22.519188Z","steps":["trace[1030378172] 'agreement among raft nodes before linearized reading' (duration: 234.653081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:19:22.519295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.337114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3296"} {"level":"info","ts":"2026-04-08T04:19:22.519353Z","caller":"traceutil/trace.go:171","msg":"trace[703622030] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4629; }","duration":"242.422626ms","start":"2026-04-08T04:19:22.276916Z","end":"2026-04-08T04:19:22.519338Z","steps":["trace[703622030] 'agreement among raft nodes before linearized reading' (duration: 242.217771ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:19:22.694344Z","caller":"traceutil/trace.go:171","msg":"trace[161339306] transaction","detail":"{read_only:false; response_revision:4631; number_of_response:1; }","duration":"371.956269ms","start":"2026-04-08T04:19:22.322369Z","end":"2026-04-08T04:19:22.694326Z","steps":["trace[161339306] 'process raft request' (duration: 371.916238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:19:22.694444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:19:22.322362Z","time spent":"372.037141ms","remote":"127.0.0.1:34144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2565,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T04:19:22.694572Z","caller":"traceutil/trace.go:171","msg":"trace[1811759157] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"373.814688ms","start":"2026-04-08T04:19:22.320721Z","end":"2026-04-08T04:19:22.694536Z","steps":["trace[1811759157] 'process raft request' (duration: 301.858125ms)","trace[1811759157] 'compare' (duration: 71.398482ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:19:22.694691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:19:22.320706Z","time spent":"373.92881ms","remote":"127.0.0.1:34028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":871,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T04:19:22.724962Z","caller":"traceutil/trace.go:171","msg":"trace[1272647992] transaction","detail":"{read_only:false; response_revision:4632; number_of_response:1; }","duration":"207.419564ms","start":"2026-04-08T04:19:22.517496Z","end":"2026-04-08T04:19:22.724916Z","steps":["trace[1272647992] 'process raft request' (duration: 207.22085ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:19:22.724992Z","caller":"traceutil/trace.go:171","msg":"trace[1582764162] transaction","detail":"{read_only:false; response_revision:4633; number_of_response:1; }","duration":"198.74671ms","start":"2026-04-08T04:19:22.526222Z","end":"2026-04-08T04:19:22.724968Z","steps":["trace[1582764162] 'process raft request' (duration: 198.618388ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:19:22.725192Z","caller":"traceutil/trace.go:171","msg":"trace[2096234131] linearizableReadLoop","detail":"{readStateIndex:4811; appliedIndex:4808; }","duration":"206.261259ms","start":"2026-04-08T04:19:22.51892Z","end":"2026-04-08T04:19:22.725181Z","steps":["trace[2096234131] 'read index received' (duration: 103.653955ms)","trace[2096234131] 'applied index is now lower than readState.Index' (duration: 102.606014ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:19:22.72546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.668408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-04-08T04:19:22.725479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.044786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12974"} {"level":"info","ts":"2026-04-08T04:19:22.725513Z","caller":"traceutil/trace.go:171","msg":"trace[1386459835] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4634; }","duration":"105.77146ms","start":"2026-04-08T04:19:22.619727Z","end":"2026-04-08T04:19:22.725498Z","steps":["trace[1386459835] 'agreement among raft nodes before linearized reading' (duration: 105.561496ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:19:22.725701Z","caller":"traceutil/trace.go:171","msg":"trace[1883230550] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"192.65308ms","start":"2026-04-08T04:19:22.5326Z","end":"2026-04-08T04:19:22.725253Z","steps":["trace[1883230550] 'process raft request' (duration: 192.315493ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:19:22.725582Z","caller":"traceutil/trace.go:171","msg":"trace[155781772] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4634; }","duration":"207.19902ms","start":"2026-04-08T04:19:22.518369Z","end":"2026-04-08T04:19:22.725568Z","steps":["trace[155781772] 'agreement among raft nodes before linearized reading' (duration: 206.900174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:19:22.728934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.070346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-08T04:19:22.729016Z","caller":"traceutil/trace.go:171","msg":"trace[2143138375] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4634; }","duration":"300.166489ms","start":"2026-04-08T04:19:22.428833Z","end":"2026-04-08T04:19:22.728999Z","steps":["trace[2143138375] 'agreement among raft nodes before linearized reading' (duration: 296.523521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:19:22.7291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:19:22.428772Z","time spent":"300.279581ms","remote":"127.0.0.1:34052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2193189,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-04-08T04:19:23.034489Z","caller":"traceutil/trace.go:171","msg":"trace[1073221305] linearizableReadLoop","detail":"{readStateIndex:4824; appliedIndex:4823; }","duration":"160.47013ms","start":"2026-04-08T04:19:22.87398Z","end":"2026-04-08T04:19:23.03445Z","steps":["trace[1073221305] 'read index received' (duration: 141.6041ms)","trace[1073221305] 'applied index is now lower than readState.Index' (duration: 18.86483ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:19:23.034608Z","caller":"traceutil/trace.go:171","msg":"trace[874412852] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"161.623555ms","start":"2026-04-08T04:19:22.872942Z","end":"2026-04-08T04:19:23.034566Z","steps":["trace[874412852] 'process raft request' (duration: 142.641512ms)","trace[874412852] 'compare' (duration: 18.661066ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:19:23.034943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.9111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"warn","ts":"2026-04-08T04:19:23.034961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.543067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-04-08T04:19:23.034996Z","caller":"traceutil/trace.go:171","msg":"trace[1139720489] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4645; }","duration":"161.051413ms","start":"2026-04-08T04:19:22.87393Z","end":"2026-04-08T04:19:23.034982Z","steps":["trace[1139720489] 'agreement among raft nodes before linearized reading' (duration: 160.705795ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:19:23.035026Z","caller":"traceutil/trace.go:171","msg":"trace[794880995] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4645; }","duration":"157.63978ms","start":"2026-04-08T04:19:22.877366Z","end":"2026-04-08T04:19:23.035006Z","steps":["trace[794880995] 'agreement among raft nodes before linearized reading' (duration: 157.375675ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:21:28.627342Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2952} {"level":"info","ts":"2026-04-08T04:21:28.729837Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2952,"took":"100.453335ms","hash":2863333460,"current-db-size-bytes":54439936,"current-db-size":"54 MB","current-db-size-in-use-bytes":29368320,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-08T04:21:28.729915Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2863333460,"revision":2952,"compact-revision":-1} {"level":"info","ts":"2026-04-08T04:22:02.641036Z","caller":"traceutil/trace.go:171","msg":"trace[576092085] linearizableReadLoop","detail":"{readStateIndex:6047; appliedIndex:6046; }","duration":"250.372746ms","start":"2026-04-08T04:22:02.390618Z","end":"2026-04-08T04:22:02.64099Z","steps":["trace[576092085] 'read index received' (duration: 250.10905ms)","trace[576092085] 'applied index is now lower than readState.Index' (duration: 261.236µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:22:02.641823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.632581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:22:02.642377Z","caller":"traceutil/trace.go:171","msg":"trace[920109172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5831; }","duration":"251.791409ms","start":"2026-04-08T04:22:02.390558Z","end":"2026-04-08T04:22:02.642349Z","steps":["trace[920109172] 'agreement among raft nodes before linearized reading' (duration: 250.59544ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:22:02.64341Z","caller":"traceutil/trace.go:171","msg":"trace[311272496] transaction","detail":"{read_only:false; response_revision:5831; number_of_response:1; }","duration":"388.656082ms","start":"2026-04-08T04:22:02.252455Z","end":"2026-04-08T04:22:02.641111Z","steps":["trace[311272496] 'process raft request' (duration: 388.275054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:22:02.643571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:22:02.252431Z","time spent":"391.035637ms","remote":"127.0.0.1:34198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T04:22:02.64518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.986216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T04:22:02.64588Z","caller":"traceutil/trace.go:171","msg":"trace[781864047] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:5833; }","duration":"143.782134ms","start":"2026-04-08T04:22:02.502077Z","end":"2026-04-08T04:22:02.645859Z","steps":["trace[781864047] 'agreement among raft nodes before linearized reading' (duration: 142.830272ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:22:02.645681Z","caller":"traceutil/trace.go:171","msg":"trace[1239863729] transaction","detail":"{read_only:false; response_revision:5833; number_of_response:1; }","duration":"224.810932ms","start":"2026-04-08T04:22:02.420853Z","end":"2026-04-08T04:22:02.645664Z","steps":["trace[1239863729] 'process raft request' (duration: 223.766657ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:22:02.646383Z","caller":"traceutil/trace.go:171","msg":"trace[1898911925] transaction","detail":"{read_only:false; response_revision:5832; number_of_response:1; }","duration":"224.317601ms","start":"2026-04-08T04:22:02.420371Z","end":"2026-04-08T04:22:02.644689Z","steps":["trace[1898911925] 'process raft request' (duration: 222.788626ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:23:13.46021Z","caller":"traceutil/trace.go:171","msg":"trace[1527794135] transaction","detail":"{read_only:false; response_revision:6397; number_of_response:1; }","duration":"115.916457ms","start":"2026-04-08T04:23:13.344261Z","end":"2026-04-08T04:23:13.460177Z","steps":["trace[1527794135] 'process raft request' (duration: 46.051663ms)","trace[1527794135] 'compare' (duration: 69.556577ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:26:28.664476Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5663} {"level":"info","ts":"2026-04-08T04:26:28.775127Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5663,"took":"109.111682ms","hash":1051214269,"current-db-size-bytes":54439936,"current-db-size":"54 MB","current-db-size-in-use-bytes":17842176,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-08T04:26:28.775174Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1051214269,"revision":5663,"compact-revision":2952}