{"level":"warn","ts":"2026-06-17T18:40:42.282293Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T18:40:42.282475Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-06-17T18:40:42.282607Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T18:40:42.282639Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-17T18:40:42.282701Z","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-06-17T18:40:42.284088Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-06-17T18:40:42.284395Z","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://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-06-17T18:40:42.290746Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.841812ms"} {"level":"info","ts":"2026-06-17T18:40:42.298156Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-06-17T18:40:42.298259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-17T18:40:42.298294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-06-17T18:40:42.29831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-17T18:40:42.298326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-06-17T18:40:42.298375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-06-17T18:40:42.304233Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-17T18:40:42.305757Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-17T18:40:42.306754Z","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-06-17T18:40:42.309566Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-17T18:40:42.309773Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-17T18:40:42.309896Z","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-06-17T18:40:42.310029Z","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-06-17T18:40:42.310049Z","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-06-17T18:40:42.31249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-06-17T18:40:42.312619Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-17T18:40:42.314127Z","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-06-17T18:40:42.314399Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-17T18:40:42.314459Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-17T18:40:42.31442Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-17T18:40:42.314551Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-17T18:40:42.798898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-17T18:40:42.798971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-17T18:40:42.798996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-06-17T18:40:42.799017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-06-17T18:40:42.799029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-17T18:40:42.799045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-06-17T18:40:42.799061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-17T18:40:42.804588Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-06-17T18:40:42.804639Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T18:40:42.804757Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T18:40:42.804765Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T18:40:42.805048Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-17T18:40:42.805076Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-17T18:40:42.807018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-17T18:40:42.807858Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-06-17T18:40:42.823102Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T18:40:42.825341Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T18:40:42.82539Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T18:40:49.732529Z","caller":"traceutil/trace.go:171","msg":"trace[1664583842] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"200.465267ms","start":"2026-06-17T18:40:49.532035Z","end":"2026-06-17T18:40:49.732501Z","steps":["trace[1664583842] 'process raft request' (duration: 200.301723ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:40:55.234695Z","caller":"traceutil/trace.go:171","msg":"trace[898416746] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"157.787313ms","start":"2026-06-17T18:40:55.076887Z","end":"2026-06-17T18:40:55.234674Z","steps":["trace[898416746] 'process raft request' (duration: 157.6426ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:40:55.44551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.353188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:40:55.445653Z","caller":"traceutil/trace.go:171","msg":"trace[1665292496] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"203.271906ms","start":"2026-06-17T18:40:55.242358Z","end":"2026-06-17T18:40:55.44563Z","steps":["trace[1665292496] 'process raft request' (duration: 98.251181ms)","trace[1665292496] 'compare' (duration: 104.227345ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:41:23.912266Z","caller":"traceutil/trace.go:171","msg":"trace[500768276] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"202.840583ms","start":"2026-06-17T18:41:23.709009Z","end":"2026-06-17T18:41:23.91185Z","steps":["trace[500768276] 'process raft request' (duration: 201.616764ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:23.912276Z","caller":"traceutil/trace.go:171","msg":"trace[498852094] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"159.819978ms","start":"2026-06-17T18:41:23.752303Z","end":"2026-06-17T18:41:23.912123Z","steps":["trace[498852094] 'read index received' (duration: 157.524842ms)","trace[498852094] 'applied index is now lower than readState.Index' (duration: 2.185593ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:41:23.91367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.170041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:41:23.913788Z","caller":"traceutil/trace.go:171","msg":"trace[436902381] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:613; }","duration":"161.320004ms","start":"2026-06-17T18:41:23.75243Z","end":"2026-06-17T18:41:23.91375Z","steps":["trace[436902381] 'agreement among raft nodes before linearized reading' (duration: 160.818582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:41:23.913993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.496056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:41:23.914154Z","caller":"traceutil/trace.go:171","msg":"trace[1383035381] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:613; }","duration":"104.67495ms","start":"2026-06-17T18:41:23.809434Z","end":"2026-06-17T18:41:23.914109Z","steps":["trace[1383035381] 'agreement among raft nodes before linearized reading' (duration: 104.458295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:41:23.915182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.384521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T18:41:23.915203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.878931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:41:23.915241Z","caller":"traceutil/trace.go:171","msg":"trace[362513318] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:613; }","duration":"106.457863ms","start":"2026-06-17T18:41:23.80876Z","end":"2026-06-17T18:41:23.915218Z","steps":["trace[362513318] 'agreement among raft nodes before linearized reading' (duration: 106.022063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:41:23.915237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.812397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T18:41:23.915257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.382887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T18:41:23.91526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.849487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T18:41:23.914262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.275385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:41:23.915299Z","caller":"traceutil/trace.go:171","msg":"trace[1405371748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:613; }","duration":"162.985124ms","start":"2026-06-17T18:41:23.752273Z","end":"2026-06-17T18:41:23.915258Z","steps":["trace[1405371748] 'agreement among raft nodes before linearized reading' (duration: 159.851309ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:23.915497Z","caller":"traceutil/trace.go:171","msg":"trace[83993565] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:613; }","duration":"127.56953ms","start":"2026-06-17T18:41:23.787788Z","end":"2026-06-17T18:41:23.915357Z","steps":["trace[83993565] 'agreement among raft nodes before linearized reading' (duration: 127.015717ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:23.915427Z","caller":"traceutil/trace.go:171","msg":"trace[612329390] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:613; }","duration":"106.598027ms","start":"2026-06-17T18:41:23.808774Z","end":"2026-06-17T18:41:23.915372Z","steps":["trace[612329390] 'agreement among raft nodes before linearized reading' (duration: 105.269375ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:23.915467Z","caller":"traceutil/trace.go:171","msg":"trace[2130916343] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:613; }","duration":"128.008902ms","start":"2026-06-17T18:41:23.787361Z","end":"2026-06-17T18:41:23.91537Z","steps":["trace[2130916343] 'agreement among raft nodes before linearized reading' (duration: 127.579371ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:23.915332Z","caller":"traceutil/trace.go:171","msg":"trace[1571583312] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:613; }","duration":"127.880168ms","start":"2026-06-17T18:41:23.787394Z","end":"2026-06-17T18:41:23.915274Z","steps":["trace[1571583312] 'agreement among raft nodes before linearized reading' (duration: 127.382177ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:27.049683Z","caller":"traceutil/trace.go:171","msg":"trace[1485237219] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"186.316165ms","start":"2026-06-17T18:41:26.86334Z","end":"2026-06-17T18:41:27.049656Z","steps":["trace[1485237219] 'process raft request' (duration: 185.775082ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:27.083674Z","caller":"traceutil/trace.go:171","msg":"trace[240415807] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"214.123424ms","start":"2026-06-17T18:41:26.86951Z","end":"2026-06-17T18:41:27.083634Z","steps":["trace[240415807] 'process raft request' (duration: 201.310236ms)","trace[240415807] 'compare' (duration: 12.714246ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:41:27.544082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.017607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:41:27.544169Z","caller":"traceutil/trace.go:171","msg":"trace[594123622] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"390.364939ms","start":"2026-06-17T18:41:27.153791Z","end":"2026-06-17T18:41:27.544156Z","steps":["trace[594123622] 'read index received' (duration: 229.197058ms)","trace[594123622] 'applied index is now lower than readState.Index' (duration: 161.166951ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:41:27.544232Z","caller":"traceutil/trace.go:171","msg":"trace[1827707186] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"433.013785ms","start":"2026-06-17T18:41:27.1112Z","end":"2026-06-17T18:41:27.544213Z","steps":["trace[1827707186] 'process raft request' (duration: 271.814944ms)","trace[1827707186] 'compare' (duration: 160.903274ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:41:27.544285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:41:27.111172Z","time spent":"433.090257ms","remote":"127.0.0.1:34984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-17T18:41:27.544339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.542863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-z5rs2\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-17T18:41:27.544362Z","caller":"traceutil/trace.go:171","msg":"trace[1088357581] range","detail":"{range_begin:/registry/pods/kube-system/cilium-z5rs2; range_end:; response_count:1; response_revision:638; }","duration":"390.603254ms","start":"2026-06-17T18:41:27.15375Z","end":"2026-06-17T18:41:27.544354Z","steps":["trace[1088357581] 'agreement among raft nodes before linearized reading' (duration: 390.487222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:41:27.544381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:41:27.153728Z","time spent":"390.649106ms","remote":"127.0.0.1:34682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-z5rs2\" "} {"level":"warn","ts":"2026-06-17T18:41:27.544434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.741849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:41:27.544535Z","caller":"traceutil/trace.go:171","msg":"trace[1521664824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"145.909643ms","start":"2026-06-17T18:41:27.398597Z","end":"2026-06-17T18:41:27.544506Z","steps":["trace[1521664824] 'agreement among raft nodes before linearized reading' (duration: 145.720729ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:42.957242Z","caller":"traceutil/trace.go:171","msg":"trace[1120641072] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"157.163943ms","start":"2026-06-17T18:41:42.800043Z","end":"2026-06-17T18:41:42.957207Z","steps":["trace[1120641072] 'process raft request' (duration: 156.968298ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:42:57.22306Z","caller":"traceutil/trace.go:171","msg":"trace[880607415] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1932; }","duration":"214.251577ms","start":"2026-06-17T18:42:57.008782Z","end":"2026-06-17T18:42:57.223034Z","steps":["trace[880607415] 'read index received' (duration: 213.982491ms)","trace[880607415] 'applied index is now lower than readState.Index' (duration: 267.816µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:42:57.223165Z","caller":"traceutil/trace.go:171","msg":"trace[219554287] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"242.751003ms","start":"2026-06-17T18:42:56.980366Z","end":"2026-06-17T18:42:57.223117Z","steps":["trace[219554287] 'process raft request' (duration: 242.485557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:42:57.223245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.405071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-17T18:42:57.223274Z","caller":"traceutil/trace.go:171","msg":"trace[272270005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1862; }","duration":"214.446982ms","start":"2026-06-17T18:42:57.008818Z","end":"2026-06-17T18:42:57.223265Z","steps":["trace[272270005] 'agreement among raft nodes before linearized reading' (duration: 214.344599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:42:57.223455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.562025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-17T18:42:57.22354Z","caller":"traceutil/trace.go:171","msg":"trace[1604577482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1862; }","duration":"214.77971ms","start":"2026-06-17T18:42:57.008741Z","end":"2026-06-17T18:42:57.223521Z","steps":["trace[1604577482] 'agreement among raft nodes before linearized reading' (duration: 214.433342ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:42:57.67959Z","caller":"traceutil/trace.go:171","msg":"trace[709288347] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"141.264931ms","start":"2026-06-17T18:42:57.53831Z","end":"2026-06-17T18:42:57.679575Z","steps":["trace[709288347] 'process raft request' (duration: 140.996144ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:42:57.679514Z","caller":"traceutil/trace.go:171","msg":"trace[2092864526] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1937; }","duration":"107.877327ms","start":"2026-06-17T18:42:57.571615Z","end":"2026-06-17T18:42:57.679492Z","steps":["trace[2092864526] 'read index received' (duration: 107.801155ms)","trace[2092864526] 'applied index is now lower than readState.Index' (duration: 74.812µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:42:57.679938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.289016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:42:57.680022Z","caller":"traceutil/trace.go:171","msg":"trace[887523233] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1867; }","duration":"108.41892ms","start":"2026-06-17T18:42:57.571581Z","end":"2026-06-17T18:42:57.68Z","steps":["trace[887523233] 'agreement among raft nodes before linearized reading' (duration: 108.263716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.128895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.672572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-17T18:43:53.129007Z","caller":"traceutil/trace.go:171","msg":"trace[1388029898] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2215; }","duration":"447.820645ms","start":"2026-06-17T18:43:52.681155Z","end":"2026-06-17T18:43:53.128976Z","steps":["trace[1388029898] 'range keys from in-memory index tree' (duration: 447.462107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.12905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:52.681133Z","time spent":"447.904357ms","remote":"127.0.0.1:35080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-17T18:43:53.129383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.369796ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:43:53.129745Z","caller":"traceutil/trace.go:171","msg":"trace[1621438403] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"379.209849ms","start":"2026-06-17T18:43:52.750511Z","end":"2026-06-17T18:43:53.129721Z","steps":["trace[1621438403] 'process raft request' (duration: 127.419163ms)","trace[1621438403] 'compare' (duration: 251.197382ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:43:53.129861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:52.750483Z","time spent":"379.319831ms","remote":"127.0.0.1:34752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T18:43:53.624157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.706501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-17T18:43:53.624271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.35763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:43:53.624383Z","caller":"traceutil/trace.go:171","msg":"trace[2020228796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2216; }","duration":"226.511844ms","start":"2026-06-17T18:43:53.397845Z","end":"2026-06-17T18:43:53.624357Z","steps":["trace[2020228796] 'range keys from in-memory index tree' (duration: 226.272049ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:43:53.624383Z","caller":"traceutil/trace.go:171","msg":"trace[1429200020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2216; }","duration":"117.954247ms","start":"2026-06-17T18:43:53.506374Z","end":"2026-06-17T18:43:53.624328Z","steps":["trace[1429200020] 'range keys from in-memory index tree' (duration: 117.526285ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:45:00.998208Z","caller":"traceutil/trace.go:171","msg":"trace[2013579211] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"278.709568ms","start":"2026-06-17T18:45:00.719473Z","end":"2026-06-17T18:45:00.998183Z","steps":["trace[2013579211] 'process raft request' (duration: 278.578114ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:45:01.057799Z","caller":"traceutil/trace.go:171","msg":"trace[2034741171] linearizableReadLoop","detail":"{readStateIndex:2885; appliedIndex:2884; }","duration":"288.237563ms","start":"2026-06-17T18:45:00.76954Z","end":"2026-06-17T18:45:01.057777Z","steps":["trace[2034741171] 'read index received' (duration: 228.854696ms)","trace[2034741171] 'applied index is now lower than readState.Index' (duration: 59.381987ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:45:01.057982Z","caller":"traceutil/trace.go:171","msg":"trace[152014242] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"327.262357ms","start":"2026-06-17T18:45:00.730711Z","end":"2026-06-17T18:45:01.057974Z","steps":["trace[152014242] 'process raft request' (duration: 326.051557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:45:01.058062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:45:00.730682Z","time spent":"327.322199ms","remote":"127.0.0.1:34752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T18:45:01.058216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.692874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T18:45:01.058243Z","caller":"traceutil/trace.go:171","msg":"trace[77508574] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2782; }","duration":"288.759295ms","start":"2026-06-17T18:45:00.769476Z","end":"2026-06-17T18:45:01.058236Z","steps":["trace[77508574] 'agreement among raft nodes before linearized reading' (duration: 288.708914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:45:01.058367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.531021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T18:45:01.058392Z","caller":"traceutil/trace.go:171","msg":"trace[1209258287] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2782; }","duration":"110.595003ms","start":"2026-06-17T18:45:00.94779Z","end":"2026-06-17T18:45:01.058385Z","steps":["trace[1209258287] 'agreement among raft nodes before linearized reading' (duration: 110.545542ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:48:54.641406Z","caller":"traceutil/trace.go:171","msg":"trace[1047341610] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"208.733781ms","start":"2026-06-17T18:48:54.432646Z","end":"2026-06-17T18:48:54.64138Z","steps":["trace[1047341610] 'process raft request' (duration: 208.572027ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:03.068155Z","caller":"traceutil/trace.go:171","msg":"trace[2034477588] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"101.653203ms","start":"2026-06-17T18:49:02.966477Z","end":"2026-06-17T18:49:03.06813Z","steps":["trace[2034477588] 'process raft request' (duration: 51.393675ms)","trace[2034477588] 'compare' (duration: 49.800747ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:49:08.025241Z","caller":"traceutil/trace.go:171","msg":"trace[512241524] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"202.820385ms","start":"2026-06-17T18:49:07.822376Z","end":"2026-06-17T18:49:08.025196Z","steps":["trace[512241524] 'process raft request' (duration: 202.551438ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:08.143326Z","caller":"traceutil/trace.go:171","msg":"trace[375287002] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"206.941776ms","start":"2026-06-17T18:49:07.936352Z","end":"2026-06-17T18:49:08.143294Z","steps":["trace[375287002] 'process raft request' (duration: 115.806682ms)","trace[375287002] 'compare' (duration: 90.886268ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:49:08.143669Z","caller":"traceutil/trace.go:171","msg":"trace[425367069] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"116.455578ms","start":"2026-06-17T18:49:08.027126Z","end":"2026-06-17T18:49:08.143581Z","steps":["trace[425367069] 'process raft request' (duration: 116.081898ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:16.319026Z","caller":"traceutil/trace.go:171","msg":"trace[1869956967] transaction","detail":"{read_only:false; response_revision:5378; number_of_response:1; }","duration":"148.110247ms","start":"2026-06-17T18:49:16.170869Z","end":"2026-06-17T18:49:16.318979Z","steps":["trace[1869956967] 'process raft request' (duration: 90.102388ms)","trace[1869956967] 'compare' (duration: 57.517667ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:49:16.458301Z","caller":"traceutil/trace.go:171","msg":"trace[1715480014] transaction","detail":"{read_only:false; response_revision:5381; number_of_response:1; }","duration":"119.813281ms","start":"2026-06-17T18:49:16.338455Z","end":"2026-06-17T18:49:16.458268Z","steps":["trace[1715480014] 'process raft request' (duration: 81.490997ms)","trace[1715480014] 'compare' (duration: 38.19111ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:49:27.883927Z","caller":"traceutil/trace.go:171","msg":"trace[734797040] transaction","detail":"{read_only:false; response_revision:5542; number_of_response:1; }","duration":"144.310233ms","start":"2026-06-17T18:49:27.739574Z","end":"2026-06-17T18:49:27.883884Z","steps":["trace[734797040] 'process raft request' (duration: 101.504219ms)","trace[734797040] 'compare' (duration: 42.63918ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:49:27.897594Z","caller":"traceutil/trace.go:171","msg":"trace[615086838] transaction","detail":"{read_only:false; response_revision:5543; number_of_response:1; }","duration":"157.946359ms","start":"2026-06-17T18:49:27.739622Z","end":"2026-06-17T18:49:27.897569Z","steps":["trace[615086838] 'process raft request' (duration: 157.705553ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:27.897781Z","caller":"traceutil/trace.go:171","msg":"trace[755107786] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"157.895598ms","start":"2026-06-17T18:49:27.739876Z","end":"2026-06-17T18:49:27.897772Z","steps":["trace[755107786] 'process raft request' (duration: 157.618251ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:27.897875Z","caller":"traceutil/trace.go:171","msg":"trace[1332755057] transaction","detail":"{read_only:false; response_revision:5545; number_of_response:1; }","duration":"157.729524ms","start":"2026-06-17T18:49:27.740115Z","end":"2026-06-17T18:49:27.897844Z","steps":["trace[1332755057] 'process raft request' (duration: 157.58383ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:50:42.838369Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3012} {"level":"info","ts":"2026-06-17T18:50:42.924716Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3012,"took":"85.094551ms","hash":1869901142,"current-db-size-bytes":59285504,"current-db-size":"59 MB","current-db-size-in-use-bytes":32239616,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-17T18:50:42.924808Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1869901142,"revision":3012,"compact-revision":-1} {"level":"info","ts":"2026-06-17T18:55:33.806335Z","caller":"traceutil/trace.go:171","msg":"trace[1906269653] transaction","detail":"{read_only:false; response_revision:8272; number_of_response:1; }","duration":"191.271087ms","start":"2026-06-17T18:55:33.615041Z","end":"2026-06-17T18:55:33.806312Z","steps":["trace[1906269653] 'process raft request' (duration: 191.145033ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:55:33.828895Z","caller":"traceutil/trace.go:171","msg":"trace[1393818538] linearizableReadLoop","detail":"{readStateIndex:8558; appliedIndex:8556; }","duration":"139.41665ms","start":"2026-06-17T18:55:33.68945Z","end":"2026-06-17T18:55:33.828867Z","steps":["trace[1393818538] 'read index received' (duration: 116.837743ms)","trace[1393818538] 'applied index is now lower than readState.Index' (duration: 22.577647ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:55:33.828951Z","caller":"traceutil/trace.go:171","msg":"trace[1594353955] transaction","detail":"{read_only:false; response_revision:8273; number_of_response:1; }","duration":"166.959748ms","start":"2026-06-17T18:55:33.66196Z","end":"2026-06-17T18:55:33.82892Z","steps":["trace[1594353955] 'process raft request' (duration: 166.744533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:55:33.829038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.569934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:55:33.829143Z","caller":"traceutil/trace.go:171","msg":"trace[1568351319] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:8273; }","duration":"139.728927ms","start":"2026-06-17T18:55:33.689397Z","end":"2026-06-17T18:55:33.829126Z","steps":["trace[1568351319] 'agreement among raft nodes before linearized reading' (duration: 139.581544ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:55:42.845038Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6153} {"level":"info","ts":"2026-06-17T18:55:42.948656Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6153,"took":"101.555431ms","hash":1743144346,"current-db-size-bytes":59285504,"current-db-size":"59 MB","current-db-size-in-use-bytes":23150592,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-17T18:55:42.948723Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1743144346,"revision":6153,"compact-revision":3012} {"level":"info","ts":"2026-06-17T18:55:44.392734Z","caller":"traceutil/trace.go:171","msg":"trace[568203600] transaction","detail":"{read_only:false; response_revision:8327; number_of_response:1; }","duration":"125.289267ms","start":"2026-06-17T18:55:44.267314Z","end":"2026-06-17T18:55:44.392603Z","steps":["trace[568203600] 'process raft request' (duration: 124.990239ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:55:45.146971Z","caller":"traceutil/trace.go:171","msg":"trace[1758566609] transaction","detail":"{read_only:false; response_revision:8330; number_of_response:1; }","duration":"227.404673ms","start":"2026-06-17T18:55:44.919539Z","end":"2026-06-17T18:55:45.146944Z","steps":["trace[1758566609] 'process raft request' (duration: 227.261999ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:13.526159Z","caller":"traceutil/trace.go:171","msg":"trace[258771943] linearizableReadLoop","detail":"{readStateIndex:8832; appliedIndex:8831; }","duration":"161.826773ms","start":"2026-06-17T18:56:13.364312Z","end":"2026-06-17T18:56:13.526139Z","steps":["trace[258771943] 'read index received' (duration: 161.679799ms)","trace[258771943] 'applied index is now lower than readState.Index' (duration: 146.184µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:56:13.52622Z","caller":"traceutil/trace.go:171","msg":"trace[567886203] transaction","detail":"{read_only:false; response_revision:8536; number_of_response:1; }","duration":"293.941116ms","start":"2026-06-17T18:56:13.232245Z","end":"2026-06-17T18:56:13.526186Z","steps":["trace[567886203] 'process raft request' (duration: 293.771302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:56:13.526349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.020778ms","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-06-17T18:56:13.526433Z","caller":"traceutil/trace.go:171","msg":"trace[1555352993] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8536; }","duration":"162.149761ms","start":"2026-06-17T18:56:13.364273Z","end":"2026-06-17T18:56:13.526423Z","steps":["trace[1555352993] 'agreement among raft nodes before linearized reading' (duration: 161.981807ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:16.839328Z","caller":"traceutil/trace.go:171","msg":"trace[825916333] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"116.107355ms","start":"2026-06-17T18:56:16.723192Z","end":"2026-06-17T18:56:16.839299Z","steps":["trace[825916333] 'process raft request' (duration: 115.952271ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:26.069095Z","caller":"traceutil/trace.go:171","msg":"trace[12830829] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"291.505487ms","start":"2026-06-17T18:56:25.77756Z","end":"2026-06-17T18:56:26.069066Z","steps":["trace[12830829] 'process raft request' (duration: 291.283592ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:26.179325Z","caller":"traceutil/trace.go:171","msg":"trace[2144514057] transaction","detail":"{read_only:false; response_revision:8649; number_of_response:1; }","duration":"104.029492ms","start":"2026-06-17T18:56:26.075274Z","end":"2026-06-17T18:56:26.179303Z","steps":["trace[2144514057] 'process raft request' (duration: 103.867708ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:27.074052Z","caller":"traceutil/trace.go:171","msg":"trace[1231214511] transaction","detail":"{read_only:false; response_revision:8655; number_of_response:1; }","duration":"111.453362ms","start":"2026-06-17T18:56:26.962576Z","end":"2026-06-17T18:56:27.074029Z","steps":["trace[1231214511] 'process raft request' (duration: 111.214916ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:41.790196Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000238b.wal"} {"level":"info","ts":"2026-06-17T18:58:20.058574Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a847c2e9c7010db6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-17T18:58:20.064561Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-17T18:58:20.064656Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-17T19:00:42.850872Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8319} {"level":"info","ts":"2026-06-17T19:00:42.929112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8319,"took":"74.337776ms","hash":935354378,"current-db-size-bytes":59285504,"current-db-size":"59 MB","current-db-size-in-use-bytes":25448448,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-17T19:00:42.929298Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":935354378,"revision":8319,"compact-revision":6153} {"level":"warn","ts":"2026-06-17T19:01:03.305551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.486976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T19:01:03.305771Z","caller":"traceutil/trace.go:171","msg":"trace[1710183741] transaction","detail":"{read_only:false; response_revision:11121; number_of_response:1; }","duration":"195.189248ms","start":"2026-06-17T19:01:03.11056Z","end":"2026-06-17T19:01:03.305749Z","steps":["trace[1710183741] 'process raft request' (duration: 49.407665ms)","trace[1710183741] 'compare' (duration: 145.277351ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:01:03.306469Z","caller":"traceutil/trace.go:171","msg":"trace[1860210291] transaction","detail":"{read_only:false; response_revision:11123; number_of_response:1; }","duration":"158.466175ms","start":"2026-06-17T19:01:03.147966Z","end":"2026-06-17T19:01:03.306432Z","steps":["trace[1860210291] 'process raft request' (duration: 158.424064ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:01:03.306824Z","caller":"traceutil/trace.go:171","msg":"trace[372691416] transaction","detail":"{read_only:false; response_revision:11122; number_of_response:1; }","duration":"194.131212ms","start":"2026-06-17T19:01:03.112636Z","end":"2026-06-17T19:01:03.306768Z","steps":["trace[372691416] 'process raft request' (duration: 193.65654ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:01:21.563161Z","caller":"traceutil/trace.go:171","msg":"trace[1013110806] linearizableReadLoop","detail":"{readStateIndex:11596; appliedIndex:11595; }","duration":"178.824395ms","start":"2026-06-17T19:01:21.384306Z","end":"2026-06-17T19:01:21.56313Z","steps":["trace[1013110806] 'read index received' (duration: 126.49382ms)","trace[1013110806] 'applied index is now lower than readState.Index' (duration: 52.327725ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:01:21.563167Z","caller":"traceutil/trace.go:171","msg":"trace[1221708126] transaction","detail":"{read_only:false; response_revision:11221; number_of_response:1; }","duration":"176.230322ms","start":"2026-06-17T19:01:21.386911Z","end":"2026-06-17T19:01:21.563141Z","steps":["trace[1221708126] 'process raft request' (duration: 176.089598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:01:21.563581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.510923ms","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-06-17T19:01:21.563635Z","caller":"traceutil/trace.go:171","msg":"trace[656192877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11221; }","duration":"166.599906ms","start":"2026-06-17T19:01:21.397018Z","end":"2026-06-17T19:01:21.563618Z","steps":["trace[656192877] 'agreement among raft nodes before linearized reading' (duration: 166.297418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:01:21.563686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.459332ms","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-06-17T19:01:21.563773Z","caller":"traceutil/trace.go:171","msg":"trace[1849340315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11221; }","duration":"166.576315ms","start":"2026-06-17T19:01:21.397178Z","end":"2026-06-17T19:01:21.563755Z","steps":["trace[1849340315] 'agreement among raft nodes before linearized reading' (duration: 166.181815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:01:21.564026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.703878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T19:01:21.564097Z","caller":"traceutil/trace.go:171","msg":"trace[118429191] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:11221; }","duration":"179.841941ms","start":"2026-06-17T19:01:21.384239Z","end":"2026-06-17T19:01:21.56408Z","steps":["trace[118429191] 'agreement among raft nodes before linearized reading' (duration: 179.00931ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:05:42.856672Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10819} {"level":"info","ts":"2026-06-17T19:05:42.93148Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10819,"took":"72.332281ms","hash":3826894625,"current-db-size-bytes":59285504,"current-db-size":"59 MB","current-db-size-in-use-bytes":27717632,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-17T19:05:42.931542Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3826894625,"revision":10819,"compact-revision":8319} {"level":"info","ts":"2026-06-17T19:07:43.016999Z","caller":"traceutil/trace.go:171","msg":"trace[1932229758] transaction","detail":"{read_only:false; response_revision:13809; number_of_response:1; }","duration":"101.915608ms","start":"2026-06-17T19:07:42.915049Z","end":"2026-06-17T19:07:43.016964Z","steps":["trace[1932229758] 'process raft request' (duration: 100.427262ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:07:51.205489Z","caller":"traceutil/trace.go:171","msg":"trace[743217334] transaction","detail":"{read_only:false; response_revision:13853; number_of_response:1; }","duration":"115.394852ms","start":"2026-06-17T19:07:51.090057Z","end":"2026-06-17T19:07:51.205452Z","steps":["trace[743217334] 'process raft request' (duration: 42.898434ms)","trace[743217334] 'compare' (duration: 72.345204ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T19:07:59.371455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.129923ms","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-06-17T19:07:59.371534Z","caller":"traceutil/trace.go:171","msg":"trace[1830060664] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13908; }","duration":"136.264116ms","start":"2026-06-17T19:07:59.235249Z","end":"2026-06-17T19:07:59.371513Z","steps":["trace[1830060664] 'range keys from in-memory index tree' (duration: 135.956248ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:07:59.371831Z","caller":"traceutil/trace.go:171","msg":"trace[1618468709] transaction","detail":"{read_only:false; response_revision:13909; number_of_response:1; }","duration":"130.405095ms","start":"2026-06-17T19:07:59.241408Z","end":"2026-06-17T19:07:59.371813Z","steps":["trace[1618468709] 'process raft request' (duration: 130.261611ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:07:59.372629Z","caller":"traceutil/trace.go:171","msg":"trace[1770566061] linearizableReadLoop","detail":"{readStateIndex:14380; appliedIndex:14378; }","duration":"126.93708ms","start":"2026-06-17T19:07:59.245656Z","end":"2026-06-17T19:07:59.372593Z","steps":["trace[1770566061] 'read index received' (duration: 126.109091ms)","trace[1770566061] 'applied index is now lower than readState.Index' (duration: 826.759µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:07:59.372784Z","caller":"traceutil/trace.go:171","msg":"trace[1645604137] transaction","detail":"{read_only:false; response_revision:13910; number_of_response:1; }","duration":"129.910892ms","start":"2026-06-17T19:07:59.242861Z","end":"2026-06-17T19:07:59.372772Z","steps":["trace[1645604137] 'process raft request' (duration: 129.586904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:07:59.372936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.889786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-17T19:07:59.372997Z","caller":"traceutil/trace.go:171","msg":"trace[2040077002] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13910; }","duration":"118.960038ms","start":"2026-06-17T19:07:59.25402Z","end":"2026-06-17T19:07:59.37298Z","steps":["trace[2040077002] 'agreement among raft nodes before linearized reading' (duration: 118.818374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:07:59.373308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.633498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:415445"} {"level":"warn","ts":"2026-06-17T19:07:59.373342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.318867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-17T19:07:59.373392Z","caller":"traceutil/trace.go:171","msg":"trace[955726453] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:13910; }","duration":"127.755891ms","start":"2026-06-17T19:07:59.245619Z","end":"2026-06-17T19:07:59.373375Z","steps":["trace[955726453] 'agreement among raft nodes before linearized reading' (duration: 127.449653ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:07:59.373421Z","caller":"traceutil/trace.go:171","msg":"trace[1837657154] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13910; }","duration":"114.42771ms","start":"2026-06-17T19:07:59.258971Z","end":"2026-06-17T19:07:59.373399Z","steps":["trace[1837657154] 'agreement among raft nodes before linearized reading' (duration: 114.133562ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:08:20.026463Z","caller":"traceutil/trace.go:171","msg":"trace[1665002773] transaction","detail":"{read_only:false; response_revision:14214; number_of_response:1; }","duration":"256.031053ms","start":"2026-06-17T19:08:19.770401Z","end":"2026-06-17T19:08:20.026433Z","steps":["trace[1665002773] 'process raft request' (duration: 255.797577ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:08:20.038751Z","caller":"traceutil/trace.go:171","msg":"trace[1469656573] linearizableReadLoop","detail":"{readStateIndex:14696; appliedIndex:14694; }","duration":"177.025999ms","start":"2026-06-17T19:08:19.861688Z","end":"2026-06-17T19:08:20.038714Z","steps":["trace[1469656573] 'read index received' (duration: 164.559848ms)","trace[1469656573] 'applied index is now lower than readState.Index' (duration: 12.46408ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T19:08:20.03939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.548572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d72b9341-38a3-4385-b795-e769bc2740aa\" ","response":"range_response_count:1 size:3636"} {"level":"info","ts":"2026-06-17T19:08:20.039494Z","caller":"traceutil/trace.go:171","msg":"trace[1019974639] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d72b9341-38a3-4385-b795-e769bc2740aa; range_end:; response_count:1; response_revision:14216; }","duration":"177.829219ms","start":"2026-06-17T19:08:19.861642Z","end":"2026-06-17T19:08:20.039471Z","steps":["trace[1019974639] 'agreement among raft nodes before linearized reading' (duration: 177.285766ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:08:20.040489Z","caller":"traceutil/trace.go:171","msg":"trace[424028452] transaction","detail":"{read_only:false; response_revision:14215; number_of_response:1; }","duration":"268.925744ms","start":"2026-06-17T19:08:19.77154Z","end":"2026-06-17T19:08:20.040466Z","steps":["trace[424028452] 'process raft request' (duration: 266.557257ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:08:20.040892Z","caller":"traceutil/trace.go:171","msg":"trace[2074600847] transaction","detail":"{read_only:false; response_revision:14216; number_of_response:1; }","duration":"126.085651ms","start":"2026-06-17T19:08:19.914784Z","end":"2026-06-17T19:08:20.04087Z","steps":["trace[2074600847] 'process raft request' (duration: 123.770135ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:09:49.959102Z","caller":"traceutil/trace.go:171","msg":"trace[336492252] transaction","detail":"{read_only:false; response_revision:15041; number_of_response:1; }","duration":"158.553034ms","start":"2026-06-17T19:09:49.800525Z","end":"2026-06-17T19:09:49.959078Z","steps":["trace[336492252] 'process raft request' (duration: 158.40799ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:09:49.971743Z","caller":"traceutil/trace.go:171","msg":"trace[1553626551] linearizableReadLoop","detail":"{readStateIndex:15546; appliedIndex:15544; }","duration":"148.375718ms","start":"2026-06-17T19:09:49.823352Z","end":"2026-06-17T19:09:49.971727Z","steps":["trace[1553626551] 'read index received' (duration: 135.576329ms)","trace[1553626551] 'applied index is now lower than readState.Index' (duration: 12.798349ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:09:49.971989Z","caller":"traceutil/trace.go:171","msg":"trace[885078621] transaction","detail":"{read_only:false; response_revision:15042; number_of_response:1; }","duration":"168.093593ms","start":"2026-06-17T19:09:49.803884Z","end":"2026-06-17T19:09:49.971978Z","steps":["trace[885078621] 'process raft request' (duration: 167.767306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:09:49.972327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.951342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-br2fs\" ","response":"range_response_count:1 size:22096"} {"level":"info","ts":"2026-06-17T19:09:49.97241Z","caller":"traceutil/trace.go:171","msg":"trace[570485104] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-br2fs; range_end:; response_count:1; response_revision:15042; }","duration":"149.072464ms","start":"2026-06-17T19:09:49.823319Z","end":"2026-06-17T19:09:49.972391Z","steps":["trace[570485104] 'agreement among raft nodes before linearized reading' (duration: 148.831699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:09:49.972428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.656619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-br2fs\" ","response":"range_response_count:1 size:22096"} {"level":"info","ts":"2026-06-17T19:09:49.972525Z","caller":"traceutil/trace.go:171","msg":"trace[1534472549] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-br2fs; range_end:; response_count:1; response_revision:15042; }","duration":"110.761071ms","start":"2026-06-17T19:09:49.861748Z","end":"2026-06-17T19:09:49.972508Z","steps":["trace[1534472549] 'agreement among raft nodes before linearized reading' (duration: 110.478954ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:09:50.114291Z","caller":"traceutil/trace.go:171","msg":"trace[1892236295] transaction","detail":"{read_only:false; response_revision:15043; number_of_response:1; }","duration":"137.71911ms","start":"2026-06-17T19:09:49.976547Z","end":"2026-06-17T19:09:50.114266Z","steps":["trace[1892236295] 'process raft request' (duration: 119.912771ms)","trace[1892236295] 'compare' (duration: 17.689267ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:09:50.129796Z","caller":"traceutil/trace.go:171","msg":"trace[183991572] linearizableReadLoop","detail":"{readStateIndex:15548; appliedIndex:15546; }","duration":"150.53444ms","start":"2026-06-17T19:09:49.979241Z","end":"2026-06-17T19:09:50.129775Z","steps":["trace[183991572] 'read index received' (duration: 117.450232ms)","trace[183991572] 'applied index is now lower than readState.Index' (duration: 33.083348ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:09:50.129873Z","caller":"traceutil/trace.go:171","msg":"trace[1159739159] transaction","detail":"{read_only:false; response_revision:15044; number_of_response:1; }","duration":"152.23232ms","start":"2026-06-17T19:09:49.977604Z","end":"2026-06-17T19:09:50.129836Z","steps":["trace[1159739159] 'process raft request' (duration: 152.038626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:09:50.144931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.117262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:77 size:744202"} {"level":"info","ts":"2026-06-17T19:09:50.145034Z","caller":"traceutil/trace.go:171","msg":"trace[1022425234] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:77; response_revision:15045; }","duration":"165.241015ms","start":"2026-06-17T19:09:49.979758Z","end":"2026-06-17T19:09:50.144999Z","steps":["trace[1022425234] 'agreement among raft nodes before linearized reading' (duration: 150.184732ms)","trace[1022425234] 'range keys from bolt db' (duration: 14.785756ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T19:09:50.147168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.898298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:77 size:744202"} {"level":"info","ts":"2026-06-17T19:09:50.147272Z","caller":"traceutil/trace.go:171","msg":"trace[619594970] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:77; response_revision:15045; }","duration":"168.022602ms","start":"2026-06-17T19:09:49.979214Z","end":"2026-06-17T19:09:50.147236Z","steps":["trace[619594970] 'agreement among raft nodes before linearized reading' (duration: 150.703734ms)","trace[619594970] 'range keys from bolt db' (duration: 17.052271ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T19:09:50.149807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.914889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:77 size:744202"} {"level":"info","ts":"2026-06-17T19:09:50.149861Z","caller":"traceutil/trace.go:171","msg":"trace[1301167324] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:77; response_revision:15045; }","duration":"167.97998ms","start":"2026-06-17T19:09:49.981861Z","end":"2026-06-17T19:09:50.149841Z","steps":["trace[1301167324] 'agreement among raft nodes before linearized reading' (duration: 148.147823ms)","trace[1301167324] 'range keys from bolt db' (duration: 19.701415ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:09:50.150711Z","caller":"traceutil/trace.go:171","msg":"trace[1806001200] transaction","detail":"{read_only:false; response_revision:15045; number_of_response:1; }","duration":"150.828437ms","start":"2026-06-17T19:09:49.979697Z","end":"2026-06-17T19:09:50.130526Z","steps":["trace[1806001200] 'process raft request' (duration: 150.048538ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:10:42.863775Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13023} {"level":"info","ts":"2026-06-17T19:10:42.949239Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13023,"took":"83.219761ms","hash":230757878,"current-db-size-bytes":59285504,"current-db-size":"59 MB","current-db-size-in-use-bytes":30232576,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-17T19:10:42.949322Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":230757878,"revision":13023,"compact-revision":10819} {"level":"info","ts":"2026-06-17T19:15:42.870098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15379} {"level":"info","ts":"2026-06-17T19:15:42.960143Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15379,"took":"87.419779ms","hash":1823556351,"current-db-size-bytes":59285504,"current-db-size":"59 MB","current-db-size-in-use-bytes":31531008,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-17T19:15:42.960246Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1823556351,"revision":15379,"compact-revision":13023} {"level":"info","ts":"2026-06-17T19:20:42.875693Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17616} {"level":"info","ts":"2026-06-17T19:20:42.971672Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17616,"took":"93.781803ms","hash":2176578449,"current-db-size-bytes":59285504,"current-db-size":"59 MB","current-db-size-in-use-bytes":26898432,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-17T19:20:42.971736Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2176578449,"revision":17616,"compact-revision":15379} {"level":"info","ts":"2026-06-17T19:21:11.065854Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a847c2e9c7010db6","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-17T19:21:11.071979Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-17T19:21:11.072093Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}