Skip to content

Instantly share code, notes, and snippets.

@ipochi
Created April 23, 2018 12:29
Show Gist options
  • Select an option

  • Save ipochi/23ba4b784ec3ee1e41f2709112d7321d to your computer and use it in GitHub Desktop.

Select an option

Save ipochi/23ba4b784ec3ee1e41f2709112d7321d to your computer and use it in GitHub Desktop.
postgres-operator - operator logs
time="2018-04-20T07:10:47Z" level=debug msg="debug flag set to true"
time="2018-04-20T07:10:47Z" level=debug msg="setting NAMESPACE to demo"
time="2018-04-20T07:10:47Z" level=debug msg="CCP_IMAGE_PREFIX set, using crunchydata"
time="2018-04-20T07:10:47Z" level=debug msg="CO_IMAGE_PREFIX set, using crunchydata"
pgclusters.cr.client-go.k8s.io exists
pgreplicas.cr.client-go.k8s.io exists
pgbackups.cr.client-go.k8s.io exists
pgupgrades.cr.client-go.k8s.io exists
pgpolicies.cr.client-go.k8s.io exists
pgtasks.cr.client-go.k8s.io exists
pgingests.cr.client-go.k8s.io exists
at end of setup, beginning wait...Watch Pgbackup objects
Watch Pgupgrade objects
Watch Pgpolicy objects
Watch Pgingestcluster objects
Watch Pgcluster objects
Watch Pgreplica objects
time="2018-04-20T07:10:50Z" level=info msg="Watch pod objects"
time="2018-04-20T07:10:50Z" level=info msg="Watch Pgtask objects"
time="2018-04-20T07:10:50Z" level=info msg="Watch job objects"
time="2018-04-20T07:10:50Z" level=info msg="MajorUpgradeProcess watch starting..."
[PgclusterCONTROLLER] OnAdd /apis/cr.client-go.k8s.io/v1/namespaces/demo/pgclusters/mycluster
time="2018-04-20T07:24:01Z" level=debug msg="StorageType is create"
time="2018-04-20T07:24:01Z" level=debug msg="Name=%s Size=%s AccessMode=%s\nmycluster-pvcReadWriteOnce200M"
time="2018-04-20T07:24:01Z" level=debug msg="in createPVC"
time="2018-04-20T07:24:01Z" level=debug msg="using dynamic PVC template"
time="2018-04-20T07:24:01Z" level=debug msg="{\n \"kind\": \"PersistentVolumeClaim\",\n \"apiVersion\": \"v1\",\n \"metadata\": {\n \"name\": \"mycluster-pvc\",\n \"labels\": {\n \"pgremove\": \"true\"\n }\n },\n \"spec\": {\n \"accessModes\": [\n \"ReadWriteOnce\"\n ],\n\t\"storageClassName\": \"portworx-sc\",\n \"resources\": {\n \"requests\": {\n \"storage\": \"200M\"\n }\n }\n }\n}\n"
UPDATED status: &v1.Pgcluster{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"mycluster", GenerateName:"", Namespace:"demo", SelfLink:"/apis/cr.client-go.k8s.io/v1/namespaces/demo/pgclusters/mycluster", UID:"cc694962-446b-11e8-831b-08002748a462", ResourceVersion:"813756", Generation:1, CreationTimestamp:v1.Time{Time:time.Time{sec:63659805841, nsec:0, loc:(*time.Location)(0x18e0b20)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"name":"mycluster"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v1.PgclusterSpec{Name:"mycluster", ClusterName:"mycluster", Policies:"", CCPImageTag:"centos7-10.3-1.8.2", Port:"5432", NodeName:"", PrimaryStorage:v1.PgStorageSpec{Name:"", StorageClass:"portworx-sc", AccessMode:"ReadWriteOnce", Size:"200M", StorageType:"dynamic", Fsgroup:"26", SupplementalGroups:""}, ReplicaStorage:v1.PgStorageSpec{Name:"", StorageClass:"portworx-sc", AccessMode:"ReadWriteOnce", Size:"200M", StorageType:"dynamic", Fsgroup:"26", SupplementalGroups:""}, ContainerResources:v1.PgContainerResources{RequestsMemory:"", RequestsCPU:"", LimitsMemory:"", LimitsCPU:""}, PrimaryHost:"mycluster", PrimaryPassword:"", User:"testuser", Password:"", Database:"userdb", RootPassword:"", Replicas:"0", Strategy:"1", SecretFrom:"", BackupPVCName:"", BackupPath:"", UserSecretName:"", RootSecretName:"", PrimarySecretName:"", Status:"", PswLastUpdate:"2018-04-20T07:24:01Z", CustomConfig:"", UserLabels:map[string]string{"crunchy_collect":"false"}}, Status:v1.PgclusterStatus{State:"Processed", Message:"Successfully processed Pgcluster by controller"}}
time="2018-04-20T07:24:01Z" level=debug msg="created PVC mycluster-pvc"
time="2018-04-20T07:24:04Z" level=info msg="created PVC =mycluster-pvc in namespace demo"
time="2018-04-20T07:24:04Z" level=debug msg="created primary pvc [mycluster-pvc]"
time="2018-04-20T07:24:04Z" level=debug msg="creating Pgcluster object strategy is [1]"
time="2018-04-20T07:24:04Z" level=debug msg="created secret mycluster-postgres-secret"
time="2018-04-20T07:24:04Z" level=debug msg="[{\"op\":\"replace\",\"path\":\"/spec/rootsecretname\",\"value\":\"mycluster-postgres-secret\"}]"
time="2018-04-20T07:24:04Z" level=debug msg="created secret mycluster-primaryuser-secret"
time="2018-04-20T07:24:04Z" level=debug msg="[{\"op\":\"replace\",\"path\":\"/spec/primarysecretname\",\"value\":\"mycluster-primaryuser-secret\"}]"
time="2018-04-20T07:24:04Z" level=debug msg="created secret mycluster-testuser-secret"
time="2018-04-20T07:24:04Z" level=debug msg="[{\"op\":\"replace\",\"path\":\"/spec/usersecretname\",\"value\":\"mycluster-testuser-secret\"}]"
time="2018-04-20T07:24:04Z" level=info msg="strategy found"
time="2018-04-20T07:24:04Z" level=info msg="creating Pgcluster object using Strategy 1 in namespace demo"
time="2018-04-20T07:24:04Z" level=info msg="created with Name=mycluster in namespace demo"
time="2018-04-20T07:24:04Z" level=debug msg="{\n \"kind\": \"Service\",\n \"apiVersion\": \"v1\",\n \"metadata\": {\n \"name\": \"mycluster\",\n \"labels\": {\n \"pg-cluster\": \"mycluster\",\n \"name\": \"mycluster\"\n }\n },\n \"spec\": {\n \"ports\": [\n\t{\n\t \"name\": \"postgres\",\n \"protocol\": \"TCP\",\n \"port\": 5432,\n \"targetPort\": 5432,\n \"nodePort\": 0\n }, {\n\t \"name\": \"node-exporter\",\n\t\"protocol\": \"TCP\",\n\t\"port\": 9100,\n\t\"targetPort\": 9100,\n\t\"nodePort\": 0\n\t}, {\n\t\"name\": \"postgres-exporter\",\n\t\"protocol\": \"TCP\",\n\t\"port\": 9187,\n\t\"targetPort\": 9187,\n\t\"nodePort\": 0\n\t}\n\t],\n \"selector\": {\n \"name\": \"mycluster\"\n },\n \"type\": \"ClusterIP\",\n \"sessionAffinity\": \"None\"\n }\n}\n"
time="2018-04-20T07:24:04Z" level=info msg="created service mycluster"
time="2018-04-20T07:24:04Z" level=debug msg="GetAffinity with nodeLabelKey=[] nodeLabelKey=[] and operator=[In]\n"
time="2018-04-20T07:24:04Z" level=error msg="configmaps \"pgo-custom-pg-config\" not found"
time="2018-04-20T07:24:04Z" level=error msg="pgo-custom-pg-config configmap not found "
time="2018-04-20T07:24:04Z" level=debug msg="pgo-custom-pg-config was not found, , skipping global configMap"
time="2018-04-20T07:24:04Z" level=debug msg="{\n \"kind\": \"Deployment\",\n \"apiVersion\": \"extensions/v1beta1\",\n \"metadata\": {\n \"name\": \"mycluster\",\n \"labels\": {\n \"name\": \"mycluster\",\"pg-cluster\": \"mycluster\",\"crunchy_collect\": \"false\"\n }\n },\n \"spec\": {\n \"replicas\": 1,\n \"template\": {\n \"metadata\": {\n \"labels\": {\n \"name\": \"mycluster\",\n \"primary\": \"true\",\n \"pg-cluster\": \"mycluster\",\n \"name\": \"mycluster\",\"pg-cluster\": \"mycluster\",\"crunchy_collect\": \"false\"\n }\n },\n \"spec\": {\n\n \"securityContext\": {\n\t \"fsGroup\": 26\n},\n\n \"containers\": [\n\t\t\n \n\n\t\t {\n \"name\": \"database\",\n \"image\": \"crunchydata/crunchy-postgres:centos7-10.3-1.8.2\",\n \"readinessProbe\": {\n \"exec\": {\n \"command\": [\n \"/opt/cpm/bin/readiness.sh\"\n ]\n },\n \"initialDelaySeconds\": 15,\n \"timeoutSeconds\": 8\n },\n\n\t\t \n\n \"env\": [{\n \"name\": \"PG_PRIMARY_PORT\",\n \"value\": \"5432\"\n }, {\n \"name\": \"PG_MODE\",\n \"value\": \"primary\"\n }, {\n \"name\": \"PG_LOCALE\",\n \"value\": \"en_US.UTF8\"\n }, {\n \"name\": \"PGDATA_PATH_OVERRIDE\",\n \"value\": \"mycluster\"\n }, {\n \"name\": \"BACKUP_PATH\",\n \"value\": \"\"\n }, {\n \"name\": \"PG_DATABASE\",\n \"value\": \"userdb\"\n }, {\n \"name\": \"PGHOST\",\n \"value\": \"/tmp\"\n }],\n \"volumeMounts\": [{\n \"mountPath\": \"/pgdata\",\n \"name\": \"pgdata\",\n \"readOnly\": false\n }, {\n \"mountPath\": \"/backup\",\n \"name\": \"backup\",\n \"readOnly\": true\n }, {\n \"mountPath\": \"/pguser\",\n \"name\": \"user-volume\"\n }, {\n \"mountPath\": \"/pgprimary\",\n \"name\": \"primary-volume\"\n }, {\n \"mountPath\": \"/pgroot\",\n \"name\": \"root-volume\"\n }, {\n \"mountPath\": \"/pgwal\",\n \"name\": \"pgwal-volume\"\n }, {\n \"mountPath\": \"/pgconf\",\n \"name\": \"pgconf-volume\"\n }, {\n \"mountPath\": \"/recover\",\n \"name\": \"recover-volume\"\n }, {\n \"mountPath\": \"/backrestrepo\",\n \"name\": \"backrestrepo-volume\"\n }\n\n ],\n\n \"ports\": [{\n \"containerPort\": 5432,\n \"protocol\": \"TCP\"\n }],\n \"resources\": {},\n \"imagePullPolicy\": \"IfNotPresent\"\n }],\n \"volumes\": [{\n \"name\": \"pgdata\",\n \"persistentVolumeClaim\": {\n\t \"claimName\": \"mycluster-pvc\"\n}\n }, {\n \"name\": \"backup\",\n \"emptyDir\": {\n}\n }, {\n \"name\": \"user-volume\",\n \"secret\": {\n \"secretName\": \"mycluster-testuser-secret\"\n }\n }, {\n \"name\": \"primary-volume\",\n \"secret\": {\n \"secretName\": \"mycluster-primaryuser-secret\"\n }\n }, {\n \"name\": \"root-volume\",\n \"secret\": {\n \"secretName\": \"mycluster-postgres-secret\"\n }\n }, {\n \"name\": \"pgwal-volume\",\n\t\t\t\"emptyDir\": { \"medium\": \"Memory\" }\n }, {\n \"name\": \"backrestrepo-volume\",\n\t\t\t\"emptyDir\": { \"medium\": \"Memory\" }\n }, {\n \"name\": \"recover-volume\",\n\t\t\t\"emptyDir\": { \"medium\": \"Memory\" }\n }, {\n \"name\": \"pgconf-volume\",\n\t\t\t\"emptyDir\": { \"medium\": \"Memory\" }\n }\n\n ],\n\n\t\t\n\n \"restartPolicy\": \"Always\",\n \"dnsPolicy\": \"ClusterFirst\"\n }\n },\n \"strategy\": {\n \"type\": \"RollingUpdate\",\n \"rollingUpdate\": {\n \"maxUnavailable\": 1,\n \"maxSurge\": 1\n }\n }\n }\n}\n"
time="2018-04-20T07:24:04Z" level=debug msg="deployment mycluster not found"
time="2018-04-20T07:24:04Z" level=info msg="created deployment mycluster"
time="2018-04-20T07:24:04Z" level=debug msg="{\"metadata\":{\"labels\":{\"crunchy_collect\":\"false\",\"pg-cluster\":\"mycluster\"}}}"
time="2018-04-20T07:24:04Z" level=debug msg="[{\"op\":\"replace\",\"path\":\"/spec/status\",\"value\":\"completed\"}]"
time="2018-04-20T07:24:04Z" level=debug msg="[{\"op\":\"replace\",\"path\":\"/spec/PrimaryStorage/name\",\"value\":\"mycluster-pvc\"}]"
time="2018-04-20T07:24:04Z" level=debug msg="pgcluster mycluster updated "
time="2018-04-20T07:24:04Z" level=debug msg="pgcluster mycluster updated "
time="2018-04-20T07:24:04Z" level=debug msg="pgcluster mycluster updated "
time="2018-04-20T07:24:04Z" level=debug msg="pgcluster mycluster updated "
time="2018-04-20T07:24:04Z" level=debug msg="pgcluster mycluster updated "
time="2018-04-20T07:24:04Z" level=debug msg="pgcluster mycluster updated "
time="2018-04-20T07:24:04Z" level=debug msg="pgcluster mycluster updated "
time="2018-04-20T07:27:34Z" level=info msg="[PodCONTROLLER] OnDelete /api/v1/namespaces/demo/pods/lspvc-mycluster-pvc\n"
time="2018-04-20T07:27:42Z" level=info msg="[PodCONTROLLER] OnDelete /api/v1/namespaces/demo/pods/lspvc-mycluster-pvc\n"
time="2018-04-20T07:28:16Z" level=info msg="[PodCONTROLLER] OnDelete /api/v1/namespaces/demo/pods/lspvc-mycluster-pvc\n"
[PgpolicyCONTROLLER] OnAdd /apis/cr.client-go.k8s.io/v1/namespaces/demo/pgpolicies/xrayapp
UPDATED status: &v1.Pgpolicy{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"xrayapp", GenerateName:"", Namespace:"demo", SelfLink:"/apis/cr.client-go.k8s.io/v1/namespaces/demo/pgpolicies/xrayapp", UID:"fa100965-446c-11e8-831b-08002748a462", ResourceVersion:"815080", Generation:1, CreationTimestamp:v1.Time{Time:time.Time{sec:63659806347, nsec:0, loc:(*time.Location)(0x18e0b20)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v1.PgpolicySpec{Name:"xrayapp", URL:"", SQL:"\\c userdb;\ncreate table xrayapp (id int, key varchar(40), value varchar(40));\ncreate table a (id int);\ncreate table xraycsvtable (name varchar(40), state varchar(40), zip varchar(40));\n\n", Status:""}, Status:v1.PgpolicyStatus{State:"Processed", Message:"Successfully processed Pgpolicy by controller"}}
time="2018-04-20T07:36:47Z" level=info msg="[JobCONTROLLER] OnUpdate /apis/batch/v1/namespaces/demo/jobs/pgo-load-mycluster-duy succeeded=0\n"
time="2018-04-20T07:45:33Z" level=error msg="error in major upgrade watch closed before Until timeout"
time="2018-04-20T08:41:32Z" level=info msg="[PodCONTROLLER] OnDelete /api/v1/namespaces/demo/pods/pgo-load-mycluster-duy-ls2gw\n"
time="2018-04-20T08:41:32Z" level=info msg="[JobCONTROLLER] OnUpdate /apis/batch/v1/namespaces/demo/jobs/pgo-load-mycluster-duy succeeded=0\n"
time="2018-04-20T08:41:32Z" level=info msg="[JobCONTROLLER] OnUpdate /apis/batch/v1/namespaces/demo/jobs/pgo-load-mycluster-duy succeeded=0\n"
time="2018-04-20T08:42:12Z" level=info msg="[JobCONTROLLER] OnUpdate /apis/batch/v1/namespaces/demo/jobs/pgo-load-mycluster-ots succeeded=0\n"
time="2018-04-20T08:42:22Z" level=info msg="[JobCONTROLLER] OnUpdate /apis/batch/v1/namespaces/demo/jobs/pgo-load-mycluster-ots succeeded=1\n"
time="2018-04-20T11:29:43Z" level=debug msg="deleteCluster called with strategy 1"
time="2018-04-20T11:29:43Z" level=info msg="strategy found"
[PgclusterCONTROLLER] OnDelete /apis/cr.client-go.k8s.io/v1/namespaces/demo/pgclusters/mycluster
time="2018-04-20T11:29:43Z" level=debug msg="deleted secret mycluster-postgres-secret"
time="2018-04-20T11:29:43Z" level=debug msg="deleted secret mycluster-primaryuser-secret"
time="2018-04-20T11:29:43Z" level=debug msg="deleted secret mycluster-testuser-secret"
time="2018-04-20T11:29:43Z" level=debug msg="deleted secret mycluster-user1-secret"
time="2018-04-20T11:29:43Z" level=info msg="deleting Pgcluster object in namespace demo"
time="2018-04-20T11:29:43Z" level=info msg="deleting with Name=mycluster in namespace demo"
time="2018-04-20T11:29:43Z" level=info msg="delete deployment mycluster"
time="2018-04-20T11:29:44Z" level=info msg="delete service mycluster"
time="2018-04-20T11:29:44Z" level=error msg="services \"mycluster-replica\" not found"
time="2018-04-20T11:29:44Z" level=error msg="error deleting Service mycluster-replica"
time="2018-04-20T11:29:44Z" level=info msg="delete service mycluster-replica"
time="2018-04-20T11:29:44Z" level=debug msg="myselector is pg-cluster=mycluster"
time="2018-04-20T11:29:44Z" level=debug msg="pgreplicas found len is %d\n0"
time="2018-04-20T11:29:44Z" level=error msg="error deleting pgbackup pgbackups.cr.client-go.k8s.io \"mycluster\" not found"
time="2018-04-20T11:29:44Z" level=error msg="error deleting pgupgrade pgupgrades.cr.client-go.k8s.io \"mycluster\" not found"
time="2018-04-20T11:29:44Z" level=info msg="will not delete pgupgrade, not found for mycluster"
time="2018-04-20T11:29:55Z" level=info msg="[PodCONTROLLER] OnDelete /api/v1/namespaces/demo/pods/mycluster-6c7b9b8774-lh5mm\n"
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment