{"level":"warn","ts":"2026-07-15T14:25:45.417236Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T14:25:45.417356Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-15T14:25:45.417439Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T14:25:45.417453Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-07-15T14:25:45.417473Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-15T14:25:45.418145Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-07-15T14:25:45.418229Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-15T14:25:45.423645Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.165443ms"} {"level":"info","ts":"2026-07-15T14:25:45.431373Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-07-15T14:25:45.431464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-07-15T14:25:45.431486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-07-15T14:25:45.431496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-15T14:25:45.431516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-07-15T14:25:45.431554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-07-15T14:25:45.442249Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-15T14:25:45.44502Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-15T14:25:45.446001Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-15T14:25:45.44804Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-15T14:25:45.448262Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-15T14:25:45.44839Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-15T14:25:45.448428Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-15T14:25:45.44844Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-15T14:25:45.448846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-07-15T14:25:45.450379Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-07-15T14:25:45.454785Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-15T14:25:45.454932Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-07-15T14:25:45.454979Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-07-15T14:25:45.455101Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-15T14:25:45.455153Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-15T14:25:45.932855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-07-15T14:25:45.93292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-07-15T14:25:45.932947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-07-15T14:25:45.932961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-07-15T14:25:45.93297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-07-15T14:25:45.93298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-07-15T14:25:45.932991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-07-15T14:25:45.934128Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T14:25:45.935069Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-07-15T14:25:45.935122Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T14:25:45.935181Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T14:25:45.935451Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-15T14:25:45.935527Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-15T14:25:45.936323Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T14:25:45.936391Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T14:25:45.936419Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T14:25:45.937623Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-15T14:25:45.938753Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-07-15T14:25:49.41553Z","caller":"traceutil/trace.go:171","msg":"trace[736658864] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"104.027358ms","start":"2026-07-15T14:25:49.311479Z","end":"2026-07-15T14:25:49.415506Z","steps":["trace[736658864] 'process raft request' (duration: 103.845393ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:49.766387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.384751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-07-15T14:25:49.766582Z","caller":"traceutil/trace.go:171","msg":"trace[262613695] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:206; }","duration":"114.654699ms","start":"2026-07-15T14:25:49.651901Z","end":"2026-07-15T14:25:49.766555Z","steps":["trace[262613695] 'range keys from in-memory index tree' (duration: 114.163464ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:49.930856Z","caller":"traceutil/trace.go:171","msg":"trace[1173038221] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"158.780277ms","start":"2026-07-15T14:25:49.772032Z","end":"2026-07-15T14:25:49.930812Z","steps":["trace[1173038221] 'process raft request' (duration: 158.54305ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:49.982909Z","caller":"traceutil/trace.go:171","msg":"trace[995747882] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"207.386446ms","start":"2026-07-15T14:25:49.775487Z","end":"2026-07-15T14:25:49.982874Z","steps":["trace[995747882] 'process raft request' (duration: 206.751749ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:49.983112Z","caller":"traceutil/trace.go:171","msg":"trace[1206682274] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"137.75576ms","start":"2026-07-15T14:25:49.845317Z","end":"2026-07-15T14:25:49.983073Z","steps":["trace[1206682274] 'process raft request' (duration: 137.127744ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:55.180937Z","caller":"traceutil/trace.go:171","msg":"trace[2092146566] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"171.979866ms","start":"2026-07-15T14:25:55.008922Z","end":"2026-07-15T14:25:55.180902Z","steps":["trace[2092146566] 'process raft request' (duration: 114.76792ms)","trace[2092146566] 'compare' (duration: 57.02634ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:55.204878Z","caller":"traceutil/trace.go:171","msg":"trace[225438660] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"192.116282ms","start":"2026-07-15T14:25:55.012729Z","end":"2026-07-15T14:25:55.204846Z","steps":["trace[225438660] 'process raft request' (duration: 191.881346ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:55.205006Z","caller":"traceutil/trace.go:171","msg":"trace[315152134] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"191.865256ms","start":"2026-07-15T14:25:55.013109Z","end":"2026-07-15T14:25:55.204975Z","steps":["trace[315152134] 'process raft request' (duration: 191.595019ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:55.205017Z","caller":"traceutil/trace.go:171","msg":"trace[2010023120] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:332; }","duration":"157.245906ms","start":"2026-07-15T14:25:55.047712Z","end":"2026-07-15T14:25:55.204958Z","steps":["trace[2010023120] 'read index received' (duration: 75.980696ms)","trace[2010023120] 'applied index is now lower than readState.Index' (duration: 81.26231ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:55.205172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.43454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-15T14:25:55.205237Z","caller":"traceutil/trace.go:171","msg":"trace[1347089658] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:321; }","duration":"157.575513ms","start":"2026-07-15T14:25:55.047646Z","end":"2026-07-15T14:25:55.205221Z","steps":["trace[1347089658] 'agreement among raft nodes before linearized reading' (duration: 157.415779ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:55.20533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.007976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-07-15T14:25:55.205385Z","caller":"traceutil/trace.go:171","msg":"trace[1768801857] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:321; }","duration":"108.145411ms","start":"2026-07-15T14:25:55.097224Z","end":"2026-07-15T14:25:55.205369Z","steps":["trace[1768801857] 'agreement among raft nodes before linearized reading' (duration: 107.973696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:55.462478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.908884ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-15T14:25:55.462836Z","caller":"traceutil/trace.go:171","msg":"trace[600319215] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"251.128956ms","start":"2026-07-15T14:25:55.211689Z","end":"2026-07-15T14:25:55.462818Z","steps":["trace[600319215] 'process raft request' (duration: 250.983552ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:55.462792Z","caller":"traceutil/trace.go:171","msg":"trace[1305752399] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"251.923479ms","start":"2026-07-15T14:25:55.210834Z","end":"2026-07-15T14:25:55.462758Z","steps":["trace[1305752399] 'process raft request' (duration: 251.775295ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:55.463066Z","caller":"traceutil/trace.go:171","msg":"trace[1013542582] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"250.633914ms","start":"2026-07-15T14:25:55.212357Z","end":"2026-07-15T14:25:55.462991Z","steps":["trace[1013542582] 'process raft request' (duration: 250.373927ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:55.463334Z","caller":"traceutil/trace.go:171","msg":"trace[301140319] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"249.984655ms","start":"2026-07-15T14:25:55.213316Z","end":"2026-07-15T14:25:55.463301Z","steps":["trace[301140319] 'process raft request' (duration: 249.458421ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:55.463899Z","caller":"traceutil/trace.go:171","msg":"trace[1243861323] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"249.499752ms","start":"2026-07-15T14:25:55.214388Z","end":"2026-07-15T14:25:55.463887Z","steps":["trace[1243861323] 'process raft request' (duration: 248.811674ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:55.464234Z","caller":"traceutil/trace.go:171","msg":"trace[1616252360] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"253.502732ms","start":"2026-07-15T14:25:55.210703Z","end":"2026-07-15T14:25:55.464205Z","steps":["trace[1616252360] 'process raft request' (duration: 83.138611ms)","trace[1616252360] 'compare' (duration: 167.714449ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:55.465284Z","caller":"traceutil/trace.go:171","msg":"trace[1701247113] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"249.380719ms","start":"2026-07-15T14:25:55.215871Z","end":"2026-07-15T14:25:55.465251Z","steps":["trace[1701247113] 'process raft request' (duration: 247.957401ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:55.465488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.094466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-15T14:25:55.46573Z","caller":"traceutil/trace.go:171","msg":"trace[286671412] linearizableReadLoop","detail":"{readStateIndex:342; appliedIndex:335; }","duration":"218.84863ms","start":"2026-07-15T14:25:55.246338Z","end":"2026-07-15T14:25:55.465187Z","steps":["trace[286671412] 'read index received' (duration: 47.640695ms)","trace[286671412] 'applied index is now lower than readState.Index' (duration: 171.205375ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:55.465876Z","caller":"traceutil/trace.go:171","msg":"trace[1819248115] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:328; }","duration":"219.444386ms","start":"2026-07-15T14:25:55.246293Z","end":"2026-07-15T14:25:55.465738Z","steps":["trace[1819248115] 'agreement among raft nodes before linearized reading' (duration: 219.049365ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:23.500553Z","caller":"traceutil/trace.go:171","msg":"trace[1845181565] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"109.985368ms","start":"2026-07-15T14:26:23.390544Z","end":"2026-07-15T14:26:23.50053Z","steps":["trace[1845181565] 'process raft request' (duration: 109.860015ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:23.508446Z","caller":"traceutil/trace.go:171","msg":"trace[1334061539] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"117.438945ms","start":"2026-07-15T14:26:23.390991Z","end":"2026-07-15T14:26:23.50843Z","steps":["trace[1334061539] 'process raft request' (duration: 116.819378ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:23.508682Z","caller":"traceutil/trace.go:171","msg":"trace[992803651] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"103.074134ms","start":"2026-07-15T14:26:23.405591Z","end":"2026-07-15T14:26:23.508665Z","steps":["trace[992803651] 'process raft request' (duration: 102.441557ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:23.508728Z","caller":"traceutil/trace.go:171","msg":"trace[252564488] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"107.229425ms","start":"2026-07-15T14:26:23.401464Z","end":"2026-07-15T14:26:23.508694Z","steps":["trace[252564488] 'process raft request' (duration: 106.480795ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:23.508788Z","caller":"traceutil/trace.go:171","msg":"trace[485536802] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"117.647761ms","start":"2026-07-15T14:26:23.39112Z","end":"2026-07-15T14:26:23.508768Z","steps":["trace[485536802] 'process raft request' (duration: 116.758457ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:23.508885Z","caller":"traceutil/trace.go:171","msg":"trace[676994852] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"105.858638ms","start":"2026-07-15T14:26:23.403017Z","end":"2026-07-15T14:26:23.508876Z","steps":["trace[676994852] 'process raft request' (duration: 104.953244ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:23.508913Z","caller":"traceutil/trace.go:171","msg":"trace[989085749] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"104.212415ms","start":"2026-07-15T14:26:23.404689Z","end":"2026-07-15T14:26:23.508902Z","steps":["trace[989085749] 'process raft request' (duration: 103.319201ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:23.508982Z","caller":"traceutil/trace.go:171","msg":"trace[77240071] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"107.863252ms","start":"2026-07-15T14:26:23.401109Z","end":"2026-07-15T14:26:23.508972Z","steps":["trace[77240071] 'process raft request' (duration: 106.805064ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:26.337852Z","caller":"traceutil/trace.go:171","msg":"trace[1637971183] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"135.40746ms","start":"2026-07-15T14:26:26.202415Z","end":"2026-07-15T14:26:26.337822Z","steps":["trace[1637971183] 'process raft request' (duration: 135.230195ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:29.888685Z","caller":"traceutil/trace.go:171","msg":"trace[181166574] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"184.945043ms","start":"2026-07-15T14:26:29.703717Z","end":"2026-07-15T14:26:29.888662Z","steps":["trace[181166574] 'process raft request' (duration: 184.83031ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:30.412601Z","caller":"traceutil/trace.go:171","msg":"trace[1372931927] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"344.303907ms","start":"2026-07-15T14:26:30.068265Z","end":"2026-07-15T14:26:30.412569Z","steps":["trace[1372931927] 'read index received' (duration: 343.174337ms)","trace[1372931927] 'applied index is now lower than readState.Index' (duration: 1.12822ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:26:30.412664Z","caller":"traceutil/trace.go:171","msg":"trace[678404609] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"454.883372ms","start":"2026-07-15T14:26:29.957747Z","end":"2026-07-15T14:26:30.41263Z","steps":["trace[678404609] 'process raft request' (duration: 453.995668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:26:30.412834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.556193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wblc5\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-15T14:26:30.41287Z","caller":"traceutil/trace.go:171","msg":"trace[1809529761] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wblc5; range_end:; response_count:1; response_revision:593; }","duration":"344.667995ms","start":"2026-07-15T14:26:30.068191Z","end":"2026-07-15T14:26:30.412859Z","steps":["trace[1809529761] 'agreement among raft nodes before linearized reading' (duration: 344.526711ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:26:30.412905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:26:30.068139Z","time spent":"344.758209ms","remote":"127.0.0.1:43386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-wblc5\" "} {"level":"warn","ts":"2026-07-15T14:26:30.413056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:26:29.9577Z","time spent":"455.067147ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:26:44.419812Z","caller":"traceutil/trace.go:171","msg":"trace[1058863849] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"257.553759ms","start":"2026-07-15T14:26:44.162233Z","end":"2026-07-15T14:26:44.419787Z","steps":["trace[1058863849] 'process raft request' (duration: 257.396475ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:27:38.851342Z","caller":"traceutil/trace.go:171","msg":"trace[1570704670] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"106.039859ms","start":"2026-07-15T14:27:38.745274Z","end":"2026-07-15T14:27:38.851314Z","steps":["trace[1570704670] 'process raft request' (duration: 99.123245ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:28:16.528474Z","caller":"traceutil/trace.go:171","msg":"trace[1125960529] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"106.519285ms","start":"2026-07-15T14:28:16.421882Z","end":"2026-07-15T14:28:16.528401Z","steps":["trace[1125960529] 'process raft request' (duration: 106.28461ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:28:25.817917Z","caller":"traceutil/trace.go:171","msg":"trace[138719669] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"281.303318ms","start":"2026-07-15T14:28:25.536583Z","end":"2026-07-15T14:28:25.817886Z","steps":["trace[138719669] 'process raft request' (duration: 281.091663ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:28:25.82756Z","caller":"traceutil/trace.go:171","msg":"trace[1047378865] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"267.981901ms","start":"2026-07-15T14:28:25.559541Z","end":"2026-07-15T14:28:25.827523Z","steps":["trace[1047378865] 'process raft request' (duration: 267.793207ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:28:44.457715Z","caller":"traceutil/trace.go:171","msg":"trace[583260558] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"105.563935ms","start":"2026-07-15T14:28:44.352117Z","end":"2026-07-15T14:28:44.457681Z","steps":["trace[583260558] 'process raft request' (duration: 105.181346ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:28:47.327765Z","caller":"traceutil/trace.go:171","msg":"trace[7679266] linearizableReadLoop","detail":"{readStateIndex:2182; appliedIndex:2181; }","duration":"154.130026ms","start":"2026-07-15T14:28:47.173602Z","end":"2026-07-15T14:28:47.327732Z","steps":["trace[7679266] 'read index received' (duration: 153.800938ms)","trace[7679266] 'applied index is now lower than readState.Index' (duration: 328.078µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:28:47.327818Z","caller":"traceutil/trace.go:171","msg":"trace[577854797] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"259.673379ms","start":"2026-07-15T14:28:47.068115Z","end":"2026-07-15T14:28:47.327788Z","steps":["trace[577854797] 'process raft request' (duration: 259.411713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:28:47.328028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.422043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-15T14:28:47.32807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.034799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-07-15T14:28:47.328091Z","caller":"traceutil/trace.go:171","msg":"trace[498604734] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2099; }","duration":"130.106061ms","start":"2026-07-15T14:28:47.197979Z","end":"2026-07-15T14:28:47.328085Z","steps":["trace[498604734] 'agreement among raft nodes before linearized reading' (duration: 130.035509ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:28:47.328095Z","caller":"traceutil/trace.go:171","msg":"trace[1652013248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2099; }","duration":"154.569197ms","start":"2026-07-15T14:28:47.173504Z","end":"2026-07-15T14:28:47.328073Z","steps":["trace[1652013248] 'agreement among raft nodes before linearized reading' (duration: 154.365242ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:28:47.328097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.945083ms","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-07-15T14:28:47.328159Z","caller":"traceutil/trace.go:171","msg":"trace[513255884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2099; }","duration":"145.045314ms","start":"2026-07-15T14:28:47.183098Z","end":"2026-07-15T14:28:47.328144Z","steps":["trace[513255884] 'agreement among raft nodes before linearized reading' (duration: 144.85883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:28:47.328271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.51696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128414"} {"level":"info","ts":"2026-07-15T14:28:47.32835Z","caller":"traceutil/trace.go:171","msg":"trace[1507842820] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2099; }","duration":"130.627473ms","start":"2026-07-15T14:28:47.197702Z","end":"2026-07-15T14:28:47.328329Z","steps":["trace[1507842820] 'agreement among raft nodes before linearized reading' (duration: 130.333406ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:29:06.501968Z","caller":"traceutil/trace.go:171","msg":"trace[237855815] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"162.744944ms","start":"2026-07-15T14:29:06.3392Z","end":"2026-07-15T14:29:06.501945Z","steps":["trace[237855815] 'process raft request' (duration: 162.57578ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:29:06.789688Z","caller":"traceutil/trace.go:171","msg":"trace[1246825089] linearizableReadLoop","detail":"{readStateIndex:2297; appliedIndex:2296; }","duration":"215.575715ms","start":"2026-07-15T14:29:06.574084Z","end":"2026-07-15T14:29:06.789659Z","steps":["trace[1246825089] 'read index received' (duration: 215.297247ms)","trace[1246825089] 'applied index is now lower than readState.Index' (duration: 277.468µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:29:06.790125Z","caller":"traceutil/trace.go:171","msg":"trace[1522422738] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"222.45035ms","start":"2026-07-15T14:29:06.567659Z","end":"2026-07-15T14:29:06.790109Z","steps":["trace[1522422738] 'process raft request' (duration: 221.810065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:29:06.790443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.343473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-15T14:29:06.790479Z","caller":"traceutil/trace.go:171","msg":"trace[6702521] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2209; }","duration":"216.440755ms","start":"2026-07-15T14:29:06.574028Z","end":"2026-07-15T14:29:06.790469Z","steps":["trace[6702521] 'agreement among raft nodes before linearized reading' (duration: 216.279571ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:29:06.962753Z","caller":"traceutil/trace.go:171","msg":"trace[1950311566] linearizableReadLoop","detail":"{readStateIndex:2299; appliedIndex:2297; }","duration":"136.486807ms","start":"2026-07-15T14:29:06.826242Z","end":"2026-07-15T14:29:06.962729Z","steps":["trace[1950311566] 'read index received' (duration: 112.6243ms)","trace[1950311566] 'applied index is now lower than readState.Index' (duration: 23.861277ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:29:06.963089Z","caller":"traceutil/trace.go:171","msg":"trace[707966388] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"167.198241ms","start":"2026-07-15T14:29:06.795876Z","end":"2026-07-15T14:29:06.963074Z","steps":["trace[707966388] 'process raft request' (duration: 142.976015ms)","trace[707966388] 'compare' (duration: 23.308755ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:29:06.96355Z","caller":"traceutil/trace.go:171","msg":"trace[607685634] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"167.237753ms","start":"2026-07-15T14:29:06.796281Z","end":"2026-07-15T14:29:06.963519Z","steps":["trace[607685634] 'process raft request' (duration: 166.386932ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:29:06.963742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.471461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:29:06.963781Z","caller":"traceutil/trace.go:171","msg":"trace[1738569780] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:2211; }","duration":"137.586444ms","start":"2026-07-15T14:29:06.826184Z","end":"2026-07-15T14:29:06.96377Z","steps":["trace[1738569780] 'agreement among raft nodes before linearized reading' (duration: 137.492532ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:30:57.632545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.468325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:30:57.632638Z","caller":"traceutil/trace.go:171","msg":"trace[2040344148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2947; }","duration":"156.627429ms","start":"2026-07-15T14:30:57.475987Z","end":"2026-07-15T14:30:57.632614Z","steps":["trace[2040344148] 'range keys from in-memory index tree' (duration: 156.348023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:31:01.793846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.741126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-15T14:31:01.79395Z","caller":"traceutil/trace.go:171","msg":"trace[1195148055] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2977; }","duration":"139.883739ms","start":"2026-07-15T14:31:01.65405Z","end":"2026-07-15T14:31:01.793933Z","steps":["trace[1195148055] 'range keys from in-memory index tree' (duration: 139.607773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:31:01.793862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.46281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-15T14:31:01.794851Z","caller":"traceutil/trace.go:171","msg":"trace[885525778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2977; }","duration":"132.171107ms","start":"2026-07-15T14:31:01.662335Z","end":"2026-07-15T14:31:01.794506Z","steps":["trace[885525778] 'range keys from in-memory index tree' (duration: 131.274925ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:31:01.981217Z","caller":"traceutil/trace.go:171","msg":"trace[2142585294] transaction","detail":"{read_only:false; response_revision:2980; number_of_response:1; }","duration":"156.459933ms","start":"2026-07-15T14:31:01.824731Z","end":"2026-07-15T14:31:01.981191Z","steps":["trace[2142585294] 'process raft request' (duration: 156.396382ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:31:01.981653Z","caller":"traceutil/trace.go:171","msg":"trace[777705883] transaction","detail":"{read_only:false; response_revision:2979; number_of_response:1; }","duration":"180.219007ms","start":"2026-07-15T14:31:01.801401Z","end":"2026-07-15T14:31:01.98162Z","steps":["trace[777705883] 'process raft request' (duration: 138.094487ms)","trace[777705883] 'compare' (duration: 41.155797ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:35:30.999649Z","caller":"traceutil/trace.go:171","msg":"trace[1258713179] transaction","detail":"{read_only:false; response_revision:5059; number_of_response:1; }","duration":"123.098173ms","start":"2026-07-15T14:35:30.876532Z","end":"2026-07-15T14:35:30.99963Z","steps":["trace[1258713179] 'process raft request' (duration: 122.97346ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:35:33.437086Z","caller":"traceutil/trace.go:171","msg":"trace[1069274394] linearizableReadLoop","detail":"{readStateIndex:5298; appliedIndex:5297; }","duration":"136.600123ms","start":"2026-07-15T14:35:33.300455Z","end":"2026-07-15T14:35:33.437055Z","steps":["trace[1069274394] 'read index received' (duration: 62.530921ms)","trace[1069274394] 'applied index is now lower than readState.Index' (duration: 74.067432ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:35:33.437386Z","caller":"traceutil/trace.go:171","msg":"trace[924069350] transaction","detail":"{read_only:false; response_revision:5098; number_of_response:1; }","duration":"140.049533ms","start":"2026-07-15T14:35:33.297301Z","end":"2026-07-15T14:35:33.43735Z","steps":["trace[924069350] 'process raft request' (duration: 65.658662ms)","trace[924069350] 'compare' (duration: 73.864987ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:35:33.437535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.061486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:35:33.437615Z","caller":"traceutil/trace.go:171","msg":"trace[1095382387] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:5098; }","duration":"137.208899ms","start":"2026-07-15T14:35:33.300386Z","end":"2026-07-15T14:35:33.437594Z","steps":["trace[1095382387] 'agreement among raft nodes before linearized reading' (duration: 137.032205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:35:33.4419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.388905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-15T14:35:33.442026Z","caller":"traceutil/trace.go:171","msg":"trace[727776456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5100; }","duration":"129.588441ms","start":"2026-07-15T14:35:33.312409Z","end":"2026-07-15T14:35:33.441997Z","steps":["trace[727776456] 'agreement among raft nodes before linearized reading' (duration: 129.220261ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:35:35.97047Z","caller":"traceutil/trace.go:171","msg":"trace[2050616752] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"223.502656ms","start":"2026-07-15T14:35:35.746942Z","end":"2026-07-15T14:35:35.970445Z","steps":["trace[2050616752] 'process raft request' (duration: 223.348172ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:35:35.97099Z","caller":"traceutil/trace.go:171","msg":"trace[175043867] linearizableReadLoop","detail":"{readStateIndex:5380; appliedIndex:5380; }","duration":"146.272282ms","start":"2026-07-15T14:35:35.824702Z","end":"2026-07-15T14:35:35.970975Z","steps":["trace[175043867] 'read index received' (duration: 146.266522ms)","trace[175043867] 'applied index is now lower than readState.Index' (duration: 4.27µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:35:35.971193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.462879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d2878f8f-afc2-46d6-94dc-5c9fdc7552dd\" ","response":"range_response_count:1 size:3762"} {"level":"info","ts":"2026-07-15T14:35:35.971283Z","caller":"traceutil/trace.go:171","msg":"trace[1141342475] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d2878f8f-afc2-46d6-94dc-5c9fdc7552dd; range_end:; response_count:1; response_revision:5178; }","duration":"146.613862ms","start":"2026-07-15T14:35:35.824648Z","end":"2026-07-15T14:35:35.971262Z","steps":["trace[1141342475] 'agreement among raft nodes before linearized reading' (duration: 146.422218ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:35:45.982222Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2850} {"level":"info","ts":"2026-07-15T14:35:46.093465Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2850,"took":"108.89066ms","hash":3516395504,"current-db-size-bytes":53129216,"current-db-size":"53 MB","current-db-size-in-use-bytes":28254208,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-15T14:35:46.09352Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3516395504,"revision":2850,"compact-revision":-1} {"level":"info","ts":"2026-07-15T14:40:45.989881Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5317} {"level":"info","ts":"2026-07-15T14:40:46.058658Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5317,"took":"66.304361ms","hash":1020002403,"current-db-size-bytes":53129216,"current-db-size":"53 MB","current-db-size-in-use-bytes":19283968,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-15T14:40:46.058709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1020002403,"revision":5317,"compact-revision":2850}