{"level":"warn","ts":"2026-09-10T17:36:45.325846Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-10T17:36:45.32595Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43: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-09-10T17:36:45.326031Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-10T17:36:45.326044Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-09-10T17:36:45.326065Z","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-09-10T17:36:45.326788Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]} {"level":"info","ts":"2026-09-10T17:36:45.326895Z","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.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43: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-09-10T17:36:45.331263Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.030523ms"} {"level":"info","ts":"2026-09-10T17:36:45.337767Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"} {"level":"info","ts":"2026-09-10T17:36:45.337849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"} {"level":"info","ts":"2026-09-10T17:36:45.337947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"} {"level":"info","ts":"2026-09-10T17:36:45.337963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-10T17:36:45.33805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"} {"level":"info","ts":"2026-09-10T17:36:45.338144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"warn","ts":"2026-09-10T17:36:45.34422Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-10T17:36:45.345523Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-10T17:36:45.346805Z","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-09-10T17:36:45.348389Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-10T17:36:45.348578Z","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-09-10T17:36:45.348722Z","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-09-10T17:36:45.348731Z","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-09-10T17:36:45.348612Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-10T17:36:45.351093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"info","ts":"2026-09-10T17:36:45.351308Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-09-10T17:36:45.35261Z","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-09-10T17:36:45.352816Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-10T17:36:45.35285Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-10T17:36:45.353241Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-09-10T17:36:45.353261Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-09-10T17:36:46.038948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"} {"level":"info","ts":"2026-09-10T17:36:46.039005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"} {"level":"info","ts":"2026-09-10T17:36:46.039021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"} {"level":"info","ts":"2026-09-10T17:36:46.039035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"} {"level":"info","ts":"2026-09-10T17:36:46.039041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-09-10T17:36:46.039063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"} {"level":"info","ts":"2026-09-10T17:36:46.039073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-09-10T17:36:46.040048Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"} {"level":"info","ts":"2026-09-10T17:36:46.040191Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-10T17:36:46.040139Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T17:36:46.040339Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-10T17:36:46.040937Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-10T17:36:46.041006Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-10T17:36:46.041223Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T17:36:46.041448Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T17:36:46.041496Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T17:36:46.041983Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"} {"level":"info","ts":"2026-09-10T17:36:46.044055Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-10T17:37:05.034286Z","caller":"traceutil/trace.go:171","msg":"trace[203340820] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"178.288112ms","start":"2026-09-10T17:37:04.855974Z","end":"2026-09-10T17:37:05.034262Z","steps":["trace[203340820] 'process raft request' (duration: 178.124567ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:37:27.669824Z","caller":"traceutil/trace.go:171","msg":"trace[1576551506] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"146.467807ms","start":"2026-09-10T17:37:27.523292Z","end":"2026-09-10T17:37:27.669759Z","steps":["trace[1576551506] 'process raft request' (duration: 84.188071ms)","trace[1576551506] 'compare' (duration: 60.703489ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:37:27.670058Z","caller":"traceutil/trace.go:171","msg":"trace[573646419] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"139.543417ms","start":"2026-09-10T17:37:27.530505Z","end":"2026-09-10T17:37:27.670048Z","steps":["trace[573646419] 'process raft request' (duration: 138.221447ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:37:32.843086Z","caller":"traceutil/trace.go:171","msg":"trace[1139159513] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"168.724992ms","start":"2026-09-10T17:37:32.672681Z","end":"2026-09-10T17:37:32.841406Z","steps":["trace[1139159513] 'process raft request' (duration: 166.496721ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:37:33.423775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.892628ms","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-09-10T17:37:33.424084Z","caller":"traceutil/trace.go:171","msg":"trace[2088011786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"210.103704ms","start":"2026-09-10T17:37:33.213779Z","end":"2026-09-10T17:37:33.423882Z","steps":["trace[2088011786] 'range keys from in-memory index tree' (duration: 209.641213ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:37:33.449957Z","caller":"traceutil/trace.go:171","msg":"trace[1524658246] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"121.346173ms","start":"2026-09-10T17:37:33.328578Z","end":"2026-09-10T17:37:33.449924Z","steps":["trace[1524658246] 'process raft request' (duration: 120.547175ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:37:34.098341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.939699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-10T17:37:34.098494Z","caller":"traceutil/trace.go:171","msg":"trace[334036914] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"460.653146ms","start":"2026-09-10T17:37:33.63782Z","end":"2026-09-10T17:37:34.098473Z","steps":["trace[334036914] 'read index received' (duration: 295.55637ms)","trace[334036914] 'applied index is now lower than readState.Index' (duration: 165.094856ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:37:34.098609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.781149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T17:37:34.098679Z","caller":"traceutil/trace.go:171","msg":"trace[1530434796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"460.900761ms","start":"2026-09-10T17:37:33.637768Z","end":"2026-09-10T17:37:34.098669Z","steps":["trace[1530434796] 'agreement among raft nodes before linearized reading' (duration: 460.756028ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:37:34.098726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:37:33.637743Z","time spent":"460.974914ms","remote":"127.0.0.1:56252","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-09-10T17:37:34.098831Z","caller":"traceutil/trace.go:171","msg":"trace[588627738] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"571.050623ms","start":"2026-09-10T17:37:33.527739Z","end":"2026-09-10T17:37:34.098789Z","steps":["trace[588627738] 'process raft request' (duration: 405.750113ms)","trace[588627738] 'compare' (duration: 163.55216ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:37:34.099041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:37:33.527711Z","time spent":"571.214917ms","remote":"127.0.0.1:56710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-10T17:38:23.554791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.997897ms","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-09-10T17:38:23.554903Z","caller":"traceutil/trace.go:171","msg":"trace[637402456] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1177; }","duration":"395.203783ms","start":"2026-09-10T17:38:23.159672Z","end":"2026-09-10T17:38:23.554876Z","steps":["trace[637402456] 'count revisions from in-memory index tree' (duration: 394.834713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:38:23.554954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:38:23.159626Z","time spent":"395.314745ms","remote":"127.0.0.1:56422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":17,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-09-10T17:38:23.555128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.031867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-09-10T17:38:23.555242Z","caller":"traceutil/trace.go:171","msg":"trace[415059313] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1177; }","duration":"551.206092ms","start":"2026-09-10T17:38:23.004007Z","end":"2026-09-10T17:38:23.555213Z","steps":["trace[415059313] 'range keys from in-memory index tree' (duration: 550.853404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:38:23.555301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:38:23.00398Z","time spent":"551.307024ms","remote":"127.0.0.1:56432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":246,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" "} {"level":"info","ts":"2026-09-10T17:38:23.723312Z","caller":"traceutil/trace.go:171","msg":"trace[674710407] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"151.278226ms","start":"2026-09-10T17:38:23.571967Z","end":"2026-09-10T17:38:23.723245Z","steps":["trace[674710407] 'process raft request' (duration: 150.767584ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.179925Z","caller":"traceutil/trace.go:171","msg":"trace[956450776] transaction","detail":"{read_only:false; response_revision:1616; number_of_response:1; }","duration":"131.607156ms","start":"2026-09-10T17:38:58.048285Z","end":"2026-09-10T17:38:58.179892Z","steps":["trace[956450776] 'process raft request' (duration: 62.006154ms)","trace[956450776] 'compare' (duration: 69.316566ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:38:58.180211Z","caller":"traceutil/trace.go:171","msg":"trace[794815304] transaction","detail":"{read_only:false; response_revision:1617; number_of_response:1; }","duration":"131.824281ms","start":"2026-09-10T17:38:58.048367Z","end":"2026-09-10T17:38:58.180191Z","steps":["trace[794815304] 'process raft request' (duration: 131.451182ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.180437Z","caller":"traceutil/trace.go:171","msg":"trace[1934089949] transaction","detail":"{read_only:false; response_revision:1618; number_of_response:1; }","duration":"131.573066ms","start":"2026-09-10T17:38:58.048842Z","end":"2026-09-10T17:38:58.180415Z","steps":["trace[1934089949] 'process raft request' (duration: 131.198868ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.18393Z","caller":"traceutil/trace.go:171","msg":"trace[767083829] transaction","detail":"{read_only:false; response_revision:1619; number_of_response:1; }","duration":"132.23798ms","start":"2026-09-10T17:38:58.051675Z","end":"2026-09-10T17:38:58.183913Z","steps":["trace[767083829] 'process raft request' (duration: 131.907553ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.183989Z","caller":"traceutil/trace.go:171","msg":"trace[1295605113] transaction","detail":"{read_only:false; response_revision:1623; number_of_response:1; }","duration":"128.485975ms","start":"2026-09-10T17:38:58.055477Z","end":"2026-09-10T17:38:58.183963Z","steps":["trace[1295605113] 'process raft request' (duration: 128.309471ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.18407Z","caller":"traceutil/trace.go:171","msg":"trace[1518616031] transaction","detail":"{read_only:false; response_revision:1621; number_of_response:1; }","duration":"132.309331ms","start":"2026-09-10T17:38:58.051751Z","end":"2026-09-10T17:38:58.18406Z","steps":["trace[1518616031] 'process raft request' (duration: 131.952263ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.18435Z","caller":"traceutil/trace.go:171","msg":"trace[107472134] transaction","detail":"{read_only:false; response_revision:1625; number_of_response:1; }","duration":"125.195133ms","start":"2026-09-10T17:38:58.059134Z","end":"2026-09-10T17:38:58.184329Z","steps":["trace[107472134] 'process raft request' (duration: 124.740942ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.184537Z","caller":"traceutil/trace.go:171","msg":"trace[1520813092] transaction","detail":"{read_only:false; response_revision:1624; number_of_response:1; }","duration":"128.426825ms","start":"2026-09-10T17:38:58.056087Z","end":"2026-09-10T17:38:58.184513Z","steps":["trace[1520813092] 'process raft request' (duration: 127.741089ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.184643Z","caller":"traceutil/trace.go:171","msg":"trace[1434574573] transaction","detail":"{read_only:false; response_revision:1620; number_of_response:1; }","duration":"132.923265ms","start":"2026-09-10T17:38:58.051703Z","end":"2026-09-10T17:38:58.184627Z","steps":["trace[1434574573] 'process raft request' (duration: 131.959143ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.184817Z","caller":"traceutil/trace.go:171","msg":"trace[1783201971] transaction","detail":"{read_only:false; response_revision:1622; number_of_response:1; }","duration":"130.806648ms","start":"2026-09-10T17:38:58.053983Z","end":"2026-09-10T17:38:58.18479Z","steps":["trace[1783201971] 'process raft request' (duration: 129.759884ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.343647Z","caller":"traceutil/trace.go:171","msg":"trace[976287056] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"120.790983ms","start":"2026-09-10T17:38:58.22281Z","end":"2026-09-10T17:38:58.343601Z","steps":["trace[976287056] 'process raft request' (duration: 60.832787ms)","trace[976287056] 'compare' (duration: 59.780492ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:38:58.343869Z","caller":"traceutil/trace.go:171","msg":"trace[439115762] transaction","detail":"{read_only:false; response_revision:1635; number_of_response:1; }","duration":"120.486237ms","start":"2026-09-10T17:38:58.223371Z","end":"2026-09-10T17:38:58.343857Z","steps":["trace[439115762] 'process raft request' (duration: 120.163009ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.343941Z","caller":"traceutil/trace.go:171","msg":"trace[937681527] transaction","detail":"{read_only:false; response_revision:1636; number_of_response:1; }","duration":"120.285222ms","start":"2026-09-10T17:38:58.223623Z","end":"2026-09-10T17:38:58.343908Z","steps":["trace[937681527] 'process raft request' (duration: 120.112567ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.516912Z","caller":"traceutil/trace.go:171","msg":"trace[1890579095] transaction","detail":"{read_only:false; response_revision:1641; number_of_response:1; }","duration":"113.54897ms","start":"2026-09-10T17:38:58.403323Z","end":"2026-09-10T17:38:58.516872Z","steps":["trace[1890579095] 'process raft request' (duration: 41.773908ms)","trace[1890579095] 'compare' (duration: 71.532167ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:38:58.826982Z","caller":"traceutil/trace.go:171","msg":"trace[1377459165] transaction","detail":"{read_only:false; response_revision:1655; number_of_response:1; }","duration":"138.603803ms","start":"2026-09-10T17:38:58.688353Z","end":"2026-09-10T17:38:58.826957Z","steps":["trace[1377459165] 'process raft request' (duration: 138.333747ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:38:58.82699Z","caller":"traceutil/trace.go:171","msg":"trace[25340332] transaction","detail":"{read_only:false; response_revision:1654; number_of_response:1; }","duration":"139.604736ms","start":"2026-09-10T17:38:58.687335Z","end":"2026-09-10T17:38:58.82694Z","steps":["trace[25340332] 'process raft request' (duration: 94.322008ms)","trace[25340332] 'compare' (duration: 44.838197ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:38:58.827073Z","caller":"traceutil/trace.go:171","msg":"trace[1097281952] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1655; }","duration":"137.770186ms","start":"2026-09-10T17:38:58.689286Z","end":"2026-09-10T17:38:58.827056Z","steps":["trace[1097281952] 'process raft request' (duration: 137.492989ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:39:13.911661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.672736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T17:39:13.9118Z","caller":"traceutil/trace.go:171","msg":"trace[557255405] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1860; }","duration":"271.924391ms","start":"2026-09-10T17:39:13.639847Z","end":"2026-09-10T17:39:13.911771Z","steps":["trace[557255405] 'range keys from in-memory index tree' (duration: 271.525472ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:39:13.911666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.41804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d41dba04-adb8-4785-81d8-442153a0175c\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-10T17:39:13.912103Z","caller":"traceutil/trace.go:171","msg":"trace[913222993] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d41dba04-adb8-4785-81d8-442153a0175c; range_end:; response_count:1; response_revision:1860; }","duration":"271.864471ms","start":"2026-09-10T17:39:13.640186Z","end":"2026-09-10T17:39:13.91205Z","steps":["trace[913222993] 'range keys from in-memory index tree' (duration: 271.167793ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:39:14.170202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.937546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T17:39:14.17046Z","caller":"traceutil/trace.go:171","msg":"trace[1214342543] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1931; }","duration":"120.545723ms","start":"2026-09-10T17:39:14.049888Z","end":"2026-09-10T17:39:14.170434Z","steps":["trace[1214342543] 'read index received' (duration: 34.381µs)","trace[1214342543] 'applied index is now lower than readState.Index' (duration: 120.510132ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:39:14.170504Z","caller":"traceutil/trace.go:171","msg":"trace[2057596831] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"160.88629ms","start":"2026-09-10T17:39:14.009593Z","end":"2026-09-10T17:39:14.170479Z","steps":["trace[2057596831] 'process raft request' (duration: 160.749807ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:14.170528Z","caller":"traceutil/trace.go:171","msg":"trace[826857483] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"218.381027ms","start":"2026-09-10T17:39:13.952115Z","end":"2026-09-10T17:39:14.170496Z","steps":["trace[826857483] 'process raft request' (duration: 79.779016ms)","trace[826857483] 'compare' (duration: 137.794214ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:39:14.17071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.241338ms","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-09-10T17:39:14.170784Z","caller":"traceutil/trace.go:171","msg":"trace[293653132] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1863; }","duration":"116.338611ms","start":"2026-09-10T17:39:14.054428Z","end":"2026-09-10T17:39:14.170767Z","steps":["trace[293653132] 'agreement among raft nodes before linearized reading' (duration: 116.151817ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:39:14.17094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.818949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-10T17:39:14.171014Z","caller":"traceutil/trace.go:171","msg":"trace[1572239894] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1863; }","duration":"121.161087ms","start":"2026-09-10T17:39:14.049835Z","end":"2026-09-10T17:39:14.170996Z","steps":["trace[1572239894] 'agreement among raft nodes before linearized reading' (duration: 120.722827ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:14.316746Z","caller":"traceutil/trace.go:171","msg":"trace[1563396418] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"139.837478ms","start":"2026-09-10T17:39:14.176873Z","end":"2026-09-10T17:39:14.31671Z","steps":["trace[1563396418] 'process raft request' (duration: 129.967611ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:14.318809Z","caller":"traceutil/trace.go:171","msg":"trace[754618184] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"139.9424ms","start":"2026-09-10T17:39:14.178839Z","end":"2026-09-10T17:39:14.318781Z","steps":["trace[754618184] 'process raft request' (duration: 139.718665ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:14.318933Z","caller":"traceutil/trace.go:171","msg":"trace[1702757844] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"139.657804ms","start":"2026-09-10T17:39:14.179249Z","end":"2026-09-10T17:39:14.318907Z","steps":["trace[1702757844] 'process raft request' (duration: 139.403228ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:14.319008Z","caller":"traceutil/trace.go:171","msg":"trace[291779160] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"139.622502ms","start":"2026-09-10T17:39:14.179365Z","end":"2026-09-10T17:39:14.318987Z","steps":["trace[291779160] 'process raft request' (duration: 139.403927ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:14.319089Z","caller":"traceutil/trace.go:171","msg":"trace[1590179397] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"139.667493ms","start":"2026-09-10T17:39:14.179407Z","end":"2026-09-10T17:39:14.319074Z","steps":["trace[1590179397] 'process raft request' (duration: 139.438379ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:14.31934Z","caller":"traceutil/trace.go:171","msg":"trace[409755614] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"107.111857ms","start":"2026-09-10T17:39:14.212211Z","end":"2026-09-10T17:39:14.319322Z","steps":["trace[409755614] 'process raft request' (duration: 106.694368ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:26.527047Z","caller":"traceutil/trace.go:171","msg":"trace[1025408079] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"116.252566ms","start":"2026-09-10T17:39:26.410747Z","end":"2026-09-10T17:39:26.527Z","steps":["trace[1025408079] 'process raft request' (duration: 110.138594ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:26.535786Z","caller":"traceutil/trace.go:171","msg":"trace[588268809] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"124.170879ms","start":"2026-09-10T17:39:26.411592Z","end":"2026-09-10T17:39:26.535763Z","steps":["trace[588268809] 'process raft request' (duration: 123.610046ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:47.408979Z","caller":"traceutil/trace.go:171","msg":"trace[306083752] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"103.425899ms","start":"2026-09-10T17:39:47.305517Z","end":"2026-09-10T17:39:47.408943Z","steps":["trace[306083752] 'process raft request' (duration: 103.189364ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:47.415236Z","caller":"traceutil/trace.go:171","msg":"trace[805686473] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"109.560121ms","start":"2026-09-10T17:39:47.30565Z","end":"2026-09-10T17:39:47.41521Z","steps":["trace[805686473] 'process raft request' (duration: 109.425348ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:52.901785Z","caller":"traceutil/trace.go:171","msg":"trace[366375475] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2209; }","duration":"130.379956ms","start":"2026-09-10T17:39:52.771384Z","end":"2026-09-10T17:39:52.901764Z","steps":["trace[366375475] 'read index received' (duration: 130.174432ms)","trace[366375475] 'applied index is now lower than readState.Index' (duration: 204.524µs)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:39:52.902018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.625141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T17:39:52.902199Z","caller":"traceutil/trace.go:171","msg":"trace[857255712] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2131; }","duration":"130.864236ms","start":"2026-09-10T17:39:52.771322Z","end":"2026-09-10T17:39:52.902186Z","steps":["trace[857255712] 'agreement among raft nodes before linearized reading' (duration: 130.644982ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:52.902069Z","caller":"traceutil/trace.go:171","msg":"trace[1624824890] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"213.134818ms","start":"2026-09-10T17:39:52.688905Z","end":"2026-09-10T17:39:52.902039Z","steps":["trace[1624824890] 'process raft request' (duration: 212.72633ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:53.574004Z","caller":"traceutil/trace.go:171","msg":"trace[1945189120] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"129.042556ms","start":"2026-09-10T17:39:53.444938Z","end":"2026-09-10T17:39:53.573981Z","steps":["trace[1945189120] 'process raft request' (duration: 128.874553ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:53.617297Z","caller":"traceutil/trace.go:171","msg":"trace[400407203] linearizableReadLoop","detail":"{readStateIndex:2214; appliedIndex:2212; }","duration":"162.412635ms","start":"2026-09-10T17:39:53.454865Z","end":"2026-09-10T17:39:53.617278Z","steps":["trace[400407203] 'read index received' (duration: 119.012102ms)","trace[400407203] 'applied index is now lower than readState.Index' (duration: 43.399843ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:39:53.617457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.567019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-10T17:39:53.617483Z","caller":"traceutil/trace.go:171","msg":"trace[379301509] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2135; }","duration":"162.63998ms","start":"2026-09-10T17:39:53.454835Z","end":"2026-09-10T17:39:53.617475Z","steps":["trace[379301509] 'agreement among raft nodes before linearized reading' (duration: 162.510468ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:53.617511Z","caller":"traceutil/trace.go:171","msg":"trace[875736672] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"171.668283ms","start":"2026-09-10T17:39:53.445803Z","end":"2026-09-10T17:39:53.617471Z","steps":["trace[875736672] 'process raft request' (duration: 171.369897ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:39:54.194971Z","caller":"traceutil/trace.go:171","msg":"trace[1707657598] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"416.785365ms","start":"2026-09-10T17:39:53.778165Z","end":"2026-09-10T17:39:54.194951Z","steps":["trace[1707657598] 'process raft request' (duration: 416.109381ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:39:54.195094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:39:53.778142Z","time spent":"416.887738ms","remote":"127.0.0.1:56420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8559,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T17:39:54.747Z","caller":"traceutil/trace.go:171","msg":"trace[644058929] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"217.6966ms","start":"2026-09-10T17:39:54.529267Z","end":"2026-09-10T17:39:54.746963Z","steps":["trace[644058929] 'process raft request' (duration: 172.398046ms)","trace[644058929] 'compare' (duration: 44.937996ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:39:54.750336Z","caller":"traceutil/trace.go:171","msg":"trace[1356483031] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2216; }","duration":"125.772855ms","start":"2026-09-10T17:39:54.62454Z","end":"2026-09-10T17:39:54.750313Z","steps":["trace[1356483031] 'read index received' (duration: 77.13994ms)","trace[1356483031] 'applied index is now lower than readState.Index' (duration: 48.631715ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:39:54.75141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.318861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T17:39:54.751459Z","caller":"traceutil/trace.go:171","msg":"trace[1124076466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2139; }","duration":"114.445554ms","start":"2026-09-10T17:39:54.637001Z","end":"2026-09-10T17:39:54.751447Z","steps":["trace[1124076466] 'agreement among raft nodes before linearized reading' (duration: 114.331622ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:39:54.752199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.651564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-10T17:39:54.752251Z","caller":"traceutil/trace.go:171","msg":"trace[880152881] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2139; }","duration":"127.742666ms","start":"2026-09-10T17:39:54.624493Z","end":"2026-09-10T17:39:54.752236Z","steps":["trace[880152881] 'agreement among raft nodes before linearized reading' (duration: 125.944438ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:40:54.841724Z","caller":"traceutil/trace.go:171","msg":"trace[576949979] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"115.506016ms","start":"2026-09-10T17:40:54.726177Z","end":"2026-09-10T17:40:54.841683Z","steps":["trace[576949979] 'process raft request' (duration: 115.393744ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:41:31.314105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.79856ms","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-09-10T17:41:31.314224Z","caller":"traceutil/trace.go:171","msg":"trace[155177822] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2766; }","duration":"139.948413ms","start":"2026-09-10T17:41:31.174259Z","end":"2026-09-10T17:41:31.314208Z","steps":["trace[155177822] 'range keys from in-memory index tree' (duration: 139.784549ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:41:31.314553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.587904ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T17:41:31.314764Z","caller":"traceutil/trace.go:171","msg":"trace[1282554318] linearizableReadLoop","detail":"{readStateIndex:2870; appliedIndex:2868; }","duration":"112.679672ms","start":"2026-09-10T17:41:31.202069Z","end":"2026-09-10T17:41:31.314748Z","steps":["trace[1282554318] 'read index received' (duration: 106.016354ms)","trace[1282554318] 'applied index is now lower than readState.Index' (duration: 6.662288ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:41:31.314899Z","caller":"traceutil/trace.go:171","msg":"trace[2002050194] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"213.918877ms","start":"2026-09-10T17:41:31.100943Z","end":"2026-09-10T17:41:31.314862Z","steps":["trace[2002050194] 'process raft request' (duration: 213.709913ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:41:31.314941Z","caller":"traceutil/trace.go:171","msg":"trace[2036677654] transaction","detail":"{read_only:false; response_revision:2767; number_of_response:1; }","duration":"214.250024ms","start":"2026-09-10T17:41:31.100662Z","end":"2026-09-10T17:41:31.314912Z","steps":["trace[2036677654] 'process raft request' (duration: 62.201611ms)","trace[2036677654] 'compare' (duration: 151.328538ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:41:31.314966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.891486ms","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-09-10T17:41:31.315066Z","caller":"traceutil/trace.go:171","msg":"trace[1835206066] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2768; }","duration":"113.026259ms","start":"2026-09-10T17:41:31.202022Z","end":"2026-09-10T17:41:31.315048Z","steps":["trace[1835206066] 'agreement among raft nodes before linearized reading' (duration: 112.828945ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:45:45.055802Z","caller":"traceutil/trace.go:171","msg":"trace[901106720] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"106.851014ms","start":"2026-09-10T17:45:44.948909Z","end":"2026-09-10T17:45:45.05576Z","steps":["trace[901106720] 'process raft request' (duration: 74.781523ms)","trace[901106720] 'compare' (duration: 31.889606ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:45:53.253843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.279598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"warn","ts":"2026-09-10T17:45:53.253861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.210553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-09-10T17:45:53.253957Z","caller":"traceutil/trace.go:171","msg":"trace[388064958] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4911; }","duration":"153.468464ms","start":"2026-09-10T17:45:53.100462Z","end":"2026-09-10T17:45:53.25393Z","steps":["trace[388064958] 'range keys from in-memory index tree' (duration: 153.022711ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:45:53.254073Z","caller":"traceutil/trace.go:171","msg":"trace[1253849036] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4911; }","duration":"150.414039ms","start":"2026-09-10T17:45:53.103562Z","end":"2026-09-10T17:45:53.253976Z","steps":["trace[1253849036] 'range keys from in-memory index tree' (duration: 149.967156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:53.254032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.964099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T17:45:53.254204Z","caller":"traceutil/trace.go:171","msg":"trace[1659889104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4911; }","duration":"130.175835ms","start":"2026-09-10T17:45:53.123974Z","end":"2026-09-10T17:45:53.254149Z","steps":["trace[1659889104] 'count revisions from in-memory index tree' (duration: 129.874135ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:45:53.501853Z","caller":"traceutil/trace.go:171","msg":"trace[518690550] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"142.661393ms","start":"2026-09-10T17:45:53.359152Z","end":"2026-09-10T17:45:53.501813Z","steps":["trace[518690550] 'process raft request' (duration: 142.238811ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:45:53.981053Z","caller":"traceutil/trace.go:171","msg":"trace[932764223] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"308.976784ms","start":"2026-09-10T17:45:53.67205Z","end":"2026-09-10T17:45:53.981027Z","steps":["trace[932764223] 'process raft request' (duration: 308.775659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:53.981225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:45:53.672023Z","time spent":"309.105108ms","remote":"127.0.0.1:56412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T17:45:53.981333Z","caller":"traceutil/trace.go:171","msg":"trace[2029045861] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"309.121678ms","start":"2026-09-10T17:45:53.672201Z","end":"2026-09-10T17:45:53.981323Z","steps":["trace[2029045861] 'process raft request' (duration: 308.784209ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:53.981477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:45:53.672194Z","time spent":"309.21271ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1868,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T17:45:53.981765Z","caller":"traceutil/trace.go:171","msg":"trace[1022897774] linearizableReadLoop","detail":"{readStateIndex:5104; appliedIndex:5100; }","duration":"305.96673ms","start":"2026-09-10T17:45:53.675781Z","end":"2026-09-10T17:45:53.981748Z","steps":["trace[1022897774] 'read index received' (duration: 305.039475ms)","trace[1022897774] 'applied index is now lower than readState.Index' (duration: 926.275µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:45:53.981784Z","caller":"traceutil/trace.go:171","msg":"trace[1762910631] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"308.791238ms","start":"2026-09-10T17:45:53.672985Z","end":"2026-09-10T17:45:53.981776Z","steps":["trace[1762910631] 'process raft request' (duration: 308.254264ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:53.981945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.111377ms","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":"info","ts":"2026-09-10T17:45:53.982003Z","caller":"traceutil/trace.go:171","msg":"trace[402619386] 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:4922; }","duration":"309.1791ms","start":"2026-09-10T17:45:53.672813Z","end":"2026-09-10T17:45:53.981992Z","steps":["trace[402619386] 'agreement among raft nodes before linearized reading' (duration: 308.993184ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:53.982026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.221491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16084"} {"level":"warn","ts":"2026-09-10T17:45:53.982052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:45:53.672811Z","time spent":"309.233972ms","remote":"127.0.0.1:56396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-09-10T17:45:53.982077Z","caller":"traceutil/trace.go:171","msg":"trace[1779203419] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4922; }","duration":"309.298383ms","start":"2026-09-10T17:45:53.672762Z","end":"2026-09-10T17:45:53.98206Z","steps":["trace[1779203419] 'agreement among raft nodes before linearized reading' (duration: 309.073286ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:53.982118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:45:53.672755Z","time spent":"309.351304ms","remote":"127.0.0.1:56422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16106,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-09-10T17:45:53.982112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:45:53.67298Z","time spent":"308.983444ms","remote":"127.0.0.1:56412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1282,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T17:45:53.981843Z","caller":"traceutil/trace.go:171","msg":"trace[285295392] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"307.869753ms","start":"2026-09-10T17:45:53.673931Z","end":"2026-09-10T17:45:53.981801Z","steps":["trace[285295392] 'process raft request' (duration: 307.725829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:53.982276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:45:53.673904Z","time spent":"308.348747ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1454,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T17:45:54.003326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.631938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T17:45:54.003444Z","caller":"traceutil/trace.go:171","msg":"trace[922428330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4923; }","duration":"325.786212ms","start":"2026-09-10T17:45:53.67763Z","end":"2026-09-10T17:45:54.003416Z","steps":["trace[922428330] 'agreement among raft nodes before linearized reading' (duration: 325.627058ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:54.003494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:45:53.67762Z","time spent":"325.862214ms","remote":"127.0.0.1:56248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-10T17:45:54.003699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.240732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3437b8a2-8a25-4245-9967-53ce8d10e50d\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-10T17:45:54.003764Z","caller":"traceutil/trace.go:171","msg":"trace[1381629707] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3437b8a2-8a25-4245-9967-53ce8d10e50d; range_end:; response_count:1; response_revision:4923; }","duration":"142.500778ms","start":"2026-09-10T17:45:53.861245Z","end":"2026-09-10T17:45:54.003745Z","steps":["trace[1381629707] 'agreement among raft nodes before linearized reading' (duration: 142.161439ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:45:54.003871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.189222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-10T17:45:54.003908Z","caller":"traceutil/trace.go:171","msg":"trace[407746281] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4923; }","duration":"294.257733ms","start":"2026-09-10T17:45:53.709639Z","end":"2026-09-10T17:45:54.003897Z","steps":["trace[407746281] 'agreement among raft nodes before linearized reading' (duration: 293.309987ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:45:54.11401Z","caller":"traceutil/trace.go:171","msg":"trace[662279306] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"110.891294ms","start":"2026-09-10T17:45:54.003052Z","end":"2026-09-10T17:45:54.113943Z","steps":["trace[662279306] 'process raft request' (duration: 104.616839ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:46:02.212183Z","caller":"traceutil/trace.go:171","msg":"trace[1544673838] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"135.125565ms","start":"2026-09-10T17:46:02.077023Z","end":"2026-09-10T17:46:02.212148Z","steps":["trace[1544673838] 'process raft request' (duration: 113.20534ms)","trace[1544673838] 'compare' (duration: 21.7558ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:46:07.439299Z","caller":"traceutil/trace.go:171","msg":"trace[2138997123] linearizableReadLoop","detail":"{readStateIndex:5284; appliedIndex:5283; }","duration":"314.72471ms","start":"2026-09-10T17:46:07.124544Z","end":"2026-09-10T17:46:07.439269Z","steps":["trace[2138997123] 'read index received' (duration: 314.546915ms)","trace[2138997123] 'applied index is now lower than readState.Index' (duration: 176.385µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:46:07.439372Z","caller":"traceutil/trace.go:171","msg":"trace[1617196163] transaction","detail":"{read_only:false; response_revision:5095; number_of_response:1; }","duration":"377.051539ms","start":"2026-09-10T17:46:07.062286Z","end":"2026-09-10T17:46:07.439337Z","steps":["trace[1617196163] 'process raft request' (duration: 376.800562ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:46:07.439554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:46:07.062249Z","time spent":"377.196433ms","remote":"127.0.0.1:56422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11649,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T17:46:07.439557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.001918ms","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-09-10T17:46:07.439623Z","caller":"traceutil/trace.go:171","msg":"trace[1680932813] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5095; }","duration":"315.129751ms","start":"2026-09-10T17:46:07.124477Z","end":"2026-09-10T17:46:07.439607Z","steps":["trace[1680932813] 'agreement among raft nodes before linearized reading' (duration: 314.926756ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:46:07.439676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:46:07.124457Z","time spent":"315.205654ms","remote":"127.0.0.1:56504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-10T17:46:07.450095Z","caller":"traceutil/trace.go:171","msg":"trace[1713518604] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"190.439002ms","start":"2026-09-10T17:46:07.259625Z","end":"2026-09-10T17:46:07.450064Z","steps":["trace[1713518604] 'process raft request' (duration: 190.101162ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:46:07.567987Z","caller":"traceutil/trace.go:171","msg":"trace[914063847] transaction","detail":"{read_only:false; response_revision:5100; number_of_response:1; }","duration":"111.264632ms","start":"2026-09-10T17:46:07.456682Z","end":"2026-09-10T17:46:07.567946Z","steps":["trace[914063847] 'process raft request' (duration: 70.090962ms)","trace[914063847] 'compare' (duration: 40.992225ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:46:46.076456Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2847} {"level":"info","ts":"2026-09-10T17:46:46.182849Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2847,"took":"105.296126ms","hash":3873290703,"current-db-size-bytes":53870592,"current-db-size":"54 MB","current-db-size-in-use-bytes":28516352,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-10T17:46:46.182915Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3873290703,"revision":2847,"compact-revision":-1} {"level":"info","ts":"2026-09-10T17:49:52.126196Z","caller":"traceutil/trace.go:171","msg":"trace[1161027256] transaction","detail":"{read_only:false; response_revision:6714; number_of_response:1; }","duration":"166.612584ms","start":"2026-09-10T17:49:51.959554Z","end":"2026-09-10T17:49:52.126167Z","steps":["trace[1161027256] 'process raft request' (duration: 166.42221ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:51:46.08423Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5433} {"level":"info","ts":"2026-09-10T17:51:46.199384Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5433,"took":"113.12367ms","hash":4162966089,"current-db-size-bytes":53870592,"current-db-size":"54 MB","current-db-size-in-use-bytes":18694144,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-10T17:51:46.199459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4162966089,"revision":5433,"compact-revision":2847}