{"level":"warn","ts":"2026-09-03T16:22:17.880924Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-03T16:22:17.881037Z","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-09-03T16:22:17.881126Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-03T16:22:17.881138Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.149:2380"]} {"level":"info","ts":"2026-09-03T16:22:17.881156Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-03T16:22:17.881881Z","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-09-03T16:22:17.881981Z","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-09-03T16:22:17.886244Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.993514ms"} {"level":"info","ts":"2026-09-03T16:22:17.897244Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab61124f07c17f20","cluster-id":"c5f62e84ad801ad2"} {"level":"info","ts":"2026-09-03T16:22:17.897507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=()"} {"level":"info","ts":"2026-09-03T16:22:17.897579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became follower at term 0"} {"level":"info","ts":"2026-09-03T16:22:17.897603Z","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-09-03T16:22:17.897646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became follower at term 1"} {"level":"info","ts":"2026-09-03T16:22:17.897747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=(12349171783868448544)"} {"level":"warn","ts":"2026-09-03T16:22:17.905356Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-03T16:22:17.907411Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-03T16:22:17.909346Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-03T16:22:17.912656Z","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-09-03T16:22:17.91291Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-03T16:22:17.913164Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-03T16:22:17.9132Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-03T16:22:17.913143Z","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-09-03T16:22:17.915804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=(12349171783868448544)"} {"level":"info","ts":"2026-09-03T16:22:17.917215Z","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-09-03T16:22:17.922502Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-03T16:22:17.922647Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.149:2380"} {"level":"info","ts":"2026-09-03T16:22:17.922703Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.149:2380"} {"level":"info","ts":"2026-09-03T16:22:17.922976Z","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-09-03T16:22:17.923056Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-03T16:22:18.898973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 is starting a new election at term 1"} {"level":"info","ts":"2026-09-03T16:22:18.899074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-03T16:22:18.89927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 received MsgPreVoteResp from ab61124f07c17f20 at term 1"} {"level":"info","ts":"2026-09-03T16:22:18.899309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became candidate at term 2"} {"level":"info","ts":"2026-09-03T16:22:18.899321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 received MsgVoteResp from ab61124f07c17f20 at term 2"} {"level":"info","ts":"2026-09-03T16:22:18.899341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became leader at term 2"} {"level":"info","ts":"2026-09-03T16:22:18.899356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab61124f07c17f20 elected leader ab61124f07c17f20 at term 2"} {"level":"info","ts":"2026-09-03T16:22:18.900455Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T16:22:18.901428Z","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-09-03T16:22:18.901434Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-03T16:22:18.901483Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-03T16:22:18.901832Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-03T16:22:18.901859Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-03T16:22:18.901926Z","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-09-03T16:22:18.902095Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T16:22:18.90216Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T16:22:18.904652Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-03T16:22:18.904647Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.149:2379"} {"level":"info","ts":"2026-09-03T16:22:35.456711Z","caller":"traceutil/trace.go:171","msg":"trace[40554972] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"172.039724ms","start":"2026-09-03T16:22:35.284645Z","end":"2026-09-03T16:22:35.456684Z","steps":["trace[40554972] 'process raft request' (duration: 171.908022ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:23:01.653056Z","caller":"traceutil/trace.go:171","msg":"trace[2034692465] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:514; }","duration":"176.142669ms","start":"2026-09-03T16:23:01.476876Z","end":"2026-09-03T16:23:01.653018Z","steps":["trace[2034692465] 'read index received' (duration: 175.810062ms)","trace[2034692465] 'applied index is now lower than readState.Index' (duration: 330.707µs)"],"step_count":2} {"level":"warn","ts":"2026-09-03T16:23:01.653241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.329533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:23:01.65324Z","caller":"traceutil/trace.go:171","msg":"trace[95232150] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"221.136472ms","start":"2026-09-03T16:23:01.432054Z","end":"2026-09-03T16:23:01.653191Z","steps":["trace[95232150] 'process raft request' (duration: 220.769134ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:23:01.653391Z","caller":"traceutil/trace.go:171","msg":"trace[679807895] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:498; }","duration":"176.505067ms","start":"2026-09-03T16:23:01.476829Z","end":"2026-09-03T16:23:01.653334Z","steps":["trace[679807895] 'agreement among raft nodes before linearized reading' (duration: 176.338953ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:23:08.831556Z","caller":"traceutil/trace.go:171","msg":"trace[1701050527] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"246.331855ms","start":"2026-09-03T16:23:08.585183Z","end":"2026-09-03T16:23:08.831515Z","steps":["trace[1701050527] 'process raft request' (duration: 245.625069ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:23:09.379423Z","caller":"traceutil/trace.go:171","msg":"trace[1863771558] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"460.130012ms","start":"2026-09-03T16:23:08.919264Z","end":"2026-09-03T16:23:09.379394Z","steps":["trace[1863771558] 'read index received' (duration: 459.968568ms)","trace[1863771558] 'applied index is now lower than readState.Index' (duration: 160.164µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:23:09.379567Z","caller":"traceutil/trace.go:171","msg":"trace[874672474] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"464.235968ms","start":"2026-09-03T16:23:08.915318Z","end":"2026-09-03T16:23:09.379554Z","steps":["trace[874672474] 'process raft request' (duration: 463.905821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:23:09.37979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.775021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-03T16:23:09.379837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.573561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-03T16:23:09.379868Z","caller":"traceutil/trace.go:171","msg":"trace[469408524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"286.905654ms","start":"2026-09-03T16:23:09.092944Z","end":"2026-09-03T16:23:09.37985Z","steps":["trace[469408524] 'agreement among raft nodes before linearized reading' (duration: 286.70927ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:23:09.37987Z","caller":"traceutil/trace.go:171","msg":"trace[792843613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"460.642872ms","start":"2026-09-03T16:23:08.919215Z","end":"2026-09-03T16:23:09.379858Z","steps":["trace[792843613] 'agreement among raft nodes before linearized reading' (duration: 460.568051ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:23:09.379894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T16:23:08.919187Z","time spent":"460.701803ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-03T16:23:09.380174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T16:23:08.915289Z","time spent":"464.31259ms","remote":"127.0.0.1:48900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-03T16:23:10.612314Z","caller":"traceutil/trace.go:171","msg":"trace[1455782710] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"119.150972ms","start":"2026-09-03T16:23:10.493108Z","end":"2026-09-03T16:23:10.612259Z","steps":["trace[1455782710] 'process raft request' (duration: 98.611877ms)","trace[1455782710] 'compare' (duration: 20.359321ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:23:25.623065Z","caller":"traceutil/trace.go:171","msg":"trace[1186031414] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:802; }","duration":"128.95283ms","start":"2026-09-03T16:23:25.49408Z","end":"2026-09-03T16:23:25.623033Z","steps":["trace[1186031414] 'read index received' (duration: 128.607913ms)","trace[1186031414] 'applied index is now lower than readState.Index' (duration: 343.657µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:23:25.623119Z","caller":"traceutil/trace.go:171","msg":"trace[1407817907] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"133.048377ms","start":"2026-09-03T16:23:25.49003Z","end":"2026-09-03T16:23:25.623078Z","steps":["trace[1407817907] 'process raft request' (duration: 132.791352ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:23:25.623296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.180795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-03T16:23:25.62338Z","caller":"traceutil/trace.go:171","msg":"trace[1777366801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"129.313368ms","start":"2026-09-03T16:23:25.494054Z","end":"2026-09-03T16:23:25.623367Z","steps":["trace[1777366801] 'agreement among raft nodes before linearized reading' (duration: 129.103334ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:23:25.798899Z","caller":"traceutil/trace.go:171","msg":"trace[1455721752] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"272.967319ms","start":"2026-09-03T16:23:25.525883Z","end":"2026-09-03T16:23:25.79885Z","steps":["trace[1455721752] 'process raft request' (duration: 224.092344ms)","trace[1455721752] 'compare' (duration: 48.6539ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:23:25.799095Z","caller":"traceutil/trace.go:171","msg":"trace[1453004448] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"211.437597ms","start":"2026-09-03T16:23:25.587587Z","end":"2026-09-03T16:23:25.799024Z","steps":["trace[1453004448] 'process raft request' (duration: 211.197361ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:23:25.806277Z","caller":"traceutil/trace.go:171","msg":"trace[1154626348] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"177.930027ms","start":"2026-09-03T16:23:25.628313Z","end":"2026-09-03T16:23:25.806243Z","steps":["trace[1154626348] 'process raft request' (duration: 177.742063ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:23:57.323595Z","caller":"traceutil/trace.go:171","msg":"trace[619814932] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"165.474065ms","start":"2026-09-03T16:23:57.158091Z","end":"2026-09-03T16:23:57.323565Z","steps":["trace[619814932] 'process raft request' (duration: 164.453473ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:24:45.547333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.454224ms","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-09-03T16:24:45.54743Z","caller":"traceutil/trace.go:171","msg":"trace[1886776773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1853; }","duration":"102.623947ms","start":"2026-09-03T16:24:45.444783Z","end":"2026-09-03T16:24:45.547407Z","steps":["trace[1886776773] 'range keys from in-memory index tree' (duration: 102.262869ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:25:42.581605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.738552ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T16:25:42.581773Z","caller":"traceutil/trace.go:171","msg":"trace[333195704] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"255.966378ms","start":"2026-09-03T16:25:42.325793Z","end":"2026-09-03T16:25:42.58176Z","steps":["trace[333195704] 'process raft request' (duration: 255.904627ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:25:42.581854Z","caller":"traceutil/trace.go:171","msg":"trace[1422937142] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"273.876785ms","start":"2026-09-03T16:25:42.307941Z","end":"2026-09-03T16:25:42.581817Z","steps":["trace[1422937142] 'process raft request' (duration: 136.671792ms)","trace[1422937142] 'compare' (duration: 136.62807ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:26:34.830712Z","caller":"traceutil/trace.go:171","msg":"trace[2121689275] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"165.954298ms","start":"2026-09-03T16:26:34.664737Z","end":"2026-09-03T16:26:34.830691Z","steps":["trace[2121689275] 'process raft request' (duration: 165.828816ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:27:05.389665Z","caller":"traceutil/trace.go:171","msg":"trace[1777298714] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"121.426733ms","start":"2026-09-03T16:27:05.268208Z","end":"2026-09-03T16:27:05.389634Z","steps":["trace[1777298714] 'process raft request' (duration: 121.184308ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:30:28.59268Z","caller":"traceutil/trace.go:171","msg":"trace[349371824] transaction","detail":"{read_only:false; response_revision:4130; number_of_response:1; }","duration":"109.14974ms","start":"2026-09-03T16:30:28.483503Z","end":"2026-09-03T16:30:28.592652Z","steps":["trace[349371824] 'process raft request' (duration: 108.983667ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:30:28.592875Z","caller":"traceutil/trace.go:171","msg":"trace[2048327304] linearizableReadLoop","detail":"{readStateIndex:4284; appliedIndex:4284; }","duration":"108.432286ms","start":"2026-09-03T16:30:28.484409Z","end":"2026-09-03T16:30:28.592841Z","steps":["trace[2048327304] 'read index received' (duration: 108.414816ms)","trace[2048327304] 'applied index is now lower than readState.Index' (duration: 14.68µs)"],"step_count":2} {"level":"warn","ts":"2026-09-03T16:30:28.593084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.654771ms","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-09-03T16:30:28.59319Z","caller":"traceutil/trace.go:171","msg":"trace[1021830423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4130; }","duration":"108.789443ms","start":"2026-09-03T16:30:28.484358Z","end":"2026-09-03T16:30:28.593148Z","steps":["trace[1021830423] 'agreement among raft nodes before linearized reading' (duration: 108.598669ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:30:28.622613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.358546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:30:28.622682Z","caller":"traceutil/trace.go:171","msg":"trace[1666075076] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:4131; }","duration":"134.467007ms","start":"2026-09-03T16:30:28.488202Z","end":"2026-09-03T16:30:28.622669Z","steps":["trace[1666075076] 'agreement among raft nodes before linearized reading' (duration: 134.327064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:30:28.622858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.147198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:30:28.622934Z","caller":"traceutil/trace.go:171","msg":"trace[1053686434] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:4131; }","duration":"115.25324ms","start":"2026-09-03T16:30:28.507662Z","end":"2026-09-03T16:30:28.622915Z","steps":["trace[1053686434] 'agreement among raft nodes before linearized reading' (duration: 115.156178ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:49.563542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.232633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2210296"} {"level":"info","ts":"2026-09-03T16:31:49.563614Z","caller":"traceutil/trace.go:171","msg":"trace[579256755] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:5081; }","duration":"109.344825ms","start":"2026-09-03T16:31:49.454255Z","end":"2026-09-03T16:31:49.5636Z","steps":["trace[579256755] 'range keys from in-memory index tree' (duration: 108.432855ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:31:57.320931Z","caller":"traceutil/trace.go:171","msg":"trace[1938098420] linearizableReadLoop","detail":"{readStateIndex:5496; appliedIndex:5495; }","duration":"374.098642ms","start":"2026-09-03T16:31:56.946802Z","end":"2026-09-03T16:31:57.320901Z","steps":["trace[1938098420] 'read index received' (duration: 373.810406ms)","trace[1938098420] 'applied index is now lower than readState.Index' (duration: 286.726µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:31:57.321055Z","caller":"traceutil/trace.go:171","msg":"trace[1551760197] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"441.461758ms","start":"2026-09-03T16:31:56.879553Z","end":"2026-09-03T16:31:57.321015Z","steps":["trace[1551760197] 'process raft request' (duration: 441.091051ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:57.321281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T16:31:56.87952Z","time spent":"441.681873ms","remote":"127.0.0.1:48520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58202,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-03T16:31:57.322182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.318587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:54 size:2221296"} {"level":"info","ts":"2026-09-03T16:31:57.322264Z","caller":"traceutil/trace.go:171","msg":"trace[1698021701] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:54; response_revision:5299; }","duration":"375.481701ms","start":"2026-09-03T16:31:56.946761Z","end":"2026-09-03T16:31:57.322243Z","steps":["trace[1698021701] 'agreement among raft nodes before linearized reading' (duration: 374.277526ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:57.322318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T16:31:56.946742Z","time spent":"375.559433ms","remote":"127.0.0.1:48524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":54,"response size":2221320,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-09-03T16:31:57.357398Z","caller":"traceutil/trace.go:171","msg":"trace[1922307309] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"391.125733ms","start":"2026-09-03T16:31:56.96624Z","end":"2026-09-03T16:31:57.357366Z","steps":["trace[1922307309] 'process raft request' (duration: 390.876548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:57.357609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T16:31:56.96622Z","time spent":"391.296647ms","remote":"127.0.0.1:48656","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-09-03T16:31:57.357754Z","caller":"traceutil/trace.go:171","msg":"trace[1539608368] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"156.77337ms","start":"2026-09-03T16:31:57.200944Z","end":"2026-09-03T16:31:57.357717Z","steps":["trace[1539608368] 'process raft request' (duration: 156.365341ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:57.358013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.191134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8lknb\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-09-03T16:31:57.35807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.92924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ccb4e25a-891b-4469-8ceb-92082a86d5d6\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-09-03T16:31:57.35823Z","caller":"traceutil/trace.go:171","msg":"trace[489557177] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ccb4e25a-891b-4469-8ceb-92082a86d5d6; range_end:; response_count:1; response_revision:5301; }","duration":"172.128865ms","start":"2026-09-03T16:31:57.186076Z","end":"2026-09-03T16:31:57.358205Z","steps":["trace[489557177] 'agreement among raft nodes before linearized reading' (duration: 171.798348ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:57.358305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.424922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-03T16:31:57.358297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.279388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-03T16:31:57.358378Z","caller":"traceutil/trace.go:171","msg":"trace[1731397383] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5301; }","duration":"334.533734ms","start":"2026-09-03T16:31:57.023826Z","end":"2026-09-03T16:31:57.35836Z","steps":["trace[1731397383] 'agreement among raft nodes before linearized reading' (duration: 334.302689ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:31:57.358082Z","caller":"traceutil/trace.go:171","msg":"trace[1832555662] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8lknb; range_end:; response_count:1; response_revision:5301; }","duration":"254.302106ms","start":"2026-09-03T16:31:57.103763Z","end":"2026-09-03T16:31:57.358065Z","steps":["trace[1832555662] 'agreement among raft nodes before linearized reading' (duration: 254.084861ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:57.358425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T16:31:57.0238Z","time spent":"334.612475ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-03T16:31:57.358409Z","caller":"traceutil/trace.go:171","msg":"trace[359868587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5301; }","duration":"325.436092ms","start":"2026-09-03T16:31:57.032952Z","end":"2026-09-03T16:31:57.358389Z","steps":["trace[359868587] 'agreement among raft nodes before linearized reading' (duration: 325.142566ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:57.358502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T16:31:57.032929Z","time spent":"325.557214ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-03T16:31:57.358526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.501785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ccb4e25a-891b-4469-8ceb-92082a86d5d6\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-09-03T16:31:57.358653Z","caller":"traceutil/trace.go:171","msg":"trace[1361058166] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ccb4e25a-891b-4469-8ceb-92082a86d5d6; range_end:; response_count:1; response_revision:5301; }","duration":"404.658879ms","start":"2026-09-03T16:31:56.953969Z","end":"2026-09-03T16:31:57.358628Z","steps":["trace[1361058166] 'agreement among raft nodes before linearized reading' (duration: 403.845652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:57.358721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T16:31:56.95395Z","time spent":"404.75295ms","remote":"127.0.0.1:48582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3625,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ccb4e25a-891b-4469-8ceb-92082a86d5d6\" "} {"level":"info","ts":"2026-09-03T16:31:59.469083Z","caller":"traceutil/trace.go:171","msg":"trace[1030570391] linearizableReadLoop","detail":"{readStateIndex:5541; appliedIndex:5540; }","duration":"100.658161ms","start":"2026-09-03T16:31:59.368396Z","end":"2026-09-03T16:31:59.469054Z","steps":["trace[1030570391] 'read index received' (duration: 100.532949ms)","trace[1030570391] 'applied index is now lower than readState.Index' (duration: 123.932µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:31:59.469178Z","caller":"traceutil/trace.go:171","msg":"trace[388308733] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"105.32204ms","start":"2026-09-03T16:31:59.363783Z","end":"2026-09-03T16:31:59.469105Z","steps":["trace[388308733] 'process raft request' (duration: 105.089285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:31:59.469355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.936728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ccb4e25a-891b-4469-8ceb-92082a86d5d6\" ","response":"range_response_count:1 size:3907"} {"level":"info","ts":"2026-09-03T16:31:59.469422Z","caller":"traceutil/trace.go:171","msg":"trace[2033907956] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ccb4e25a-891b-4469-8ceb-92082a86d5d6; range_end:; response_count:1; response_revision:5342; }","duration":"101.06847ms","start":"2026-09-03T16:31:59.368335Z","end":"2026-09-03T16:31:59.469404Z","steps":["trace[2033907956] 'agreement among raft nodes before linearized reading' (duration: 100.861586ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:32:04.296257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.675379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T16:32:04.296443Z","caller":"traceutil/trace.go:171","msg":"trace[1197586128] linearizableReadLoop","detail":"{readStateIndex:5641; appliedIndex:5640; }","duration":"143.446798ms","start":"2026-09-03T16:32:04.15297Z","end":"2026-09-03T16:32:04.296417Z","steps":["trace[1197586128] 'read index received' (duration: 40.02µs)","trace[1197586128] 'applied index is now lower than readState.Index' (duration: 143.404918ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:32:04.296472Z","caller":"traceutil/trace.go:171","msg":"trace[1367986869] transaction","detail":"{read_only:false; response_revision:5439; number_of_response:1; }","duration":"229.571081ms","start":"2026-09-03T16:32:04.06686Z","end":"2026-09-03T16:32:04.296431Z","steps":["trace[1367986869] 'process raft request' (duration: 21.775371ms)","trace[1367986869] 'compare' (duration: 207.063764ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T16:32:04.296937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.96026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T16:32:04.296987Z","caller":"traceutil/trace.go:171","msg":"trace[690951526] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5439; }","duration":"144.042801ms","start":"2026-09-03T16:32:04.152932Z","end":"2026-09-03T16:32:04.296975Z","steps":["trace[690951526] 'agreement among raft nodes before linearized reading' (duration: 143.575821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:32:04.310212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.126005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:32:04.310315Z","caller":"traceutil/trace.go:171","msg":"trace[1190157041] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:5440; }","duration":"129.278129ms","start":"2026-09-03T16:32:04.181011Z","end":"2026-09-03T16:32:04.310289Z","steps":["trace[1190157041] 'agreement among raft nodes before linearized reading' (duration: 129.068145ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:32:04.310326Z","caller":"traceutil/trace.go:171","msg":"trace[591247221] transaction","detail":"{read_only:false; response_revision:5440; number_of_response:1; }","duration":"115.008725ms","start":"2026-09-03T16:32:04.195295Z","end":"2026-09-03T16:32:04.310304Z","steps":["trace[591247221] 'process raft request' (duration: 114.605377ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:32:04.590172Z","caller":"traceutil/trace.go:171","msg":"trace[1681765421] transaction","detail":"{read_only:false; response_revision:5448; number_of_response:1; }","duration":"110.435849ms","start":"2026-09-03T16:32:04.479679Z","end":"2026-09-03T16:32:04.590115Z","steps":["trace[1681765421] 'process raft request' (duration: 110.283965ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:32:11.653508Z","caller":"traceutil/trace.go:171","msg":"trace[1111927302] transaction","detail":"{read_only:false; response_revision:5567; number_of_response:1; }","duration":"181.103345ms","start":"2026-09-03T16:32:11.472373Z","end":"2026-09-03T16:32:11.653476Z","steps":["trace[1111927302] 'process raft request' (duration: 88.75373ms)","trace[1111927302] 'compare' (duration: 92.009228ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:32:11.653584Z","caller":"traceutil/trace.go:171","msg":"trace[559293557] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"181.074015ms","start":"2026-09-03T16:32:11.472472Z","end":"2026-09-03T16:32:11.653546Z","steps":["trace[559293557] 'process raft request' (duration: 180.873171ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:32:11.653729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.313881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T16:32:11.653791Z","caller":"traceutil/trace.go:171","msg":"trace[355989616] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:5570; }","duration":"140.424994ms","start":"2026-09-03T16:32:11.51335Z","end":"2026-09-03T16:32:11.653775Z","steps":["trace[355989616] 'agreement among raft nodes before linearized reading' (duration: 140.283411ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:32:11.653884Z","caller":"traceutil/trace.go:171","msg":"trace[27893805] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"143.602541ms","start":"2026-09-03T16:32:11.510269Z","end":"2026-09-03T16:32:11.653872Z","steps":["trace[27893805] 'process raft request' (duration: 143.235683ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:32:11.653587Z","caller":"traceutil/trace.go:171","msg":"trace[1025627001] linearizableReadLoop","detail":"{readStateIndex:5775; appliedIndex:5771; }","duration":"140.166888ms","start":"2026-09-03T16:32:11.513399Z","end":"2026-09-03T16:32:11.653566Z","steps":["trace[1025627001] 'read index received' (duration: 47.941885ms)","trace[1025627001] 'applied index is now lower than readState.Index' (duration: 92.223863ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:32:11.653612Z","caller":"traceutil/trace.go:171","msg":"trace[790057218] transaction","detail":"{read_only:false; response_revision:5569; number_of_response:1; }","duration":"181.019954ms","start":"2026-09-03T16:32:11.472567Z","end":"2026-09-03T16:32:11.653587Z","steps":["trace[790057218] 'process raft request' (duration: 180.86318ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:32:18.927187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2933} {"level":"info","ts":"2026-09-03T16:32:19.008205Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2933,"took":"79.757808ms","hash":3894373921,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":31719424,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-03T16:32:19.008254Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3894373921,"revision":2933,"compact-revision":-1} {"level":"info","ts":"2026-09-03T16:32:19.928907Z","caller":"traceutil/trace.go:171","msg":"trace[1152767825] linearizableReadLoop","detail":"{readStateIndex:5907; appliedIndex:5905; }","duration":"175.049087ms","start":"2026-09-03T16:32:19.753831Z","end":"2026-09-03T16:32:19.92888Z","steps":["trace[1152767825] 'read index received' (duration: 72.520716ms)","trace[1152767825] 'applied index is now lower than readState.Index' (duration: 102.527241ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:32:19.928982Z","caller":"traceutil/trace.go:171","msg":"trace[317995216] transaction","detail":"{read_only:false; response_revision:5699; number_of_response:1; }","duration":"176.723752ms","start":"2026-09-03T16:32:19.752191Z","end":"2026-09-03T16:32:19.928915Z","steps":["trace[317995216] 'process raft request' (duration: 135.373426ms)","trace[317995216] 'compare' (duration: 41.207583ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T16:32:19.929095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.063052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:32:19.929159Z","caller":"traceutil/trace.go:171","msg":"trace[2066936440] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5699; }","duration":"145.161404ms","start":"2026-09-03T16:32:19.783962Z","end":"2026-09-03T16:32:19.929124Z","steps":["trace[2066936440] 'agreement among raft nodes before linearized reading' (duration: 145.077783ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:32:19.929306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.466846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80213"} {"level":"info","ts":"2026-09-03T16:32:19.929378Z","caller":"traceutil/trace.go:171","msg":"trace[1926271019] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5699; }","duration":"175.561548ms","start":"2026-09-03T16:32:19.753802Z","end":"2026-09-03T16:32:19.929364Z","steps":["trace[1926271019] 'agreement among raft nodes before linearized reading' (duration: 175.17827ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:32:22.495515Z","caller":"traceutil/trace.go:171","msg":"trace[152789612] transaction","detail":"{read_only:false; response_revision:5720; number_of_response:1; }","duration":"106.214749ms","start":"2026-09-03T16:32:22.389268Z","end":"2026-09-03T16:32:22.495483Z","steps":["trace[152789612] 'process raft request' (duration: 106.080346ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:32:37.98863Z","caller":"traceutil/trace.go:171","msg":"trace[382462750] transaction","detail":"{read_only:false; response_revision:5925; number_of_response:1; }","duration":"159.14348ms","start":"2026-09-03T16:32:37.829457Z","end":"2026-09-03T16:32:37.988601Z","steps":["trace[382462750] 'process raft request' (duration: 158.916175ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:37:18.936509Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5680} {"level":"info","ts":"2026-09-03T16:37:19.027284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5680,"took":"89.206147ms","hash":2581622536,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":25899008,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-03T16:37:19.027353Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2581622536,"revision":5680,"compact-revision":2933} {"level":"info","ts":"2026-09-03T16:38:57.601051Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002356.wal"} {"level":"info","ts":"2026-09-03T16:38:58.288518Z","caller":"traceutil/trace.go:171","msg":"trace[333818823] linearizableReadLoop","detail":"{readStateIndex:9055; appliedIndex:9053; }","duration":"141.268937ms","start":"2026-09-03T16:38:58.14722Z","end":"2026-09-03T16:38:58.288489Z","steps":["trace[333818823] 'read index received' (duration: 48.6981ms)","trace[333818823] 'applied index is now lower than readState.Index' (duration: 92.569687ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:38:58.288625Z","caller":"traceutil/trace.go:171","msg":"trace[1004282375] transaction","detail":"{read_only:false; response_revision:8748; number_of_response:1; }","duration":"145.149858ms","start":"2026-09-03T16:38:58.143433Z","end":"2026-09-03T16:38:58.288583Z","steps":["trace[1004282375] 'process raft request' (duration: 119.084683ms)","trace[1004282375] 'compare' (duration: 25.845251ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T16:38:58.288868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.620774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-03T16:38:58.288914Z","caller":"traceutil/trace.go:171","msg":"trace[243287755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8748; }","duration":"141.722277ms","start":"2026-09-03T16:38:58.14718Z","end":"2026-09-03T16:38:58.288903Z","steps":["trace[243287755] 'agreement among raft nodes before linearized reading' (duration: 141.451881ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:02.150413Z","caller":"traceutil/trace.go:171","msg":"trace[1038643012] transaction","detail":"{read_only:false; response_revision:8764; number_of_response:1; }","duration":"220.540225ms","start":"2026-09-03T16:39:01.929847Z","end":"2026-09-03T16:39:02.150387Z","steps":["trace[1038643012] 'process raft request' (duration: 220.31695ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:02.173481Z","caller":"traceutil/trace.go:171","msg":"trace[1278013671] transaction","detail":"{read_only:false; response_revision:8765; number_of_response:1; }","duration":"115.003658ms","start":"2026-09-03T16:39:02.058453Z","end":"2026-09-03T16:39:02.173456Z","steps":["trace[1278013671] 'process raft request' (duration: 114.506866ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:02.33612Z","caller":"traceutil/trace.go:171","msg":"trace[1310605207] linearizableReadLoop","detail":"{readStateIndex:9074; appliedIndex:9073; }","duration":"114.300282ms","start":"2026-09-03T16:39:02.221798Z","end":"2026-09-03T16:39:02.336098Z","steps":["trace[1310605207] 'read index received' (duration: 114.085268ms)","trace[1310605207] 'applied index is now lower than readState.Index' (duration: 214.184µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:39:02.336168Z","caller":"traceutil/trace.go:171","msg":"trace[293743449] transaction","detail":"{read_only:false; response_revision:8767; number_of_response:1; }","duration":"128.360716ms","start":"2026-09-03T16:39:02.207782Z","end":"2026-09-03T16:39:02.336143Z","steps":["trace[293743449] 'process raft request' (duration: 128.138822ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:39:02.33627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.457395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:39:02.336343Z","caller":"traceutil/trace.go:171","msg":"trace[250391298] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:8767; }","duration":"114.585858ms","start":"2026-09-03T16:39:02.221744Z","end":"2026-09-03T16:39:02.33633Z","steps":["trace[250391298] 'agreement among raft nodes before linearized reading' (duration: 114.459385ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:14.563343Z","caller":"traceutil/trace.go:171","msg":"trace[2126148982] transaction","detail":"{read_only:false; response_revision:8830; number_of_response:1; }","duration":"142.489624ms","start":"2026-09-03T16:39:14.420826Z","end":"2026-09-03T16:39:14.563316Z","steps":["trace[2126148982] 'process raft request' (duration: 99.582599ms)","trace[2126148982] 'compare' (duration: 42.66427ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:39:14.570924Z","caller":"traceutil/trace.go:171","msg":"trace[1191554447] linearizableReadLoop","detail":"{readStateIndex:9141; appliedIndex:9139; }","duration":"140.758989ms","start":"2026-09-03T16:39:14.430144Z","end":"2026-09-03T16:39:14.570903Z","steps":["trace[1191554447] 'read index received' (duration: 90.276865ms)","trace[1191554447] 'applied index is now lower than readState.Index' (duration: 50.480944ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:39:14.571038Z","caller":"traceutil/trace.go:171","msg":"trace[417329822] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"150.187015ms","start":"2026-09-03T16:39:14.42083Z","end":"2026-09-03T16:39:14.570982Z","steps":["trace[417329822] 'process raft request' (duration: 149.958361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:39:14.571259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.095356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-09-03T16:39:14.571325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.924695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8lknb\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-09-03T16:39:14.571335Z","caller":"traceutil/trace.go:171","msg":"trace[1623452185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8831; }","duration":"141.207578ms","start":"2026-09-03T16:39:14.430113Z","end":"2026-09-03T16:39:14.571321Z","steps":["trace[1623452185] 'agreement among raft nodes before linearized reading' (duration: 141.028824ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:14.571381Z","caller":"traceutil/trace.go:171","msg":"trace[503138846] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8lknb; range_end:; response_count:1; response_revision:8831; }","duration":"122.005727ms","start":"2026-09-03T16:39:14.449359Z","end":"2026-09-03T16:39:14.571365Z","steps":["trace[503138846] 'agreement among raft nodes before linearized reading' (duration: 121.859194ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:39:14.571397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.634431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-03T16:39:14.571499Z","caller":"traceutil/trace.go:171","msg":"trace[1287860739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8831; }","duration":"136.790316ms","start":"2026-09-03T16:39:14.434687Z","end":"2026-09-03T16:39:14.571477Z","steps":["trace[1287860739] 'agreement among raft nodes before linearized reading' (duration: 136.534771ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:40.505663Z","caller":"traceutil/trace.go:171","msg":"trace[449231677] transaction","detail":"{read_only:false; response_revision:9023; number_of_response:1; }","duration":"114.831997ms","start":"2026-09-03T16:39:40.390805Z","end":"2026-09-03T16:39:40.505637Z","steps":["trace[449231677] 'process raft request' (duration: 110.258682ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:42.702569Z","caller":"traceutil/trace.go:171","msg":"trace[411235175] transaction","detail":"{read_only:false; response_revision:9037; number_of_response:1; }","duration":"165.25384ms","start":"2026-09-03T16:39:42.537287Z","end":"2026-09-03T16:39:42.702541Z","steps":["trace[411235175] 'process raft request' (duration: 165.181918ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:42.70265Z","caller":"traceutil/trace.go:171","msg":"trace[642400130] transaction","detail":"{read_only:false; response_revision:9036; number_of_response:1; }","duration":"165.310251ms","start":"2026-09-03T16:39:42.537286Z","end":"2026-09-03T16:39:42.702596Z","steps":["trace[642400130] 'process raft request' (duration: 160.163983ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:44.712515Z","caller":"traceutil/trace.go:171","msg":"trace[1052408155] transaction","detail":"{read_only:false; response_revision:9045; number_of_response:1; }","duration":"179.555179ms","start":"2026-09-03T16:39:44.532931Z","end":"2026-09-03T16:39:44.712487Z","steps":["trace[1052408155] 'process raft request' (duration: 179.318064ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:39:47.206011Z","caller":"traceutil/trace.go:171","msg":"trace[1884798225] transaction","detail":"{read_only:false; response_revision:9062; number_of_response:1; }","duration":"137.219935ms","start":"2026-09-03T16:39:47.068724Z","end":"2026-09-03T16:39:47.205944Z","steps":["trace[1884798225] 'process raft request' (duration: 109.363404ms)","trace[1884798225] 'compare' (duration: 27.563465ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:39:47.988336Z","caller":"traceutil/trace.go:171","msg":"trace[355632951] transaction","detail":"{read_only:false; response_revision:9064; number_of_response:1; }","duration":"246.985457ms","start":"2026-09-03T16:39:47.741323Z","end":"2026-09-03T16:39:47.988308Z","steps":["trace[355632951] 'process raft request' (duration: 246.818683ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:40:57.648407Z","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-09-03T16:40:57.658857Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-03T16:40:57.658981Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-03T16:41:28.067648Z","caller":"traceutil/trace.go:171","msg":"trace[120191214] linearizableReadLoop","detail":"{readStateIndex:10329; appliedIndex:10328; }","duration":"142.454856ms","start":"2026-09-03T16:41:27.925161Z","end":"2026-09-03T16:41:28.067616Z","steps":["trace[120191214] 'read index received' (duration: 112.526285ms)","trace[120191214] 'applied index is now lower than readState.Index' (duration: 29.926821ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T16:41:28.067967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.748591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-03T16:41:28.06807Z","caller":"traceutil/trace.go:171","msg":"trace[1080562627] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9982; }","duration":"142.935186ms","start":"2026-09-03T16:41:27.925113Z","end":"2026-09-03T16:41:28.068048Z","steps":["trace[1080562627] 'agreement among raft nodes before linearized reading' (duration: 142.607929ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:42:18.946499Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7963} {"level":"info","ts":"2026-09-03T16:42:19.019044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7963,"took":"70.427341ms","hash":2082460372,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":27791360,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-03T16:42:19.019103Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2082460372,"revision":7963,"compact-revision":5680} {"level":"info","ts":"2026-09-03T16:47:05.985734Z","caller":"traceutil/trace.go:171","msg":"trace[614243766] linearizableReadLoop","detail":"{readStateIndex:12839; appliedIndex:12838; }","duration":"102.967193ms","start":"2026-09-03T16:47:05.882742Z","end":"2026-09-03T16:47:05.985709Z","steps":["trace[614243766] 'read index received' (duration: 102.80412ms)","trace[614243766] 'applied index is now lower than readState.Index' (duration: 162.153µs)"],"step_count":2} {"level":"warn","ts":"2026-09-03T16:47:05.985927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.179517ms","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-09-03T16:47:05.985961Z","caller":"traceutil/trace.go:171","msg":"trace[83685121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12414; }","duration":"103.264219ms","start":"2026-09-03T16:47:05.882688Z","end":"2026-09-03T16:47:05.985952Z","steps":["trace[83685121] 'agreement among raft nodes before linearized reading' (duration: 103.114676ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:47:05.986132Z","caller":"traceutil/trace.go:171","msg":"trace[355418754] transaction","detail":"{read_only:false; response_revision:12414; number_of_response:1; }","duration":"246.54071ms","start":"2026-09-03T16:47:05.73954Z","end":"2026-09-03T16:47:05.986081Z","steps":["trace[355418754] 'process raft request' (duration: 246.05684ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:47:18.958335Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10338} {"level":"info","ts":"2026-09-03T16:47:19.056555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10338,"took":"95.692613ms","hash":3997463129,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":25722880,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-03T16:47:19.056644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3997463129,"revision":10338,"compact-revision":7963} {"level":"info","ts":"2026-09-03T16:52:18.965604Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12524} {"level":"info","ts":"2026-09-03T16:52:19.047171Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12524,"took":"79.281106ms","hash":608843029,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":27701248,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-03T16:52:19.047256Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":608843029,"revision":12524,"compact-revision":10338} {"level":"info","ts":"2026-09-03T16:54:22.675249Z","caller":"traceutil/trace.go:171","msg":"trace[667417188] transaction","detail":"{read_only:false; response_revision:15470; number_of_response:1; }","duration":"112.568341ms","start":"2026-09-03T16:54:22.562639Z","end":"2026-09-03T16:54:22.675207Z","steps":["trace[667417188] 'process raft request' (duration: 112.291645ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:55:49.735789Z","caller":"traceutil/trace.go:171","msg":"trace[422524370] transaction","detail":"{read_only:false; response_revision:16280; number_of_response:1; }","duration":"180.411393ms","start":"2026-09-03T16:55:49.555352Z","end":"2026-09-03T16:55:49.735763Z","steps":["trace[422524370] 'process raft request' (duration: 180.221749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.101745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.231477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-ppdvg\" ","response":"range_response_count:1 size:22099"} {"level":"info","ts":"2026-09-03T16:55:50.101806Z","caller":"traceutil/trace.go:171","msg":"trace[1455597115] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-ppdvg; range_end:; response_count:1; response_revision:16280; }","duration":"292.342009ms","start":"2026-09-03T16:55:49.809451Z","end":"2026-09-03T16:55:50.101793Z","steps":["trace[1455597115] 'range keys from in-memory index tree' (duration: 292.106115ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.101815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.434226ms","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-09-03T16:55:50.101859Z","caller":"traceutil/trace.go:171","msg":"trace[627683936] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16280; }","duration":"159.506537ms","start":"2026-09-03T16:55:49.942341Z","end":"2026-09-03T16:55:50.101847Z","steps":["trace[627683936] 'range keys from in-memory index tree' (duration: 159.348064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.101744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.557519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-ppdvg\" ","response":"range_response_count:1 size:22099"} {"level":"info","ts":"2026-09-03T16:55:50.10201Z","caller":"traceutil/trace.go:171","msg":"trace[354087175] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-ppdvg; range_end:; response_count:1; response_revision:16280; }","duration":"248.833954ms","start":"2026-09-03T16:55:49.85317Z","end":"2026-09-03T16:55:50.102004Z","steps":["trace[354087175] 'range keys from in-memory index tree' (duration: 248.413585ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.102016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.663685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-03T16:55:50.101983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.887421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:55:50.10207Z","caller":"traceutil/trace.go:171","msg":"trace[1989085128] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16280; }","duration":"154.992463ms","start":"2026-09-03T16:55:49.947072Z","end":"2026-09-03T16:55:50.102065Z","steps":["trace[1989085128] 'range keys from in-memory index tree' (duration: 154.850961ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:55:50.102071Z","caller":"traceutil/trace.go:171","msg":"trace[695513526] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16280; }","duration":"153.765157ms","start":"2026-09-03T16:55:49.948273Z","end":"2026-09-03T16:55:50.102038Z","steps":["trace[695513526] 'range keys from in-memory index tree' (duration: 153.569653ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.1022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.063893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:55:50.102246Z","caller":"traceutil/trace.go:171","msg":"trace[462778809] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16280; }","duration":"153.151234ms","start":"2026-09-03T16:55:49.949081Z","end":"2026-09-03T16:55:50.102233Z","steps":["trace[462778809] 'range keys from in-memory index tree' (duration: 152.983181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.102396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.975572ms","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-09-03T16:55:50.10242Z","caller":"traceutil/trace.go:171","msg":"trace[1434344522] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16280; }","duration":"153.018653ms","start":"2026-09-03T16:55:49.949395Z","end":"2026-09-03T16:55:50.102414Z","steps":["trace[1434344522] 'range keys from in-memory index tree' (duration: 152.894571ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.101795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.228485ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:55:50.102486Z","caller":"traceutil/trace.go:171","msg":"trace[1049608653] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:16280; }","duration":"240.91742ms","start":"2026-09-03T16:55:49.861557Z","end":"2026-09-03T16:55:50.102474Z","steps":["trace[1049608653] 'range keys from in-memory index tree' (duration: 240.222915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.10252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.439117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-03T16:55:50.102535Z","caller":"traceutil/trace.go:171","msg":"trace[366238427] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16280; }","duration":"147.454707ms","start":"2026-09-03T16:55:49.955076Z","end":"2026-09-03T16:55:50.102531Z","steps":["trace[366238427] 'range keys from in-memory index tree' (duration: 147.385555ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.103456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.005467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T16:55:50.103481Z","caller":"traceutil/trace.go:171","msg":"trace[1516210824] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:16280; }","duration":"133.044387ms","start":"2026-09-03T16:55:49.970431Z","end":"2026-09-03T16:55:50.103475Z","steps":["trace[1516210824] 'count revisions from in-memory index tree' (duration: 132.977596ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:55:50.36707Z","caller":"traceutil/trace.go:171","msg":"trace[1895121816] transaction","detail":"{read_only:false; response_revision:16282; number_of_response:1; }","duration":"259.402405ms","start":"2026-09-03T16:55:50.107634Z","end":"2026-09-03T16:55:50.367036Z","steps":["trace[1895121816] 'process raft request' (duration: 160.235703ms)","trace[1895121816] 'compare' (duration: 98.451758ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:55:50.367442Z","caller":"traceutil/trace.go:171","msg":"trace[1883405505] transaction","detail":"{read_only:false; response_revision:16283; number_of_response:1; }","duration":"259.590639ms","start":"2026-09-03T16:55:50.107796Z","end":"2026-09-03T16:55:50.367387Z","steps":["trace[1883405505] 'process raft request' (duration: 259.1682ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:55:50.367483Z","caller":"traceutil/trace.go:171","msg":"trace[566832393] linearizableReadLoop","detail":"{readStateIndex:16845; appliedIndex:16842; }","duration":"253.42582ms","start":"2026-09-03T16:55:50.114027Z","end":"2026-09-03T16:55:50.367453Z","steps":["trace[566832393] 'read index received' (duration: 153.818219ms)","trace[566832393] 'applied index is now lower than readState.Index' (duration: 99.606701ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T16:55:50.367543Z","caller":"traceutil/trace.go:171","msg":"trace[459142458] transaction","detail":"{read_only:false; response_revision:16284; number_of_response:1; }","duration":"259.701681ms","start":"2026-09-03T16:55:50.107797Z","end":"2026-09-03T16:55:50.367498Z","steps":["trace[459142458] 'process raft request' (duration: 259.460256ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.367771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.794676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-h5kmm\" ","response":"range_response_count:1 size:20644"} {"level":"info","ts":"2026-09-03T16:55:50.367815Z","caller":"traceutil/trace.go:171","msg":"trace[1618855324] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-h5kmm; range_end:; response_count:1; response_revision:16284; }","duration":"263.869007ms","start":"2026-09-03T16:55:50.103934Z","end":"2026-09-03T16:55:50.367803Z","steps":["trace[1618855324] 'agreement among raft nodes before linearized reading' (duration: 263.693844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.367822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.678445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:55:50.367866Z","caller":"traceutil/trace.go:171","msg":"trace[1880031684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16284; }","duration":"252.769166ms","start":"2026-09-03T16:55:50.115085Z","end":"2026-09-03T16:55:50.367854Z","steps":["trace[1880031684] 'agreement among raft nodes before linearized reading' (duration: 252.675844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.368112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.361964ms","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-09-03T16:55:50.368141Z","caller":"traceutil/trace.go:171","msg":"trace[2056526123] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16284; }","duration":"134.392465ms","start":"2026-09-03T16:55:50.233741Z","end":"2026-09-03T16:55:50.368134Z","steps":["trace[2056526123] 'agreement among raft nodes before linearized reading' (duration: 134.269632ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.368156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.910546ms","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-09-03T16:55:50.36821Z","caller":"traceutil/trace.go:171","msg":"trace[437043611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16284; }","duration":"209.995967ms","start":"2026-09-03T16:55:50.158197Z","end":"2026-09-03T16:55:50.368192Z","steps":["trace[437043611] 'agreement among raft nodes before linearized reading' (duration: 209.833424ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.368221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.178519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:55:50.368252Z","caller":"traceutil/trace.go:171","msg":"trace[1039316747] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16284; }","duration":"145.228449ms","start":"2026-09-03T16:55:50.223014Z","end":"2026-09-03T16:55:50.368243Z","steps":["trace[1039316747] 'agreement among raft nodes before linearized reading' (duration: 145.180888ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.368413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.647997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737330"} {"level":"warn","ts":"2026-09-03T16:55:50.368456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.719951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-09-03T16:55:50.368486Z","caller":"traceutil/trace.go:171","msg":"trace[858247280] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16284; }","duration":"146.790913ms","start":"2026-09-03T16:55:50.221686Z","end":"2026-09-03T16:55:50.368477Z","steps":["trace[858247280] 'agreement among raft nodes before linearized reading' (duration: 146.69734ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:55:50.368486Z","caller":"traceutil/trace.go:171","msg":"trace[713918449] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:16284; }","duration":"256.778371ms","start":"2026-09-03T16:55:50.11169Z","end":"2026-09-03T16:55:50.368468Z","steps":["trace[713918449] 'agreement among raft nodes before linearized reading' (duration: 255.869281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.368326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.932722ms","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-09-03T16:55:50.368664Z","caller":"traceutil/trace.go:171","msg":"trace[272799828] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16284; }","duration":"243.28176ms","start":"2026-09-03T16:55:50.125373Z","end":"2026-09-03T16:55:50.368655Z","steps":["trace[272799828] 'agreement among raft nodes before linearized reading' (duration: 242.88238ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.368666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.185226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:55:50.368694Z","caller":"traceutil/trace.go:171","msg":"trace[754324858] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16284; }","duration":"152.236627ms","start":"2026-09-03T16:55:50.216449Z","end":"2026-09-03T16:55:50.368685Z","steps":["trace[754324858] 'agreement among raft nodes before linearized reading' (duration: 152.191116ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.36871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.608068ms","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-09-03T16:55:50.368771Z","caller":"traceutil/trace.go:171","msg":"trace[845049212] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16284; }","duration":"145.68206ms","start":"2026-09-03T16:55:50.223072Z","end":"2026-09-03T16:55:50.368754Z","steps":["trace[845049212] 'agreement among raft nodes before linearized reading' (duration: 145.474005ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.368866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.348614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-09-03T16:55:50.368896Z","caller":"traceutil/trace.go:171","msg":"trace[345829012] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16284; }","duration":"246.406744ms","start":"2026-09-03T16:55:50.122482Z","end":"2026-09-03T16:55:50.368889Z","steps":["trace[345829012] 'agreement among raft nodes before linearized reading' (duration: 246.329053ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.368903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.225288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-09-03T16:55:50.368952Z","caller":"traceutil/trace.go:171","msg":"trace[2011597849] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16284; }","duration":"143.30927ms","start":"2026-09-03T16:55:50.225632Z","end":"2026-09-03T16:55:50.368941Z","steps":["trace[2011597849] 'agreement among raft nodes before linearized reading' (duration: 142.763978ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.369054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.980278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T16:55:50.3691Z","caller":"traceutil/trace.go:171","msg":"trace[1889382367] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16284; }","duration":"249.08589ms","start":"2026-09-03T16:55:50.120004Z","end":"2026-09-03T16:55:50.36909Z","steps":["trace[1889382367] 'agreement among raft nodes before linearized reading' (duration: 249.021169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T16:55:50.369989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.637155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737330"} {"level":"info","ts":"2026-09-03T16:55:50.370057Z","caller":"traceutil/trace.go:171","msg":"trace[2057524407] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:16284; }","duration":"254.722187ms","start":"2026-09-03T16:55:50.115318Z","end":"2026-09-03T16:55:50.37004Z","steps":["trace[2057524407] 'agreement among raft nodes before linearized reading' (duration: 253.731347ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:57:18.976263Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14537} {"level":"info","ts":"2026-09-03T16:57:19.067371Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14537,"took":"87.570981ms","hash":2162869953,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":34480128,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-03T16:57:19.067455Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2162869953,"revision":14537,"compact-revision":12524} {"level":"warn","ts":"2026-09-03T16:59:01.602509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.066485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-03T16:59:01.602785Z","caller":"traceutil/trace.go:171","msg":"trace[155189937] transaction","detail":"{read_only:false; response_revision:17794; number_of_response:1; }","duration":"133.94173ms","start":"2026-09-03T16:59:01.468814Z","end":"2026-09-03T16:59:01.602756Z","steps":["trace[155189937] 'compare' (duration: 124.954013ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:59:03.548139Z","caller":"traceutil/trace.go:171","msg":"trace[1977134994] transaction","detail":"{read_only:false; response_revision:17808; number_of_response:1; }","duration":"127.639249ms","start":"2026-09-03T16:59:03.420468Z","end":"2026-09-03T16:59:03.548107Z","steps":["trace[1977134994] 'process raft request' (duration: 127.359922ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:59:03.731894Z","caller":"traceutil/trace.go:171","msg":"trace[2146028405] transaction","detail":"{read_only:false; response_revision:17810; number_of_response:1; }","duration":"119.301935ms","start":"2026-09-03T16:59:03.612569Z","end":"2026-09-03T16:59:03.731871Z","steps":["trace[2146028405] 'process raft request' (duration: 119.175602ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:59:03.744258Z","caller":"traceutil/trace.go:171","msg":"trace[1665674013] transaction","detail":"{read_only:false; response_revision:17811; number_of_response:1; }","duration":"124.2767ms","start":"2026-09-03T16:59:03.619943Z","end":"2026-09-03T16:59:03.74422Z","steps":["trace[1665674013] 'process raft request' (duration: 124.141447ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:59:03.744557Z","caller":"traceutil/trace.go:171","msg":"trace[1931004453] transaction","detail":"{read_only:false; response_revision:17812; number_of_response:1; }","duration":"117.416716ms","start":"2026-09-03T16:59:03.627126Z","end":"2026-09-03T16:59:03.744543Z","steps":["trace[1931004453] 'process raft request' (duration: 117.060059ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:59:03.744668Z","caller":"traceutil/trace.go:171","msg":"trace[1740435235] transaction","detail":"{read_only:false; response_revision:17813; number_of_response:1; }","duration":"102.70265ms","start":"2026-09-03T16:59:03.641956Z","end":"2026-09-03T16:59:03.744659Z","steps":["trace[1740435235] 'process raft request' (duration: 102.504936ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T16:59:03.74466Z","caller":"traceutil/trace.go:171","msg":"trace[210743227] linearizableReadLoop","detail":"{readStateIndex:18422; appliedIndex:18421; }","duration":"118.298835ms","start":"2026-09-03T16:59:03.626341Z","end":"2026-09-03T16:59:03.74464Z","steps":["trace[210743227] 'read index received' (duration: 105.530299ms)","trace[210743227] 'applied index is now lower than readState.Index' (duration: 12.767346ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T16:59:03.744836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.476289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-09-03T16:59:03.744893Z","caller":"traceutil/trace.go:171","msg":"trace[1706057320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17813; }","duration":"118.5461ms","start":"2026-09-03T16:59:03.62633Z","end":"2026-09-03T16:59:03.744876Z","steps":["trace[1706057320] 'agreement among raft nodes before linearized reading' (duration: 118.370047ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T17:02:18.9873Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16846} {"level":"info","ts":"2026-09-03T17:02:19.092273Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16846,"took":"101.042494ms","hash":1452411293,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":32055296,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-03T17:02:19.092368Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1452411293,"revision":16846,"compact-revision":14537} {"level":"info","ts":"2026-09-03T17:02:23.853071Z","caller":"traceutil/trace.go:171","msg":"trace[2021508970] transaction","detail":"{read_only:false; response_revision:19153; number_of_response:1; }","duration":"100.402722ms","start":"2026-09-03T17:02:23.752638Z","end":"2026-09-03T17:02:23.85304Z","steps":["trace[2021508970] 'process raft request' (duration: 100.198188ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T17:02:24.353372Z","caller":"traceutil/trace.go:171","msg":"trace[747565599] transaction","detail":"{read_only:false; response_revision:19154; number_of_response:1; }","duration":"151.430534ms","start":"2026-09-03T17:02:24.201916Z","end":"2026-09-03T17:02:24.353346Z","steps":["trace[747565599] 'process raft request' (duration: 151.246901ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T17:02:33.065235Z","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-09-03T17:02:33.071365Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-03T17:02:33.071514Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-03T17:07:18.994259Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19125} {"level":"info","ts":"2026-09-03T17:07:19.103466Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19125,"took":"104.100089ms","hash":1486330296,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":34312192,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-03T17:07:19.1036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1486330296,"revision":19125,"compact-revision":16846} {"level":"info","ts":"2026-09-03T17:10:03.268392Z","caller":"traceutil/trace.go:171","msg":"trace[1753434734] transaction","detail":"{read_only:false; response_revision:22505; number_of_response:1; }","duration":"123.691455ms","start":"2026-09-03T17:10:03.144635Z","end":"2026-09-03T17:10:03.268327Z","steps":["trace[1753434734] 'process raft request' (duration: 55.208174ms)","trace[1753434734] 'compare' (duration: 68.356778ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T17:10:35.639148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.641791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-09-03T17:10:35.639706Z","caller":"traceutil/trace.go:171","msg":"trace[892413901] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22685; }","duration":"190.272454ms","start":"2026-09-03T17:10:35.449409Z","end":"2026-09-03T17:10:35.639681Z","steps":["trace[892413901] 'range keys from in-memory index tree' (duration: 189.415676ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T17:10:36.181463Z","caller":"traceutil/trace.go:171","msg":"trace[1811378606] transaction","detail":"{read_only:false; response_revision:22687; number_of_response:1; }","duration":"537.460444ms","start":"2026-09-03T17:10:35.643974Z","end":"2026-09-03T17:10:36.181434Z","steps":["trace[1811378606] 'process raft request' (duration: 537.233869ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:10:36.181616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:35.64395Z","time spent":"537.589047ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T17:10:36.181749Z","caller":"traceutil/trace.go:171","msg":"trace[1405048177] transaction","detail":"{read_only:false; response_revision:22688; number_of_response:1; }","duration":"537.458114ms","start":"2026-09-03T17:10:35.644273Z","end":"2026-09-03T17:10:36.181732Z","steps":["trace[1405048177] 'process raft request' (duration: 537.122657ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T17:10:36.181759Z","caller":"traceutil/trace.go:171","msg":"trace[723170073] transaction","detail":"{read_only:false; response_revision:22689; number_of_response:1; }","duration":"536.346372ms","start":"2026-09-03T17:10:35.645383Z","end":"2026-09-03T17:10:36.181729Z","steps":["trace[723170073] 'process raft request' (duration: 536.238429ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:10:36.181815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:35.644258Z","time spent":"537.524316ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T17:10:36.181901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:35.645361Z","time spent":"536.463654ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T17:10:36.306468Z","caller":"traceutil/trace.go:171","msg":"trace[501304516] linearizableReadLoop","detail":"{readStateIndex:23464; appliedIndex:23460; }","duration":"443.323902ms","start":"2026-09-03T17:10:35.863117Z","end":"2026-09-03T17:10:36.306441Z","steps":["trace[501304516] 'read index received' (duration: 317.866021ms)","trace[501304516] 'applied index is now lower than readState.Index' (duration: 125.456701ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T17:10:36.306604Z","caller":"traceutil/trace.go:171","msg":"trace[972954080] transaction","detail":"{read_only:false; response_revision:22690; number_of_response:1; }","duration":"575.621235ms","start":"2026-09-03T17:10:35.730968Z","end":"2026-09-03T17:10:36.306589Z","steps":["trace[972954080] 'process raft request' (duration: 562.959342ms)","trace[972954080] 'compare' (duration: 12.208653ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T17:10:36.306668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.158831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-03T17:10:36.306719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:35.730939Z","time spent":"575.698747ms","remote":"127.0.0.1:48656","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-09-03T17:10:36.306738Z","caller":"traceutil/trace.go:171","msg":"trace[792870411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22690; }","duration":"213.271033ms","start":"2026-09-03T17:10:36.09345Z","end":"2026-09-03T17:10:36.306721Z","steps":["trace[792870411] 'agreement among raft nodes before linearized reading' (duration: 213.165951ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:10:36.306939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.787543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T17:10:36.307061Z","caller":"traceutil/trace.go:171","msg":"trace[434406765] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:22690; }","duration":"443.975177ms","start":"2026-09-03T17:10:35.863061Z","end":"2026-09-03T17:10:36.307036Z","steps":["trace[434406765] 'agreement among raft nodes before linearized reading' (duration: 443.64884ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:10:36.30714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:35.863039Z","time spent":"444.085248ms","remote":"127.0.0.1:48496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":92,"response size":32,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-09-03T17:10:36.948774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.524171ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-03T17:10:36.948906Z","caller":"traceutil/trace.go:171","msg":"trace[1544108481] transaction","detail":"{read_only:false; response_revision:22691; number_of_response:1; }","duration":"530.97726ms","start":"2026-09-03T17:10:36.417903Z","end":"2026-09-03T17:10:36.94888Z","steps":["trace[1544108481] 'process raft request' (duration: 244.244974ms)","trace[1544108481] 'compare' (duration: 286.166574ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T17:10:36.949029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:36.417883Z","time spent":"531.072082ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T17:10:37.164569Z","caller":"traceutil/trace.go:171","msg":"trace[1797287571] transaction","detail":"{read_only:false; response_revision:22693; number_of_response:1; }","duration":"687.19196ms","start":"2026-09-03T17:10:36.477355Z","end":"2026-09-03T17:10:37.164547Z","steps":["trace[1797287571] 'process raft request' (duration: 687.114058ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T17:10:37.164621Z","caller":"traceutil/trace.go:171","msg":"trace[344690361] transaction","detail":"{read_only:false; response_revision:22692; number_of_response:1; }","duration":"745.913306ms","start":"2026-09-03T17:10:36.418678Z","end":"2026-09-03T17:10:37.164591Z","steps":["trace[344690361] 'process raft request' (duration: 745.562579ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T17:10:37.164697Z","caller":"traceutil/trace.go:171","msg":"trace[774233211] linearizableReadLoop","detail":"{readStateIndex:23468; appliedIndex:23464; }","duration":"665.919718ms","start":"2026-09-03T17:10:36.498747Z","end":"2026-09-03T17:10:37.164667Z","steps":["trace[774233211] 'read index received' (duration: 163.50558ms)","trace[774233211] 'applied index is now lower than readState.Index' (duration: 502.411978ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T17:10:37.164744Z","caller":"traceutil/trace.go:171","msg":"trace[1723246788] transaction","detail":"{read_only:false; response_revision:22694; number_of_response:1; }","duration":"682.615134ms","start":"2026-09-03T17:10:36.482109Z","end":"2026-09-03T17:10:37.164724Z","steps":["trace[1723246788] 'process raft request' (duration: 682.40262ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:10:37.164747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:36.47731Z","time spent":"687.329632ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T17:10:37.164782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:36.418652Z","time spent":"746.050599ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T17:10:37.164843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:36.482082Z","time spent":"682.704086ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T17:10:37.16489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.146283ms","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-09-03T17:10:37.164936Z","caller":"traceutil/trace.go:171","msg":"trace[1698591772] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:22694; }","duration":"666.197554ms","start":"2026-09-03T17:10:36.498722Z","end":"2026-09-03T17:10:37.164919Z","steps":["trace[1698591772] 'agreement among raft nodes before linearized reading' (duration: 666.087672ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:10:37.164987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:36.49867Z","time spent":"666.303706ms","remote":"127.0.0.1:40878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":32,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"warn","ts":"2026-09-03T17:10:37.165035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.147777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T17:10:37.165096Z","caller":"traceutil/trace.go:171","msg":"trace[1380896658] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:22694; }","duration":"563.249629ms","start":"2026-09-03T17:10:36.601831Z","end":"2026-09-03T17:10:37.16508Z","steps":["trace[1380896658] 'agreement among raft nodes before linearized reading' (duration: 563.051665ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:10:37.165148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:10:36.601812Z","time spent":"563.323221ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":82,"response size":32,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"info","ts":"2026-09-03T17:10:37.363743Z","caller":"traceutil/trace.go:171","msg":"trace[518572348] transaction","detail":"{read_only:false; response_revision:22695; number_of_response:1; }","duration":"123.086792ms","start":"2026-09-03T17:10:37.240632Z","end":"2026-09-03T17:10:37.363719Z","steps":["trace[518572348] 'process raft request' (duration: 121.001789ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T17:12:19.00342Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21598} {"level":"info","ts":"2026-09-03T17:12:19.120895Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21598,"took":"113.990884ms","hash":1900193893,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":28524544,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-03T17:12:19.120968Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1900193893,"revision":21598,"compact-revision":19125} {"level":"info","ts":"2026-09-03T17:15:02.129473Z","caller":"traceutil/trace.go:171","msg":"trace[824352615] transaction","detail":"{read_only:false; response_revision:25286; number_of_response:1; }","duration":"127.73699ms","start":"2026-09-03T17:15:02.001714Z","end":"2026-09-03T17:15:02.129451Z","steps":["trace[824352615] 'process raft request' (duration: 127.574947ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:15:02.672339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.140958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-03T17:15:02.673375Z","caller":"traceutil/trace.go:171","msg":"trace[81531074] transaction","detail":"{read_only:false; response_revision:25289; number_of_response:1; }","duration":"349.800883ms","start":"2026-09-03T17:15:02.323554Z","end":"2026-09-03T17:15:02.673355Z","steps":["trace[81531074] 'process raft request' (duration: 349.755592ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:15:02.673619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:15:02.323523Z","time spent":"349.898425ms","remote":"127.0.0.1:48656","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-09-03T17:15:02.674044Z","caller":"traceutil/trace.go:171","msg":"trace[837717723] transaction","detail":"{read_only:false; response_revision:25288; number_of_response:1; }","duration":"461.329345ms","start":"2026-09-03T17:15:02.212678Z","end":"2026-09-03T17:15:02.674007Z","steps":["trace[837717723] 'process raft request' (duration: 460.511949ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:15:02.674177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:15:02.212644Z","time spent":"461.469628ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T17:15:02.674474Z","caller":"traceutil/trace.go:171","msg":"trace[1290381132] transaction","detail":"{read_only:false; response_revision:25287; number_of_response:1; }","duration":"666.172142ms","start":"2026-09-03T17:15:02.00826Z","end":"2026-09-03T17:15:02.674432Z","steps":["trace[1290381132] 'process raft request' (duration: 275.863429ms)","trace[1290381132] 'compare' (duration: 388.002936ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T17:15:02.673346Z","caller":"traceutil/trace.go:171","msg":"trace[1691272857] linearizableReadLoop","detail":"{readStateIndex:26143; appliedIndex:26141; }","duration":"634.070646ms","start":"2026-09-03T17:15:02.039252Z","end":"2026-09-03T17:15:02.673323Z","steps":["trace[1691272857] 'read index received' (duration: 90.045287ms)","trace[1691272857] 'applied index is now lower than readState.Index' (duration: 544.023839ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T17:15:02.674853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.561688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T17:15:02.674939Z","caller":"traceutil/trace.go:171","msg":"trace[1480997711] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:25289; }","duration":"635.697181ms","start":"2026-09-03T17:15:02.03922Z","end":"2026-09-03T17:15:02.674917Z","steps":["trace[1480997711] 'agreement among raft nodes before linearized reading' (duration: 635.503587ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:15:02.674981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:15:02.039206Z","time spent":"635.765202ms","remote":"127.0.0.1:58250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "} {"level":"warn","ts":"2026-09-03T17:15:02.675066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.252533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T17:15:02.67514Z","caller":"traceutil/trace.go:171","msg":"trace[505098517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25289; }","duration":"582.368325ms","start":"2026-09-03T17:15:02.092759Z","end":"2026-09-03T17:15:02.675127Z","steps":["trace[505098517] 'agreement among raft nodes before linearized reading' (duration: 582.185722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:15:02.675198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:15:02.092734Z","time spent":"582.453928ms","remote":"127.0.0.1:48446","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-09-03T17:15:02.675498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.149\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-09-03T17:15:02.675555Z","caller":"traceutil/trace.go:171","msg":"trace[2013238901] range","detail":"{range_begin:/registry/masterleases/162.253.55.149; range_end:; response_count:1; response_revision:25289; }","duration":"212.258582ms","start":"2026-09-03T17:15:02.463288Z","end":"2026-09-03T17:15:02.675547Z","steps":["trace[2013238901] 'agreement among raft nodes before linearized reading' (duration: 212.123229ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:15:02.675567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.852716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-09-03T17:15:02.675668Z","caller":"traceutil/trace.go:171","msg":"trace[639533483] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:25289; }","duration":"446.977349ms","start":"2026-09-03T17:15:02.228662Z","end":"2026-09-03T17:15:02.675639Z","steps":["trace[639533483] 'agreement among raft nodes before linearized reading' (duration: 446.742884ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T17:15:02.675726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:15:02.228643Z","time spent":"447.0638ms","remote":"127.0.0.1:48568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2107,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-09-03T17:15:02.676637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T17:15:02.00825Z","time spent":"666.288755ms","remote":"127.0.0.1:48656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T17:15:54.771244Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068a6.wal"} {"level":"info","ts":"2026-09-03T17:17:19.01234Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23543} {"level":"info","ts":"2026-09-03T17:17:19.126507Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23543,"took":"109.960895ms","hash":749673231,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":43638784,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-09-03T17:17:19.126575Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":749673231,"revision":23543,"compact-revision":21598} {"level":"info","ts":"2026-09-03T17:22:19.020414Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26613} {"level":"info","ts":"2026-09-03T17:22:19.182845Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26613,"took":"159.160919ms","hash":3328706341,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":30945280,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-03T17:22:19.182924Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3328706341,"revision":26613,"compact-revision":23543} {"level":"info","ts":"2026-09-03T17:22:45.401738Z","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-09-03T17:22:45.408174Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-03T17:22:45.408361Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}