{"level":"warn","ts":"2026-10-17T10:04:44.693845Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:04:44.693937Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.149: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.149:2380","--initial-cluster=instance=https://162.253.55.149:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.149:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.149: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-10-17T10:04:44.694006Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:04:44.69402Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.149:2380"]} {"level":"info","ts":"2026-10-17T10:04:44.694038Z","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-10-17T10:04:44.694859Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"]} {"level":"info","ts":"2026-10-17T10:04:44.694976Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.149:2380"],"listen-peer-urls":["https://162.253.55.149:2380"],"advertise-client-urls":["https://162.253.55.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.149: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-10-17T10:04:44.69789Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.647707ms"} {"level":"info","ts":"2026-10-17T10:04:44.703927Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab61124f07c17f20","cluster-id":"c5f62e84ad801ad2"} {"level":"info","ts":"2026-10-17T10:04:44.703995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:04:44.704017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became follower at term 0"} {"level":"info","ts":"2026-10-17T10:04:44.704028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab61124f07c17f20 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:04:44.704035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became follower at term 1"} {"level":"info","ts":"2026-10-17T10:04:44.704072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=(12349171783868448544)"} {"level":"warn","ts":"2026-10-17T10:04:44.709759Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:04:44.711479Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:04:44.713027Z","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-10-17T10:04:44.715575Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab61124f07c17f20","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:04:44.716362Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab61124f07c17f20","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:04:44.71651Z","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-10-17T10:04:44.717559Z","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-10-17T10:04:44.717599Z","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-10-17T10:04:44.718407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=(12349171783868448544)"} {"level":"info","ts":"2026-10-17T10:04:44.718588Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c5f62e84ad801ad2","local-member-id":"ab61124f07c17f20","added-peer-id":"ab61124f07c17f20","added-peer-peer-urls":["https://162.253.55.149:2380"]} {"level":"info","ts":"2026-10-17T10:04:44.72206Z","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-10-17T10:04:44.722211Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.149:2380"} {"level":"info","ts":"2026-10-17T10:04:44.72226Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.149:2380"} {"level":"info","ts":"2026-10-17T10:04:44.722686Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab61124f07c17f20","initial-advertise-peer-urls":["https://162.253.55.149:2380"],"listen-peer-urls":["https://162.253.55.149:2380"],"advertise-client-urls":["https://162.253.55.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:04:44.722762Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:04:45.004255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:04:45.004332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:04:45.004374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 received MsgPreVoteResp from ab61124f07c17f20 at term 1"} {"level":"info","ts":"2026-10-17T10:04:45.004395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:04:45.004407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 received MsgVoteResp from ab61124f07c17f20 at term 2"} {"level":"info","ts":"2026-10-17T10:04:45.004422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became leader at term 2"} {"level":"info","ts":"2026-10-17T10:04:45.004436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab61124f07c17f20 elected leader ab61124f07c17f20 at term 2"} {"level":"info","ts":"2026-10-17T10:04:45.005621Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:04:45.006563Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:04:45.006552Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab61124f07c17f20","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.149:2379]}","request-path":"/0/members/ab61124f07c17f20/attributes","cluster-id":"c5f62e84ad801ad2","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:04:45.007005Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:04:45.00737Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c5f62e84ad801ad2","local-member-id":"ab61124f07c17f20","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:04:45.007538Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:04:45.007573Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:04:45.010511Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T10:04:45.010513Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.149:2379"} {"level":"info","ts":"2026-10-17T10:04:45.011204Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:04:45.011237Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-10-17T10:05:01.365759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.337067ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:05:01.366131Z","caller":"traceutil/trace.go:171","msg":"trace[324994823] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:373; }","duration":"156.723696ms","start":"2026-10-17T10:05:01.209384Z","end":"2026-10-17T10:05:01.366107Z","steps":["trace[324994823] 'range keys from in-memory index tree' (duration: 156.323567ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:01.367395Z","caller":"traceutil/trace.go:171","msg":"trace[610661584] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"197.43657ms","start":"2026-10-17T10:05:01.169934Z","end":"2026-10-17T10:05:01.367371Z","steps":["trace[610661584] 'process raft request' (duration: 197.328848ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:12.157662Z","caller":"traceutil/trace.go:171","msg":"trace[109380867] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"210.778629ms","start":"2026-10-17T10:05:11.946806Z","end":"2026-10-17T10:05:12.157585Z","steps":["trace[109380867] 'process raft request' (duration: 210.566724ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:30.861336Z","caller":"traceutil/trace.go:171","msg":"trace[501182967] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"260.067084ms","start":"2026-10-17T10:05:30.601234Z","end":"2026-10-17T10:05:30.861302Z","steps":["trace[501182967] 'process raft request' (duration: 240.691312ms)","trace[501182967] 'compare' (duration: 18.963483ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:05:30.863501Z","caller":"traceutil/trace.go:171","msg":"trace[80090006] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"243.676289ms","start":"2026-10-17T10:05:30.619773Z","end":"2026-10-17T10:05:30.863449Z","steps":["trace[80090006] 'process raft request' (duration: 243.397442ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:30.864054Z","caller":"traceutil/trace.go:171","msg":"trace[1250188077] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"185.097895ms","start":"2026-10-17T10:05:30.67893Z","end":"2026-10-17T10:05:30.864027Z","steps":["trace[1250188077] 'process raft request' (duration: 184.633445ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:05:37.607317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.950429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:05:37.607428Z","caller":"traceutil/trace.go:171","msg":"trace[712717276] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"245.377325ms","start":"2026-10-17T10:05:37.362031Z","end":"2026-10-17T10:05:37.607408Z","steps":["trace[712717276] 'process raft request' (duration: 123.671789ms)","trace[712717276] 'compare' (duration: 120.843417ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:05:37.61776Z","caller":"traceutil/trace.go:171","msg":"trace[569700403] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"230.139394ms","start":"2026-10-17T10:05:37.387597Z","end":"2026-10-17T10:05:37.617736Z","steps":["trace[569700403] 'process raft request' (duration: 229.875849ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:37.845574Z","caller":"traceutil/trace.go:171","msg":"trace[1640745774] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"208.703157ms","start":"2026-10-17T10:05:37.63685Z","end":"2026-10-17T10:05:37.845553Z","steps":["trace[1640745774] 'read index received' (duration: 208.438332ms)","trace[1640745774] 'applied index is now lower than readState.Index' (duration: 263.796µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:05:37.845759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.887062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:05:37.845798Z","caller":"traceutil/trace.go:171","msg":"trace[20924989] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:665; }","duration":"208.957953ms","start":"2026-10-17T10:05:37.636829Z","end":"2026-10-17T10:05:37.845787Z","steps":["trace[20924989] 'agreement among raft nodes before linearized reading' (duration: 208.80346ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:37.845897Z","caller":"traceutil/trace.go:171","msg":"trace[1535747141] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"209.324111ms","start":"2026-10-17T10:05:37.636533Z","end":"2026-10-17T10:05:37.845857Z","steps":["trace[1535747141] 'process raft request' (duration: 208.704448ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:38.028047Z","caller":"traceutil/trace.go:171","msg":"trace[1003446331] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:688; }","duration":"139.834791ms","start":"2026-10-17T10:05:37.888188Z","end":"2026-10-17T10:05:38.028023Z","steps":["trace[1003446331] 'read index received' (duration: 100.032245ms)","trace[1003446331] 'applied index is now lower than readState.Index' (duration: 39.801586ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:05:38.028142Z","caller":"traceutil/trace.go:171","msg":"trace[167052574] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"179.094294ms","start":"2026-10-17T10:05:37.849009Z","end":"2026-10-17T10:05:38.028103Z","steps":["trace[167052574] 'process raft request' (duration: 139.262628ms)","trace[167052574] 'compare' (duration: 39.54454ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:05:38.028169Z","caller":"traceutil/trace.go:171","msg":"trace[933674364] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"156.940502ms","start":"2026-10-17T10:05:37.871178Z","end":"2026-10-17T10:05:38.028119Z","steps":["trace[933674364] 'process raft request' (duration: 156.752898ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:05:38.028346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.145836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T10:05:38.028269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.067606ms","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-10-17T10:05:38.028422Z","caller":"traceutil/trace.go:171","msg":"trace[625643347] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:667; }","duration":"140.27534ms","start":"2026-10-17T10:05:37.888133Z","end":"2026-10-17T10:05:38.028409Z","steps":["trace[625643347] 'agreement among raft nodes before linearized reading' (duration: 140.011164ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:38.028422Z","caller":"traceutil/trace.go:171","msg":"trace[2079350844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"105.267609ms","start":"2026-10-17T10:05:37.923135Z","end":"2026-10-17T10:05:38.028403Z","steps":["trace[2079350844] 'agreement among raft nodes before linearized reading' (duration: 105.157016ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:38.518129Z","caller":"traceutil/trace.go:171","msg":"trace[1289786646] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"118.890314ms","start":"2026-10-17T10:05:38.399211Z","end":"2026-10-17T10:05:38.518101Z","steps":["trace[1289786646] 'process raft request' (duration: 118.71079ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:05:38.546303Z","caller":"traceutil/trace.go:171","msg":"trace[1319282329] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"146.335411ms","start":"2026-10-17T10:05:38.399943Z","end":"2026-10-17T10:05:38.546278Z","steps":["trace[1319282329] 'process raft request' (duration: 146.204658ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:05:54.049662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.817348ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-17T10:05:54.050403Z","caller":"traceutil/trace.go:171","msg":"trace[795985790] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"127.953913ms","start":"2026-10-17T10:05:53.922424Z","end":"2026-10-17T10:05:54.050377Z","steps":["trace[795985790] 'read index received' (duration: 48.041µs)","trace[795985790] 'applied index is now lower than readState.Index' (duration: 127.903402ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:05:54.050528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.086735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:05:54.050613Z","caller":"traceutil/trace.go:171","msg":"trace[133533509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"128.221858ms","start":"2026-10-17T10:05:53.922371Z","end":"2026-10-17T10:05:54.050593Z","steps":["trace[133533509] 'agreement among raft nodes before linearized reading' (duration: 128.060265ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:12.850636Z","caller":"traceutil/trace.go:171","msg":"trace[1286617130] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"202.089983ms","start":"2026-10-17T10:07:12.648519Z","end":"2026-10-17T10:07:12.850609Z","steps":["trace[1286617130] 'process raft request' (duration: 201.91848ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:07:13.160246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.667932ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:07:13.160383Z","caller":"traceutil/trace.go:171","msg":"trace[432112162] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1940; }","duration":"163.419916ms","start":"2026-10-17T10:07:12.996945Z","end":"2026-10-17T10:07:13.160365Z","steps":["trace[432112162] 'read index received' (duration: 17.461018ms)","trace[432112162] 'applied index is now lower than readState.Index' (duration: 145.957638ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:07:13.160476Z","caller":"traceutil/trace.go:171","msg":"trace[605174357] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"175.493407ms","start":"2026-10-17T10:07:12.984939Z","end":"2026-10-17T10:07:13.160432Z","steps":["trace[605174357] 'process raft request' (duration: 29.507639ms)","trace[605174357] 'compare' (duration: 145.513598ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:07:13.16068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.712613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T10:07:13.160805Z","caller":"traceutil/trace.go:171","msg":"trace[506801986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1870; }","duration":"163.925737ms","start":"2026-10-17T10:07:12.996855Z","end":"2026-10-17T10:07:13.160781Z","steps":["trace[506801986] 'agreement among raft nodes before linearized reading' (duration: 163.6053ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:25.818717Z","caller":"traceutil/trace.go:171","msg":"trace[494216661] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"158.046321ms","start":"2026-10-17T10:07:25.660645Z","end":"2026-10-17T10:07:25.818691Z","steps":["trace[494216661] 'process raft request' (duration: 157.880627ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:25.819397Z","caller":"traceutil/trace.go:171","msg":"trace[1585765455] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"107.377304ms","start":"2026-10-17T10:07:25.711993Z","end":"2026-10-17T10:07:25.81937Z","steps":["trace[1585765455] 'process raft request' (duration: 107.268801ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:08:04.252016Z","caller":"traceutil/trace.go:171","msg":"trace[1890961036] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"154.609889ms","start":"2026-10-17T10:08:04.097371Z","end":"2026-10-17T10:08:04.251981Z","steps":["trace[1890961036] 'process raft request' (duration: 90.950258ms)","trace[1890961036] 'compare' (duration: 63.536049ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:08:04.517646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.666791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-17T10:08:04.517723Z","caller":"traceutil/trace.go:171","msg":"trace[1406510243] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2198; }","duration":"108.752862ms","start":"2026-10-17T10:08:04.408954Z","end":"2026-10-17T10:08:04.517707Z","steps":["trace[1406510243] 'range keys from in-memory index tree' (duration: 108.566589ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:08:04.651797Z","caller":"traceutil/trace.go:171","msg":"trace[1220299703] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"129.795125ms","start":"2026-10-17T10:08:04.521982Z","end":"2026-10-17T10:08:04.651777Z","steps":["trace[1220299703] 'process raft request' (duration: 129.601051ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:08:04.716783Z","caller":"traceutil/trace.go:171","msg":"trace[1704202975] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"194.708482ms","start":"2026-10-17T10:08:04.522027Z","end":"2026-10-17T10:08:04.716735Z","steps":["trace[1704202975] 'process raft request' (duration: 194.57978ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:08:04.71694Z","caller":"traceutil/trace.go:171","msg":"trace[1901655380] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"191.263728ms","start":"2026-10-17T10:08:04.525666Z","end":"2026-10-17T10:08:04.71693Z","steps":["trace[1901655380] 'process raft request' (duration: 191.032633ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:08:56.082346Z","caller":"traceutil/trace.go:171","msg":"trace[59230330] linearizableReadLoop","detail":"{readStateIndex:2749; appliedIndex:2748; }","duration":"159.785003ms","start":"2026-10-17T10:08:55.922533Z","end":"2026-10-17T10:08:56.082318Z","steps":["trace[59230330] 'read index received' (duration: 159.62339ms)","trace[59230330] 'applied index is now lower than readState.Index' (duration: 160.323µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:08:56.082401Z","caller":"traceutil/trace.go:171","msg":"trace[1295062704] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"176.620077ms","start":"2026-10-17T10:08:55.905743Z","end":"2026-10-17T10:08:56.082363Z","steps":["trace[1295062704] 'process raft request' (duration: 176.388632ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:08:56.082564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.005187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T10:08:56.082654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.090384ms","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-10-17T10:08:56.082685Z","caller":"traceutil/trace.go:171","msg":"trace[786899686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2648; }","duration":"160.174041ms","start":"2026-10-17T10:08:55.922488Z","end":"2026-10-17T10:08:56.082662Z","steps":["trace[786899686] 'agreement among raft nodes before linearized reading' (duration: 159.977847ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:08:56.082719Z","caller":"traceutil/trace.go:171","msg":"trace[1768985977] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2648; }","duration":"156.194195ms","start":"2026-10-17T10:08:55.926509Z","end":"2026-10-17T10:08:56.082703Z","steps":["trace[1768985977] 'agreement among raft nodes before linearized reading' (duration: 155.996541ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:09:29.144735Z","caller":"traceutil/trace.go:171","msg":"trace[734036409] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"109.435785ms","start":"2026-10-17T10:09:29.035271Z","end":"2026-10-17T10:09:29.144707Z","steps":["trace[734036409] 'process raft request' (duration: 109.177819ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:12:42.019599Z","caller":"traceutil/trace.go:171","msg":"trace[1744332819] transaction","detail":"{read_only:false; response_revision:4064; number_of_response:1; }","duration":"184.400697ms","start":"2026-10-17T10:12:41.835159Z","end":"2026-10-17T10:12:42.01956Z","steps":["trace[1744332819] 'process raft request' (duration: 184.143292ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:13:47.258879Z","caller":"traceutil/trace.go:171","msg":"trace[1523259404] transaction","detail":"{read_only:false; response_revision:4485; number_of_response:1; }","duration":"114.4363ms","start":"2026-10-17T10:13:47.144386Z","end":"2026-10-17T10:13:47.258822Z","steps":["trace[1523259404] 'process raft request' (duration: 18.165532ms)","trace[1523259404] 'compare' (duration: 95.9227ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:14:07.507829Z","caller":"traceutil/trace.go:171","msg":"trace[324383374] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"162.884275ms","start":"2026-10-17T10:14:07.344915Z","end":"2026-10-17T10:14:07.507799Z","steps":["trace[324383374] 'process raft request' (duration: 162.715891ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:14:10.368513Z","caller":"traceutil/trace.go:171","msg":"trace[1844471480] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"143.307261ms","start":"2026-10-17T10:14:10.225169Z","end":"2026-10-17T10:14:10.368476Z","steps":["trace[1844471480] 'process raft request' (duration: 143.132948ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:14:10.495321Z","caller":"traceutil/trace.go:171","msg":"trace[1122122701] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"154.932623ms","start":"2026-10-17T10:14:10.340341Z","end":"2026-10-17T10:14:10.495274Z","steps":["trace[1122122701] 'process raft request' (duration: 134.169415ms)","trace[1122122701] 'compare' (duration: 20.584824ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:14:10.509942Z","caller":"traceutil/trace.go:171","msg":"trace[573929545] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"133.49048ms","start":"2026-10-17T10:14:10.376394Z","end":"2026-10-17T10:14:10.509884Z","steps":["trace[573929545] 'process raft request' (duration: 133.297366ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:14:19.653343Z","caller":"traceutil/trace.go:171","msg":"trace[1287053770] transaction","detail":"{read_only:false; response_revision:5424; number_of_response:1; }","duration":"101.240665ms","start":"2026-10-17T10:14:19.552058Z","end":"2026-10-17T10:14:19.653299Z","steps":["trace[1287053770] 'process raft request' (duration: 100.861167ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:14:19.653483Z","caller":"traceutil/trace.go:171","msg":"trace[1061880167] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"101.269585ms","start":"2026-10-17T10:14:19.55219Z","end":"2026-10-17T10:14:19.653459Z","steps":["trace[1061880167] 'process raft request' (duration: 100.915587ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:14:25.750272Z","caller":"traceutil/trace.go:171","msg":"trace[1424619370] transaction","detail":"{read_only:false; response_revision:5518; number_of_response:1; }","duration":"178.608924ms","start":"2026-10-17T10:14:25.571612Z","end":"2026-10-17T10:14:25.75022Z","steps":["trace[1424619370] 'process raft request' (duration: 170.343656ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:14:34.163727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.119836ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-17T10:14:34.164074Z","caller":"traceutil/trace.go:171","msg":"trace[674889544] linearizableReadLoop","detail":"{readStateIndex:5899; appliedIndex:5897; }","duration":"160.530224ms","start":"2026-10-17T10:14:34.00352Z","end":"2026-10-17T10:14:34.164051Z","steps":["trace[674889544] 'read index received' (duration: 129.32094ms)","trace[674889544] 'applied index is now lower than readState.Index' (duration: 31.208144ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:14:34.164191Z","caller":"traceutil/trace.go:171","msg":"trace[1503064538] transaction","detail":"{read_only:false; response_revision:5690; number_of_response:1; }","duration":"217.936882ms","start":"2026-10-17T10:14:33.946241Z","end":"2026-10-17T10:14:34.164177Z","steps":["trace[1503064538] 'process raft request' (duration: 217.632976ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:14:34.164413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.106688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T10:14:34.164525Z","caller":"traceutil/trace.go:171","msg":"trace[1064877880] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:5690; }","duration":"156.253702ms","start":"2026-10-17T10:14:34.008244Z","end":"2026-10-17T10:14:34.164498Z","steps":["trace[1064877880] 'agreement among raft nodes before linearized reading' (duration: 156.081468ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:14:34.164592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.033695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:14:34.164717Z","caller":"traceutil/trace.go:171","msg":"trace[866081348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5690; }","duration":"161.203668ms","start":"2026-10-17T10:14:34.003485Z","end":"2026-10-17T10:14:34.164688Z","steps":["trace[866081348] 'agreement among raft nodes before linearized reading' (duration: 160.967562ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:14:34.165146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.04943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-17T10:14:34.165245Z","caller":"traceutil/trace.go:171","msg":"trace[1099697601] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5690; }","duration":"145.178693ms","start":"2026-10-17T10:14:34.020043Z","end":"2026-10-17T10:14:34.165222Z","steps":["trace[1099697601] 'agreement among raft nodes before linearized reading' (duration: 144.425257ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:14:45.317163Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2935} {"level":"info","ts":"2026-10-17T10:14:45.633566Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2935,"took":"314.65753ms","hash":649228537,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":32432128,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T10:14:45.633654Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":649228537,"revision":2935,"compact-revision":-1} {"level":"info","ts":"2026-10-17T10:15:27.122554Z","caller":"traceutil/trace.go:171","msg":"trace[1237574703] transaction","detail":"{read_only:false; response_revision:6200; number_of_response:1; }","duration":"109.980112ms","start":"2026-10-17T10:15:27.012527Z","end":"2026-10-17T10:15:27.122507Z","steps":["trace[1237574703] 'process raft request' (duration: 109.755998ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:19:45.324163Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5845} {"level":"info","ts":"2026-10-17T10:19:45.41359Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5845,"took":"87.693264ms","hash":80197822,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":26312704,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T10:19:45.413668Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":80197822,"revision":5845,"compact-revision":2935} {"level":"info","ts":"2026-10-17T10:20:57.786208Z","caller":"traceutil/trace.go:171","msg":"trace[931243376] transaction","detail":"{read_only:false; response_revision:8610; number_of_response:1; }","duration":"222.105298ms","start":"2026-10-17T10:20:57.56408Z","end":"2026-10-17T10:20:57.786185Z","steps":["trace[931243376] 'process raft request' (duration: 221.825463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:20:57.984333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.144425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:20:57.984428Z","caller":"traceutil/trace.go:171","msg":"trace[2096207471] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8610; }","duration":"118.285859ms","start":"2026-10-17T10:20:57.86612Z","end":"2026-10-17T10:20:57.984405Z","steps":["trace[2096207471] 'range keys from in-memory index tree' (duration: 118.056714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:20:57.984389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.015787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-17T10:20:57.984499Z","caller":"traceutil/trace.go:171","msg":"trace[1590913457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8610; }","duration":"143.209012ms","start":"2026-10-17T10:20:57.841266Z","end":"2026-10-17T10:20:57.984475Z","steps":["trace[1590913457] 'range keys from in-memory index tree' (duration: 142.790123ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:20:57.98452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.439099ms","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-10-17T10:20:57.984634Z","caller":"traceutil/trace.go:171","msg":"trace[302438096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8610; }","duration":"131.554431ms","start":"2026-10-17T10:20:57.853066Z","end":"2026-10-17T10:20:57.98462Z","steps":["trace[302438096] 'range keys from in-memory index tree' (duration: 131.216005ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:09.112838Z","caller":"traceutil/trace.go:171","msg":"trace[1712999674] linearizableReadLoop","detail":"{readStateIndex:8976; appliedIndex:8975; }","duration":"131.352988ms","start":"2026-10-17T10:21:08.981459Z","end":"2026-10-17T10:21:09.112812Z","steps":["trace[1712999674] 'read index received' (duration: 131.112073ms)","trace[1712999674] 'applied index is now lower than readState.Index' (duration: 240.045µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:09.112894Z","caller":"traceutil/trace.go:171","msg":"trace[199341538] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"133.605085ms","start":"2026-10-17T10:21:08.979255Z","end":"2026-10-17T10:21:09.11286Z","steps":["trace[199341538] 'process raft request' (duration: 133.404351ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:09.113171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.683554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T10:21:09.113275Z","caller":"traceutil/trace.go:171","msg":"trace[1249334433] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8669; }","duration":"131.839878ms","start":"2026-10-17T10:21:08.981411Z","end":"2026-10-17T10:21:09.113251Z","steps":["trace[1249334433] 'agreement among raft nodes before linearized reading' (duration: 131.505621ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:09.544414Z","caller":"traceutil/trace.go:171","msg":"trace[1858096421] transaction","detail":"{read_only:false; response_revision:8672; number_of_response:1; }","duration":"204.004521ms","start":"2026-10-17T10:21:09.34038Z","end":"2026-10-17T10:21:09.544385Z","steps":["trace[1858096421] 'process raft request' (duration: 189.107413ms)","trace[1858096421] 'compare' (duration: 14.519731ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:10.587083Z","caller":"traceutil/trace.go:171","msg":"trace[1406880859] linearizableReadLoop","detail":"{readStateIndex:8983; appliedIndex:8982; }","duration":"149.160319ms","start":"2026-10-17T10:21:10.437888Z","end":"2026-10-17T10:21:10.587048Z","steps":["trace[1406880859] 'read index received' (duration: 148.77406ms)","trace[1406880859] 'applied index is now lower than readState.Index' (duration: 384.469µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:10.58716Z","caller":"traceutil/trace.go:171","msg":"trace[1426232565] transaction","detail":"{read_only:false; response_revision:8676; number_of_response:1; }","duration":"258.555837ms","start":"2026-10-17T10:21:10.328552Z","end":"2026-10-17T10:21:10.587108Z","steps":["trace[1426232565] 'process raft request' (duration: 258.099348ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:10.5874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.457984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T10:21:10.587446Z","caller":"traceutil/trace.go:171","msg":"trace[2012061944] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:8676; }","duration":"149.609048ms","start":"2026-10-17T10:21:10.437825Z","end":"2026-10-17T10:21:10.587434Z","steps":["trace[2012061944] 'agreement among raft nodes before linearized reading' (duration: 149.380863ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:10.841377Z","caller":"traceutil/trace.go:171","msg":"trace[1525957802] linearizableReadLoop","detail":"{readStateIndex:8984; appliedIndex:8983; }","duration":"254.179994ms","start":"2026-10-17T10:21:10.587177Z","end":"2026-10-17T10:21:10.841357Z","steps":["trace[1525957802] 'read index received' (duration: 215.343093ms)","trace[1525957802] 'applied index is now lower than readState.Index' (duration: 38.835961ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:21:10.841555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.144234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T10:21:10.841595Z","caller":"traceutil/trace.go:171","msg":"trace[2135245227] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:8677; }","duration":"371.249016ms","start":"2026-10-17T10:21:10.470334Z","end":"2026-10-17T10:21:10.841583Z","steps":["trace[2135245227] 'agreement among raft nodes before linearized reading' (duration: 371.147143ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:10.841536Z","caller":"traceutil/trace.go:171","msg":"trace[512126444] transaction","detail":"{read_only:false; response_revision:8677; number_of_response:1; }","duration":"371.080402ms","start":"2026-10-17T10:21:10.470385Z","end":"2026-10-17T10:21:10.841466Z","steps":["trace[512126444] 'process raft request' (duration: 332.189331ms)","trace[512126444] 'compare' (duration: 38.605726ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:21:10.841636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:21:10.470303Z","time spent":"371.322068ms","remote":"127.0.0.1:50036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":13,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:21:10.841659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.895245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T10:21:10.84185Z","caller":"traceutil/trace.go:171","msg":"trace[1137087809] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8677; }","duration":"223.14975ms","start":"2026-10-17T10:21:10.618681Z","end":"2026-10-17T10:21:10.841831Z","steps":["trace[1137087809] 'agreement among raft nodes before linearized reading' (duration: 222.874934ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:10.841852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:21:10.470353Z","time spent":"371.344468ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:21:11.667773Z","caller":"traceutil/trace.go:171","msg":"trace[1634260720] transaction","detail":"{read_only:false; response_revision:8683; number_of_response:1; }","duration":"105.672938ms","start":"2026-10-17T10:21:11.562062Z","end":"2026-10-17T10:21:11.667735Z","steps":["trace[1634260720] 'process raft request' (duration: 105.242329ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:37.507762Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023e1.wal"} {"level":"info","ts":"2026-10-17T10:21:40.939564Z","caller":"traceutil/trace.go:171","msg":"trace[390527495] transaction","detail":"{read_only:false; response_revision:8891; number_of_response:1; }","duration":"237.657463ms","start":"2026-10-17T10:21:40.701877Z","end":"2026-10-17T10:21:40.939535Z","steps":["trace[390527495] 'process raft request' (duration: 237.0485ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:43.88359Z","caller":"traceutil/trace.go:171","msg":"trace[1959563734] transaction","detail":"{read_only:false; response_revision:8908; number_of_response:1; }","duration":"123.649284ms","start":"2026-10-17T10:21:43.759902Z","end":"2026-10-17T10:21:43.883551Z","steps":["trace[1959563734] 'process raft request' (duration: 120.539728ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:52.318226Z","caller":"traceutil/trace.go:171","msg":"trace[1591213903] linearizableReadLoop","detail":"{readStateIndex:9270; appliedIndex:9269; }","duration":"174.087309ms","start":"2026-10-17T10:21:52.144112Z","end":"2026-10-17T10:21:52.3182Z","steps":["trace[1591213903] 'read index received' (duration: 173.938015ms)","trace[1591213903] 'applied index is now lower than readState.Index' (duration: 148.304µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:52.318285Z","caller":"traceutil/trace.go:171","msg":"trace[585298503] transaction","detail":"{read_only:false; response_revision:8952; number_of_response:1; }","duration":"213.56519ms","start":"2026-10-17T10:21:52.104675Z","end":"2026-10-17T10:21:52.31824Z","steps":["trace[585298503] 'process raft request' (duration: 213.344754ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:52.318567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.860759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nt6lk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-17T10:21:52.318637Z","caller":"traceutil/trace.go:171","msg":"trace[857506988] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nt6lk; range_end:; response_count:1; response_revision:8952; }","duration":"154.977042ms","start":"2026-10-17T10:21:52.163642Z","end":"2026-10-17T10:21:52.318619Z","steps":["trace[857506988] 'agreement among raft nodes before linearized reading' (duration: 154.723236ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:52.31864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.528168ms","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-10-17T10:21:52.318803Z","caller":"traceutil/trace.go:171","msg":"trace[2090715449] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8952; }","duration":"174.769173ms","start":"2026-10-17T10:21:52.144017Z","end":"2026-10-17T10:21:52.318786Z","steps":["trace[2090715449] 'agreement among raft nodes before linearized reading' (duration: 174.321363ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:21:54.376825Z","caller":"traceutil/trace.go:171","msg":"trace[928249803] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8972; }","duration":"126.895703ms","start":"2026-10-17T10:21:54.249903Z","end":"2026-10-17T10:21:54.376799Z","steps":["trace[928249803] 'process raft request' (duration: 85.924211ms)","trace[928249803] 'compare' (duration: 40.83412ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:54.38193Z","caller":"traceutil/trace.go:171","msg":"trace[1405498450] linearizableReadLoop","detail":"{readStateIndex:9292; appliedIndex:9290; }","duration":"119.626488ms","start":"2026-10-17T10:21:54.262268Z","end":"2026-10-17T10:21:54.381895Z","steps":["trace[1405498450] 'read index received' (duration: 73.554617ms)","trace[1405498450] 'applied index is now lower than readState.Index' (duration: 46.070241ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:21:54.3821Z","caller":"traceutil/trace.go:171","msg":"trace[1790091196] transaction","detail":"{read_only:false; response_revision:8973; number_of_response:1; }","duration":"127.384443ms","start":"2026-10-17T10:21:54.254685Z","end":"2026-10-17T10:21:54.38207Z","steps":["trace[1790091196] 'process raft request' (duration: 126.998224ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:21:54.382167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.862493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:21:54.382214Z","caller":"traceutil/trace.go:171","msg":"trace[612039574] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8973; }","duration":"119.939304ms","start":"2026-10-17T10:21:54.262261Z","end":"2026-10-17T10:21:54.3822Z","steps":["trace[612039574] 'agreement among raft nodes before linearized reading' (duration: 119.824213ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:22:58.754882Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab61124f07c17f20","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T10:22:58.761939Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T10:22:58.762068Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T10:24:45.335845Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7994} {"level":"info","ts":"2026-10-17T10:24:45.404581Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7994,"took":"66.665619ms","hash":1756930357,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":27840512,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T10:24:45.404646Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1756930357,"revision":7994,"compact-revision":5845} {"level":"info","ts":"2026-10-17T10:29:01.893516Z","caller":"traceutil/trace.go:171","msg":"trace[1375452395] transaction","detail":"{read_only:false; response_revision:12255; number_of_response:1; }","duration":"172.366415ms","start":"2026-10-17T10:29:01.72112Z","end":"2026-10-17T10:29:01.893486Z","steps":["trace[1375452395] 'process raft request' (duration: 145.891522ms)","trace[1375452395] 'compare' (duration: 25.728777ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:29:45.348703Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10368} {"level":"info","ts":"2026-10-17T10:29:45.442704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10368,"took":"91.402213ms","hash":436534819,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":26345472,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T10:29:45.442801Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":436534819,"revision":10368,"compact-revision":7994} {"level":"info","ts":"2026-10-17T10:34:45.356145Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12567} {"level":"info","ts":"2026-10-17T10:34:45.460307Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12567,"took":"101.6076ms","hash":118533890,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":27594752,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T10:34:45.460436Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":118533890,"revision":12567,"compact-revision":10368} {"level":"info","ts":"2026-10-17T10:35:06.735037Z","caller":"traceutil/trace.go:171","msg":"trace[1897597572] transaction","detail":"{read_only:false; response_revision:14719; number_of_response:1; }","duration":"179.809382ms","start":"2026-10-17T10:35:06.555193Z","end":"2026-10-17T10:35:06.735002Z","steps":["trace[1897597572] 'process raft request' (duration: 179.240571ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:47.398713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.871485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nt6lk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-17T10:35:47.398815Z","caller":"traceutil/trace.go:171","msg":"trace[1855103888] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nt6lk; range_end:; response_count:1; response_revision:14947; }","duration":"190.030929ms","start":"2026-10-17T10:35:47.208763Z","end":"2026-10-17T10:35:47.398793Z","steps":["trace[1855103888] 'range keys from in-memory index tree' (duration: 189.702202ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:47.39886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.549772ms","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-10-17T10:35:47.398933Z","caller":"traceutil/trace.go:171","msg":"trace[578754816] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14947; }","duration":"327.688475ms","start":"2026-10-17T10:35:47.07123Z","end":"2026-10-17T10:35:47.398919Z","steps":["trace[578754816] 'range keys from in-memory index tree' (duration: 327.413789ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:47.398887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.532565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-17T10:35:47.398962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:35:47.071208Z","time spent":"327.748767ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-17T10:35:47.398999Z","caller":"traceutil/trace.go:171","msg":"trace[1901976553] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:14947; }","duration":"313.75165ms","start":"2026-10-17T10:35:47.08522Z","end":"2026-10-17T10:35:47.398972Z","steps":["trace[1901976553] 'count revisions from in-memory index tree' (duration: 313.438673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:47.399052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:35:47.085199Z","time spent":"313.83989ms","remote":"127.0.0.1:53632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-10-17T10:35:47.464617Z","caller":"traceutil/trace.go:171","msg":"trace[363913716] transaction","detail":"{read_only:false; response_revision:14948; number_of_response:1; }","duration":"232.732388ms","start":"2026-10-17T10:35:47.231852Z","end":"2026-10-17T10:35:47.464585Z","steps":["trace[363913716] 'process raft request' (duration: 232.577324ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:57.848357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.233205ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:35:57.848498Z","caller":"traceutil/trace.go:171","msg":"trace[1673672416] linearizableReadLoop","detail":"{readStateIndex:15644; appliedIndex:15643; }","duration":"290.050725ms","start":"2026-10-17T10:35:57.558419Z","end":"2026-10-17T10:35:57.848469Z","steps":["trace[1673672416] 'read index received' (duration: 66.570575ms)","trace[1673672416] 'applied index is now lower than readState.Index' (duration: 223.47856ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:35:57.848536Z","caller":"traceutil/trace.go:171","msg":"trace[131819070] transaction","detail":"{read_only:false; response_revision:15120; number_of_response:1; }","duration":"299.890694ms","start":"2026-10-17T10:35:57.548594Z","end":"2026-10-17T10:35:57.848485Z","steps":["trace[131819070] 'process raft request' (duration: 76.421535ms)","trace[131819070] 'compare' (duration: 222.957778ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:35:57.848743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.598161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6bc81f32-34a1-4ecd-a4cc-38e43fec43da\" ","response":"range_response_count:1 size:3607"} {"level":"info","ts":"2026-10-17T10:35:57.848948Z","caller":"traceutil/trace.go:171","msg":"trace[536938357] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6bc81f32-34a1-4ecd-a4cc-38e43fec43da; range_end:; response_count:1; response_revision:15120; }","duration":"119.881668ms","start":"2026-10-17T10:35:57.729051Z","end":"2026-10-17T10:35:57.848933Z","steps":["trace[536938357] 'agreement among raft nodes before linearized reading' (duration: 119.551981ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:57.848764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:35:57.548569Z","time spent":"300.072608ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:35:57.849131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.700259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nt6lk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-17T10:35:57.849205Z","caller":"traceutil/trace.go:171","msg":"trace[2009784002] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nt6lk; range_end:; response_count:1; response_revision:15120; }","duration":"290.825482ms","start":"2026-10-17T10:35:57.558362Z","end":"2026-10-17T10:35:57.849187Z","steps":["trace[2009784002] 'agreement among raft nodes before linearized reading' (duration: 290.21569ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:35:57.978948Z","caller":"traceutil/trace.go:171","msg":"trace[153264968] linearizableReadLoop","detail":"{readStateIndex:15645; appliedIndex:15644; }","duration":"123.768441ms","start":"2026-10-17T10:35:57.855158Z","end":"2026-10-17T10:35:57.978927Z","steps":["trace[153264968] 'read index received' (duration: 123.469534ms)","trace[153264968] 'applied index is now lower than readState.Index' (duration: 297.667µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:35:57.979072Z","caller":"traceutil/trace.go:171","msg":"trace[207017449] transaction","detail":"{read_only:false; response_revision:15121; number_of_response:1; }","duration":"123.946675ms","start":"2026-10-17T10:35:57.855096Z","end":"2026-10-17T10:35:57.979043Z","steps":["trace[207017449] 'process raft request' (duration: 123.592517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:35:57.979703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.525626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:67 size:630057"} {"level":"info","ts":"2026-10-17T10:35:57.979751Z","caller":"traceutil/trace.go:171","msg":"trace[490578115] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:67; response_revision:15121; }","duration":"124.588538ms","start":"2026-10-17T10:35:57.855152Z","end":"2026-10-17T10:35:57.979741Z","steps":["trace[490578115] 'agreement among raft nodes before linearized reading' (duration: 123.896563ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:37:06.398323Z","caller":"traceutil/trace.go:171","msg":"trace[1411142856] transaction","detail":"{read_only:false; response_revision:16045; number_of_response:1; }","duration":"148.913197ms","start":"2026-10-17T10:37:06.249357Z","end":"2026-10-17T10:37:06.39827Z","steps":["trace[1411142856] 'process raft request' (duration: 148.673362ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:37:26.009481Z","caller":"traceutil/trace.go:171","msg":"trace[322439603] linearizableReadLoop","detail":"{readStateIndex:16706; appliedIndex:16705; }","duration":"114.032055ms","start":"2026-10-17T10:37:25.895424Z","end":"2026-10-17T10:37:26.009457Z","steps":["trace[322439603] 'read index received' (duration: 113.79876ms)","trace[322439603] 'applied index is now lower than readState.Index' (duration: 232.135µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:37:26.009547Z","caller":"traceutil/trace.go:171","msg":"trace[1767265904] transaction","detail":"{read_only:false; response_revision:16151; number_of_response:1; }","duration":"115.15357ms","start":"2026-10-17T10:37:25.894358Z","end":"2026-10-17T10:37:26.009511Z","steps":["trace[1767265904] 'process raft request' (duration: 114.925055ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:37:26.009751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.315952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-17T10:37:26.009792Z","caller":"traceutil/trace.go:171","msg":"trace[1191914906] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16151; }","duration":"114.426414ms","start":"2026-10-17T10:37:25.895355Z","end":"2026-10-17T10:37:26.009781Z","steps":["trace[1191914906] 'agreement among raft nodes before linearized reading' (duration: 114.238671ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:39:45.361794Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14567} {"level":"info","ts":"2026-10-17T10:39:45.44895Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14567,"took":"84.294984ms","hash":2080358841,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":31399936,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T10:39:45.449037Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2080358841,"revision":14567,"compact-revision":12567} {"level":"info","ts":"2026-10-17T10:40:53.897846Z","caller":"traceutil/trace.go:171","msg":"trace[909802030] transaction","detail":"{read_only:false; response_revision:17718; number_of_response:1; }","duration":"121.246131ms","start":"2026-10-17T10:40:53.776572Z","end":"2026-10-17T10:40:53.897818Z","steps":["trace[909802030] 'process raft request' (duration: 35.057727ms)","trace[909802030] 'compare' (duration: 85.883659ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:43:13.375394Z","caller":"traceutil/trace.go:171","msg":"trace[1579426483] transaction","detail":"{read_only:false; response_revision:18657; number_of_response:1; }","duration":"365.854231ms","start":"2026-10-17T10:43:13.009517Z","end":"2026-10-17T10:43:13.375372Z","steps":["trace[1579426483] 'process raft request' (duration: 365.699859ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:13.375461Z","caller":"traceutil/trace.go:171","msg":"trace[1439977805] linearizableReadLoop","detail":"{readStateIndex:19295; appliedIndex:19295; }","duration":"266.108067ms","start":"2026-10-17T10:43:13.109331Z","end":"2026-10-17T10:43:13.375439Z","steps":["trace[1439977805] 'read index received' (duration: 266.099657ms)","trace[1439977805] 'applied index is now lower than readState.Index' (duration: 6.86µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:43:13.375536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:13.009497Z","time spent":"365.966094ms","remote":"127.0.0.1:36684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7439,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:43:13.375669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.314022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-xn8cf\" ","response":"range_response_count:1 size:9792"} {"level":"info","ts":"2026-10-17T10:43:13.375719Z","caller":"traceutil/trace.go:171","msg":"trace[1946516960] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-xn8cf; range_end:; response_count:1; response_revision:18657; }","duration":"266.405603ms","start":"2026-10-17T10:43:13.109294Z","end":"2026-10-17T10:43:13.375699Z","steps":["trace[1946516960] 'agreement among raft nodes before linearized reading' (duration: 266.232009ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:15.496451Z","caller":"traceutil/trace.go:171","msg":"trace[464938564] transaction","detail":"{read_only:false; response_revision:18690; number_of_response:1; }","duration":"104.571358ms","start":"2026-10-17T10:43:15.391845Z","end":"2026-10-17T10:43:15.496416Z","steps":["trace[464938564] 'process raft request' (duration: 104.252422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:22.741612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.841868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-17T10:43:22.741742Z","caller":"traceutil/trace.go:171","msg":"trace[826660839] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18734; }","duration":"171.105664ms","start":"2026-10-17T10:43:22.570615Z","end":"2026-10-17T10:43:22.741721Z","steps":["trace[826660839] 'range keys from in-memory index tree' (duration: 170.579033ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:23.651407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.066554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:43:23.65149Z","caller":"traceutil/trace.go:171","msg":"trace[1662926063] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:18738; }","duration":"349.202188ms","start":"2026-10-17T10:43:23.30227Z","end":"2026-10-17T10:43:23.651472Z","steps":["trace[1662926063] 'count revisions from in-memory index tree' (duration: 348.970471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:23.651528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:43:23.30225Z","time spent":"349.266079ms","remote":"127.0.0.1:36526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:43:23.651867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.260824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-10-17T10:43:23.651999Z","caller":"traceutil/trace.go:171","msg":"trace[1645173831] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18738; }","duration":"246.429338ms","start":"2026-10-17T10:43:23.405543Z","end":"2026-10-17T10:43:23.651972Z","steps":["trace[1645173831] 'range keys from in-memory index tree' (duration: 246.106242ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:23.652389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.170047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-10-17T10:43:23.652445Z","caller":"traceutil/trace.go:171","msg":"trace[844708490] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18738; }","duration":"141.249568ms","start":"2026-10-17T10:43:23.511178Z","end":"2026-10-17T10:43:23.652428Z","steps":["trace[844708490] 'range keys from in-memory index tree' (duration: 141.069454ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:43:23.669756Z","caller":"traceutil/trace.go:171","msg":"trace[1031625376] linearizableReadLoop","detail":"{readStateIndex:19379; appliedIndex:19378; }","duration":"136.282902ms","start":"2026-10-17T10:43:23.533453Z","end":"2026-10-17T10:43:23.669736Z","steps":["trace[1031625376] 'read index received' (duration: 136.095687ms)","trace[1031625376] 'applied index is now lower than readState.Index' (duration: 186.365µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:43:23.670049Z","caller":"traceutil/trace.go:171","msg":"trace[2042097420] transaction","detail":"{read_only:false; response_revision:18739; number_of_response:1; }","duration":"146.556072ms","start":"2026-10-17T10:43:23.523481Z","end":"2026-10-17T10:43:23.670037Z","steps":["trace[2042097420] 'process raft request' (duration: 146.120842ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:43:23.671311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.776973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-17T10:43:23.671353Z","caller":"traceutil/trace.go:171","msg":"trace[1978984753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18739; }","duration":"137.938508ms","start":"2026-10-17T10:43:23.533402Z","end":"2026-10-17T10:43:23.671341Z","steps":["trace[1978984753] 'agreement among raft nodes before linearized reading' (duration: 136.823393ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:44:10.850043Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab61124f07c17f20","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T10:44:10.855308Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T10:44:10.855386Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T10:44:45.368132Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17006} {"level":"info","ts":"2026-10-17T10:44:45.473038Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17006,"took":"101.531962ms","hash":1162998561,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":33935360,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T10:44:45.473123Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1162998561,"revision":17006,"compact-revision":14567} {"level":"info","ts":"2026-10-17T10:49:26.52023Z","caller":"traceutil/trace.go:171","msg":"trace[712932186] transaction","detail":"{read_only:false; response_revision:21534; number_of_response:1; }","duration":"342.289387ms","start":"2026-10-17T10:49:26.177911Z","end":"2026-10-17T10:49:26.520201Z","steps":["trace[712932186] 'process raft request' (duration: 341.859268ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:26.520397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:49:26.177811Z","time spent":"342.496232ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:49:42.750792Z","caller":"traceutil/trace.go:171","msg":"trace[218890264] linearizableReadLoop","detail":"{readStateIndex:22351; appliedIndex:22350; }","duration":"125.109915ms","start":"2026-10-17T10:49:42.625659Z","end":"2026-10-17T10:49:42.750768Z","steps":["trace[218890264] 'read index received' (duration: 124.85643ms)","trace[218890264] 'applied index is now lower than readState.Index' (duration: 252.405µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:49:42.750911Z","caller":"traceutil/trace.go:171","msg":"trace[1838301699] transaction","detail":"{read_only:false; response_revision:21616; number_of_response:1; }","duration":"160.662843ms","start":"2026-10-17T10:49:42.590175Z","end":"2026-10-17T10:49:42.750838Z","steps":["trace[1838301699] 'process raft request' (duration: 160.436458ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:42.751053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.373381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T10:49:42.751101Z","caller":"traceutil/trace.go:171","msg":"trace[584230115] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:21616; }","duration":"125.445452ms","start":"2026-10-17T10:49:42.62564Z","end":"2026-10-17T10:49:42.751086Z","steps":["trace[584230115] 'agreement among raft nodes before linearized reading' (duration: 125.31817ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:42.911626Z","caller":"traceutil/trace.go:171","msg":"trace[2095492723] transaction","detail":"{read_only:false; response_revision:21617; number_of_response:1; }","duration":"155.774609ms","start":"2026-10-17T10:49:42.755813Z","end":"2026-10-17T10:49:42.911587Z","steps":["trace[2095492723] 'process raft request' (duration: 151.711093ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:42.911726Z","caller":"traceutil/trace.go:171","msg":"trace[920449746] transaction","detail":"{read_only:false; response_revision:21618; number_of_response:1; }","duration":"155.621315ms","start":"2026-10-17T10:49:42.75607Z","end":"2026-10-17T10:49:42.911692Z","steps":["trace[920449746] 'process raft request' (duration: 155.452551ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:43.616284Z","caller":"traceutil/trace.go:171","msg":"trace[282806866] transaction","detail":"{read_only:false; response_revision:21621; number_of_response:1; }","duration":"349.593408ms","start":"2026-10-17T10:49:43.266651Z","end":"2026-10-17T10:49:43.616244Z","steps":["trace[282806866] 'process raft request' (duration: 349.299642ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:43.616718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:49:43.266621Z","time spent":"349.960315ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:49:45.374893Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19647} {"level":"info","ts":"2026-10-17T10:49:45.508652Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19647,"took":"129.53093ms","hash":957689689,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":29212672,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-17T10:49:45.508731Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":957689689,"revision":19647,"compact-revision":17006} {"level":"info","ts":"2026-10-17T10:54:45.385013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21632} {"level":"info","ts":"2026-10-17T10:54:45.506739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21632,"took":"116.762488ms","hash":2662109501,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":42811392,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-10-17T10:54:45.506789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2662109501,"revision":21632,"compact-revision":19647} {"level":"info","ts":"2026-10-17T10:57:11.480467Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006977.wal"} {"level":"info","ts":"2026-10-17T10:57:21.459299Z","caller":"traceutil/trace.go:171","msg":"trace[1776553092] transaction","detail":"{read_only:false; response_revision:26217; number_of_response:1; }","duration":"215.48823ms","start":"2026-10-17T10:57:21.243748Z","end":"2026-10-17T10:57:21.459236Z","steps":["trace[1776553092] 'process raft request' (duration: 214.411318ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:21.459443Z","caller":"traceutil/trace.go:171","msg":"trace[1040669135] linearizableReadLoop","detail":"{readStateIndex:27078; appliedIndex:27077; }","duration":"120.447575ms","start":"2026-10-17T10:57:21.338965Z","end":"2026-10-17T10:57:21.459413Z","steps":["trace[1040669135] 'read index received' (duration: 119.178748ms)","trace[1040669135] 'applied index is now lower than readState.Index' (duration: 1.266747ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:21.459802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.732202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T10:57:21.459863Z","caller":"traceutil/trace.go:171","msg":"trace[1181934234] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:26217; }","duration":"120.945447ms","start":"2026-10-17T10:57:21.338903Z","end":"2026-10-17T10:57:21.459849Z","steps":["trace[1181934234] 'agreement among raft nodes before linearized reading' (duration: 120.754122ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:21.460156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.746438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-17T10:57:21.460259Z","caller":"traceutil/trace.go:171","msg":"trace[1239420382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26217; }","duration":"102.897252ms","start":"2026-10-17T10:57:21.357344Z","end":"2026-10-17T10:57:21.460242Z","steps":["trace[1239420382] 'agreement among raft nodes before linearized reading' (duration: 102.570985ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:21.460327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.148159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-17T10:57:21.460422Z","caller":"traceutil/trace.go:171","msg":"trace[1178725405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26217; }","duration":"104.264801ms","start":"2026-10-17T10:57:21.356138Z","end":"2026-10-17T10:57:21.460403Z","steps":["trace[1178725405] 'agreement among raft nodes before linearized reading' (duration: 103.959284ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:21.460148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.961874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T10:57:21.460809Z","caller":"traceutil/trace.go:171","msg":"trace[527283553] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:26217; }","duration":"118.7124ms","start":"2026-10-17T10:57:21.342061Z","end":"2026-10-17T10:57:21.460774Z","steps":["trace[527283553] 'agreement among raft nodes before linearized reading' (duration: 117.739519ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.073384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.059176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:57:22.073491Z","caller":"traceutil/trace.go:171","msg":"trace[784544853] transaction","detail":"{read_only:false; response_revision:26218; number_of_response:1; }","duration":"607.312758ms","start":"2026-10-17T10:57:21.466157Z","end":"2026-10-17T10:57:22.073469Z","steps":["trace[784544853] 'process raft request' (duration: 219.081648ms)","trace[784544853] 'compare' (duration: 387.837631ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:22.074196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.466123Z","time spent":"607.993122ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.558738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.976684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T10:57:22.559157Z","caller":"traceutil/trace.go:171","msg":"trace[306810062] transaction","detail":"{read_only:false; response_revision:26221; number_of_response:1; }","duration":"1.010424034s","start":"2026-10-17T10:57:21.548665Z","end":"2026-10-17T10:57:22.559089Z","steps":["trace[306810062] 'process raft request' (duration: 1.01026487s)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:22.559245Z","caller":"traceutil/trace.go:171","msg":"trace[1144601955] transaction","detail":"{read_only:false; response_revision:26227; number_of_response:1; }","duration":"265.488585ms","start":"2026-10-17T10:57:22.293738Z","end":"2026-10-17T10:57:22.559227Z","steps":["trace[1144601955] 'process raft request' (duration: 265.448294ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:22.559533Z","caller":"traceutil/trace.go:171","msg":"trace[490791430] transaction","detail":"{read_only:false; response_revision:26222; number_of_response:1; }","duration":"1.004623951s","start":"2026-10-17T10:57:21.554899Z","end":"2026-10-17T10:57:22.559523Z","steps":["trace[490791430] 'process raft request' (duration: 1.004089649s)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.559601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.554866Z","time spent":"1.004696993s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:57:22.559599Z","caller":"traceutil/trace.go:171","msg":"trace[105582048] transaction","detail":"{read_only:false; response_revision:26220; number_of_response:1; }","duration":"1.093293419s","start":"2026-10-17T10:57:21.466246Z","end":"2026-10-17T10:57:22.55954Z","steps":["trace[105582048] 'process raft request' (duration: 1.092624465s)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:22.55975Z","caller":"traceutil/trace.go:171","msg":"trace[131444875] transaction","detail":"{read_only:false; response_revision:26223; number_of_response:1; }","duration":"1.002542566s","start":"2026-10-17T10:57:21.557197Z","end":"2026-10-17T10:57:22.55974Z","steps":["trace[131444875] 'process raft request' (duration: 1.001833711s)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.559806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.557155Z","time spent":"1.002624897s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.559804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.466221Z","time spent":"1.093474243s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.559843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.54863Z","time spent":"1.010628108s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:57:22.55992Z","caller":"traceutil/trace.go:171","msg":"trace[1312285775] linearizableReadLoop","detail":"{readStateIndex:27081; appliedIndex:27078; }","duration":"1.074279654s","start":"2026-10-17T10:57:21.48563Z","end":"2026-10-17T10:57:22.55991Z","steps":["trace[1312285775] 'read index received' (duration: 199.689113ms)","trace[1312285775] 'applied index is now lower than readState.Index' (duration: 874.589091ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:57:22.56005Z","caller":"traceutil/trace.go:171","msg":"trace[1793462170] transaction","detail":"{read_only:false; response_revision:26224; number_of_response:1; }","duration":"606.775506ms","start":"2026-10-17T10:57:21.953264Z","end":"2026-10-17T10:57:22.560039Z","steps":["trace[1793462170] 'process raft request' (duration: 605.812225ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.560111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.953226Z","time spent":"606.855277ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:57:22.560224Z","caller":"traceutil/trace.go:171","msg":"trace[1079131808] transaction","detail":"{read_only:false; response_revision:26226; number_of_response:1; }","duration":"390.342245ms","start":"2026-10-17T10:57:22.169846Z","end":"2026-10-17T10:57:22.560189Z","steps":["trace[1079131808] 'process raft request' (duration: 389.297472ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:22.560281Z","caller":"traceutil/trace.go:171","msg":"trace[925287067] transaction","detail":"{read_only:false; response_revision:26225; number_of_response:1; }","duration":"593.430802ms","start":"2026-10-17T10:57:21.966835Z","end":"2026-10-17T10:57:22.560266Z","steps":["trace[925287067] 'process raft request' (duration: 592.275756ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.560357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.966808Z","time spent":"593.506812ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.560385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:22.169817Z","time spent":"390.481808ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.560419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.591325ms","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:8"} {"level":"info","ts":"2026-10-17T10:57:22.560461Z","caller":"traceutil/trace.go:171","msg":"trace[2104782653] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26228; }","duration":"886.669937ms","start":"2026-10-17T10:57:21.673779Z","end":"2026-10-17T10:57:22.560449Z","steps":["trace[2104782653] 'agreement among raft nodes before linearized reading' (duration: 886.611566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.560494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.673755Z","time spent":"886.728949ms","remote":"127.0.0.1:55436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:57:22.56036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074730364s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:57:22.560589Z","caller":"traceutil/trace.go:171","msg":"trace[732803756] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:26228; }","duration":"1.07499343s","start":"2026-10-17T10:57:21.485577Z","end":"2026-10-17T10:57:22.56057Z","steps":["trace[732803756] 'agreement among raft nodes before linearized reading' (duration: 1.074737784s)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.560639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.485561Z","time spent":"1.075061761s","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":30,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"info","ts":"2026-10-17T10:57:22.56086Z","caller":"traceutil/trace.go:171","msg":"trace[254505797] transaction","detail":"{read_only:false; response_revision:26219; number_of_response:1; }","duration":"1.093388212s","start":"2026-10-17T10:57:21.466157Z","end":"2026-10-17T10:57:22.559545Z","steps":["trace[254505797] 'process raft request' (duration: 843.5138ms)","trace[254505797] 'compare' (duration: 248.488623ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:22.560912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.569838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-10-17T10:57:22.566408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.065316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:57:22.566462Z","caller":"traceutil/trace.go:171","msg":"trace[385855731] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26228; }","duration":"295.150477ms","start":"2026-10-17T10:57:22.271288Z","end":"2026-10-17T10:57:22.566439Z","steps":["trace[385855731] 'agreement among raft nodes before linearized reading' (duration: 289.528197ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:22.566535Z","caller":"traceutil/trace.go:171","msg":"trace[84548397] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:26228; }","duration":"610.2491ms","start":"2026-10-17T10:57:21.956241Z","end":"2026-10-17T10:57:22.56649Z","steps":["trace[84548397] 'agreement among raft nodes before linearized reading' (duration: 604.712882ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.560992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.53579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T10:57:22.566602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.956222Z","time spent":"610.365002ms","remote":"127.0.0.1:53130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true "} {"level":"info","ts":"2026-10-17T10:57:22.56666Z","caller":"traceutil/trace.go:171","msg":"trace[1804866139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26228; }","duration":"643.236302ms","start":"2026-10-17T10:57:21.923386Z","end":"2026-10-17T10:57:22.566622Z","steps":["trace[1804866139] 'agreement among raft nodes before linearized reading' (duration: 637.571551ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.566705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.923353Z","time spent":"643.337514ms","remote":"127.0.0.1:49926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T10:57:22.56705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.337324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T10:57:22.567124Z","caller":"traceutil/trace.go:171","msg":"trace[708686094] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:26228; }","duration":"327.428694ms","start":"2026-10-17T10:57:22.239656Z","end":"2026-10-17T10:57:22.567085Z","steps":["trace[708686094] 'agreement among raft nodes before linearized reading' (duration: 327.314443ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.567166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:22.239635Z","time spent":"327.521066ms","remote":"127.0.0.1:55610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":9,"response size":32,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:57:22.567573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.345389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-17T10:57:22.567639Z","caller":"traceutil/trace.go:171","msg":"trace[1191346859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26228; }","duration":"301.421561ms","start":"2026-10-17T10:57:22.266195Z","end":"2026-10-17T10:57:22.567616Z","steps":["trace[1191346859] 'agreement among raft nodes before linearized reading' (duration: 294.873301ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.567622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.040465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"warn","ts":"2026-10-17T10:57:22.567698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:22.266181Z","time spent":"301.505873ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-17T10:57:22.56782Z","caller":"traceutil/trace.go:171","msg":"trace[1148682104] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:26228; }","duration":"203.214259ms","start":"2026-10-17T10:57:22.364502Z","end":"2026-10-17T10:57:22.567717Z","steps":["trace[1148682104] 'agreement among raft nodes before linearized reading' (duration: 196.242529ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:22.56806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:57:21.466128Z","time spent":"1.101840932s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:57:22.569718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.911092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:57:22.569834Z","caller":"traceutil/trace.go:171","msg":"trace[1800001215] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:26228; }","duration":"126.055455ms","start":"2026-10-17T10:57:22.443726Z","end":"2026-10-17T10:57:22.569782Z","steps":["trace[1800001215] 'agreement among raft nodes before linearized reading' (duration: 125.769069ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:19.020689Z","caller":"traceutil/trace.go:171","msg":"trace[2112447484] linearizableReadLoop","detail":"{readStateIndex:27617; appliedIndex:27616; }","duration":"113.261061ms","start":"2026-10-17T10:58:18.907381Z","end":"2026-10-17T10:58:19.020642Z","steps":["trace[2112447484] 'read index received' (duration: 113.127468ms)","trace[2112447484] 'applied index is now lower than readState.Index' (duration: 132.823µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:19.021105Z","caller":"traceutil/trace.go:171","msg":"trace[1415388930] transaction","detail":"{read_only:false; response_revision:26743; number_of_response:1; }","duration":"137.575719ms","start":"2026-10-17T10:58:18.883513Z","end":"2026-10-17T10:58:19.021088Z","steps":["trace[1415388930] 'process raft request' (duration: 136.980106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:19.021482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.067418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-17T10:58:19.021525Z","caller":"traceutil/trace.go:171","msg":"trace[1496421001] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26743; }","duration":"114.217682ms","start":"2026-10-17T10:58:18.907294Z","end":"2026-10-17T10:58:19.021512Z","steps":["trace[1496421001] 'agreement among raft nodes before linearized reading' (duration: 114.016387ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:19.021899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.181407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-17T10:58:19.021972Z","caller":"traceutil/trace.go:171","msg":"trace[930436751] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:26743; }","duration":"112.29918ms","start":"2026-10-17T10:58:18.909664Z","end":"2026-10-17T10:58:19.021963Z","steps":["trace[930436751] 'agreement among raft nodes before linearized reading' (duration: 112.026714ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:24.529017Z","caller":"traceutil/trace.go:171","msg":"trace[340043074] transaction","detail":"{read_only:false; response_revision:26779; number_of_response:1; }","duration":"119.990975ms","start":"2026-10-17T10:58:24.408994Z","end":"2026-10-17T10:58:24.528985Z","steps":["trace[340043074] 'process raft request' (duration: 119.786281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.221734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.719708ms","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:6"} {"level":"info","ts":"2026-10-17T10:58:25.221841Z","caller":"traceutil/trace.go:171","msg":"trace[550878670] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:26779; }","duration":"438.936083ms","start":"2026-10-17T10:58:24.782877Z","end":"2026-10-17T10:58:25.221813Z","steps":["trace[550878670] 'count revisions from in-memory index tree' (duration: 438.587295ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.221889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.782818Z","time spent":"439.059777ms","remote":"127.0.0.1:55636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"info","ts":"2026-10-17T10:58:25.369822Z","caller":"traceutil/trace.go:171","msg":"trace[1954868496] transaction","detail":"{read_only:false; response_revision:26780; number_of_response:1; }","duration":"539.601967ms","start":"2026-10-17T10:58:24.830196Z","end":"2026-10-17T10:58:25.369798Z","steps":["trace[1954868496] 'process raft request' (duration: 539.434383ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.370151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.830163Z","time spent":"539.732319ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.920318Z","caller":"traceutil/trace.go:171","msg":"trace[1591469797] transaction","detail":"{read_only:false; response_revision:26781; number_of_response:1; }","duration":"1.089932471s","start":"2026-10-17T10:58:24.830349Z","end":"2026-10-17T10:58:25.920282Z","steps":["trace[1591469797] 'process raft request' (duration: 1.070868546s)","trace[1591469797] 'compare' (duration: 18.251448ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:25.920405Z","caller":"traceutil/trace.go:171","msg":"trace[1781787811] transaction","detail":"{read_only:false; response_revision:26783; number_of_response:1; }","duration":"1.083160567s","start":"2026-10-17T10:58:24.837221Z","end":"2026-10-17T10:58:25.920382Z","steps":["trace[1781787811] 'process raft request' (duration: 1.083087805s)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.920473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.830303Z","time spent":"1.090092024s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:58:25.920536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.837192Z","time spent":"1.08327223s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.920659Z","caller":"traceutil/trace.go:171","msg":"trace[745969565] transaction","detail":"{read_only:false; response_revision:26782; number_of_response:1; }","duration":"1.087048269s","start":"2026-10-17T10:58:24.833601Z","end":"2026-10-17T10:58:25.920649Z","steps":["trace[745969565] 'process raft request' (duration: 1.0866196s)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.920702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.833588Z","time spent":"1.0870889s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.921004Z","caller":"traceutil/trace.go:171","msg":"trace[819566013] transaction","detail":"{read_only:false; response_revision:26784; number_of_response:1; }","duration":"1.083521094s","start":"2026-10-17T10:58:24.837441Z","end":"2026-10-17T10:58:25.920962Z","steps":["trace[819566013] 'process raft request' (duration: 1.082909031s)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.921186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.837432Z","time spent":"1.083664378s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.921308Z","caller":"traceutil/trace.go:171","msg":"trace[1574952228] transaction","detail":"{read_only:false; response_revision:26785; number_of_response:1; }","duration":"1.083569925s","start":"2026-10-17T10:58:24.837725Z","end":"2026-10-17T10:58:25.921295Z","steps":["trace[1574952228] 'process raft request' (duration: 1.082812039s)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:25.921311Z","caller":"traceutil/trace.go:171","msg":"trace[301954029] linearizableReadLoop","detail":"{readStateIndex:27660; appliedIndex:27655; }","duration":"872.39763ms","start":"2026-10-17T10:58:25.048894Z","end":"2026-10-17T10:58:25.921292Z","steps":["trace[301954029] 'read index received' (duration: 321.597586ms)","trace[301954029] 'applied index is now lower than readState.Index' (duration: 550.799384ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:25.92139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:24.837713Z","time spent":"1.083634736s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:58:25.921468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.559973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-17T10:58:25.921496Z","caller":"traceutil/trace.go:171","msg":"trace[1486047934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26786; }","duration":"872.675696ms","start":"2026-10-17T10:58:25.048814Z","end":"2026-10-17T10:58:25.921489Z","steps":["trace[1486047934] 'agreement among raft nodes before linearized reading' (duration: 872.563684ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.921518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.048792Z","time spent":"872.720247ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-17T10:58:25.921445Z","caller":"traceutil/trace.go:171","msg":"trace[1176404344] transaction","detail":"{read_only:false; response_revision:26786; number_of_response:1; }","duration":"571.527286ms","start":"2026-10-17T10:58:25.349782Z","end":"2026-10-17T10:58:25.921309Z","steps":["trace[1176404344] 'process raft request' (duration: 571.474635ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.922144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.349757Z","time spent":"572.080978ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.928116Z","caller":"traceutil/trace.go:171","msg":"trace[40029894] transaction","detail":"{read_only:false; response_revision:26787; number_of_response:1; }","duration":"482.404679ms","start":"2026-10-17T10:58:25.445678Z","end":"2026-10-17T10:58:25.928083Z","steps":["trace[40029894] 'process raft request' (duration: 482.173634ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.928229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.445649Z","time spent":"482.528281ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:25.928335Z","caller":"traceutil/trace.go:171","msg":"trace[301059007] transaction","detail":"{read_only:false; response_revision:26788; number_of_response:1; }","duration":"185.173512ms","start":"2026-10-17T10:58:25.743152Z","end":"2026-10-17T10:58:25.928325Z","steps":["trace[301059007] 'process raft request' (duration: 184.817194ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.92861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.408326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-17T10:58:25.92865Z","caller":"traceutil/trace.go:171","msg":"trace[592454836] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26788; }","duration":"860.465947ms","start":"2026-10-17T10:58:25.068172Z","end":"2026-10-17T10:58:25.928638Z","steps":["trace[592454836] 'agreement among raft nodes before linearized reading' (duration: 860.316403ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.928677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.068158Z","time spent":"860.512408ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-17T10:58:25.92873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.095496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T10:58:25.92879Z","caller":"traceutil/trace.go:171","msg":"trace[512558646] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:26788; }","duration":"532.198848ms","start":"2026-10-17T10:58:25.396574Z","end":"2026-10-17T10:58:25.928773Z","steps":["trace[512558646] 'agreement among raft nodes before linearized reading' (duration: 532.085256ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.928808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.878491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-17T10:58:25.928834Z","caller":"traceutil/trace.go:171","msg":"trace[2058884280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26788; }","duration":"865.918612ms","start":"2026-10-17T10:58:25.062906Z","end":"2026-10-17T10:58:25.928825Z","steps":["trace[2058884280] 'agreement among raft nodes before linearized reading' (duration: 865.84072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.928836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.396546Z","time spent":"532.281121ms","remote":"127.0.0.1:50186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":7,"response size":32,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:58:25.928862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.062896Z","time spent":"865.961163ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-17T10:58:25.929067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.425674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-17T10:58:25.929098Z","caller":"traceutil/trace.go:171","msg":"trace[647902038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26788; }","duration":"867.479086ms","start":"2026-10-17T10:58:25.061611Z","end":"2026-10-17T10:58:25.92909Z","steps":["trace[647902038] 'agreement among raft nodes before linearized reading' (duration: 867.391554ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:25.929119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:25.061598Z","time spent":"867.515947ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-17T10:58:25.929209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.47823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:58:25.929244Z","caller":"traceutil/trace.go:171","msg":"trace[702051793] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:26788; }","duration":"187.514631ms","start":"2026-10-17T10:58:25.741719Z","end":"2026-10-17T10:58:25.929234Z","steps":["trace[702051793] 'agreement among raft nodes before linearized reading' (duration: 186.739234ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.081783Z","caller":"traceutil/trace.go:171","msg":"trace[1032901570] linearizableReadLoop","detail":"{readStateIndex:27664; appliedIndex:27663; }","duration":"153.327353ms","start":"2026-10-17T10:58:25.928432Z","end":"2026-10-17T10:58:26.081759Z","steps":["trace[1032901570] 'read index received' (duration: 106.19218ms)","trace[1032901570] 'applied index is now lower than readState.Index' (duration: 47.134153ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:26.082177Z","caller":"traceutil/trace.go:171","msg":"trace[1286872425] transaction","detail":"{read_only:false; response_revision:26789; number_of_response:1; }","duration":"156.405269ms","start":"2026-10-17T10:58:25.925743Z","end":"2026-10-17T10:58:26.082148Z","steps":["trace[1286872425] 'process raft request' (duration: 108.909438ms)","trace[1286872425] 'compare' (duration: 46.98695ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:26.083063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.567805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T10:58:26.083188Z","caller":"traceutil/trace.go:171","msg":"trace[1543442011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26789; }","duration":"158.749988ms","start":"2026-10-17T10:58:25.924408Z","end":"2026-10-17T10:58:26.083158Z","steps":["trace[1543442011] 'agreement among raft nodes before linearized reading' (duration: 157.705916ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.08426Z","caller":"traceutil/trace.go:171","msg":"trace[651302418] transaction","detail":"{read_only:false; response_revision:26790; number_of_response:1; }","duration":"151.850733ms","start":"2026-10-17T10:58:25.932386Z","end":"2026-10-17T10:58:26.084237Z","steps":["trace[651302418] 'process raft request' (duration: 151.578787ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.084539Z","caller":"traceutil/trace.go:171","msg":"trace[1303701173] transaction","detail":"{read_only:false; response_revision:26791; number_of_response:1; }","duration":"150.610417ms","start":"2026-10-17T10:58:25.933906Z","end":"2026-10-17T10:58:26.084517Z","steps":["trace[1303701173] 'process raft request' (duration: 150.183537ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:26.084745Z","caller":"traceutil/trace.go:171","msg":"trace[1759672498] transaction","detail":"{read_only:false; response_revision:26792; number_of_response:1; }","duration":"149.919911ms","start":"2026-10-17T10:58:25.934809Z","end":"2026-10-17T10:58:26.084728Z","steps":["trace[1759672498] 'process raft request' (duration: 149.319028ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:59:45.392842Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24725} {"level":"info","ts":"2026-10-17T10:59:45.544551Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24725,"took":"147.472469ms","hash":2469559958,"current-db-size-bytes":59015168,"current-db-size":"59 MB","current-db-size-in-use-bytes":35971072,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-17T10:59:45.5446Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2469559958,"revision":24725,"compact-revision":21632} {"level":"info","ts":"2026-10-17T11:02:15.417861Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab61124f07c17f20","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:02:15.423806Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T11:02:15.424017Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T11:04:45.400591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27549} {"level":"info","ts":"2026-10-17T11:04:45.534408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27549,"took":"130.393956ms","hash":3701487672,"current-db-size-bytes":59015168,"current-db-size":"59 MB","current-db-size-in-use-bytes":37335040,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-17T11:04:45.53448Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3701487672,"revision":27549,"compact-revision":24725} {"level":"info","ts":"2026-10-17T11:09:45.408586Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30302} {"level":"info","ts":"2026-10-17T11:09:45.564679Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30302,"took":"150.993136ms","hash":69984904,"current-db-size-bytes":59015168,"current-db-size":"59 MB","current-db-size-in-use-bytes":30744576,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:09:45.56476Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":69984904,"revision":30302,"compact-revision":27549} {"level":"info","ts":"2026-10-17T11:14:45.417234Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32586} {"level":"info","ts":"2026-10-17T11:14:45.575207Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32586,"took":"153.337785ms","hash":724567057,"current-db-size-bytes":59015168,"current-db-size":"59 MB","current-db-size-in-use-bytes":30216192,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:14:45.575282Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":724567057,"revision":32586,"compact-revision":30302} {"level":"info","ts":"2026-10-17T11:19:45.424751Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34812} {"level":"info","ts":"2026-10-17T11:19:45.567005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34812,"took":"137.774126ms","hash":731581995,"current-db-size-bytes":59015168,"current-db-size":"59 MB","current-db-size-in-use-bytes":31182848,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:19:45.567108Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":731581995,"revision":34812,"compact-revision":32586} {"level":"info","ts":"2026-10-17T11:23:25.95699Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab61124f07c17f20","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:23:25.964437Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T11:23:25.964777Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T11:24:45.437714Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37112} {"level":"info","ts":"2026-10-17T11:24:45.59175Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37112,"took":"150.005636ms","hash":3285839685,"current-db-size-bytes":60284928,"current-db-size":"60 MB","current-db-size-in-use-bytes":32993280,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T11:24:45.591858Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3285839685,"revision":37112,"compact-revision":34812} {"level":"info","ts":"2026-10-17T11:29:45.446531Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39382} {"level":"info","ts":"2026-10-17T11:29:45.58048Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39382,"took":"129.941357ms","hash":306543053,"current-db-size-bytes":62828544,"current-db-size":"63 MB","current-db-size-in-use-bytes":32161792,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:29:45.580553Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":306543053,"revision":39382,"compact-revision":37112}