{"level":"warn","ts":"2026-09-16T02:11:20.199035Z","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-16T02:11:20.199121Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.234: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.234:2380","--initial-cluster=instance=https://162.253.55.234:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.234:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.234: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-16T02:11:20.199181Z","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-16T02:11:20.199188Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.234:2380"]} {"level":"info","ts":"2026-09-16T02:11:20.199204Z","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-16T02:11:20.199792Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.234:2379"]} {"level":"info","ts":"2026-09-16T02:11:20.199872Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.234:2380"],"listen-peer-urls":["https://162.253.55.234:2380"],"advertise-client-urls":["https://162.253.55.234:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.234:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.234: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-16T02:11:20.205211Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.137445ms"} {"level":"info","ts":"2026-09-16T02:11:20.212962Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"403fac606ddb6bbc","cluster-id":"3f7d75ded657ac1e"} {"level":"info","ts":"2026-09-16T02:11:20.213086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc switched to configuration voters=()"} {"level":"info","ts":"2026-09-16T02:11:20.213118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became follower at term 0"} {"level":"info","ts":"2026-09-16T02:11:20.213143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 403fac606ddb6bbc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-16T02:11:20.213162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became follower at term 1"} {"level":"info","ts":"2026-09-16T02:11:20.213205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc switched to configuration voters=(4629608472120093628)"} {"level":"warn","ts":"2026-09-16T02:11:20.22319Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-16T02:11:20.22613Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-16T02:11:20.231085Z","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-16T02:11:20.234868Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"403fac606ddb6bbc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-16T02:11:20.235098Z","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-16T02:11:20.235169Z","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-16T02:11:20.235162Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"403fac606ddb6bbc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-16T02:11:20.235217Z","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-16T02:11:20.240067Z","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-16T02:11:20.240141Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.234:2380"} {"level":"info","ts":"2026-09-16T02:11:20.240186Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.234:2380"} {"level":"info","ts":"2026-09-16T02:11:20.240272Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"403fac606ddb6bbc","initial-advertise-peer-urls":["https://162.253.55.234:2380"],"listen-peer-urls":["https://162.253.55.234:2380"],"advertise-client-urls":["https://162.253.55.234:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.234:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-16T02:11:20.240297Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-16T02:11:20.240827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc switched to configuration voters=(4629608472120093628)"} {"level":"info","ts":"2026-09-16T02:11:20.241027Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f7d75ded657ac1e","local-member-id":"403fac606ddb6bbc","added-peer-id":"403fac606ddb6bbc","added-peer-peer-urls":["https://162.253.55.234:2380"]} {"level":"info","ts":"2026-09-16T02:11:20.813725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc is starting a new election at term 1"} {"level":"info","ts":"2026-09-16T02:11:20.813824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became pre-candidate at term 1"} {"level":"info","ts":"2026-09-16T02:11:20.813847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc received MsgPreVoteResp from 403fac606ddb6bbc at term 1"} {"level":"info","ts":"2026-09-16T02:11:20.813861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became candidate at term 2"} {"level":"info","ts":"2026-09-16T02:11:20.813946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc received MsgVoteResp from 403fac606ddb6bbc at term 2"} {"level":"info","ts":"2026-09-16T02:11:20.813971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became leader at term 2"} {"level":"info","ts":"2026-09-16T02:11:20.813984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 403fac606ddb6bbc elected leader 403fac606ddb6bbc at term 2"} {"level":"info","ts":"2026-09-16T02:11:20.815201Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"403fac606ddb6bbc","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.234:2379]}","request-path":"/0/members/403fac606ddb6bbc/attributes","cluster-id":"3f7d75ded657ac1e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-16T02:11:20.815324Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-16T02:11:20.815288Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T02:11:20.815423Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-16T02:11:20.816599Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f7d75ded657ac1e","local-member-id":"403fac606ddb6bbc","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T02:11:20.81676Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T02:11:20.816895Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T02:11:20.817174Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-16T02:11:20.817252Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-16T02:11:20.818189Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-16T02:11:20.826715Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.234:2379"} {"level":"warn","ts":"2026-09-16T02:11:23.791247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.538509ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-16T02:11:23.791378Z","caller":"traceutil/trace.go:171","msg":"trace[1512642812] linearizableReadLoop","detail":"{readStateIndex:79; appliedIndex:78; }","duration":"534.355463ms","start":"2026-09-16T02:11:23.257006Z","end":"2026-09-16T02:11:23.791362Z","steps":["trace[1512642812] 'read index received' (duration: 220.998338ms)","trace[1512642812] 'applied index is now lower than readState.Index' (duration: 313.355905ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:11:23.79142Z","caller":"traceutil/trace.go:171","msg":"trace[1627710779] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"535.123018ms","start":"2026-09-16T02:11:23.256273Z","end":"2026-09-16T02:11:23.791396Z","steps":["trace[1627710779] 'process raft request' (duration: 221.812425ms)","trace[1627710779] 'compare' (duration: 312.384953ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:11:23.791514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.499567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-16T02:11:23.791549Z","caller":"traceutil/trace.go:171","msg":"trace[1928902246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:75; }","duration":"534.55911ms","start":"2026-09-16T02:11:23.256982Z","end":"2026-09-16T02:11:23.791541Z","steps":["trace[1928902246] 'agreement among raft nodes before linearized reading' (duration: 534.461997ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:11:23.791511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:11:23.256252Z","time spent":"535.21841ms","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-16T02:11:23.791575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:11:23.256971Z","time spent":"534.598341ms","remote":"127.0.0.1:39522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-16T02:11:23.791709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.073255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-16T02:11:23.791951Z","caller":"traceutil/trace.go:171","msg":"trace[1999807455] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:75; }","duration":"534.389554ms","start":"2026-09-16T02:11:23.257536Z","end":"2026-09-16T02:11:23.791925Z","steps":["trace[1999807455] 'agreement among raft nodes before linearized reading' (duration: 533.95894ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:11:23.792045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:11:23.257525Z","time spent":"534.504508ms","remote":"127.0.0.1:39876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"info","ts":"2026-09-16T02:11:23.949303Z","caller":"traceutil/trace.go:171","msg":"trace[588492542] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"144.522901ms","start":"2026-09-16T02:11:23.804756Z","end":"2026-09-16T02:11:23.949279Z","steps":["trace[588492542] 'process raft request' (duration: 91.342764ms)","trace[588492542] 'compare' (duration: 53.083304ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:12:07.62352Z","caller":"traceutil/trace.go:171","msg":"trace[1890811941] transaction","detail":"{read_only:false; number_of_response:0; response_revision:565; }","duration":"177.487347ms","start":"2026-09-16T02:12:07.446006Z","end":"2026-09-16T02:12:07.623494Z","steps":["trace[1890811941] 'process raft request' (duration: 126.357878ms)","trace[1890811941] 'compare' (duration: 50.971498ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:12:07.623707Z","caller":"traceutil/trace.go:171","msg":"trace[732483289] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:583; }","duration":"175.366641ms","start":"2026-09-16T02:12:07.448319Z","end":"2026-09-16T02:12:07.623685Z","steps":["trace[732483289] 'read index received' (duration: 3.893721ms)","trace[732483289] 'applied index is now lower than readState.Index' (duration: 171.47222ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:12:07.623735Z","caller":"traceutil/trace.go:171","msg":"trace[88952213] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"174.580294ms","start":"2026-09-16T02:12:07.449127Z","end":"2026-09-16T02:12:07.623707Z","steps":["trace[88952213] 'process raft request' (duration: 174.470653ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.623717Z","caller":"traceutil/trace.go:171","msg":"trace[71555333] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"177.497978ms","start":"2026-09-16T02:12:07.446183Z","end":"2026-09-16T02:12:07.623681Z","steps":["trace[71555333] 'process raft request' (duration: 177.275686ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.623821Z","caller":"traceutil/trace.go:171","msg":"trace[1202114384] transaction","detail":"{read_only:false; number_of_response:1; response_revision:570; }","duration":"173.555967ms","start":"2026-09-16T02:12:07.45026Z","end":"2026-09-16T02:12:07.623816Z","steps":["trace[1202114384] 'process raft request' (duration: 173.361055ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.623937Z","caller":"traceutil/trace.go:171","msg":"trace[1342733804] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"177.693189ms","start":"2026-09-16T02:12:07.446229Z","end":"2026-09-16T02:12:07.623922Z","steps":["trace[1342733804] 'process raft request' (duration: 177.263745ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.623954Z","caller":"traceutil/trace.go:171","msg":"trace[1552207024] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"177.83176ms","start":"2026-09-16T02:12:07.446105Z","end":"2026-09-16T02:12:07.623937Z","steps":["trace[1552207024] 'process raft request' (duration: 177.288056ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.624022Z","caller":"traceutil/trace.go:171","msg":"trace[287418152] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"173.600837ms","start":"2026-09-16T02:12:07.450415Z","end":"2026-09-16T02:12:07.624016Z","steps":["trace[287418152] 'process raft request' (duration: 173.229734ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:07.623799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.463672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:07.624061Z","caller":"traceutil/trace.go:171","msg":"trace[357146968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"175.742674ms","start":"2026-09-16T02:12:07.448303Z","end":"2026-09-16T02:12:07.624046Z","steps":["trace[357146968] 'agreement among raft nodes before linearized reading' (duration: 175.448442ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.624074Z","caller":"traceutil/trace.go:171","msg":"trace[264249137] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"175.041818ms","start":"2026-09-16T02:12:07.449023Z","end":"2026-09-16T02:12:07.624064Z","steps":["trace[264249137] 'process raft request' (duration: 174.537834ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.625197Z","caller":"traceutil/trace.go:171","msg":"trace[857184516] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"164.338965ms","start":"2026-09-16T02:12:07.460838Z","end":"2026-09-16T02:12:07.625177Z","steps":["trace[857184516] 'process raft request' (duration: 164.106003ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.626045Z","caller":"traceutil/trace.go:171","msg":"trace[2072203748] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"158.383208ms","start":"2026-09-16T02:12:07.467654Z","end":"2026-09-16T02:12:07.626037Z","steps":["trace[2072203748] 'process raft request' (duration: 157.387461ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:07.626114Z","caller":"traceutil/trace.go:171","msg":"trace[1727136057] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"152.755844ms","start":"2026-09-16T02:12:07.473351Z","end":"2026-09-16T02:12:07.626106Z","steps":["trace[1727136057] 'process raft request' (duration: 152.587033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:09.903675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.448478ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-16T02:12:14.299914Z","caller":"traceutil/trace.go:171","msg":"trace[1318168395] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"432.359099ms","start":"2026-09-16T02:12:13.867528Z","end":"2026-09-16T02:12:14.299887Z","steps":["trace[1318168395] 'process raft request' (duration: 431.827553ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:14.300272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:13.867501Z","time spent":"432.512781ms","remote":"127.0.0.1:39634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-16T02:12:14.874395Z","caller":"traceutil/trace.go:171","msg":"trace[1698711972] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:683; }","duration":"362.662838ms","start":"2026-09-16T02:12:14.511696Z","end":"2026-09-16T02:12:14.874358Z","steps":["trace[1698711972] 'read index received' (duration: 362.414545ms)","trace[1698711972] 'applied index is now lower than readState.Index' (duration: 246.903µs)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:12:14.874452Z","caller":"traceutil/trace.go:171","msg":"trace[1365420046] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"494.078661ms","start":"2026-09-16T02:12:14.380355Z","end":"2026-09-16T02:12:14.874434Z","steps":["trace[1365420046] 'process raft request' (duration: 493.841789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:14.8747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.252226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.234\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-09-16T02:12:14.874721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.029061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-244hq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-16T02:12:14.874762Z","caller":"traceutil/trace.go:171","msg":"trace[1257797160] range","detail":"{range_begin:/registry/pods/kube-system/cilium-244hq; range_end:; response_count:1; response_revision:658; }","duration":"363.135342ms","start":"2026-09-16T02:12:14.511615Z","end":"2026-09-16T02:12:14.87475Z","steps":["trace[1257797160] 'agreement among raft nodes before linearized reading' (duration: 362.93504ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:14.874758Z","caller":"traceutil/trace.go:171","msg":"trace[2080618811] range","detail":"{range_begin:/registry/masterleases/162.253.55.234; range_end:; response_count:1; response_revision:658; }","duration":"215.362076ms","start":"2026-09-16T02:12:14.659378Z","end":"2026-09-16T02:12:14.87474Z","steps":["trace[2080618811] 'agreement among raft nodes before linearized reading' (duration: 215.237915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:14.874738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.179971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-16T02:12:14.874821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.342932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-16T02:12:14.874861Z","caller":"traceutil/trace.go:171","msg":"trace[1395150719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"261.334102ms","start":"2026-09-16T02:12:14.613496Z","end":"2026-09-16T02:12:14.87483Z","steps":["trace[1395150719] 'agreement among raft nodes before linearized reading' (duration: 261.09646ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:14.874881Z","caller":"traceutil/trace.go:171","msg":"trace[537640025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:658; }","duration":"149.430793ms","start":"2026-09-16T02:12:14.725436Z","end":"2026-09-16T02:12:14.874866Z","steps":["trace[537640025] 'agreement among raft nodes before linearized reading' (duration: 149.16197ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:14.874796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:14.51158Z","time spent":"363.208103ms","remote":"127.0.0.1:39718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-244hq\" "} {"level":"warn","ts":"2026-09-16T02:12:14.874749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:14.380326Z","time spent":"494.192422ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-16T02:12:32.265763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.633336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:32.265925Z","caller":"traceutil/trace.go:171","msg":"trace[1184530950] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:824; }","duration":"356.806908ms","start":"2026-09-16T02:12:31.909099Z","end":"2026-09-16T02:12:32.265906Z","steps":["trace[1184530950] 'range keys from in-memory index tree' (duration: 356.567025ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.265973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.485787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:32.266076Z","caller":"traceutil/trace.go:171","msg":"trace[1946102755] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:824; }","duration":"208.637939ms","start":"2026-09-16T02:12:32.057417Z","end":"2026-09-16T02:12:32.266055Z","steps":["trace[1946102755] 'range keys from in-memory index tree' (duration: 208.409626ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.266143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:31.909072Z","time spent":"356.92848ms","remote":"127.0.0.1:54772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-09-16T02:12:32.266378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.041287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-16T02:12:32.266396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.833672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:32.26647Z","caller":"traceutil/trace.go:171","msg":"trace[1583179131] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:824; }","duration":"208.960564ms","start":"2026-09-16T02:12:32.057491Z","end":"2026-09-16T02:12:32.266452Z","steps":["trace[1583179131] 'count revisions from in-memory index tree' (duration: 208.72638ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.266421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.133688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-16T02:12:32.266531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.31776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:32.26658Z","caller":"traceutil/trace.go:171","msg":"trace[1080803245] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:824; }","duration":"322.366402ms","start":"2026-09-16T02:12:31.9442Z","end":"2026-09-16T02:12:32.266566Z","steps":["trace[1080803245] 'count revisions from in-memory index tree' (duration: 322.240359ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.266646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.918184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-16T02:12:32.266652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:31.944158Z","time spent":"322.478553ms","remote":"127.0.0.1:54778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-09-16T02:12:32.266681Z","caller":"traceutil/trace.go:171","msg":"trace[349885145] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:824; }","duration":"208.998774ms","start":"2026-09-16T02:12:32.05767Z","end":"2026-09-16T02:12:32.266669Z","steps":["trace[349885145] 'range keys from in-memory index tree' (duration: 208.846422ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:32.266616Z","caller":"traceutil/trace.go:171","msg":"trace[1522974790] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:824; }","duration":"322.32881ms","start":"2026-09-16T02:12:31.944275Z","end":"2026-09-16T02:12:32.266603Z","steps":["trace[1522974790] 'range keys from in-memory index tree' (duration: 322.010366ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.266859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:31.944166Z","time spent":"322.677726ms","remote":"127.0.0.1:54778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-09-16T02:12:32.267075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.562356ms","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":"info","ts":"2026-09-16T02:12:32.267131Z","caller":"traceutil/trace.go:171","msg":"trace[1620471626] 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:824; }","duration":"171.623407ms","start":"2026-09-16T02:12:32.095479Z","end":"2026-09-16T02:12:32.267103Z","steps":["trace[1620471626] 'range keys from in-memory index tree' (duration: 171.470115ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.266904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.319502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:32.267255Z","caller":"traceutil/trace.go:171","msg":"trace[1520638306] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:824; }","duration":"196.681547ms","start":"2026-09-16T02:12:32.070557Z","end":"2026-09-16T02:12:32.267239Z","steps":["trace[1520638306] 'range keys from in-memory index tree' (duration: 196.234941ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.267322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.707608ms","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":"info","ts":"2026-09-16T02:12:32.267375Z","caller":"traceutil/trace.go:171","msg":"trace[631242935] 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:824; }","duration":"171.78717ms","start":"2026-09-16T02:12:32.095555Z","end":"2026-09-16T02:12:32.267343Z","steps":["trace[631242935] 'count revisions from in-memory index tree' (duration: 171.627487ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.266937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.318062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-16T02:12:32.267501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.171331ms","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":"info","ts":"2026-09-16T02:12:32.267511Z","caller":"traceutil/trace.go:171","msg":"trace[954771236] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:824; }","duration":"196.916881ms","start":"2026-09-16T02:12:32.070583Z","end":"2026-09-16T02:12:32.2675Z","steps":["trace[954771236] 'count revisions from in-memory index tree' (duration: 196.266401ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:32.267527Z","caller":"traceutil/trace.go:171","msg":"trace[1588631262] 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:824; }","duration":"171.211931ms","start":"2026-09-16T02:12:32.096306Z","end":"2026-09-16T02:12:32.267518Z","steps":["trace[1588631262] 'range keys from in-memory index tree' (duration: 171.1262ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.266967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.390068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:32.267713Z","caller":"traceutil/trace.go:171","msg":"trace[712330488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:824; }","duration":"196.14576ms","start":"2026-09-16T02:12:32.071556Z","end":"2026-09-16T02:12:32.267702Z","steps":["trace[712330488] 'range keys from in-memory index tree' (duration: 195.296517ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.267855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.961248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:32.267925Z","caller":"traceutil/trace.go:171","msg":"trace[1509688144] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:824; }","duration":"130.05672ms","start":"2026-09-16T02:12:32.137848Z","end":"2026-09-16T02:12:32.267905Z","steps":["trace[1509688144] 'range keys from in-memory index tree' (duration: 129.878917ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:32.266465Z","caller":"traceutil/trace.go:171","msg":"trace[807933543] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:824; }","duration":"322.178799ms","start":"2026-09-16T02:12:31.944264Z","end":"2026-09-16T02:12:32.266442Z","steps":["trace[807933543] 'range keys from in-memory index tree' (duration: 321.946465ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:32.268472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:31.944247Z","time spent":"324.203678ms","remote":"127.0.0.1:54778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-09-16T02:12:32.270327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.818606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:32.270398Z","caller":"traceutil/trace.go:171","msg":"trace[523113051] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:824; }","duration":"132.2034ms","start":"2026-09-16T02:12:32.138172Z","end":"2026-09-16T02:12:32.270375Z","steps":["trace[523113051] 'count revisions from in-memory index tree' (duration: 129.715485ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:50.286091Z","caller":"traceutil/trace.go:171","msg":"trace[2054352953] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"120.72979ms","start":"2026-09-16T02:12:50.165293Z","end":"2026-09-16T02:12:50.286023Z","steps":["trace[2054352953] 'process raft request' (duration: 120.571318ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:50.286331Z","caller":"traceutil/trace.go:171","msg":"trace[142789339] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"120.678929ms","start":"2026-09-16T02:12:50.165636Z","end":"2026-09-16T02:12:50.286315Z","steps":["trace[142789339] 'process raft request' (duration: 120.309003ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:50.2865Z","caller":"traceutil/trace.go:171","msg":"trace[1270607311] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"119.926716ms","start":"2026-09-16T02:12:50.166545Z","end":"2026-09-16T02:12:50.286472Z","steps":["trace[1270607311] 'process raft request' (duration: 119.426727ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:50.2865Z","caller":"traceutil/trace.go:171","msg":"trace[1383044391] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"119.885136ms","start":"2026-09-16T02:12:50.16656Z","end":"2026-09-16T02:12:50.286445Z","steps":["trace[1383044391] 'process raft request' (duration: 119.429378ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:13:02.167595Z","caller":"traceutil/trace.go:171","msg":"trace[1007808041] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"163.891055ms","start":"2026-09-16T02:13:02.003666Z","end":"2026-09-16T02:13:02.167557Z","steps":["trace[1007808041] 'process raft request' (duration: 161.167652ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:13:50.514272Z","caller":"traceutil/trace.go:171","msg":"trace[2027415387] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"140.672084ms","start":"2026-09-16T02:13:50.373545Z","end":"2026-09-16T02:13:50.514217Z","steps":["trace[2027415387] 'process raft request' (duration: 55.521862ms)","trace[2027415387] 'compare' (duration: 85.012329ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:13:50.755698Z","caller":"traceutil/trace.go:171","msg":"trace[1917251044] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"207.674251ms","start":"2026-09-16T02:13:50.547983Z","end":"2026-09-16T02:13:50.755657Z","steps":["trace[1917251044] 'process raft request' (duration: 180.359896ms)","trace[1917251044] 'compare' (duration: 27.009458ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:13:51.183667Z","caller":"traceutil/trace.go:171","msg":"trace[1936656397] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"173.878962ms","start":"2026-09-16T02:13:51.009734Z","end":"2026-09-16T02:13:51.183613Z","steps":["trace[1936656397] 'process raft request' (duration: 173.676027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:04.870541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.273441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.234\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-16T02:14:04.870653Z","caller":"traceutil/trace.go:171","msg":"trace[887940832] range","detail":"{range_begin:/registry/masterleases/162.253.55.234; range_end:; response_count:1; response_revision:2021; }","duration":"204.424075ms","start":"2026-09-16T02:14:04.666211Z","end":"2026-09-16T02:14:04.870635Z","steps":["trace[887940832] 'range keys from in-memory index tree' (duration: 204.100297ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:04.870783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.220747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11988"} {"level":"info","ts":"2026-09-16T02:14:04.870885Z","caller":"traceutil/trace.go:171","msg":"trace[1018355586] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2021; }","duration":"193.365151ms","start":"2026-09-16T02:14:04.677498Z","end":"2026-09-16T02:14:04.870863Z","steps":["trace[1018355586] 'range keys from in-memory index tree' (duration: 193.051173ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:26.141149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.711376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:476"} {"level":"warn","ts":"2026-09-16T02:14:26.141236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.690468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-16T02:14:26.141282Z","caller":"traceutil/trace.go:171","msg":"trace[195061668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2148; }","duration":"117.922892ms","start":"2026-09-16T02:14:26.02333Z","end":"2026-09-16T02:14:26.141253Z","steps":["trace[195061668] 'range keys from in-memory index tree' (duration: 117.376877ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:26.141309Z","caller":"traceutil/trace.go:171","msg":"trace[1629848539] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2148; }","duration":"260.76494ms","start":"2026-09-16T02:14:25.880522Z","end":"2026-09-16T02:14:26.141287Z","steps":["trace[1629848539] 'range keys from in-memory index tree' (duration: 260.514793ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:26.375094Z","caller":"traceutil/trace.go:171","msg":"trace[1758928464] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2234; }","duration":"208.473199ms","start":"2026-09-16T02:14:26.166553Z","end":"2026-09-16T02:14:26.375026Z","steps":["trace[1758928464] 'read index received' (duration: 5.009948ms)","trace[1758928464] 'applied index is now lower than readState.Index' (duration: 203.461571ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:14:26.375392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.831609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-16T02:14:26.375464Z","caller":"traceutil/trace.go:171","msg":"trace[373848062] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2151; }","duration":"208.958862ms","start":"2026-09-16T02:14:26.166487Z","end":"2026-09-16T02:14:26.375446Z","steps":["trace[373848062] 'agreement among raft nodes before linearized reading' (duration: 208.756147ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:26.375386Z","caller":"traceutil/trace.go:171","msg":"trace[1043031622] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"225.385704ms","start":"2026-09-16T02:14:26.149947Z","end":"2026-09-16T02:14:26.375333Z","steps":["trace[1043031622] 'process raft request' (duration: 224.778999ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:26.673178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.542642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-16T02:14:26.673348Z","caller":"traceutil/trace.go:171","msg":"trace[600103700] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"280.833199ms","start":"2026-09-16T02:14:26.392485Z","end":"2026-09-16T02:14:26.673318Z","steps":["trace[600103700] 'process raft request' (duration: 170.03136ms)","trace[600103700] 'compare' (duration: 110.221964ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:14:26.673688Z","caller":"traceutil/trace.go:171","msg":"trace[138309425] linearizableReadLoop","detail":"{readStateIndex:2239; appliedIndex:2237; }","duration":"277.587645ms","start":"2026-09-16T02:14:26.395915Z","end":"2026-09-16T02:14:26.673503Z","steps":["trace[138309425] 'read index received' (duration: 20.885717ms)","trace[138309425] 'applied index is now lower than readState.Index' (duration: 256.697638ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:14:26.674081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.13047ms","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-09-16T02:14:26.674146Z","caller":"traceutil/trace.go:171","msg":"trace[1711807338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2155; }","duration":"278.256342ms","start":"2026-09-16T02:14:26.39587Z","end":"2026-09-16T02:14:26.674126Z","steps":["trace[1711807338] 'agreement among raft nodes before linearized reading' (duration: 277.965535ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:16:03.304107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.01608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-09-16T02:16:03.304204Z","caller":"traceutil/trace.go:171","msg":"trace[386679443] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2776; }","duration":"139.147654ms","start":"2026-09-16T02:16:03.165032Z","end":"2026-09-16T02:16:03.30418Z","steps":["trace[386679443] 'range keys from in-memory index tree' (duration: 138.888166ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:16:03.304096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.817227ms","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-09-16T02:16:03.304349Z","caller":"traceutil/trace.go:171","msg":"trace[1387826656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2776; }","duration":"122.125086ms","start":"2026-09-16T02:16:03.182199Z","end":"2026-09-16T02:16:03.304325Z","steps":["trace[1387826656] 'range keys from in-memory index tree' (duration: 121.607082ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:16:03.304099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.12359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-09-16T02:16:03.304491Z","caller":"traceutil/trace.go:171","msg":"trace[1693061063] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2776; }","duration":"184.549911ms","start":"2026-09-16T02:16:03.11992Z","end":"2026-09-16T02:16:03.30447Z","steps":["trace[1693061063] 'range keys from in-memory index tree' (duration: 183.969095ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:16:08.794193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.017761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-16T02:16:08.794336Z","caller":"traceutil/trace.go:171","msg":"trace[66069801] transaction","detail":"{read_only:false; response_revision:2803; number_of_response:1; }","duration":"226.937381ms","start":"2026-09-16T02:16:08.567374Z","end":"2026-09-16T02:16:08.794312Z","steps":["trace[66069801] 'process raft request' (duration: 109.681883ms)","trace[66069801] 'compare' (duration: 116.877167ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:16:08.795595Z","caller":"traceutil/trace.go:171","msg":"trace[1723042738] transaction","detail":"{read_only:false; response_revision:2804; number_of_response:1; }","duration":"227.675212ms","start":"2026-09-16T02:16:08.567898Z","end":"2026-09-16T02:16:08.795573Z","steps":["trace[1723042738] 'process raft request' (duration: 227.547708ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:16:08.795734Z","caller":"traceutil/trace.go:171","msg":"trace[1059961769] transaction","detail":"{read_only:false; response_revision:2805; number_of_response:1; }","duration":"174.211724ms","start":"2026-09-16T02:16:08.62151Z","end":"2026-09-16T02:16:08.795722Z","steps":["trace[1059961769] 'process raft request' (duration: 174.016788ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.361132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.079956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-16T02:20:55.361238Z","caller":"traceutil/trace.go:171","msg":"trace[303034530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5029; }","duration":"142.24376ms","start":"2026-09-16T02:20:55.218974Z","end":"2026-09-16T02:20:55.361218Z","steps":["trace[303034530] 'range keys from in-memory index tree' (duration: 141.846429ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.361349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.507937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-16T02:20:55.361351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.722304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-598f948996-sggqc.18d5abbcbca25555\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-09-16T02:20:55.361423Z","caller":"traceutil/trace.go:171","msg":"trace[1427656517] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:5029; }","duration":"317.654301ms","start":"2026-09-16T02:20:55.04375Z","end":"2026-09-16T02:20:55.361404Z","steps":["trace[1427656517] 'range keys from in-memory index tree' (duration: 317.431455ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:55.361443Z","caller":"traceutil/trace.go:171","msg":"trace[1773160778] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-598f948996-sggqc.18d5abbcbca25555; range_end:; response_count:1; response_revision:5029; }","duration":"296.913819ms","start":"2026-09-16T02:20:55.064505Z","end":"2026-09-16T02:20:55.361419Z","steps":["trace[1773160778] 'range keys from in-memory index tree' (duration: 296.512848ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.361461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:20:55.043735Z","time spent":"317.717143ms","remote":"127.0.0.1:52060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-09-16T02:20:55.361495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.179157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-09-16T02:20:55.36159Z","caller":"traceutil/trace.go:171","msg":"trace[755665732] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5029; }","duration":"297.334251ms","start":"2026-09-16T02:20:55.06423Z","end":"2026-09-16T02:20:55.361564Z","steps":["trace[755665732] 'range keys from in-memory index tree' (duration: 296.97169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.361612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.198045ms","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:2082"} {"level":"info","ts":"2026-09-16T02:20:55.36166Z","caller":"traceutil/trace.go:171","msg":"trace[483235947] 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:5029; }","duration":"216.275007ms","start":"2026-09-16T02:20:55.145368Z","end":"2026-09-16T02:20:55.361643Z","steps":["trace[483235947] 'range keys from in-memory index tree' (duration: 216.072662ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:55.560715Z","caller":"traceutil/trace.go:171","msg":"trace[1095884676] linearizableReadLoop","detail":"{readStateIndex:5230; appliedIndex:5229; }","duration":"194.330351ms","start":"2026-09-16T02:20:55.366355Z","end":"2026-09-16T02:20:55.560685Z","steps":["trace[1095884676] 'read index received' (duration: 194.248969ms)","trace[1095884676] 'applied index is now lower than readState.Index' (duration: 79.792µs)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:20:55.56076Z","caller":"traceutil/trace.go:171","msg":"trace[922668606] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"196.465321ms","start":"2026-09-16T02:20:55.364251Z","end":"2026-09-16T02:20:55.560716Z","steps":["trace[922668606] 'process raft request' (duration: 196.239815ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.561048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.656621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f424274e-0409-4077-978d-1b8371d4dae8\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-09-16T02:20:55.561083Z","caller":"traceutil/trace.go:171","msg":"trace[1093193756] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f424274e-0409-4077-978d-1b8371d4dae8; range_end:; response_count:1; response_revision:5030; }","duration":"194.769874ms","start":"2026-09-16T02:20:55.366301Z","end":"2026-09-16T02:20:55.56107Z","steps":["trace[1093193756] 'agreement among raft nodes before linearized reading' (duration: 194.577218ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:55.679619Z","caller":"traceutil/trace.go:171","msg":"trace[1947566539] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"311.986503ms","start":"2026-09-16T02:20:55.367598Z","end":"2026-09-16T02:20:55.679584Z","steps":["trace[1947566539] 'process raft request' (duration: 311.52234ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:55.679852Z","caller":"traceutil/trace.go:171","msg":"trace[595906646] linearizableReadLoop","detail":"{readStateIndex:5232; appliedIndex:5230; }","duration":"118.971617ms","start":"2026-09-16T02:20:55.560845Z","end":"2026-09-16T02:20:55.679817Z","steps":["trace[595906646] 'read index received' (duration: 118.168255ms)","trace[595906646] 'applied index is now lower than readState.Index' (duration: 802.032µs)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:20:55.67987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:20:55.36757Z","time spent":"312.169717ms","remote":"127.0.0.1:39786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-16T02:20:55.680055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.627848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:20:55.680102Z","caller":"traceutil/trace.go:171","msg":"trace[1393745868] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:5032; }","duration":"308.744462ms","start":"2026-09-16T02:20:55.371342Z","end":"2026-09-16T02:20:55.680087Z","steps":["trace[1393745868] 'agreement among raft nodes before linearized reading' (duration: 308.582027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.680135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:20:55.371284Z","time spent":"308.842994ms","remote":"127.0.0.1:39618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" "} {"level":"warn","ts":"2026-09-16T02:20:55.680409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.468654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:20:55.680476Z","caller":"traceutil/trace.go:171","msg":"trace[1903590360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5032; }","duration":"256.572998ms","start":"2026-09-16T02:20:55.423882Z","end":"2026-09-16T02:20:55.680455Z","steps":["trace[1903590360] 'agreement among raft nodes before linearized reading' (duration: 256.474955ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:55.681904Z","caller":"traceutil/trace.go:171","msg":"trace[1538571604] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"303.790552ms","start":"2026-09-16T02:20:55.378093Z","end":"2026-09-16T02:20:55.681884Z","steps":["trace[1538571604] 'process raft request' (duration: 301.371674ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.682038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:20:55.378075Z","time spent":"303.878385ms","remote":"127.0.0.1:39718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16542,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-16T02:20:55.867367Z","caller":"traceutil/trace.go:171","msg":"trace[1695248479] linearizableReadLoop","detail":"{readStateIndex:5237; appliedIndex:5233; }","duration":"116.451787ms","start":"2026-09-16T02:20:55.750893Z","end":"2026-09-16T02:20:55.867345Z","steps":["trace[1695248479] 'read index received' (duration: 115.601463ms)","trace[1695248479] 'applied index is now lower than readState.Index' (duration: 849.414µs)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:20:55.867495Z","caller":"traceutil/trace.go:171","msg":"trace[864244787] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"170.282886ms","start":"2026-09-16T02:20:55.697201Z","end":"2026-09-16T02:20:55.867484Z","steps":["trace[864244787] 'process raft request' (duration: 170.05506ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.867751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.840307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1580"} {"level":"info","ts":"2026-09-16T02:20:55.867798Z","caller":"traceutil/trace.go:171","msg":"trace[1549928060] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5037; }","duration":"116.950701ms","start":"2026-09-16T02:20:55.750833Z","end":"2026-09-16T02:20:55.867784Z","steps":["trace[1549928060] 'agreement among raft nodes before linearized reading' (duration: 116.797137ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:55.868055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.369318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1580"} {"level":"info","ts":"2026-09-16T02:20:55.868091Z","caller":"traceutil/trace.go:171","msg":"trace[917275321] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5037; }","duration":"114.42615ms","start":"2026-09-16T02:20:55.753656Z","end":"2026-09-16T02:20:55.868082Z","steps":["trace[917275321] 'agreement among raft nodes before linearized reading' (duration: 114.334938ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:55.868894Z","caller":"traceutil/trace.go:171","msg":"trace[188858482] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"170.095572ms","start":"2026-09-16T02:20:55.696862Z","end":"2026-09-16T02:20:55.866957Z","steps":["trace[188858482] 'process raft request' (duration: 169.754502ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:55.867187Z","caller":"traceutil/trace.go:171","msg":"trace[316059118] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"170.110292ms","start":"2026-09-16T02:20:55.697014Z","end":"2026-09-16T02:20:55.867124Z","steps":["trace[316059118] 'process raft request' (duration: 169.777933ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:55.867448Z","caller":"traceutil/trace.go:171","msg":"trace[853858571] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"170.385ms","start":"2026-09-16T02:20:55.697007Z","end":"2026-09-16T02:20:55.867392Z","steps":["trace[853858571] 'process raft request' (duration: 170.058091ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:56.266399Z","caller":"traceutil/trace.go:171","msg":"trace[2020671869] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"159.950097ms","start":"2026-09-16T02:20:56.106417Z","end":"2026-09-16T02:20:56.266368Z","steps":["trace[2020671869] 'process raft request' (duration: 159.657749ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:56.266618Z","caller":"traceutil/trace.go:171","msg":"trace[1579781355] linearizableReadLoop","detail":"{readStateIndex:5242; appliedIndex:5240; }","duration":"159.234937ms","start":"2026-09-16T02:20:56.107356Z","end":"2026-09-16T02:20:56.266591Z","steps":["trace[1579781355] 'read index received' (duration: 17.189122ms)","trace[1579781355] 'applied index is now lower than readState.Index' (duration: 142.044314ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:20:56.266975Z","caller":"traceutil/trace.go:171","msg":"trace[415722604] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"152.22812ms","start":"2026-09-16T02:20:56.114734Z","end":"2026-09-16T02:20:56.266962Z","steps":["trace[415722604] 'process raft request' (duration: 151.566141ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:56.266983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.585926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f424274e-0409-4077-978d-1b8371d4dae8\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-09-16T02:20:56.267051Z","caller":"traceutil/trace.go:171","msg":"trace[1749382389] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f424274e-0409-4077-978d-1b8371d4dae8; range_end:; response_count:1; response_revision:5043; }","duration":"159.69684ms","start":"2026-09-16T02:20:56.107333Z","end":"2026-09-16T02:20:56.26703Z","steps":["trace[1749382389] 'agreement among raft nodes before linearized reading' (duration: 159.460763ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:20:56.397209Z","caller":"traceutil/trace.go:171","msg":"trace[506335107] linearizableReadLoop","detail":"{readStateIndex:5244; appliedIndex:5243; }","duration":"130.497611ms","start":"2026-09-16T02:20:56.26669Z","end":"2026-09-16T02:20:56.397188Z","steps":["trace[506335107] 'read index received' (duration: 77.143345ms)","trace[506335107] 'applied index is now lower than readState.Index' (duration: 53.352196ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:20:56.397226Z","caller":"traceutil/trace.go:171","msg":"trace[862602356] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"146.386547ms","start":"2026-09-16T02:20:56.250814Z","end":"2026-09-16T02:20:56.397201Z","steps":["trace[862602356] 'process raft request' (duration: 93.102982ms)","trace[862602356] 'compare' (duration: 53.166091ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:20:56.397483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.997857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:20:56.397605Z","caller":"traceutil/trace.go:171","msg":"trace[1105702177] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:0; response_revision:5044; }","duration":"289.168442ms","start":"2026-09-16T02:20:56.108406Z","end":"2026-09-16T02:20:56.397575Z","steps":["trace[1105702177] 'agreement among raft nodes before linearized reading' (duration: 288.928675ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:20:59.436625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.652794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-16T02:20:59.436702Z","caller":"traceutil/trace.go:171","msg":"trace[1445499794] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5153; }","duration":"105.781877ms","start":"2026-09-16T02:20:59.330902Z","end":"2026-09-16T02:20:59.436683Z","steps":["trace[1445499794] 'range keys from in-memory index tree' (duration: 105.52847ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.616442Z","caller":"traceutil/trace.go:171","msg":"trace[1297240218] transaction","detail":"{read_only:false; response_revision:5262; number_of_response:1; }","duration":"383.97194ms","start":"2026-09-16T02:21:08.232448Z","end":"2026-09-16T02:21:08.61642Z","steps":["trace[1297240218] 'process raft request' (duration: 383.808915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:08.616584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:21:08.232435Z","time spent":"384.073913ms","remote":"127.0.0.1:39718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10670,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-16T02:21:08.657006Z","caller":"traceutil/trace.go:171","msg":"trace[2079405572] linearizableReadLoop","detail":"{readStateIndex:5468; appliedIndex:5467; }","duration":"334.822292ms","start":"2026-09-16T02:21:08.322156Z","end":"2026-09-16T02:21:08.656978Z","steps":["trace[2079405572] 'read index received' (duration: 294.857881ms)","trace[2079405572] 'applied index is now lower than readState.Index' (duration: 39.96284ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:21:08.65706Z","caller":"traceutil/trace.go:171","msg":"trace[1062490176] transaction","detail":"{read_only:false; response_revision:5263; number_of_response:1; }","duration":"338.877415ms","start":"2026-09-16T02:21:08.318157Z","end":"2026-09-16T02:21:08.657035Z","steps":["trace[1062490176] 'process raft request' (duration: 338.603797ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:08.657189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:21:08.318135Z","time spent":"338.988289ms","remote":"127.0.0.1:39786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-16T02:21:08.65726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.088629ms","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-16T02:21:08.657315Z","caller":"traceutil/trace.go:171","msg":"trace[515724514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5263; }","duration":"335.193412ms","start":"2026-09-16T02:21:08.322107Z","end":"2026-09-16T02:21:08.6573Z","steps":["trace[515724514] 'agreement among raft nodes before linearized reading' (duration: 334.999706ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:08.657383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:21:08.322092Z","time spent":"335.281395ms","remote":"127.0.0.1:39786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-16T02:21:08.756121Z","caller":"traceutil/trace.go:171","msg":"trace[1324783768] transaction","detail":"{read_only:false; response_revision:5264; number_of_response:1; }","duration":"130.643934ms","start":"2026-09-16T02:21:08.625438Z","end":"2026-09-16T02:21:08.756082Z","steps":["trace[1324783768] 'process raft request' (duration: 84.85727ms)","trace[1324783768] 'compare' (duration: 45.534577ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:21:08.756576Z","caller":"traceutil/trace.go:171","msg":"trace[1329026120] transaction","detail":"{read_only:false; response_revision:5265; number_of_response:1; }","duration":"131.023475ms","start":"2026-09-16T02:21:08.625509Z","end":"2026-09-16T02:21:08.756532Z","steps":["trace[1329026120] 'process raft request' (duration: 130.50011ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.758299Z","caller":"traceutil/trace.go:171","msg":"trace[1473287776] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"132.60678ms","start":"2026-09-16T02:21:08.625675Z","end":"2026-09-16T02:21:08.758281Z","steps":["trace[1473287776] 'process raft request' (duration: 130.744128ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.758466Z","caller":"traceutil/trace.go:171","msg":"trace[2136225427] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"132.199358ms","start":"2026-09-16T02:21:08.626257Z","end":"2026-09-16T02:21:08.758457Z","steps":["trace[2136225427] 'process raft request' (duration: 130.391147ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.75863Z","caller":"traceutil/trace.go:171","msg":"trace[1612666524] linearizableReadLoop","detail":"{readStateIndex:5472; appliedIndex:5468; }","duration":"101.498337ms","start":"2026-09-16T02:21:08.657076Z","end":"2026-09-16T02:21:08.758575Z","steps":["trace[1612666524] 'read index received' (duration: 53.230273ms)","trace[1612666524] 'applied index is now lower than readState.Index' (duration: 48.258774ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:21:08.758901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.101998ms","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-09-16T02:21:08.758995Z","caller":"traceutil/trace.go:171","msg":"trace[840370849] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5268; }","duration":"284.211792ms","start":"2026-09-16T02:21:08.474734Z","end":"2026-09-16T02:21:08.758946Z","steps":["trace[840370849] 'agreement among raft nodes before linearized reading' (duration: 284.036087ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:08.759138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.408231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-09-16T02:21:08.759175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.296565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-16T02:21:08.759189Z","caller":"traceutil/trace.go:171","msg":"trace[1603038250] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5268; }","duration":"277.490423ms","start":"2026-09-16T02:21:08.481683Z","end":"2026-09-16T02:21:08.759173Z","steps":["trace[1603038250] 'agreement among raft nodes before linearized reading' (duration: 277.37035ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.759247Z","caller":"traceutil/trace.go:171","msg":"trace[844629708] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5268; }","duration":"284.362807ms","start":"2026-09-16T02:21:08.474832Z","end":"2026-09-16T02:21:08.759194Z","steps":["trace[844629708] 'agreement among raft nodes before linearized reading' (duration: 284.263284ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:08.759494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.406641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-09-16T02:21:08.759545Z","caller":"traceutil/trace.go:171","msg":"trace[53663525] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5268; }","duration":"149.509734ms","start":"2026-09-16T02:21:08.610023Z","end":"2026-09-16T02:21:08.759533Z","steps":["trace[53663525] 'agreement among raft nodes before linearized reading' (duration: 148.728282ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.91882Z","caller":"traceutil/trace.go:171","msg":"trace[365745320] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"152.624751ms","start":"2026-09-16T02:21:08.766165Z","end":"2026-09-16T02:21:08.91879Z","steps":["trace[365745320] 'process raft request' (duration: 105.689875ms)","trace[365745320] 'compare' (duration: 46.770521ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:21:08.918985Z","caller":"traceutil/trace.go:171","msg":"trace[1371799785] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"151.51381ms","start":"2026-09-16T02:21:08.76741Z","end":"2026-09-16T02:21:08.918923Z","steps":["trace[1371799785] 'process raft request' (duration: 151.372036ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.919228Z","caller":"traceutil/trace.go:171","msg":"trace[2002917659] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"152.850767ms","start":"2026-09-16T02:21:08.766368Z","end":"2026-09-16T02:21:08.919218Z","steps":["trace[2002917659] 'process raft request' (duration: 152.358693ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.919296Z","caller":"traceutil/trace.go:171","msg":"trace[329131864] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"144.227645ms","start":"2026-09-16T02:21:08.775003Z","end":"2026-09-16T02:21:08.91923Z","steps":["trace[329131864] 'process raft request' (duration: 143.815754ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:09.08055Z","caller":"traceutil/trace.go:171","msg":"trace[834841083] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"153.926398ms","start":"2026-09-16T02:21:08.926597Z","end":"2026-09-16T02:21:09.080523Z","steps":["trace[834841083] 'process raft request' (duration: 144.4006ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:09.080831Z","caller":"traceutil/trace.go:171","msg":"trace[851211991] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"149.055011ms","start":"2026-09-16T02:21:08.931762Z","end":"2026-09-16T02:21:09.080817Z","steps":["trace[851211991] 'process raft request' (duration: 148.533086ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:20.859074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2867} {"level":"info","ts":"2026-09-16T02:21:20.956471Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2867,"took":"95.356404ms","hash":481350838,"current-db-size-bytes":52834304,"current-db-size":"53 MB","current-db-size-in-use-bytes":28192768,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-16T02:21:20.956543Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":481350838,"revision":2867,"compact-revision":-1} {"level":"info","ts":"2026-09-16T02:24:48.118224Z","caller":"traceutil/trace.go:171","msg":"trace[1181837336] transaction","detail":"{read_only:false; response_revision:6867; number_of_response:1; }","duration":"136.950581ms","start":"2026-09-16T02:24:47.981246Z","end":"2026-09-16T02:24:48.118196Z","steps":["trace[1181837336] 'process raft request' (duration: 55.402647ms)","trace[1181837336] 'compare' (duration: 81.263368ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:26:20.86627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5348} {"level":"info","ts":"2026-09-16T02:26:20.937197Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5348,"took":"69.41611ms","hash":1983428532,"current-db-size-bytes":52834304,"current-db-size":"53 MB","current-db-size-in-use-bytes":19148800,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-16T02:26:20.937252Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1983428532,"revision":5348,"compact-revision":2867}