{"level":"warn","ts":"2026-10-04T05:38:36.65475Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-04T05:38:36.654876Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.4: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.4:2380","--initial-cluster=instance=https://162.253.55.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.4:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-04T05:38:36.654975Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-04T05:38:36.654992Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.4:2380"]} {"level":"info","ts":"2026-10-04T05:38:36.655023Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-04T05:38:36.655904Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.4:2379"]} {"level":"info","ts":"2026-10-04T05:38:36.656004Z","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.4:2380"],"listen-peer-urls":["https://162.253.55.4:2380"],"advertise-client-urls":["https://162.253.55.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.4:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-04T05:38:36.660936Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.651069ms"} {"level":"info","ts":"2026-10-04T05:38:36.670919Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"caafea9f270da559","cluster-id":"271ff399bb4addea"} {"level":"info","ts":"2026-10-04T05:38:36.670999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 switched to configuration voters=()"} {"level":"info","ts":"2026-10-04T05:38:36.671027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became follower at term 0"} {"level":"info","ts":"2026-10-04T05:38:36.671059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft caafea9f270da559 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-04T05:38:36.671069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became follower at term 1"} {"level":"info","ts":"2026-10-04T05:38:36.67113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 switched to configuration voters=(14605150085861713241)"} {"level":"warn","ts":"2026-10-04T05:38:36.685076Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-04T05:38:36.689004Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-04T05:38:36.691987Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-04T05:38:36.694466Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"caafea9f270da559","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-04T05:38:36.694634Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T05:38:36.69472Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T05:38:36.694729Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T05:38:36.694662Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"caafea9f270da559","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-04T05:38:36.696768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 switched to configuration voters=(14605150085861713241)"} {"level":"info","ts":"2026-10-04T05:38:36.696909Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"271ff399bb4addea","local-member-id":"caafea9f270da559","added-peer-id":"caafea9f270da559","added-peer-peer-urls":["https://162.253.55.4:2380"]} {"level":"info","ts":"2026-10-04T05:38:36.701163Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-04T05:38:36.701427Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"caafea9f270da559","initial-advertise-peer-urls":["https://162.253.55.4:2380"],"listen-peer-urls":["https://162.253.55.4:2380"],"advertise-client-urls":["https://162.253.55.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-04T05:38:36.701453Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-04T05:38:36.701506Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.4:2380"} {"level":"info","ts":"2026-10-04T05:38:36.701552Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.4:2380"} {"level":"info","ts":"2026-10-04T05:38:37.371501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 is starting a new election at term 1"} {"level":"info","ts":"2026-10-04T05:38:37.3716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-04T05:38:37.371659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 received MsgPreVoteResp from caafea9f270da559 at term 1"} {"level":"info","ts":"2026-10-04T05:38:37.37169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became candidate at term 2"} {"level":"info","ts":"2026-10-04T05:38:37.371707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 received MsgVoteResp from caafea9f270da559 at term 2"} {"level":"info","ts":"2026-10-04T05:38:37.371727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became leader at term 2"} {"level":"info","ts":"2026-10-04T05:38:37.371747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: caafea9f270da559 elected leader caafea9f270da559 at term 2"} {"level":"info","ts":"2026-10-04T05:38:37.373508Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"caafea9f270da559","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.4:2379]}","request-path":"/0/members/caafea9f270da559/attributes","cluster-id":"271ff399bb4addea","publish-timeout":"7s"} {"level":"info","ts":"2026-10-04T05:38:37.373677Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-04T05:38:37.373838Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-04T05:38:37.373851Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T05:38:37.375515Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"271ff399bb4addea","local-member-id":"caafea9f270da559","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T05:38:37.375645Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T05:38:37.375684Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T05:38:37.377399Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-04T05:38:37.377585Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-04T05:38:37.377663Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-04T05:38:37.385111Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.4:2379"} {"level":"info","ts":"2026-10-04T05:39:24.004645Z","caller":"traceutil/trace.go:171","msg":"trace[1436401931] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"169.584451ms","start":"2026-10-04T05:39:23.834671Z","end":"2026-10-04T05:39:24.004255Z","steps":["trace[1436401931] 'process raft request' (duration: 169.389062ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:39:24.173256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.586656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bgn8q\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-10-04T05:39:24.173361Z","caller":"traceutil/trace.go:171","msg":"trace[1912692163] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bgn8q; range_end:; response_count:1; response_revision:593; }","duration":"136.747073ms","start":"2026-10-04T05:39:24.03659Z","end":"2026-10-04T05:39:24.173338Z","steps":["trace[1912692163] 'range keys from in-memory index tree' (duration: 136.376266ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:39:24.343143Z","caller":"traceutil/trace.go:171","msg":"trace[1018694323] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"144.345541ms","start":"2026-10-04T05:39:24.198755Z","end":"2026-10-04T05:39:24.343101Z","steps":["trace[1018694323] 'process raft request' (duration: 143.937423ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:39:24.662249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.431004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T05:39:24.662385Z","caller":"traceutil/trace.go:171","msg":"trace[1651638148] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"283.119813ms","start":"2026-10-04T05:39:24.379246Z","end":"2026-10-04T05:39:24.662366Z","steps":["trace[1651638148] 'read index received' (duration: 85.699916ms)","trace[1651638148] 'applied index is now lower than readState.Index' (duration: 197.418577ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T05:39:24.662538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.302012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T05:39:24.662495Z","caller":"traceutil/trace.go:171","msg":"trace[440796509] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"400.997398ms","start":"2026-10-04T05:39:24.261401Z","end":"2026-10-04T05:39:24.662398Z","steps":["trace[440796509] 'process raft request' (duration: 203.705896ms)","trace[440796509] 'compare' (duration: 195.102454ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T05:39:24.662588Z","caller":"traceutil/trace.go:171","msg":"trace[1770149215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"283.388726ms","start":"2026-10-04T05:39:24.379189Z","end":"2026-10-04T05:39:24.662578Z","steps":["trace[1770149215] 'agreement among raft nodes before linearized reading' (duration: 283.310572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:39:24.662754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T05:39:24.261361Z","time spent":"401.256779ms","remote":"127.0.0.1:36356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T05:39:24.66289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.711424ms","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-10-04T05:39:24.662921Z","caller":"traceutil/trace.go:171","msg":"trace[1028884322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"266.797168ms","start":"2026-10-04T05:39:24.396114Z","end":"2026-10-04T05:39:24.662911Z","steps":["trace[1028884322] 'agreement among raft nodes before linearized reading' (duration: 266.638351ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:39:24.824955Z","caller":"traceutil/trace.go:171","msg":"trace[1528679802] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"155.648733ms","start":"2026-10-04T05:39:24.669241Z","end":"2026-10-04T05:39:24.82489Z","steps":["trace[1528679802] 'process raft request' (duration: 105.804369ms)","trace[1528679802] 'compare' (duration: 49.567152ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T05:39:39.650616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.964122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T05:39:39.650748Z","caller":"traceutil/trace.go:171","msg":"trace[668167630] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"180.711428ms","start":"2026-10-04T05:39:39.470014Z","end":"2026-10-04T05:39:39.650725Z","steps":["trace[668167630] 'process raft request' (duration: 65.538206ms)","trace[668167630] 'compare' (duration: 114.831484ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T05:41:01.562395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.284493ms","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-10-04T05:41:01.562903Z","caller":"traceutil/trace.go:171","msg":"trace[1484609140] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1842; }","duration":"100.817561ms","start":"2026-10-04T05:41:01.462034Z","end":"2026-10-04T05:41:01.562851Z","steps":["trace[1484609140] 'range keys from in-memory index tree' (duration: 100.011034ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:41:01.562504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.396137ms","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-10-04T05:41:01.563248Z","caller":"traceutil/trace.go:171","msg":"trace[355010557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1842; }","duration":"132.183332ms","start":"2026-10-04T05:41:01.431001Z","end":"2026-10-04T05:41:01.563184Z","steps":["trace[355010557] 'range keys from in-memory index tree' (duration: 131.108486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:41:02.000577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.602773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T05:41:02.000684Z","caller":"traceutil/trace.go:171","msg":"trace[1607310876] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1845; }","duration":"110.812498ms","start":"2026-10-04T05:41:01.889847Z","end":"2026-10-04T05:41:02.00066Z","steps":["trace[1607310876] 'count revisions from in-memory index tree' (duration: 110.508667ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:41:36.10647Z","caller":"traceutil/trace.go:171","msg":"trace[403681045] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"148.100037ms","start":"2026-10-04T05:41:35.958342Z","end":"2026-10-04T05:41:36.106442Z","steps":["trace[403681045] 'process raft request' (duration: 147.904092ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:41:36.346933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.470339ms","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-10-04T05:41:36.347047Z","caller":"traceutil/trace.go:171","msg":"trace[355755924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2090; }","duration":"179.648892ms","start":"2026-10-04T05:41:36.167365Z","end":"2026-10-04T05:41:36.347014Z","steps":["trace[355755924] 'count revisions from in-memory index tree' (duration: 179.36106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:41:36.347066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.870084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T05:41:36.347176Z","caller":"traceutil/trace.go:171","msg":"trace[1993735588] linearizableReadLoop","detail":"{readStateIndex:2172; appliedIndex:2171; }","duration":"149.858779ms","start":"2026-10-04T05:41:36.197297Z","end":"2026-10-04T05:41:36.347156Z","steps":["trace[1993735588] 'read index received' (duration: 16.817533ms)","trace[1993735588] 'applied index is now lower than readState.Index' (duration: 133.039246ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T05:41:36.34729Z","caller":"traceutil/trace.go:171","msg":"trace[538986670] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"176.313095ms","start":"2026-10-04T05:41:36.170959Z","end":"2026-10-04T05:41:36.347273Z","steps":["trace[538986670] 'process raft request' (duration: 43.129999ms)","trace[538986670] 'compare' (duration: 132.749754ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T05:41:36.347341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.373378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-04T05:41:36.347377Z","caller":"traceutil/trace.go:171","msg":"trace[345368248] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2091; }","duration":"145.436843ms","start":"2026-10-04T05:41:36.201933Z","end":"2026-10-04T05:41:36.34737Z","steps":["trace[345368248] 'agreement among raft nodes before linearized reading' (duration: 145.335626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:41:36.347568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.28235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-04T05:41:36.347606Z","caller":"traceutil/trace.go:171","msg":"trace[1811953463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2091; }","duration":"150.345305ms","start":"2026-10-04T05:41:36.197256Z","end":"2026-10-04T05:41:36.347601Z","steps":["trace[1811953463] 'agreement among raft nodes before linearized reading' (duration: 150.250668ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:41:36.638396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.368941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T05:41:36.639225Z","caller":"traceutil/trace.go:171","msg":"trace[2028036470] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"257.282841ms","start":"2026-10-04T05:41:36.381909Z","end":"2026-10-04T05:41:36.639191Z","steps":["trace[2028036470] 'process raft request' (duration: 143.022824ms)","trace[2028036470] 'compare' (duration: 113.0675ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T05:42:42.658957Z","caller":"traceutil/trace.go:171","msg":"trace[777914898] transaction","detail":"{read_only:false; response_revision:2550; number_of_response:1; }","duration":"156.442605ms","start":"2026-10-04T05:42:42.502482Z","end":"2026-10-04T05:42:42.658925Z","steps":["trace[777914898] 'process raft request' (duration: 156.248498ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:43:14.197551Z","caller":"traceutil/trace.go:171","msg":"trace[1914556244] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"244.978523ms","start":"2026-10-04T05:43:13.952538Z","end":"2026-10-04T05:43:14.197517Z","steps":["trace[1914556244] 'process raft request' (duration: 244.785133ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:43:19.647162Z","caller":"traceutil/trace.go:171","msg":"trace[1166605131] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"188.25581ms","start":"2026-10-04T05:43:19.458876Z","end":"2026-10-04T05:43:19.647132Z","steps":["trace[1166605131] 'process raft request' (duration: 188.190479ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:43:19.647203Z","caller":"traceutil/trace.go:171","msg":"trace[915972906] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"189.965325ms","start":"2026-10-04T05:43:19.457198Z","end":"2026-10-04T05:43:19.647164Z","steps":["trace[915972906] 'process raft request' (duration: 189.379883ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:48:14.737874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.040621ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T05:48:14.738391Z","caller":"traceutil/trace.go:171","msg":"trace[841432175] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"209.133925ms","start":"2026-10-04T05:48:14.529228Z","end":"2026-10-04T05:48:14.738362Z","steps":["trace[841432175] 'process raft request' (duration: 60.442837ms)","trace[841432175] 'compare' (duration: 147.706092ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T05:48:15.243477Z","caller":"traceutil/trace.go:171","msg":"trace[1403680111] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"177.886601ms","start":"2026-10-04T05:48:15.065557Z","end":"2026-10-04T05:48:15.243443Z","steps":["trace[1403680111] 'process raft request' (duration: 169.56017ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:15.284473Z","caller":"traceutil/trace.go:171","msg":"trace[251773676] transaction","detail":"{read_only:false; response_revision:5062; number_of_response:1; }","duration":"166.266579ms","start":"2026-10-04T05:48:15.118175Z","end":"2026-10-04T05:48:15.284442Z","steps":["trace[251773676] 'process raft request' (duration: 166.018575ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:28.388499Z","caller":"traceutil/trace.go:171","msg":"trace[723170809] linearizableReadLoop","detail":"{readStateIndex:5437; appliedIndex:5433; }","duration":"144.88726ms","start":"2026-10-04T05:48:28.243586Z","end":"2026-10-04T05:48:28.388473Z","steps":["trace[723170809] 'read index received' (duration: 239.944µs)","trace[723170809] 'applied index is now lower than readState.Index' (duration: 144.645996ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T05:48:28.388607Z","caller":"traceutil/trace.go:171","msg":"trace[2000376136] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"158.963121ms","start":"2026-10-04T05:48:28.229598Z","end":"2026-10-04T05:48:28.388561Z","steps":["trace[2000376136] 'process raft request' (duration: 158.758679ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:28.388697Z","caller":"traceutil/trace.go:171","msg":"trace[1094071842] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"158.148743ms","start":"2026-10-04T05:48:28.230482Z","end":"2026-10-04T05:48:28.388631Z","steps":["trace[1094071842] 'process raft request' (duration: 157.9244ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:28.388942Z","caller":"traceutil/trace.go:171","msg":"trace[125022236] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"159.903725ms","start":"2026-10-04T05:48:28.229009Z","end":"2026-10-04T05:48:28.388913Z","steps":["trace[125022236] 'process raft request' (duration: 159.13712ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:48:28.389102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.399179ms","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-10-04T05:48:28.389642Z","caller":"traceutil/trace.go:171","msg":"trace[1971761576] 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:5235; }","duration":"146.012844ms","start":"2026-10-04T05:48:28.243509Z","end":"2026-10-04T05:48:28.389522Z","steps":["trace[1971761576] 'agreement among raft nodes before linearized reading' (duration: 145.294323ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:28.953186Z","caller":"traceutil/trace.go:171","msg":"trace[1953990373] transaction","detail":"{read_only:false; response_revision:5241; number_of_response:1; }","duration":"179.19407ms","start":"2026-10-04T05:48:28.773963Z","end":"2026-10-04T05:48:28.953157Z","steps":["trace[1953990373] 'process raft request' (duration: 178.960506ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:29.021024Z","caller":"traceutil/trace.go:171","msg":"trace[1040249953] transaction","detail":"{read_only:false; response_revision:5242; number_of_response:1; }","duration":"231.488609ms","start":"2026-10-04T05:48:28.789506Z","end":"2026-10-04T05:48:29.020995Z","steps":["trace[1040249953] 'process raft request' (duration: 231.245575ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:29.021421Z","caller":"traceutil/trace.go:171","msg":"trace[277063851] transaction","detail":"{read_only:false; response_revision:5243; number_of_response:1; }","duration":"231.221035ms","start":"2026-10-04T05:48:28.790185Z","end":"2026-10-04T05:48:29.021406Z","steps":["trace[277063851] 'process raft request' (duration: 230.734556ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:29.021512Z","caller":"traceutil/trace.go:171","msg":"trace[28947206] linearizableReadLoop","detail":"{readStateIndex:5445; appliedIndex:5442; }","duration":"215.685868ms","start":"2026-10-04T05:48:28.805787Z","end":"2026-10-04T05:48:29.021473Z","steps":["trace[28947206] 'read index received' (duration: 147.157001ms)","trace[28947206] 'applied index is now lower than readState.Index' (duration: 68.527297ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T05:48:29.02158Z","caller":"traceutil/trace.go:171","msg":"trace[959460548] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"192.750481ms","start":"2026-10-04T05:48:28.828798Z","end":"2026-10-04T05:48:29.021549Z","steps":["trace[959460548] 'process raft request' (duration: 192.471714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:48:29.021794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.604942ms","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-10-04T05:48:29.021847Z","caller":"traceutil/trace.go:171","msg":"trace[709970187] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5244; }","duration":"216.736781ms","start":"2026-10-04T05:48:28.805095Z","end":"2026-10-04T05:48:29.021831Z","steps":["trace[709970187] 'agreement among raft nodes before linearized reading' (duration: 216.580892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:48:29.022582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.174513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-04T05:48:29.022674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.123572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-10-04T05:48:29.02273Z","caller":"traceutil/trace.go:171","msg":"trace[1136999850] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5244; }","duration":"199.227629ms","start":"2026-10-04T05:48:28.823482Z","end":"2026-10-04T05:48:29.02271Z","steps":["trace[1136999850] 'agreement among raft nodes before linearized reading' (duration: 198.345758ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:29.02273Z","caller":"traceutil/trace.go:171","msg":"trace[1688240400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5244; }","duration":"171.381144ms","start":"2026-10-04T05:48:28.851325Z","end":"2026-10-04T05:48:29.022706Z","steps":["trace[1688240400] 'agreement among raft nodes before linearized reading' (duration: 170.61752ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:48:29.023179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.57061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18db3d7f4a720118\" ","response":"range_response_count:1 size:740"} {"level":"info","ts":"2026-10-04T05:48:29.023589Z","caller":"traceutil/trace.go:171","msg":"trace[2055342536] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18db3d7f4a720118; range_end:; response_count:1; response_revision:5244; }","duration":"246.787582ms","start":"2026-10-04T05:48:28.776496Z","end":"2026-10-04T05:48:29.023284Z","steps":["trace[2055342536] 'agreement among raft nodes before linearized reading' (duration: 245.508798ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T05:48:29.024361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.716099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-04T05:48:29.024409Z","caller":"traceutil/trace.go:171","msg":"trace[920491857] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5244; }","duration":"121.819995ms","start":"2026-10-04T05:48:28.902572Z","end":"2026-10-04T05:48:29.024392Z","steps":["trace[920491857] 'agreement among raft nodes before linearized reading' (duration: 119.266736ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:48:37.416912Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2850} {"level":"info","ts":"2026-10-04T05:48:37.507708Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2850,"took":"86.095183ms","hash":577998013,"current-db-size-bytes":51200000,"current-db-size":"51 MB","current-db-size-in-use-bytes":27398144,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-04T05:48:37.5078Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":577998013,"revision":2850,"compact-revision":-1} {"level":"warn","ts":"2026-10-04T05:52:33.981182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.048074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-04T05:52:33.981341Z","caller":"traceutil/trace.go:171","msg":"trace[1052591809] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:7026; }","duration":"157.260653ms","start":"2026-10-04T05:52:33.824061Z","end":"2026-10-04T05:52:33.981322Z","steps":["trace[1052591809] 'count revisions from in-memory index tree' (duration: 156.976463ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T05:53:37.426008Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5310} {"level":"info","ts":"2026-10-04T05:53:37.521857Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5310,"took":"93.33667ms","hash":2237671738,"current-db-size-bytes":51200000,"current-db-size":"51 MB","current-db-size-in-use-bytes":18788352,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-04T05:53:37.521927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2237671738,"revision":5310,"compact-revision":2850}