{"level":"warn","ts":"2026-09-09T06:10:52.631572Z","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-09T06:10:52.631698Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.243: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.243:2380","--initial-cluster=instance=https://162.253.55.243:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.243:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.243: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-09T06:10:52.631786Z","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-09T06:10:52.631795Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.243:2380"]} {"level":"info","ts":"2026-09-09T06:10:52.631818Z","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-09T06:10:52.632849Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.243:2379"]} {"level":"info","ts":"2026-09-09T06:10:52.632955Z","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.243:2380"],"listen-peer-urls":["https://162.253.55.243:2380"],"advertise-client-urls":["https://162.253.55.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.243: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-09T06:10:52.638017Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.803631ms"} {"level":"info","ts":"2026-09-09T06:10:52.651301Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"91f23f9850a60ad9","cluster-id":"a1aa8913d5e5414a"} {"level":"info","ts":"2026-09-09T06:10:52.651398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-09T06:10:52.651433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 became follower at term 0"} {"level":"info","ts":"2026-09-09T06:10:52.651451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 91f23f9850a60ad9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-09T06:10:52.651471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 became follower at term 1"} {"level":"info","ts":"2026-09-09T06:10:52.651525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 switched to configuration voters=(10516538003284167385)"} {"level":"warn","ts":"2026-09-09T06:10:52.660364Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-09T06:10:52.661873Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-09T06:10:52.66759Z","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-09T06:10:52.670183Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"91f23f9850a60ad9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-09T06:10:52.671444Z","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-09T06:10:52.671571Z","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-09T06:10:52.671584Z","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-09T06:10:52.675485Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"91f23f9850a60ad9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-09T06:10:52.676638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 switched to configuration voters=(10516538003284167385)"} {"level":"info","ts":"2026-09-09T06:10:52.677181Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a1aa8913d5e5414a","local-member-id":"91f23f9850a60ad9","added-peer-id":"91f23f9850a60ad9","added-peer-peer-urls":["https://162.253.55.243:2380"]} {"level":"info","ts":"2026-09-09T06:10:52.678248Z","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-09T06:10:52.678371Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.243:2380"} {"level":"info","ts":"2026-09-09T06:10:52.678401Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.243:2380"} {"level":"info","ts":"2026-09-09T06:10:52.679247Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"91f23f9850a60ad9","initial-advertise-peer-urls":["https://162.253.55.243:2380"],"listen-peer-urls":["https://162.253.55.243:2380"],"advertise-client-urls":["https://162.253.55.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-09T06:10:52.679335Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-09T06:10:53.255131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-09T06:10:53.255216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-09T06:10:53.25528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 received MsgPreVoteResp from 91f23f9850a60ad9 at term 1"} {"level":"info","ts":"2026-09-09T06:10:53.25531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 became candidate at term 2"} {"level":"info","ts":"2026-09-09T06:10:53.255332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 received MsgVoteResp from 91f23f9850a60ad9 at term 2"} {"level":"info","ts":"2026-09-09T06:10:53.255354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"91f23f9850a60ad9 became leader at term 2"} {"level":"info","ts":"2026-09-09T06:10:53.255412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 91f23f9850a60ad9 elected leader 91f23f9850a60ad9 at term 2"} {"level":"info","ts":"2026-09-09T06:10:53.25696Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T06:10:53.258027Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"91f23f9850a60ad9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.243:2379]}","request-path":"/0/members/91f23f9850a60ad9/attributes","cluster-id":"a1aa8913d5e5414a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-09T06:10:53.258084Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T06:10:53.258239Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T06:10:53.258428Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-09T06:10:53.258455Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-09T06:10:53.259082Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a1aa8913d5e5414a","local-member-id":"91f23f9850a60ad9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T06:10:53.259209Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T06:10:53.259245Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T06:10:53.260956Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-09T06:10:53.275304Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.243:2379"} {"level":"warn","ts":"2026-09-09T06:10:56.521277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.723704ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-09T06:10:56.521434Z","caller":"traceutil/trace.go:171","msg":"trace[157574258] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"557.551793ms","start":"2026-09-09T06:10:55.963859Z","end":"2026-09-09T06:10:56.521411Z","steps":["trace[157574258] 'process raft request' (duration: 267.098736ms)","trace[157574258] 'compare' (duration: 289.571813ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:10:56.521506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:10:55.963839Z","time spent":"557.641144ms","remote":"127.0.0.1:52670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":666,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T06:10:56.771065Z","caller":"traceutil/trace.go:171","msg":"trace[783477007] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"242.145268ms","start":"2026-09-09T06:10:56.528884Z","end":"2026-09-09T06:10:56.771029Z","steps":["trace[783477007] 'process raft request' (duration: 175.433459ms)","trace[783477007] 'compare' (duration: 66.582639ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:11:43.122742Z","caller":"traceutil/trace.go:171","msg":"trace[687079218] transaction","detail":"{read_only:false; number_of_response:1; response_revision:577; }","duration":"120.876053ms","start":"2026-09-09T06:11:43.001841Z","end":"2026-09-09T06:11:43.122718Z","steps":["trace[687079218] 'process raft request' (duration: 120.8134ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:43.122791Z","caller":"traceutil/trace.go:171","msg":"trace[1546811678] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"124.341421ms","start":"2026-09-09T06:11:42.998428Z","end":"2026-09-09T06:11:43.122769Z","steps":["trace[1546811678] 'process raft request' (duration: 124.194887ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:43.122786Z","caller":"traceutil/trace.go:171","msg":"trace[1016455497] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"133.382459ms","start":"2026-09-09T06:11:42.989367Z","end":"2026-09-09T06:11:43.122749Z","steps":["trace[1016455497] 'process raft request' (duration: 133.035209ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:43.123019Z","caller":"traceutil/trace.go:171","msg":"trace[394552663] transaction","detail":"{read_only:false; number_of_response:1; response_revision:577; }","duration":"116.570233ms","start":"2026-09-09T06:11:43.006441Z","end":"2026-09-09T06:11:43.123011Z","steps":["trace[394552663] 'process raft request' (duration: 116.256685ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:43.123257Z","caller":"traceutil/trace.go:171","msg":"trace[2034222859] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:587; }","duration":"111.325318ms","start":"2026-09-09T06:11:43.011902Z","end":"2026-09-09T06:11:43.123227Z","steps":["trace[2034222859] 'read index received' (duration: 23.345587ms)","trace[2034222859] 'applied index is now lower than readState.Index' (duration: 87.978671ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:11:43.123351Z","caller":"traceutil/trace.go:171","msg":"trace[141893163] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"100.560704ms","start":"2026-09-09T06:11:43.022778Z","end":"2026-09-09T06:11:43.123339Z","steps":["trace[141893163] 'process raft request' (duration: 100.222076ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:11:43.123422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.491672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-09T06:11:43.123454Z","caller":"traceutil/trace.go:171","msg":"trace[1274791384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"111.596566ms","start":"2026-09-09T06:11:43.01185Z","end":"2026-09-09T06:11:43.123446Z","steps":["trace[1274791384] 'agreement among raft nodes before linearized reading' (duration: 111.482543ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:11:43.470378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.493672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-09-09T06:11:43.47089Z","caller":"traceutil/trace.go:171","msg":"trace[691429222] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"411.84967ms","start":"2026-09-09T06:11:43.059019Z","end":"2026-09-09T06:11:43.470869Z","steps":["trace[691429222] 'process raft request' (duration: 411.751607ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:43.471053Z","caller":"traceutil/trace.go:171","msg":"trace[939396952] transaction","detail":"{read_only:false; number_of_response:0; response_revision:578; }","duration":"427.86735ms","start":"2026-09-09T06:11:43.042911Z","end":"2026-09-09T06:11:43.470778Z","steps":["trace[939396952] 'process raft request' (duration: 106.867995ms)","trace[939396952] 'compare' (duration: 320.4216ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:11:43.470943Z","caller":"traceutil/trace.go:171","msg":"trace[468406772] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"422.800719ms","start":"2026-09-09T06:11:43.048084Z","end":"2026-09-09T06:11:43.470885Z","steps":["trace[468406772] 'process raft request' (duration: 422.548993ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:11:43.471615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:43.05899Z","time spent":"411.999445ms","remote":"127.0.0.1:52358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:11:43.472103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:43.042888Z","time spent":"428.541408ms","remote":"127.0.0.1:52870","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T06:11:43.472358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:43.048069Z","time spent":"424.137005ms","remote":"127.0.0.1:52358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:11:43.477106Z","caller":"traceutil/trace.go:171","msg":"trace[1876366516] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"342.524616ms","start":"2026-09-09T06:11:43.134559Z","end":"2026-09-09T06:11:43.477084Z","steps":["trace[1876366516] 'process raft request' (duration: 342.389083ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:43.477288Z","caller":"traceutil/trace.go:171","msg":"trace[760857081] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"334.799898ms","start":"2026-09-09T06:11:43.142472Z","end":"2026-09-09T06:11:43.477272Z","steps":["trace[760857081] 'process raft request' (duration: 334.540022ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:11:43.477302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:43.13455Z","time spent":"342.68819ms","remote":"127.0.0.1:52358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T06:11:43.477433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:43.142445Z","time spent":"334.890039ms","remote":"127.0.0.1:52358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:11:43.477139Z","caller":"traceutil/trace.go:171","msg":"trace[413666464] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"345.06421ms","start":"2026-09-09T06:11:43.132043Z","end":"2026-09-09T06:11:43.477108Z","steps":["trace[413666464] 'process raft request' (duration: 344.847095ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:11:43.477595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:43.132034Z","time spent":"345.521763ms","remote":"127.0.0.1:52358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:11:43.478065Z","caller":"traceutil/trace.go:171","msg":"trace[1198746273] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"348.672673ms","start":"2026-09-09T06:11:43.129366Z","end":"2026-09-09T06:11:43.478039Z","steps":["trace[1198746273] 'process raft request' (duration: 347.410271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:11:43.478291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:43.129343Z","time spent":"348.869838ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T06:11:43.488344Z","caller":"traceutil/trace.go:171","msg":"trace[1331494439] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"338.647237ms","start":"2026-09-09T06:11:43.149661Z","end":"2026-09-09T06:11:43.488308Z","steps":["trace[1331494439] 'process raft request' (duration: 338.282908ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:43.48833Z","caller":"traceutil/trace.go:171","msg":"trace[1512485420] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"182.581333ms","start":"2026-09-09T06:11:43.305663Z","end":"2026-09-09T06:11:43.488245Z","steps":["trace[1512485420] 'read index received' (duration: 171.935111ms)","trace[1512485420] 'applied index is now lower than readState.Index' (duration: 10.644982ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:11:43.488635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.008304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:11:43.489012Z","caller":"traceutil/trace.go:171","msg":"trace[585457947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"183.458545ms","start":"2026-09-09T06:11:43.305533Z","end":"2026-09-09T06:11:43.488991Z","steps":["trace[585457947] 'agreement among raft nodes before linearized reading' (duration: 182.948662ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:11:43.489301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:43.149629Z","time spent":"339.120159ms","remote":"127.0.0.1:52358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T06:11:50.51269Z","caller":"traceutil/trace.go:171","msg":"trace[1624712692] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:692; }","duration":"108.975724ms","start":"2026-09-09T06:11:50.40366Z","end":"2026-09-09T06:11:50.512636Z","steps":["trace[1624712692] 'read index received' (duration: 108.618134ms)","trace[1624712692] 'applied index is now lower than readState.Index' (duration: 356.68µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:11:50.512962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.247721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:11:50.512968Z","caller":"traceutil/trace.go:171","msg":"trace[1124240645] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"119.507613ms","start":"2026-09-09T06:11:50.393434Z","end":"2026-09-09T06:11:50.512941Z","steps":["trace[1124240645] 'process raft request' (duration: 118.970459ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:50.513005Z","caller":"traceutil/trace.go:171","msg":"trace[290003777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:670; }","duration":"109.423165ms","start":"2026-09-09T06:11:50.40357Z","end":"2026-09-09T06:11:50.512993Z","steps":["trace[290003777] 'agreement among raft nodes before linearized reading' (duration: 109.23071ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:11:50.694457Z","caller":"traceutil/trace.go:171","msg":"trace[1730948488] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"160.223095ms","start":"2026-09-09T06:11:50.534186Z","end":"2026-09-09T06:11:50.694409Z","steps":["trace[1730948488] 'process raft request' (duration: 139.310978ms)","trace[1730948488] 'compare' (duration: 20.665931ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:11:51.243594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.478617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qfzzt\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-09T06:11:51.243785Z","caller":"traceutil/trace.go:171","msg":"trace[1338006727] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qfzzt; range_end:; response_count:1; response_revision:676; }","duration":"368.732455ms","start":"2026-09-09T06:11:50.875028Z","end":"2026-09-09T06:11:51.24376Z","steps":["trace[1338006727] 'range keys from in-memory index tree' (duration: 368.245531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:11:51.243887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T06:11:50.874972Z","time spent":"368.899239ms","remote":"127.0.0.1:52502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-qfzzt\" "} {"level":"warn","ts":"2026-09-09T06:12:07.252303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.728018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-djng9\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-09-09T06:12:07.252471Z","caller":"traceutil/trace.go:171","msg":"trace[54008287] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-djng9; range_end:; response_count:1; response_revision:835; }","duration":"270.940536ms","start":"2026-09-09T06:12:06.981479Z","end":"2026-09-09T06:12:07.25242Z","steps":["trace[54008287] 'range keys from in-memory index tree' (duration: 270.513541ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:27.515411Z","caller":"traceutil/trace.go:171","msg":"trace[774360330] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"131.646389ms","start":"2026-09-09T06:12:27.383711Z","end":"2026-09-09T06:12:27.515357Z","steps":["trace[774360330] 'process raft request' (duration: 110.367534ms)","trace[774360330] 'compare' (duration: 20.86111ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:12:27.515547Z","caller":"traceutil/trace.go:171","msg":"trace[1216995067] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"125.385738ms","start":"2026-09-09T06:12:27.390134Z","end":"2026-09-09T06:12:27.51552Z","steps":["trace[1216995067] 'process raft request' (duration: 125.007324ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:27.515859Z","caller":"traceutil/trace.go:171","msg":"trace[1252747104] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"103.029206ms","start":"2026-09-09T06:12:27.412795Z","end":"2026-09-09T06:12:27.515825Z","steps":["trace[1252747104] 'process raft request' (duration: 102.436296ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:28.381541Z","caller":"traceutil/trace.go:171","msg":"trace[540046392] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"105.821849ms","start":"2026-09-09T06:12:28.275685Z","end":"2026-09-09T06:12:28.381507Z","steps":["trace[540046392] 'process raft request' (duration: 105.448647ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:12:39.946656Z","caller":"traceutil/trace.go:171","msg":"trace[2034249795] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"139.019372ms","start":"2026-09-09T06:12:39.807526Z","end":"2026-09-09T06:12:39.946545Z","steps":["trace[2034249795] 'process raft request' (duration: 138.845966ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:13:04.790647Z","caller":"traceutil/trace.go:171","msg":"trace[553276633] linearizableReadLoop","detail":"{readStateIndex:1556; appliedIndex:1555; }","duration":"235.126019ms","start":"2026-09-09T06:13:04.555492Z","end":"2026-09-09T06:13:04.790618Z","steps":["trace[553276633] 'read index received' (duration: 234.858889ms)","trace[553276633] 'applied index is now lower than readState.Index' (duration: 266.03µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:13:04.790738Z","caller":"traceutil/trace.go:171","msg":"trace[1130208610] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"295.194661ms","start":"2026-09-09T06:13:04.495515Z","end":"2026-09-09T06:13:04.79071Z","steps":["trace[1130208610] 'process raft request' (duration: 294.922281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:13:04.790857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.574864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:13:04.790915Z","caller":"traceutil/trace.go:171","msg":"trace[669587421] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1511; }","duration":"128.69415ms","start":"2026-09-09T06:13:04.662196Z","end":"2026-09-09T06:13:04.79089Z","steps":["trace[669587421] 'agreement among raft nodes before linearized reading' (duration: 128.592766ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:13:04.790963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.42592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T06:13:04.791103Z","caller":"traceutil/trace.go:171","msg":"trace[1831573035] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1511; }","duration":"235.64869ms","start":"2026-09-09T06:13:04.555423Z","end":"2026-09-09T06:13:04.791072Z","steps":["trace[1831573035] 'agreement among raft nodes before linearized reading' (duration: 235.327127ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:13:09.948979Z","caller":"traceutil/trace.go:171","msg":"trace[228370686] transaction","detail":"{read_only:false; response_revision:1606; number_of_response:1; }","duration":"147.544207ms","start":"2026-09-09T06:13:09.801398Z","end":"2026-09-09T06:13:09.948942Z","steps":["trace[228370686] 'process raft request' (duration: 93.132134ms)","trace[228370686] 'compare' (duration: 54.189624ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:13:32.3086Z","caller":"traceutil/trace.go:171","msg":"trace[242306300] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"177.687212ms","start":"2026-09-09T06:13:32.13087Z","end":"2026-09-09T06:13:32.308557Z","steps":["trace[242306300] 'process raft request' (duration: 176.902069ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:13:32.454697Z","caller":"traceutil/trace.go:171","msg":"trace[78405929] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1993; }","duration":"128.983833ms","start":"2026-09-09T06:13:32.325682Z","end":"2026-09-09T06:13:32.454666Z","steps":["trace[78405929] 'read index received' (duration: 66.4924ms)","trace[78405929] 'applied index is now lower than readState.Index' (duration: 62.490093ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:13:32.454759Z","caller":"traceutil/trace.go:171","msg":"trace[1892949663] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"137.841707ms","start":"2026-09-09T06:13:32.316873Z","end":"2026-09-09T06:13:32.454714Z","steps":["trace[1892949663] 'process raft request' (duration: 75.298771ms)","trace[1892949663] 'compare' (duration: 62.333027ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:13:32.454981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.279967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-09T06:13:32.455037Z","caller":"traceutil/trace.go:171","msg":"trace[194616616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1922; }","duration":"129.415492ms","start":"2026-09-09T06:13:32.32561Z","end":"2026-09-09T06:13:32.455025Z","steps":["trace[194616616] 'agreement among raft nodes before linearized reading' (duration: 129.211134ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:13:32.749212Z","caller":"traceutil/trace.go:171","msg":"trace[755644346] linearizableReadLoop","detail":"{readStateIndex:2001; appliedIndex:2000; }","duration":"163.74452ms","start":"2026-09-09T06:13:32.585435Z","end":"2026-09-09T06:13:32.74918Z","steps":["trace[755644346] 'read index received' (duration: 124.52378ms)","trace[755644346] 'applied index is now lower than readState.Index' (duration: 39.21978ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:13:32.74949Z","caller":"traceutil/trace.go:171","msg":"trace[594493492] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"209.086381ms","start":"2026-09-09T06:13:32.540348Z","end":"2026-09-09T06:13:32.749435Z","steps":["trace[594493492] 'process raft request' (duration: 169.719635ms)","trace[594493492] 'compare' (duration: 38.97736ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:13:32.749731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.268621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-09T06:13:32.750142Z","caller":"traceutil/trace.go:171","msg":"trace[2065381091] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1929; }","duration":"164.503521ms","start":"2026-09-09T06:13:32.585414Z","end":"2026-09-09T06:13:32.749917Z","steps":["trace[2065381091] 'agreement among raft nodes before linearized reading' (duration: 163.884665ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:13:47.159613Z","caller":"traceutil/trace.go:171","msg":"trace[2046265569] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"115.734992ms","start":"2026-09-09T06:13:47.043849Z","end":"2026-09-09T06:13:47.159584Z","steps":["trace[2046265569] 'process raft request' (duration: 115.538214ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:14:07.735546Z","caller":"traceutil/trace.go:171","msg":"trace[1061356936] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"152.083469ms","start":"2026-09-09T06:14:07.583426Z","end":"2026-09-09T06:14:07.73551Z","steps":["trace[1061356936] 'process raft request' (duration: 150.524714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:14:08.15022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.572771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T06:14:08.150356Z","caller":"traceutil/trace.go:171","msg":"trace[1587553157] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2176; }","duration":"131.830984ms","start":"2026-09-09T06:14:08.018498Z","end":"2026-09-09T06:14:08.150329Z","steps":["trace[1587553157] 'count revisions from in-memory index tree' (duration: 131.475048ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:15:17.743801Z","caller":"traceutil/trace.go:171","msg":"trace[1842089248] linearizableReadLoop","detail":"{readStateIndex:2751; appliedIndex:2750; }","duration":"176.299561ms","start":"2026-09-09T06:15:17.567453Z","end":"2026-09-09T06:15:17.743752Z","steps":["trace[1842089248] 'read index received' (duration: 176.23067ms)","trace[1842089248] 'applied index is now lower than readState.Index' (duration: 65.891µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:15:17.744083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.613173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-09T06:15:17.744116Z","caller":"traceutil/trace.go:171","msg":"trace[250489157] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2653; }","duration":"176.672314ms","start":"2026-09-09T06:15:17.567433Z","end":"2026-09-09T06:15:17.744105Z","steps":["trace[250489157] 'agreement among raft nodes before linearized reading' (duration: 176.468043ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:15:17.757213Z","caller":"traceutil/trace.go:171","msg":"trace[774201610] transaction","detail":"{read_only:false; response_revision:2654; number_of_response:1; }","duration":"108.771841ms","start":"2026-09-09T06:15:17.648397Z","end":"2026-09-09T06:15:17.757169Z","steps":["trace[774201610] 'process raft request' (duration: 108.60871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:15:50.883133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.6856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T06:15:50.883245Z","caller":"traceutil/trace.go:171","msg":"trace[1978187517] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2834; }","duration":"172.879882ms","start":"2026-09-09T06:15:50.710342Z","end":"2026-09-09T06:15:50.883222Z","steps":["trace[1978187517] 'count revisions from in-memory index tree' (duration: 172.586169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:20:40.040641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.265942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T06:20:40.040989Z","caller":"traceutil/trace.go:171","msg":"trace[1637720082] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"179.408924ms","start":"2026-09-09T06:20:39.861511Z","end":"2026-09-09T06:20:40.04092Z","steps":["trace[1637720082] 'process raft request' (duration: 57.76676ms)","trace[1637720082] 'compare' (duration: 120.892477ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:20:40.041037Z","caller":"traceutil/trace.go:171","msg":"trace[1681830520] transaction","detail":"{read_only:false; response_revision:5114; number_of_response:1; }","duration":"178.396558ms","start":"2026-09-09T06:20:39.86262Z","end":"2026-09-09T06:20:40.041017Z","steps":["trace[1681830520] 'process raft request' (duration: 178.162959ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:40.041211Z","caller":"traceutil/trace.go:171","msg":"trace[1241368440] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"172.151988ms","start":"2026-09-09T06:20:39.86903Z","end":"2026-09-09T06:20:40.041182Z","steps":["trace[1241368440] 'process raft request' (duration: 171.94434ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:53.287332Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2848} {"level":"info","ts":"2026-09-09T06:20:53.383699Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2848,"took":"95.303103ms","hash":2123524369,"current-db-size-bytes":52051968,"current-db-size":"52 MB","current-db-size-in-use-bytes":27361280,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-09T06:20:53.383776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2123524369,"revision":2848,"compact-revision":-1} {"level":"info","ts":"2026-09-09T06:20:53.732286Z","caller":"traceutil/trace.go:171","msg":"trace[239786287] linearizableReadLoop","detail":"{readStateIndex:5490; appliedIndex:5489; }","duration":"181.378574ms","start":"2026-09-09T06:20:53.550883Z","end":"2026-09-09T06:20:53.732261Z","steps":["trace[239786287] 'read index received' (duration: 181.215729ms)","trace[239786287] 'applied index is now lower than readState.Index' (duration: 161.975µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:20:53.732533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.633374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-09-09T06:20:53.732657Z","caller":"traceutil/trace.go:171","msg":"trace[1787802535] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"206.400751ms","start":"2026-09-09T06:20:53.526236Z","end":"2026-09-09T06:20:53.732637Z","steps":["trace[1787802535] 'process raft request' (duration: 205.881521ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:53.732586Z","caller":"traceutil/trace.go:171","msg":"trace[299653147] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5291; }","duration":"181.742898ms","start":"2026-09-09T06:20:53.550828Z","end":"2026-09-09T06:20:53.732571Z","steps":["trace[299653147] 'agreement among raft nodes before linearized reading' (duration: 181.52758ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:53.960827Z","caller":"traceutil/trace.go:171","msg":"trace[154555563] linearizableReadLoop","detail":"{readStateIndex:5491; appliedIndex:5490; }","duration":"211.997947ms","start":"2026-09-09T06:20:53.748786Z","end":"2026-09-09T06:20:53.960784Z","steps":["trace[154555563] 'read index received' (duration: 193.218523ms)","trace[154555563] 'applied index is now lower than readState.Index' (duration: 18.777164ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T06:20:53.961197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.894208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T06:20:53.961368Z","caller":"traceutil/trace.go:171","msg":"trace[755351873] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:5292; }","duration":"131.084755ms","start":"2026-09-09T06:20:53.83026Z","end":"2026-09-09T06:20:53.961345Z","steps":["trace[755351873] 'agreement among raft nodes before linearized reading' (duration: 130.835926ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:20:53.961501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.692863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1453"} {"level":"info","ts":"2026-09-09T06:20:53.961584Z","caller":"traceutil/trace.go:171","msg":"trace[1024677902] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5292; }","duration":"212.832328ms","start":"2026-09-09T06:20:53.748726Z","end":"2026-09-09T06:20:53.961558Z","steps":["trace[1024677902] 'agreement among raft nodes before linearized reading' (duration: 212.324288ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:53.961533Z","caller":"traceutil/trace.go:171","msg":"trace[222582177] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"212.965924ms","start":"2026-09-09T06:20:53.748488Z","end":"2026-09-09T06:20:53.961454Z","steps":["trace[222582177] 'process raft request' (duration: 193.614368ms)","trace[222582177] 'compare' (duration: 18.187572ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:20:54.133741Z","caller":"traceutil/trace.go:171","msg":"trace[1085994073] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"127.793627ms","start":"2026-09-09T06:20:54.00589Z","end":"2026-09-09T06:20:54.133684Z","steps":["trace[1085994073] 'process raft request' (duration: 64.043989ms)","trace[1085994073] 'compare' (duration: 63.458587ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:20:54.133799Z","caller":"traceutil/trace.go:171","msg":"trace[75015546] linearizableReadLoop","detail":"{readStateIndex:5498; appliedIndex:5494; }","duration":"123.551899ms","start":"2026-09-09T06:20:54.010219Z","end":"2026-09-09T06:20:54.133771Z","steps":["trace[75015546] 'read index received' (duration: 59.671297ms)","trace[75015546] 'applied index is now lower than readState.Index' (duration: 63.879072ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:20:54.133977Z","caller":"traceutil/trace.go:171","msg":"trace[1303209283] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"127.265867ms","start":"2026-09-09T06:20:54.006694Z","end":"2026-09-09T06:20:54.133959Z","steps":["trace[1303209283] 'process raft request' (duration: 126.961666ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:54.134174Z","caller":"traceutil/trace.go:171","msg":"trace[11480701] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"127.499966ms","start":"2026-09-09T06:20:54.006657Z","end":"2026-09-09T06:20:54.134157Z","steps":["trace[11480701] 'process raft request' (duration: 126.920744ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:54.134276Z","caller":"traceutil/trace.go:171","msg":"trace[1645614918] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"125.888707ms","start":"2026-09-09T06:20:54.00837Z","end":"2026-09-09T06:20:54.134259Z","steps":["trace[1645614918] 'process raft request' (duration: 125.347226ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T06:20:54.134696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.453423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18d392c1ecc1ff9a\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-09-09T06:20:54.134762Z","caller":"traceutil/trace.go:171","msg":"trace[1369338014] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18d392c1ecc1ff9a; range_end:; response_count:1; response_revision:5299; }","duration":"124.560477ms","start":"2026-09-09T06:20:54.01018Z","end":"2026-09-09T06:20:54.13474Z","steps":["trace[1369338014] 'agreement among raft nodes before linearized reading' (duration: 124.36773ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:54.49154Z","caller":"traceutil/trace.go:171","msg":"trace[502322160] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"123.255078ms","start":"2026-09-09T06:20:54.36826Z","end":"2026-09-09T06:20:54.491515Z","steps":["trace[502322160] 'process raft request' (duration: 123.181825ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T06:20:54.491943Z","caller":"traceutil/trace.go:171","msg":"trace[1000364520] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"128.609987ms","start":"2026-09-09T06:20:54.363185Z","end":"2026-09-09T06:20:54.491795Z","steps":["trace[1000364520] 'process raft request' (duration: 56.570833ms)","trace[1000364520] 'compare' (duration: 71.577357ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T06:25:53.294318Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5288} {"level":"info","ts":"2026-09-09T06:25:53.375147Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5288,"took":"79.223425ms","hash":2268671253,"current-db-size-bytes":52051968,"current-db-size":"52 MB","current-db-size-in-use-bytes":18984960,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-09T06:25:53.375216Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2268671253,"revision":5288,"compact-revision":2848}