search

projectcalico / calico

Cloud native networking and network security
https://docs.tigera.io/calico/latest/about/
Apache License 2.0
5.89k stars 1.31k forks source link

vxlan.calico int down #4262

Closed brathina-spectro closed 3 years ago

brathina-spectro commented 3 years ago

Calico daemonset installation on Kubernetes cluster doesn't create vxlan.calico interface.

Expected Behavior

vxlan.calico interface gets created and calico runs fine

Current Behavior

vxlan.calico interface fails to get created

Steps to Reproduce (for bugs)

calico-node daemonset setting

apiVersion: apps/v1
kind: DaemonSet
metadata:
  annotations:
    deprecated.daemonset.template.generation: "4"
    kubectl.kubernetes.io/last-applied-configuration: |
      {"apiVersion":"apps/v1","kind":"DaemonSet","metadata":{"annotations":{},"labels":{"k8s-app":"calico-node"},"name":"calico-node","namespace":"kube-system"},"spec":{"selector":{"matchLabels":{"k8s-app":"calico-node"}},"template":{"metadata":{"labels":{"k8s-app":"calico-node"}},"spec":{"containers":[{"env":[{"name":"DATASTORE_TYPE","value":"kubernetes"},{"name":"WAIT_FOR_DATASTORE","value":"true"},{"name":"NODENAME","valueFrom":{"fieldRef":{"fieldPath":"spec.nodeName"}}},{"name":"CALICO_NETWORKING_BACKEND","valueFrom":{"configMapKeyRef":{"key":"calico_backend","name":"calico-config"}}},{"name":"CLUSTER_TYPE","value":"k8s,bgp"},{"name":"IP","value":"autodetect"},{"name":"CALICO_IPV4POOL_VXLAN","value":"Always"},{"name":"FELIX_VXLANMTU","valueFrom":{"configMapKeyRef":{"key":"veth_mtu","name":"calico-config"}}},{"name":"CALICO_DISABLE_FILE_LOGGING","value":"true"},{"name":"FELIX_DEFAULTENDPOINTTOHOSTACTION","value":"ACCEPT"},{"name":"FELIX_IPV6SUPPORT","value":"false"},{"name":"FELIX_LOGSEVERITYSCREEN","value":"info"},{"name":"FELIX_HEALTHENABLED","value":"true"},{"name":"USE_POD_CIDR","value":"true"}],"envFrom":[{"configMapRef":{"name":"kubernetes-services-endpoint","optional":true}}],"image":"calico/node:v3.16.5","livenessProbe":{"exec":{"command":["/bin/calico-node","-felix-live"]},"failureThreshold":6,"initialDelaySeconds":10,"periodSeconds":10},"name":"calico-node","readinessProbe":{"exec":{"command":["/bin/calico-node","-felix-ready"]},"periodSeconds":10},"resources":{"requests":{"cpu":"250m"}},"securityContext":{"privileged":true},"volumeMounts":[{"mountPath":"/lib/modules","name":"lib-modules","readOnly":true},{"mountPath":"/run/xtables.lock","name":"xtables-lock","readOnly":false},{"mountPath":"/var/run/calico","name":"var-run-calico","readOnly":false},{"mountPath":"/var/lib/calico","name":"var-lib-calico","readOnly":false},{"mountPath":"/var/run/nodeagent","name":"policysync"},{"mountPath":"/sys/fs/","mountPropagation":"Bidirectional","name":"sysfs"}]}],"hostNetwork":true,"initContainers":[{"command":["/opt/cni/bin/calico-ipam","-upgrade"],"env":[{"name":"KUBERNETES_NODE_NAME","valueFrom":{"fieldRef":{"fieldPath":"spec.nodeName"}}},{"name":"CALICO_NETWORKING_BACKEND","valueFrom":{"configMapKeyRef":{"key":"calico_backend","name":"calico-config"}}}],"envFrom":[{"configMapRef":{"name":"kubernetes-services-endpoint","optional":true}}],"image":"calico/cni:v3.16.5","name":"upgrade-ipam","securityContext":{"privileged":true},"volumeMounts":[{"mountPath":"/var/lib/cni/networks","name":"host-local-net-dir"},{"mountPath":"/host/opt/cni/bin","name":"cni-bin-dir"}]},{"command":["/opt/cni/bin/install"],"env":[{"name":"CNI_CONF_NAME","value":"10-calico.conflist"},{"name":"CNI_NETWORK_CONFIG","valueFrom":{"configMapKeyRef":{"key":"cni_network_config","name":"calico-config"}}},{"name":"KUBERNETES_NODE_NAME","valueFrom":{"fieldRef":{"fieldPath":"spec.nodeName"}}},{"name":"CNI_MTU","valueFrom":{"configMapKeyRef":{"key":"veth_mtu","name":"calico-config"}}},{"name":"SLEEP","value":"false"}],"envFrom":[{"configMapRef":{"name":"kubernetes-services-endpoint","optional":true}}],"image":"calico/cni:v3.16.5","name":"install-cni","securityContext":{"privileged":true},"volumeMounts":[{"mountPath":"/host/opt/cni/bin","name":"cni-bin-dir"},{"mountPath":"/host/etc/cni/net.d","name":"cni-net-dir"}]},{"image":"calico/pod2daemon-flexvol:v3.16.5","name":"flexvol-driver","securityContext":{"privileged":true},"volumeMounts":[{"mountPath":"/host/driver","name":"flexvol-driver-host"}]}],"nodeSelector":{"kubernetes.io/os":"linux"},"priorityClassName":"system-node-critical","serviceAccountName":"calico-node","terminationGracePeriodSeconds":0,"tolerations":[{"effect":"NoSchedule","operator":"Exists"},{"key":"CriticalAddonsOnly","operator":"Exists"},{"effect":"NoExecute","operator":"Exists"}],"volumes":[{"hostPath":{"path":"/lib/modules"},"name":"lib-modules"},{"hostPath":{"path":"/var/run/calico"},"name":"var-run-calico"},{"hostPath":{"path":"/var/lib/calico"},"name":"var-lib-calico"},{"hostPath":{"path":"/run/xtables.lock","type":"FileOrCreate"},"name":"xtables-lock"},{"hostPath":{"path":"/sys/fs/","type":"DirectoryOrCreate"},"name":"sysfs"},{"hostPath":{"path":"/opt/cni/bin"},"name":"cni-bin-dir"},{"hostPath":{"path":"/etc/cni/net.d"},"name":"cni-net-dir"},{"hostPath":{"path":"/var/lib/cni/networks"},"name":"host-local-net-dir"},{"hostPath":{"path":"/var/run/nodeagent","type":"DirectoryOrCreate"},"name":"policysync"},{"hostPath":{"path":"/usr/libexec/kubernetes/kubelet-plugins/volume/exec/nodeagent~uds","type":"DirectoryOrCreate"},"name":"flexvol-driver-host"}]}},"updateStrategy":{"rollingUpdate":{"maxUnavailable":1},"type":"RollingUpdate"}}}
  creationTimestamp: "2020-12-16T23:56:26Z"
  generation: 4
  labels:
    k8s-app: calico-node
  name: calico-node
  namespace: kube-system
  resourceVersion: "374644"
  selfLink: /apis/apps/v1/namespaces/kube-system/daemonsets/calico-node
  uid: 6a73feef-5e6d-4096-a5fa-ec8cd991903c
spec:
  revisionHistoryLimit: 10
  selector:
    matchLabels:
      k8s-app: calico-node
  template:
    metadata:
      annotations:
        kubectl.kubernetes.io/restartedAt: "2020-12-17T10:44:20-08:00"
      creationTimestamp: null
      labels:
        k8s-app: calico-node
    spec:
      containers:
      - env:
        - name: DATASTORE_TYPE
          value: kubernetes
        - name: WAIT_FOR_DATASTORE
          value: "true"
        - name: NODENAME
          valueFrom:
            fieldRef:
              apiVersion: v1
              fieldPath: spec.nodeName
        - name: CALICO_NETWORKING_BACKEND
          valueFrom:
            configMapKeyRef:
              key: calico_backend
              name: calico-config
        - name: CLUSTER_TYPE
          value: k8s,bgp
        - name: IP
          value: autodetect
        - name: CALICO_IPV4POOL_VXLAN
          value: Always
        - name: CALICO_DISABLE_FILE_LOGGING
          value: "true"
        - name: FELIX_DEFAULTENDPOINTTOHOSTACTION
          value: ACCEPT
        - name: FELIX_IPV6SUPPORT
          value: "false"
        - name: FELIX_LOGSEVERITYSCREEN
          value: info
        - name: FELIX_HEALTHENABLED
          value: "true"
        - name: USE_POD_CIDR
          value: "true"
        envFrom:
        - configMapRef:
            name: kubernetes-services-endpoint
            optional: true
        image: calico/node:v3.16.5
        imagePullPolicy: IfNotPresent
        livenessProbe:
          exec:
            command:
            - /bin/calico-node
            - -felix-live
          failureThreshold: 6
          initialDelaySeconds: 10
          periodSeconds: 10
          successThreshold: 1
          timeoutSeconds: 1
        name: calico-node
        readinessProbe:
          exec:
            command:
            - /bin/calico-node
            - -felix-ready
          failureThreshold: 3
          periodSeconds: 10
          successThreshold: 1
          timeoutSeconds: 1
        resources:
          requests:
            cpu: 250m
        securityContext:
          privileged: true
        terminationMessagePath: /dev/termination-log
        terminationMessagePolicy: File
        volumeMounts:
        - mountPath: /lib/modules
          name: lib-modules
          readOnly: true
        - mountPath: /run/xtables.lock
          name: xtables-lock
        - mountPath: /var/run/calico
          name: var-run-calico
        - mountPath: /var/lib/calico
          name: var-lib-calico
        - mountPath: /var/run/nodeagent
          name: policysync
        - mountPath: /sys/fs/
          mountPropagation: Bidirectional
          name: sysfs
      dnsPolicy: ClusterFirst
      hostNetwork: true
      initContainers:
      - command:
        - /opt/cni/bin/calico-ipam
        - -upgrade
        env:
        - name: KUBERNETES_NODE_NAME
          valueFrom:
            fieldRef:
              apiVersion: v1
              fieldPath: spec.nodeName
        - name: CALICO_NETWORKING_BACKEND
          valueFrom:
            configMapKeyRef:
              key: calico_backend
              name: calico-config
        envFrom:
        - configMapRef:
            name: kubernetes-services-endpoint
            optional: true
        image: calico/cni:v3.16.5
        imagePullPolicy: IfNotPresent
        name: upgrade-ipam
        resources: {}
        securityContext:
          privileged: true
        terminationMessagePath: /dev/termination-log
        terminationMessagePolicy: File
        volumeMounts:
        - mountPath: /var/lib/cni/networks
          name: host-local-net-dir
        - mountPath: /host/opt/cni/bin
          name: cni-bin-dir
      - command:
        - /opt/cni/bin/install
        env:
        - name: CNI_CONF_NAME
          value: 10-calico.conflist
        - name: CNI_NETWORK_CONFIG
          valueFrom:
            configMapKeyRef:
              key: cni_network_config
              name: calico-config
        - name: KUBERNETES_NODE_NAME
          valueFrom:
            fieldRef:
              apiVersion: v1
              fieldPath: spec.nodeName
        - name: CNI_MTU
          valueFrom:
            configMapKeyRef:
              key: veth_mtu
              name: calico-config
        - name: SLEEP
          value: "false"
        envFrom:
        - configMapRef:
            name: kubernetes-services-endpoint
            optional: true
        image: calico/cni:v3.16.5
        imagePullPolicy: IfNotPresent
        name: install-cni
        resources: {}
        securityContext:
          privileged: true
        terminationMessagePath: /dev/termination-log
        terminationMessagePolicy: File
        volumeMounts:
        - mountPath: /host/opt/cni/bin
          name: cni-bin-dir
        - mountPath: /host/etc/cni/net.d
          name: cni-net-dir
      - image: calico/pod2daemon-flexvol:v3.16.5
        imagePullPolicy: IfNotPresent
        name: flexvol-driver
        resources: {}
        securityContext:
          privileged: true
        terminationMessagePath: /dev/termination-log
        terminationMessagePolicy: File
        volumeMounts:
        - mountPath: /host/driver
          name: flexvol-driver-host
      nodeSelector:
        kubernetes.io/os: linux
      priorityClassName: system-node-critical
      restartPolicy: Always
      schedulerName: default-scheduler
      securityContext: {}
      serviceAccount: calico-node
      serviceAccountName: calico-node
      terminationGracePeriodSeconds: 0
      tolerations:
      - effect: NoSchedule
        operator: Exists
      - key: CriticalAddonsOnly
        operator: Exists
      - effect: NoExecute
        operator: Exists
      volumes:
      - hostPath:
          path: /lib/modules
          type: ""
        name: lib-modules
      - hostPath:
          path: /var/run/calico
          type: ""
        name: var-run-calico
      - hostPath:
          path: /var/lib/calico
          type: ""
        name: var-lib-calico
      - hostPath:
          path: /run/xtables.lock
          type: FileOrCreate
        name: xtables-lock
      - hostPath:
          path: /sys/fs/
          type: DirectoryOrCreate
        name: sysfs
      - hostPath:
          path: /opt/cni/bin
          type: ""
        name: cni-bin-dir
      - hostPath:
          path: /etc/cni/net.d
          type: ""
        name: cni-net-dir
      - hostPath:
          path: /var/lib/cni/networks
          type: ""
        name: host-local-net-dir
      - hostPath:
          path: /var/run/nodeagent
          type: DirectoryOrCreate
        name: policysync
      - hostPath:
          path: /usr/libexec/kubernetes/kubelet-plugins/volume/exec/nodeagent~uds
          type: DirectoryOrCreate
        name: flexvol-driver-host
  updateStrategy:
    rollingUpdate:
      maxUnavailable: 1
    type: RollingUpdate
status:
  currentNumberScheduled: 2
  desiredNumberScheduled: 2
  numberAvailable: 2
  numberMisscheduled: 0
  numberReady: 2
  observedGeneration: 4
  updatedNumberScheduled: 2

calico-config comfigmap setting

apiVersion: v1
data:
  calico_backend: vxlan
  cni_network_config: |-
    {
      "name": "k8s-pod-network",
      "cniVersion": "0.3.1",
      "plugins": [
        {
          "type": "calico",
          "log_level": "info",
          "log_file_path": "/var/log/calico/cni/cni.log",
          "datastore_type": "kubernetes",
          "nodename": "__KUBERNETES_NODE_NAME__",
          "mtu": __CNI_MTU__,
          "ipam": {
              "subnet": "usePodCidr",
              "type": "host-local"
          },
          "policy": {
              "type": "k8s"
          },
          "kubernetes": {
              "kubeconfig": "__KUBECONFIG_FILEPATH__"
          }
        },
        {
          "type": "portmap",
          "snat": true,
          "capabilities": {"portMappings": true}
        },
        {
          "type": "bandwidth",
          "capabilities": {"bandwidth": true}
        }
      ]
    }
  typha_service_name: none
  veth_mtu: "1440"
kind: ConfigMap
metadata:
  annotations:
    kubectl.kubernetes.io/last-applied-configuration: |
      {"apiVersion":"v1","data":{"calico_backend":"vxlan","cni_network_config":"{\n  \"name\": \"k8s-pod-network\",\n  \"cniVersion\": \"0.3.1\",\n  \"plugins\": [\n    {\n      \"type\": \"calico\",\n      \"log_level\": \"info\",\n      \"log_file_path\": \"/var/log/calico/cni/cni.log\",\n      \"datastore_type\": \"kubernetes\",\n      \"nodename\": \"__KUBERNETES_NODE_NAME__\",\n      \"mtu\": __CNI_MTU__,\n      \"ipam\": {\n          \"subnet\": \"usePodCidr\",\n          \"type\": \"host-local\"\n      },\n      \"policy\": {\n          \"type\": \"k8s\"\n      },\n      \"kubernetes\": {\n          \"kubeconfig\": \"__KUBECONFIG_FILEPATH__\"\n      }\n    },\n    {\n      \"type\": \"portmap\",\n      \"snat\": true,\n      \"capabilities\": {\"portMappings\": true}\n    },\n    {\n      \"type\": \"bandwidth\",\n      \"capabilities\": {\"bandwidth\": true}\n    }\n  ]\n}","typha_service_name":"none","veth_mtu":"1440"},"kind":"ConfigMap","metadata":{"annotations":{},"name":"calico-config","namespace":"kube-system"}}
  creationTimestamp: "2020-12-16T23:56:23Z"
  name: calico-config
  namespace: kube-system
  resourceVersion: "459"
  selfLink: /api/v1/namespaces/kube-system/configmaps/calico-config
  uid: 68e28f9d-5703-4176-a0d8-561e17d3a000

calico-node log

2020-12-17 18:44:36.080 [INFO][12] startup/startup.go 376: Early log level set to info
2020-12-17 18:44:36.080 [INFO][12] startup/startup.go 392: Using NODENAME environment for node name
2020-12-17 18:44:36.080 [INFO][12] startup/startup.go 404: Determined node name: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t
2020-12-17 18:44:36.082 [INFO][12] startup/startup.go 436: Checking datastore connection
2020-12-17 18:44:36.099 [INFO][12] startup/startup.go 460: Datastore connection verified
2020-12-17 18:44:36.100 [INFO][12] startup/startup.go 109: Datastore is ready
2020-12-17 18:44:36.114 [INFO][12] startup/startup.go 756: Using autodetected IPv4 address on interface eth0: 10.1.0.4/16
2020-12-17 18:44:36.114 [INFO][12] startup/startup.go 833: No AS number configured on node resource, using global value
2020-12-17 18:44:36.114 [INFO][12] startup/startup.go 181: Setting NetworkUnavailable to False
2020-12-17 18:44:36.175 [INFO][12] startup/startup.go 878: found v4=192.168.0.0/16 in the kubeadm config map
2020-12-17 18:44:36.175 [INFO][12] startup/startup.go 882: found v6= in the kubeadm config map
2020-12-17 18:44:36.179 [INFO][12] startup/startup.go 688: FELIX_IPV6SUPPORT is false through environment variable
2020-12-17 18:44:36.187 [INFO][12] startup/startup.go 214: Using node name: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t
CALICO_NETWORKING_BACKEND is vxlan - no need to run a BGP daemon
Calico node started successfully
2020-12-17 18:44:37.417 [INFO][43] felix/logutils.go 82: Early screen log level set to info
2020-12-17 18:44:37.422 [INFO][43] felix/daemon.go 142: Felix starting up GOMAXPROCS=2 builddate="4e54da10cf3e292e7aac66650a37bf8bd12ce26d" gitcommit="2020-11-06T19:03:29+0000" version="v3.16.5"
2020-12-17 18:44:37.423 [INFO][43] felix/daemon.go 161: Kubernetes server override env vars. KUBERNETES_SERVICE_HOST="10.96.0.1" KUBERNETES_SERVICE_PORT="443"
2020-12-17 18:44:37.423 [INFO][43] felix/daemon.go 166: Loading configuration...
2020-12-17 18:44:37.424 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "etcdscheme"=""
2020-12-17 18:44:37.424 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "etcdkeyfile"=""
2020-12-17 18:44:37.424 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "healthenabled"="true"
2020-12-17 18:44:37.424 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "etcdcafile"=""
2020-12-17 18:44:37.424 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "etcdendpoints"=""
2020-12-17 18:44:37.424 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "felixhostname"="boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t"
2020-12-17 18:44:37.424 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "datastoretype"="kubernetes"
2020-12-17 18:44:37.425 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "etcdcertfile"=""
2020-12-17 18:44:37.425 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "etcdaddr"=""
2020-12-17 18:44:37.425 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "defaultendpointtohostaction"="ACCEPT"
2020-12-17 18:44:37.425 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "logseverityscreen"="info"
2020-12-17 18:44:37.425 [INFO][43] felix/env_var_loader.go 40: Found felix environment variable: "ipv6support"="false"
2020-12-17 18:44:37.425 [INFO][43] felix/daemon.go 192: Loading config file: /etc/calico/felix.cfg
2020-12-17 18:44:37.425 [INFO][43] felix/config_params.go 335: Merging in config from environment variable: map[datastoretype:kubernetes defaultendpointtohostaction:ACCEPT etcdaddr: etcdcafile: etcdcertfile: etcdendpoints: etcdkeyfile: etcdscheme: felixhostname:boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t healthenabled:true ipv6support:false logseverityscreen:info]
2020-12-17 18:44:37.425 [INFO][43] felix/config_params.go 344: Ignoring empty configuration parameter. Use value 'none' if your intention is to explicitly disable the default value. name="etcdscheme" source=environment variable
2020-12-17 18:44:37.425 [INFO][43] felix/config_params.go 344: Ignoring empty configuration parameter. Use value 'none' if your intention is to explicitly disable the default value. name="etcdcertfile" source=environment variable
2020-12-17 18:44:37.425 [INFO][43] felix/config_params.go 344: Ignoring empty configuration parameter. Use value 'none' if your intention is to explicitly disable the default value. name="etcdaddr" source=environment variable
2020-12-17 18:44:37.425 [INFO][43] felix/config_params.go 344: Ignoring empty configuration parameter. Use value 'none' if your intention is to explicitly disable the default value. name="etcdkeyfile" source=environment variable
2020-12-17 18:44:37.425 [INFO][43] felix/config_params.go 344: Ignoring empty configuration parameter. Use value 'none' if your intention is to explicitly disable the default value. name="etcdcafile" source=environment variable
2020-12-17 18:44:37.425 [INFO][43] felix/config_params.go 344: Ignoring empty configuration parameter. Use value 'none' if your intention is to explicitly disable the default value. name="etcdendpoints" source=environment variable
2020-12-17 18:44:37.425 [INFO][43] felix/config_params.go 424: Parsing value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.426 [INFO][43] felix/config_params.go 460: Parsed value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.426 [INFO][43] felix/config_params.go 424: Parsing value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.426 [INFO][43] felix/config_params.go 460: Parsed value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.426 [INFO][43] felix/config_params.go 424: Parsing value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.427 [INFO][43] felix/config_params.go 460: Parsed value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.427 [INFO][43] felix/config_params.go 424: Parsing value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.427 [INFO][43] felix/config_params.go 460: Parsed value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.427 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: info (from environment variable)
2020-12-17 18:44:37.428 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from environment variable)
2020-12-17 18:44:37.428 [INFO][43] felix/config_params.go 424: Parsing value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.428 [INFO][43] felix/config_params.go 460: Parsed value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.428 [INFO][43] felix/config_params.go 335: Merging in config from config file: map[LogFilePath:None LogSeverityFile:None LogSeveritySys:None MetadataAddr:None]
2020-12-17 18:44:37.428 [INFO][43] felix/config_params.go 424: Parsing value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.428 [INFO][43] felix/config_params.go 460: Parsed value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.429 [INFO][43] felix/config_params.go 424: Parsing value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.429 [INFO][43] felix/config_params.go 460: Parsed value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.429 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: info (from environment variable)
2020-12-17 18:44:37.429 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from environment variable)
2020-12-17 18:44:37.429 [INFO][43] felix/config_params.go 424: Parsing value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.429 [INFO][43] felix/config_params.go 460: Parsed value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.429 [INFO][43] felix/config_params.go 424: Parsing value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.429 [INFO][43] felix/config_params.go 460: Parsed value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.430 [INFO][43] felix/config_params.go 424: Parsing value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.430 [INFO][43] felix/config_params.go 460: Parsed value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.430 [INFO][43] felix/config_params.go 424: Parsing value for LogFilePath: None (from config file)
2020-12-17 18:44:37.430 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.430 [INFO][43] felix/config_params.go 460: Parsed value for LogFilePath:  (from config file)
2020-12-17 18:44:37.430 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityFile: None (from config file)
2020-12-17 18:44:37.430 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.431 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityFile:  (from config file)
2020-12-17 18:44:37.431 [INFO][43] felix/config_params.go 424: Parsing value for LogSeveritySys: None (from config file)
2020-12-17 18:44:37.431 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.431 [INFO][43] felix/config_params.go 460: Parsed value for LogSeveritySys:  (from config file)
2020-12-17 18:44:37.431 [INFO][43] felix/config_params.go 424: Parsing value for MetadataAddr: None (from config file)
2020-12-17 18:44:37.432 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.432 [INFO][43] felix/config_params.go 460: Parsed value for MetadataAddr:  (from config file)
2020-12-17 18:44:37.432 [INFO][43] felix/health.go 233: Health enabled.  Starting server. host="localhost" port=9099
2020-12-17 18:44:37.432 [INFO][43] felix/config_params.go 545: Encap disabled, disabling node poll (if KDD is in use).
2020-12-17 18:44:37.433 [INFO][43] felix/daemon.go 224: Connecting to datastore datastore="kubernetes"
2020-12-17 18:44:37.436 [INFO][43] felix/daemon.go 231: Created datastore client
2020-12-17 18:44:37.446 [INFO][42] monitor-addresses/startup.go 392: Using NODENAME environment for node name
2020-12-17 18:44:37.446 [INFO][42] monitor-addresses/startup.go 404: Determined node name: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t
2020-12-17 18:44:37.457 [INFO][43] felix/daemon.go 887: Loaded ready flag kind="ClusterInformation" name="default" ready=true
2020-12-17 18:44:37.463 [INFO][43] felix/daemon.go 867: No config of this type kind="FelixConfiguration" name="node.boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t"
2020-12-17 18:44:37.470 [INFO][43] felix/felixnodeprocessor.go 208: Using pod cidr
2020-12-17 18:44:37.470 [INFO][43] felix/felixnodeprocessor.go 214: Current CIDRS: [192.168.1.0/24]
2020-12-17 18:44:37.470 [INFO][43] felix/felixnodeprocessor.go 215: Old CIDRS: []
2020-12-17 18:44:37.470 [INFO][43] felix/config_params.go 335: Merging in config from datastore (global): map[CalicoVersion:v3.16.5 ClusterGUID:962b79cda07b4b00aca27c3644424782 ClusterType:k8s,bgp,kubeadm,kdd LogSeverityScreen:Info ReportingIntervalSecs:0 VXLANEnabled:true]
2020-12-17 18:44:37.470 [INFO][43] felix/config_params.go 424: Parsing value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.470 [INFO][43] felix/config_params.go 460: Parsed value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.470 [INFO][43] felix/config_params.go 424: Parsing value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 460: Parsed value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 424: Parsing value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 460: Parsed value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 424: Parsing value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 460: Parsed value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: info (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 424: Parsing value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 460: Parsed value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityFile: None (from config file)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityFile:  (from config file)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 424: Parsing value for LogSeveritySys: None (from config file)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 460: Parsed value for LogSeveritySys:  (from config file)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 424: Parsing value for MetadataAddr: None (from config file)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 460: Parsed value for MetadataAddr:  (from config file)
2020-12-17 18:44:37.471 [INFO][43] felix/config_params.go 424: Parsing value for LogFilePath: None (from config file)
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 460: Parsed value for LogFilePath:  (from config file)
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 424: Parsing value for CalicoVersion: v3.16.5 (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 460: Parsed value for CalicoVersion: v3.16.5 (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: Info (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 463: Skipping config value for LogSeverityScreen from datastore (global); already have a value from environment variable
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 424: Parsing value for VXLANEnabled: true (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 460: Parsed value for VXLANEnabled: true (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 424: Parsing value for ReportingIntervalSecs: 0 (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 460: Parsed value for ReportingIntervalSecs: 0s (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 424: Parsing value for ClusterGUID: 962b79cda07b4b00aca27c3644424782 (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 460: Parsed value for ClusterGUID: 962b79cda07b4b00aca27c3644424782 (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 424: Parsing value for ClusterType: k8s,bgp,kubeadm,kdd (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 460: Parsed value for ClusterType: k8s,bgp,kubeadm,kdd (from datastore (global))
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 335: Merging in config from datastore (per-host): map[IpInIpTunnelAddr:192.168.1.1]
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 424: Parsing value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 460: Parsed value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.472 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: info (from environment variable)
2020-12-17 18:44:37.473 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from environment variable)
2020-12-17 18:44:37.473 [INFO][43] felix/config_params.go 424: Parsing value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.473 [INFO][43] felix/config_params.go 460: Parsed value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.473 [INFO][43] felix/config_params.go 424: Parsing value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.473 [INFO][43] felix/config_params.go 460: Parsed value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.474 [INFO][43] felix/config_params.go 424: Parsing value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.474 [INFO][43] felix/config_params.go 460: Parsed value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.474 [INFO][43] felix/config_params.go 424: Parsing value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.474 [INFO][43] felix/config_params.go 460: Parsed value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.474 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityFile: None (from config file)
2020-12-17 18:44:37.474 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.474 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityFile:  (from config file)
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 424: Parsing value for LogSeveritySys: None (from config file)
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 460: Parsed value for LogSeveritySys:  (from config file)
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 424: Parsing value for MetadataAddr: None (from config file)
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 460: Parsed value for MetadataAddr:  (from config file)
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 424: Parsing value for LogFilePath: None (from config file)
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 460: Parsed value for LogFilePath:  (from config file)
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 424: Parsing value for IpInIpTunnelAddr: 192.168.1.1 (from datastore (per-host))
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 460: Parsed value for IpInIpTunnelAddr: 192.168.1.1 (from datastore (per-host))
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 424: Parsing value for ClusterType: k8s,bgp,kubeadm,kdd (from datastore (global))
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 460: Parsed value for ClusterType: k8s,bgp,kubeadm,kdd (from datastore (global))
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 424: Parsing value for CalicoVersion: v3.16.5 (from datastore (global))
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 460: Parsed value for CalicoVersion: v3.16.5 (from datastore (global))
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: Info (from datastore (global))
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from datastore (global))
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 463: Skipping config value for LogSeverityScreen from datastore (global); already have a value from environment variable
2020-12-17 18:44:37.475 [INFO][43] felix/config_params.go 424: Parsing value for VXLANEnabled: true (from datastore (global))
2020-12-17 18:44:37.476 [INFO][43] felix/config_params.go 460: Parsed value for VXLANEnabled: true (from datastore (global))
2020-12-17 18:44:37.476 [INFO][43] felix/config_params.go 424: Parsing value for ReportingIntervalSecs: 0 (from datastore (global))
2020-12-17 18:44:37.476 [INFO][43] felix/config_params.go 460: Parsed value for ReportingIntervalSecs: 0s (from datastore (global))
2020-12-17 18:44:37.476 [INFO][43] felix/config_params.go 424: Parsing value for ClusterGUID: 962b79cda07b4b00aca27c3644424782 (from datastore (global))
2020-12-17 18:44:37.476 [INFO][43] felix/config_params.go 460: Parsed value for ClusterGUID: 962b79cda07b4b00aca27c3644424782 (from datastore (global))
2020-12-17 18:44:37.478 [INFO][43] felix/daemon.go 286: Using Kubernetes datastore driver, sharing Kubernetes client with datastore driver.
2020-12-17 18:44:37.484 [INFO][43] felix/daemon.go 311: Server Version: version.Info{Major:"1", Minor:"16", GitVersion:"v1.16.15", GitCommit:"2adc8d7091e89b6e3ca8d048140618ec89b39369", GitTreeState:"clean", BuildDate:"2020-09-02T11:31:21Z", GoVersion:"go1.13.15", Compiler:"gc", Platform:"linux/amd64"}

2020-12-17 18:44:37.484 [INFO][43] felix/health.go 133: Health of component changed lastReport=health.HealthReport{Live:true, Ready:false} name="felix-startup" newReport=&health.HealthReport{Live:true, Ready:true}
2020-12-17 18:44:37.484 [INFO][43] felix/health.go 230: Health enabled.  Server is already running. host="localhost" port=9099
2020-12-17 18:44:37.484 [INFO][43] felix/daemon.go 356: Successfully loaded configuration. GOMAXPROCS=2 builddate="4e54da10cf3e292e7aac66650a37bf8bd12ce26d" config=&config.Config{UseInternalDataplaneDriver:true, DataplaneDriver:"calico-iptables-plugin", WireguardEnabled:false, WireguardListeningPort:51820, WireguardRoutingRulePriority:99, WireguardInterfaceName:"wireguard.cali", WireguardMTU:1420, BPFEnabled:false, BPFDisableUnprivileged:true, BPFLogLevel:"off", BPFDataIfacePattern:(*regexp.Regexp)(0xc000195360), BPFConnectTimeLoadBalancingEnabled:true, BPFExternalServiceMode:"tunnel", BPFKubeProxyIptablesCleanupEnabled:true, BPFKubeProxyMinSyncPeriod:1000000000, BPFKubeProxyEndpointSlicesEnabled:false, DebugBPFCgroupV2:"", DebugBPFMapRepinEnabled:true, DatastoreType:"kubernetes", FelixHostname:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t", EtcdAddr:"127.0.0.1:2379", EtcdScheme:"http", EtcdKeyFile:"", EtcdCertFile:"", EtcdCaFile:"", EtcdEndpoints:[]string(nil), TyphaAddr:"", TyphaK8sServiceName:"", TyphaK8sNamespace:"kube-system", TyphaReadTimeout:30000000000, TyphaWriteTimeout:10000000000, TyphaKeyFile:"", TyphaCertFile:"", TyphaCAFile:"", TyphaCN:"", TyphaURISAN:"", Ipv6Support:false, IptablesBackend:"legacy", RouteRefreshInterval:90000000000, InterfaceRefreshInterval:90000000000, DeviceRouteSourceAddress:net.IP(nil), DeviceRouteProtocol:3, RemoveExternalRoutes:true, IptablesRefreshInterval:90000000000, IptablesPostWriteCheckIntervalSecs:1000000000, IptablesLockFilePath:"/run/xtables.lock", IptablesLockTimeoutSecs:0, IptablesLockProbeIntervalMillis:50000000, FeatureDetectOverride:map[string]string(nil), IpsetsRefreshInterval:10000000000, MaxIpsetSize:1048576, XDPRefreshInterval:90000000000, PolicySyncPathPrefix:"", NetlinkTimeoutSecs:10000000000, MetadataAddr:"", MetadataPort:8775, OpenstackRegion:"", InterfacePrefix:"cali", InterfaceExclude:[]*regexp.Regexp{(*regexp.Regexp)(0xc0001955e0)}, ChainInsertMode:"insert", DefaultEndpointToHostAction:"ACCEPT", IptablesFilterAllowAction:"ACCEPT", IptablesMangleAllowAction:"ACCEPT", LogPrefix:"calico-packet", LogFilePath:"", LogSeverityFile:"", LogSeverityScreen:"INFO", LogSeveritySys:"", VXLANEnabled:true, VXLANPort:4789, VXLANVNI:4096, VXLANMTU:1410, IPv4VXLANTunnelAddr:net.IP(nil), VXLANTunnelMACAddr:"", IpInIpEnabled:false, IpInIpMtu:1440, IpInIpTunnelAddr:net.IP{0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xff, 0xff, 0xc0, 0xa8, 0x1, 0x1}, AllowVXLANPacketsFromWorkloads:false, AllowIPIPPacketsFromWorkloads:false, AWSSrcDstCheck:"DoNothing", ReportingIntervalSecs:0, ReportingTTLSecs:90000000000, EndpointReportingEnabled:false, EndpointReportingDelaySecs:1000000000, IptablesMarkMask:0xffff0000, DisableConntrackInvalidCheck:false, HealthEnabled:true, HealthPort:9099, HealthHost:"localhost", PrometheusMetricsEnabled:false, PrometheusMetricsHost:"", PrometheusMetricsPort:9091, PrometheusGoMetricsEnabled:true, PrometheusProcessMetricsEnabled:true, FailsafeInboundHostPorts:[]config.ProtoPort{config.ProtoPort{Protocol:"tcp", Port:0x16}, config.ProtoPort{Protocol:"udp", Port:0x44}, config.ProtoPort{Protocol:"tcp", Port:0xb3}, config.ProtoPort{Protocol:"tcp", Port:0x94b}, config.ProtoPort{Protocol:"tcp", Port:0x94c}, config.ProtoPort{Protocol:"tcp", Port:0x1561}, config.ProtoPort{Protocol:"tcp", Port:0x192b}, config.ProtoPort{Protocol:"tcp", Port:0x1a0a}, config.ProtoPort{Protocol:"tcp", Port:0x1a0b}}, FailsafeOutboundHostPorts:[]config.ProtoPort{config.ProtoPort{Protocol:"udp", Port:0x35}, config.ProtoPort{Protocol:"udp", Port:0x43}, config.ProtoPort{Protocol:"tcp", Port:0xb3}, config.ProtoPort{Protocol:"tcp", Port:0x94b}, config.ProtoPort{Protocol:"tcp", Port:0x94c}, config.ProtoPort{Protocol:"tcp", Port:0x1561}, config.ProtoPort{Protocol:"tcp", Port:0x192b}, config.ProtoPort{Protocol:"tcp", Port:0x1a0a}, config.ProtoPort{Protocol:"tcp", Port:0x1a0b}}, KubeNodePortRanges:[]numorstring.Port{numorstring.Port{MinPort:0x7530, MaxPort:0x7fff, PortName:""}}, NATPortRange:numorstring.Port{MinPort:0x0, MaxPort:0x0, PortName:""}, NATOutgoingAddress:net.IP(nil), UsageReportingEnabled:true, UsageReportingInitialDelaySecs:300000000000, UsageReportingIntervalSecs:86400000000000, ClusterGUID:"962b79cda07b4b00aca27c3644424782", ClusterType:"k8s,bgp,kubeadm,kdd", CalicoVersion:"v3.16.5", ExternalNodesCIDRList:[]string(nil), DebugMemoryProfilePath:"", DebugCPUProfilePath:"/tmp/felix-cpu-<timestamp>.pprof", DebugDisableLogDropping:false, DebugSimulateCalcGraphHangAfter:0, DebugSimulateDataplaneHangAfter:0, DebugPanicAfter:0, DebugSimulateDataRace:false, RouteSource:"CalicoIPAM", RouteTableRange:idalloc.IndexRange{Min:1, Max:250}, IptablesNATOutgoingInterfaceFilter:"", SidecarAccelerationEnabled:false, XDPEnabled:true, GenericXDPEnabled:false, Variant:"Calico", internalOverrides:map[string]string{}, sourceToRawConfig:map[config.Source]map[string]string{0x1:map[string]string{"CalicoVersion":"v3.16.5", "ClusterGUID":"962b79cda07b4b00aca27c3644424782", "ClusterType":"k8s,bgp,kubeadm,kdd", "LogSeverityScreen":"Info", "ReportingIntervalSecs":"0", "VXLANEnabled":"true"}, 0x2:map[string]string{"IpInIpTunnelAddr":"192.168.1.1"}, 0x3:map[string]string{"LogFilePath":"None", "LogSeverityFile":"None", "LogSeveritySys":"None", "MetadataAddr":"None"}, 0x4:map[string]string{"datastoretype":"kubernetes", "defaultendpointtohostaction":"ACCEPT", "felixhostname":"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t", "healthenabled":"true", "ipv6support":"false", "logseverityscreen":"info"}}, rawValues:map[string]string{"CalicoVersion":"v3.16.5", "ClusterGUID":"962b79cda07b4b00aca27c3644424782", "ClusterType":"k8s,bgp,kubeadm,kdd", "DatastoreType":"kubernetes", "DefaultEndpointToHostAction":"ACCEPT", "FelixHostname":"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t", "HealthEnabled":"true", "IpInIpTunnelAddr":"192.168.1.1", "Ipv6Support":"false", "LogFilePath":"None", "LogSeverityFile":"None", "LogSeverityScreen":"info", "LogSeveritySys":"None", "MetadataAddr":"None", "ReportingIntervalSecs":"0", "VXLANEnabled":"true"}, Err:error(nil), loadClientConfigFromEnvironment:(func() (*apiconfig.CalicoAPIConfig, error))(0x11fae90), useNodeResourceUpdates:false} gitcommit="2020-11-06T19:03:29+0000" version="v3.16.5"
2020-12-17 18:44:37.485 [INFO][43] felix/driver.go 63: Using internal (linux) dataplane driver.
2020-12-17 18:44:37.485 [INFO][43] felix/driver.go 118: Calculated iptables mark bits acceptMark=0x10000 endpointMark=0xfff00000 endpointMarkNonCali=0x100000 passMark=0x20000 scratch0Mark=0x40000 scratch1Mark=0x80000
2020-12-17 18:44:37.485 [INFO][43] felix/int_dataplane.go 273: Creating internal dataplane driver. config=intdataplane.Config{Hostname:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t", IPv6Enabled:false, RuleRendererOverride:rules.RuleRenderer(nil), IPIPMTU:1440, VXLANMTU:1410, MaxIPSetSize:1048576, IptablesBackend:"legacy", IPSetsRefreshInterval:10000000000, RouteRefreshInterval:90000000000, DeviceRouteSourceAddress:net.IP(nil), DeviceRouteProtocol:3, RemoveExternalRoutes:true, IptablesRefreshInterval:90000000000, IptablesPostWriteCheckInterval:1000000000, IptablesInsertMode:"insert", IptablesLockFilePath:"/run/xtables.lock", IptablesLockTimeout:0, IptablesLockProbeInterval:50000000, XDPRefreshInterval:90000000000, Wireguard:wireguard.Config{Enabled:false, ListeningPort:51820, FirewallMark:0, RoutingRulePriority:99, RoutingTableIndex:1, InterfaceName:"wireguard.cali", MTU:1420}, NetlinkTimeout:10000000000, RulesConfig:rules.Config{IPSetConfigV4:(*ipsets.IPVersionConfig)(0xc00028e5a0), IPSetConfigV6:(*ipsets.IPVersionConfig)(0xc00028e690), WorkloadIfacePrefixes:[]string{"cali"}, IptablesMarkAccept:0x10000, IptablesMarkPass:0x20000, IptablesMarkScratch0:0x40000, IptablesMarkScratch1:0x80000, IptablesMarkEndpoint:0xfff00000, IptablesMarkNonCaliEndpoint:0x100000, KubeNodePortRanges:[]numorstring.Port{numorstring.Port{MinPort:0x7530, MaxPort:0x7fff, PortName:""}}, KubeIPVSSupportEnabled:false, OpenStackMetadataIP:net.IP(nil), OpenStackMetadataPort:0x2247, OpenStackSpecialCasesEnabled:false, VXLANEnabled:true, VXLANPort:4789, VXLANVNI:4096, IPIPEnabled:false, IPIPTunnelAddress:net.IP{0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xff, 0xff, 0xc0, 0xa8, 0x1, 0x1}, VXLANTunnelAddress:net.IP(nil), AllowVXLANPacketsFromWorkloads:false, AllowIPIPPacketsFromWorkloads:false, WireguardEnabled:false, WireguardInterfaceName:"wireguard.cali", IptablesLogPrefix:"calico-packet", EndpointToHostAction:"ACCEPT", IptablesFilterAllowAction:"ACCEPT", IptablesMangleAllowAction:"ACCEPT", FailsafeInboundHostPorts:[]config.ProtoPort{config.ProtoPort{Protocol:"tcp", Port:0x16}, config.ProtoPort{Protocol:"udp", Port:0x44}, config.ProtoPort{Protocol:"tcp", Port:0xb3}, config.ProtoPort{Protocol:"tcp", Port:0x94b}, config.ProtoPort{Protocol:"tcp", Port:0x94c}, config.ProtoPort{Protocol:"tcp", Port:0x1561}, config.ProtoPort{Protocol:"tcp", Port:0x192b}, config.ProtoPort{Protocol:"tcp", Port:0x1a0a}, config.ProtoPort{Protocol:"tcp", Port:0x1a0b}}, FailsafeOutboundHostPorts:[]config.ProtoPort{config.ProtoPort{Protocol:"udp", Port:0x35}, config.ProtoPort{Protocol:"udp", Port:0x43}, config.ProtoPort{Protocol:"tcp", Port:0xb3}, config.ProtoPort{Protocol:"tcp", Port:0x94b}, config.ProtoPort{Protocol:"tcp", Port:0x94c}, config.ProtoPort{Protocol:"tcp", Port:0x1561}, config.ProtoPort{Protocol:"tcp", Port:0x192b}, config.ProtoPort{Protocol:"tcp", Port:0x1a0a}, config.ProtoPort{Protocol:"tcp", Port:0x1a0b}}, DisableConntrackInvalid:false, NATPortRange:numorstring.Port{MinPort:0x0, MaxPort:0x0, PortName:""}, IptablesNATOutgoingInterfaceFilter:"", NATOutgoingAddress:net.IP(nil), BPFEnabled:false}, IfaceMonitorConfig:ifacemonitor.Config{InterfaceExcludes:[]*regexp.Regexp{(*regexp.Regexp)(0xc0001955e0)}, ResyncInterval:90000000000}, StatusReportingInterval:0, ConfigChangedRestartCallback:(func())(0x1c9d5f0), PostInSyncCallback:(func())(0x1c80890), HealthAggregator:(*health.HealthAggregator)(0xc0000c0090), RouteTableManager:(*idalloc.IndexAllocator)(0xc00012a070), DebugSimulateDataplaneHangAfter:0, ExternalNodesCidrs:[]string(nil), BPFEnabled:false, BPFDisableUnprivileged:true, BPFKubeProxyIptablesCleanupEnabled:true, BPFLogLevel:"off", BPFDataIfacePattern:(*regexp.Regexp)(0xc000195360), XDPEnabled:true, XDPAllowGeneric:false, BPFConntrackTimeouts:conntrack.Timeouts{CreationGracePeriod:10000000000, TCPPreEstablished:20000000000, TCPEstablished:3600000000000, TCPFinsSeen:30000000000, TCPResetSeen:40000000000, UDPLastSeen:60000000000, ICMPLastSeen:5000000000}, BPFCgroupV2:"", BPFConnTimeLBEnabled:true, BPFMapRepin:true, BPFNodePortDSREnabled:false, KubeProxyMinSyncPeriod:1000000000, KubeProxyEndpointSlicesEnabled:false, SidecarAccelerationEnabled:false, LookPathOverride:(func(string) (string, error))(nil), KubeClientSet:(*kubernetes.Clientset)(0xc000250840), FeatureDetectOverrides:map[string]string(nil)}
2020-12-17 18:44:37.485 [INFO][43] felix/rule_defs.go 321: Creating rule renderer. config=rules.Config{IPSetConfigV4:(*ipsets.IPVersionConfig)(0xc00028e5a0), IPSetConfigV6:(*ipsets.IPVersionConfig)(0xc00028e690), WorkloadIfacePrefixes:[]string{"cali"}, IptablesMarkAccept:0x10000, IptablesMarkPass:0x20000, IptablesMarkScratch0:0x40000, IptablesMarkScratch1:0x80000, IptablesMarkEndpoint:0xfff00000, IptablesMarkNonCaliEndpoint:0x100000, KubeNodePortRanges:[]numorstring.Port{numorstring.Port{MinPort:0x7530, MaxPort:0x7fff, PortName:""}}, KubeIPVSSupportEnabled:false, OpenStackMetadataIP:net.IP(nil), OpenStackMetadataPort:0x2247, OpenStackSpecialCasesEnabled:false, VXLANEnabled:true, VXLANPort:4789, VXLANVNI:4096, IPIPEnabled:false, IPIPTunnelAddress:net.IP{0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xff, 0xff, 0xc0, 0xa8, 0x1, 0x1}, VXLANTunnelAddress:net.IP(nil), AllowVXLANPacketsFromWorkloads:false, AllowIPIPPacketsFromWorkloads:false, WireguardEnabled:false, WireguardInterfaceName:"wireguard.cali", IptablesLogPrefix:"calico-packet", EndpointToHostAction:"ACCEPT", IptablesFilterAllowAction:"ACCEPT", IptablesMangleAllowAction:"ACCEPT", FailsafeInboundHostPorts:[]config.ProtoPort{config.ProtoPort{Protocol:"tcp", Port:0x16}, config.ProtoPort{Protocol:"udp", Port:0x44}, config.ProtoPort{Protocol:"tcp", Port:0xb3}, config.ProtoPort{Protocol:"tcp", Port:0x94b}, config.ProtoPort{Protocol:"tcp", Port:0x94c}, config.ProtoPort{Protocol:"tcp", Port:0x1561}, config.ProtoPort{Protocol:"tcp", Port:0x192b}, config.ProtoPort{Protocol:"tcp", Port:0x1a0a}, config.ProtoPort{Protocol:"tcp", Port:0x1a0b}}, FailsafeOutboundHostPorts:[]config.ProtoPort{config.ProtoPort{Protocol:"udp", Port:0x35}, config.ProtoPort{Protocol:"udp", Port:0x43}, config.ProtoPort{Protocol:"tcp", Port:0xb3}, config.ProtoPort{Protocol:"tcp", Port:0x94b}, config.ProtoPort{Protocol:"tcp", Port:0x94c}, config.ProtoPort{Protocol:"tcp", Port:0x1561}, config.ProtoPort{Protocol:"tcp", Port:0x192b}, config.ProtoPort{Protocol:"tcp", Port:0x1a0a}, config.ProtoPort{Protocol:"tcp", Port:0x1a0b}}, DisableConntrackInvalid:false, NATPortRange:numorstring.Port{MinPort:0x0, MaxPort:0x0, PortName:""}, IptablesNATOutgoingInterfaceFilter:"", NATOutgoingAddress:net.IP(nil), BPFEnabled:false}
2020-12-17 18:44:37.485 [INFO][43] felix/rule_defs.go 331: Workload to host packets will be accepted.
2020-12-17 18:44:37.485 [INFO][43] felix/rule_defs.go 345: filter table allowed packets will be accepted immediately.
2020-12-17 18:44:37.485 [INFO][43] felix/rule_defs.go 353: mangle table allowed packets will be accepted immediately.
2020-12-17 18:44:37.485 [INFO][43] felix/iface_monitor.go 72: configured to periodically rescan interfaces. interval=1m30s
2020-12-17 18:44:37.485 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"ip6tables-legacy-save", "ip6tables-save"} command="ip6tables-legacy-save" ipVersion=0x6 saveOrRestore="save"
2020-12-17 18:44:37.486 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-save", "iptables-save"} command="iptables-legacy-save" ipVersion=0x4 saveOrRestore="save"
2020-12-17 18:44:37.509 [INFO][43] felix/feature_detect.go 137: Updating detected iptables features features=iptables.Features{SNATFullyRandom:true, MASQFullyRandom:true, RestoreSupportsLock:true} iptablesVersion=1.8.2 kernelVersion=5.4.0-1031
2020-12-17 18:44:37.509 [INFO][43] felix/table.go 325: Calculated old-insert detection regex. pattern="(?:-j|--jump) cali-|(?:-j|--jump) califw-|(?:-j|--jump) calitw-|(?:-j|--jump) califh-|(?:-j|--jump) calith-|(?:-j|--jump) calipi-|(?:-j|--jump) calipo-|(?:-j|--jump) felix-"
2020-12-17 18:44:37.509 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-restore", "iptables-restore"} command="iptables-legacy-restore" ipVersion=0x4 saveOrRestore="restore"
2020-12-17 18:44:37.509 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-save", "iptables-save"} command="iptables-legacy-save" ipVersion=0x4 saveOrRestore="save"
2020-12-17 18:44:37.513 [INFO][43] felix/table.go 325: Calculated old-insert detection regex. pattern="(?:-j|--jump) cali-|(?:-j|--jump) califw-|(?:-j|--jump) calitw-|(?:-j|--jump) califh-|(?:-j|--jump) calith-|(?:-j|--jump) calipi-|(?:-j|--jump) calipo-|(?:-j|--jump) felix-|-A POSTROUTING .* felix-masq-ipam-pools .*|-A POSTROUTING -o tunl0 -m addrtype ! --src-type LOCAL --limit-iface-out -m addrtype --src-type LOCAL -j MASQUERADE"
2020-12-17 18:44:37.513 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-restore", "iptables-restore"} command="iptables-legacy-restore" ipVersion=0x4 saveOrRestore="restore"
2020-12-17 18:44:37.513 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-save", "iptables-save"} command="iptables-legacy-save" ipVersion=0x4 saveOrRestore="save"
2020-12-17 18:44:37.514 [INFO][43] felix/table.go 325: Calculated old-insert detection regex. pattern="(?:-j|--jump) cali-|(?:-j|--jump) califw-|(?:-j|--jump) calitw-|(?:-j|--jump) califh-|(?:-j|--jump) calith-|(?:-j|--jump) calipi-|(?:-j|--jump) calipo-|(?:-j|--jump) felix-"
2020-12-17 18:44:37.514 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-restore", "iptables-restore"} command="iptables-legacy-restore" ipVersion=0x4 saveOrRestore="restore"
2020-12-17 18:44:37.514 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-save", "iptables-save"} command="iptables-legacy-save" ipVersion=0x4 saveOrRestore="save"
2020-12-17 18:44:37.514 [INFO][43] felix/table.go 325: Calculated old-insert detection regex. pattern="(?:-j|--jump) cali-|(?:-j|--jump) califw-|(?:-j|--jump) calitw-|(?:-j|--jump) califh-|(?:-j|--jump) calith-|(?:-j|--jump) calipi-|(?:-j|--jump) calipo-|(?:-j|--jump) felix-"
2020-12-17 18:44:37.514 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-restore", "iptables-restore"} command="iptables-legacy-restore" ipVersion=0x4 saveOrRestore="restore"
2020-12-17 18:44:37.514 [INFO][43] felix/feature_detect.go 259: Looked up iptables command backendMode="legacy" candidates=[]string{"iptables-legacy-save", "iptables-save"} command="iptables-legacy-save" ipVersion=0x4 saveOrRestore="save"
2020-12-17 18:44:37.514 [INFO][43] felix/route_table.go 241: Calculated interface name regexp regex="^vxlan.calico$"
2020-12-17 18:44:37.515 [INFO][43] felix/int_dataplane.go 417: XDP acceleration enabled.
2020-12-17 18:44:37.516 [INFO][43] felix/vxlan_mgr.go 340: VXLAN tunnel device thread started.
2020-12-17 18:44:37.521 [INFO][43] felix/connecttime.go 46: Running bpftool to look up programs attached to cgroup args=[]string{"bpftool", "-j", "-p", "cgroup", "show", "/run/calico/cgroup"}
2020-12-17 18:44:37.530 [INFO][43] felix/route_table.go 241: Calculated interface name regexp regex="^cali.*"
2020-12-17 18:44:37.530 [INFO][43] felix/ipsets.go 119: Queueing IP set for creation family="inet" setID="all-ipam-pools" setType="hash:net"
2020-12-17 18:44:37.530 [INFO][43] felix/ipsets.go 119: Queueing IP set for creation family="inet" setID="masq-ipam-pools" setType="hash:net"
2020-12-17 18:44:37.530 [INFO][43] felix/route_table.go 241: Calculated interface name regexp regex="^wireguard.cali$"
2020-12-17 18:44:37.530 [INFO][43] felix/int_dataplane.go 727: Registering to report health.
2020-12-17 18:44:37.532 [INFO][43] felix/int_dataplane.go 1347: attempted to modprobe nf_conntrack_proto_sctp error=exit status 1 output=""
2020-12-17 18:44:37.532 [INFO][43] felix/int_dataplane.go 1349: Making sure IPv4 forwarding is enabled.
2020-12-17 18:44:37.532 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-failsafe-in" ipVersion=0x4 table="raw"
2020-12-17 18:44:37.532 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-failsafe-out" ipVersion=0x4 table="raw"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-PREROUTING" ipVersion=0x4 table="raw"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-from-host-endpoint"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-OUTPUT" ipVersion=0x4 table="raw"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-to-host-endpoint"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-PREROUTING"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-OUTPUT"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-FORWARD" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-from-hep-forward"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-from-wl-dispatch"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-to-wl-dispatch"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-to-hep-forward"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-INPUT" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-wl-to-host"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-from-host-endpoint"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-wl-to-host" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-failsafe-in" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-OUTPUT" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-to-host-endpoint"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-failsafe-out" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-FORWARD"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-INPUT"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-OUTPUT"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-PREROUTING" ipVersion=0x4 table="nat"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fip-dnat"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-POSTROUTING" ipVersion=0x4 table="nat"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fip-snat"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-nat-outgoing"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-OUTPUT" ipVersion=0x4 table="nat"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-PREROUTING"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-POSTROUTING"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-OUTPUT"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-failsafe-in" ipVersion=0x4 table="mangle"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-PREROUTING" ipVersion=0x4 table="mangle"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-from-host-endpoint"
2020-12-17 18:44:37.533 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-PREROUTING"
2020-12-17 18:44:37.549 [INFO][43] felix/int_dataplane.go 1097: Set XDP failsafe ports: [{Protocol:tcp Port:22} {Protocol:udp Port:68} {Protocol:tcp Port:179} {Protocol:tcp Port:2379} {Protocol:tcp Port:2380} {Protocol:tcp Port:5473} {Protocol:tcp Port:6443} {Protocol:tcp Port:6666} {Protocol:tcp Port:6667}]
2020-12-17 18:44:37.549 [INFO][43] felix/int_dataplane.go 889: IPIP disabled. Not starting tunnel update thread.
2020-12-17 18:44:37.550 [INFO][43] felix/int_dataplane.go 1126: Started internal iptables dataplane driver loop
2020-12-17 18:44:37.550 [INFO][43] felix/int_dataplane.go 1136: Will refresh IP sets on timer interval=1m30s
2020-12-17 18:44:37.550 [INFO][43] felix/int_dataplane.go 1146: Will refresh routes on timer interval=1m30s
2020-12-17 18:44:37.550 [INFO][43] felix/int_dataplane.go 1156: Will refresh XDP on timer interval=1m30s
2020-12-17 18:44:37.551 [INFO][43] felix/int_dataplane.go 1562: Started internal status report thread
2020-12-17 18:44:37.551 [INFO][43] felix/int_dataplane.go 1564: Process status reports disabled
2020-12-17 18:44:37.549 [INFO][43] felix/daemon.go 384: Connect to the dataplane driver.
2020-12-17 18:44:37.551 [INFO][43] felix/daemon.go 462: using resource updates where applicable
2020-12-17 18:44:37.551 [INFO][43] felix/daemon.go 465: Created Syncer syncer=&watchersyncer.watcherSyncer{status:0x0, watcherCaches:[]*watchersyncer.watcherCache{(*watchersyncer.watcherCache)(0xc00063cb80), (*watchersyncer.watcherCache)(0xc00063cc80), (*watchersyncer.watcherCache)(0xc00063cd80), (*watchersyncer.watcherCache)(0xc00063ce80), (*watchersyncer.watcherCache)(0xc00063cf00), (*watchersyncer.watcherCache)(0xc00063cf80), (*watchersyncer.watcherCache)(0xc00063d000), (*watchersyncer.watcherCache)(0xc00063d080), (*watchersyncer.watcherCache)(0xc00063d100), (*watchersyncer.watcherCache)(0xc00063d180), (*watchersyncer.watcherCache)(0xc00063d200)}, results:(chan interface {})(0xc0003576e0), numSynced:0, callbacks:(*calc.SyncerCallbacksDecoupler)(0xc000010478), wgwc:(*sync.WaitGroup)(nil), wgws:(*sync.WaitGroup)(nil), cancel:(context.CancelFunc)(nil)}
2020-12-17 18:44:37.551 [INFO][43] felix/daemon.go 469: Starting the datastore Syncer
2020-12-17 18:44:37.551 [INFO][43] felix/watchersyncer.go 89: Start called
2020-12-17 18:44:37.551 [INFO][43] felix/iface_monitor.go 97: Interface monitoring thread started.
2020-12-17 18:44:37.551 [INFO][43] felix/calc_graph.go 112: Creating calculation graph, filtered to hostname boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t
2020-12-17 18:44:37.551 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.WorkloadEndpointKey: (dispatcher.UpdateHandler)(0x1644460)
2020-12-17 18:44:37.551 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostEndpointKey: (dispatcher.UpdateHandler)(0x1644460)
2020-12-17 18:44:37.551 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.WorkloadEndpointKey: (dispatcher.UpdateHandler)(0x1644540)
2020-12-17 18:44:37.551 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostEndpointKey: (dispatcher.UpdateHandler)(0x1644540)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.WorkloadEndpointKey: (dispatcher.UpdateHandler)(0x1644330)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostEndpointKey: (dispatcher.UpdateHandler)(0x1644330)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.PolicyKey: (dispatcher.UpdateHandler)(0x1644330)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ProfileRulesKey: (dispatcher.UpdateHandler)(0x1644330)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ProfileLabelsKey: (dispatcher.UpdateHandler)(0x1644330)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ProfileTagsKey: (dispatcher.UpdateHandler)(0x1644330)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ProfileTagsKey: (dispatcher.UpdateHandler)(0x1589060)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ProfileLabelsKey: (dispatcher.UpdateHandler)(0x1589060)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.WorkloadEndpointKey: (dispatcher.UpdateHandler)(0x1589060)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostEndpointKey: (dispatcher.UpdateHandler)(0x1589060)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.NetworkSetKey: (dispatcher.UpdateHandler)(0x1589060)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.PolicyKey: (dispatcher.UpdateHandler)(0x1644a60)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.WorkloadEndpointKey: (dispatcher.UpdateHandler)(0x1644a60)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostEndpointKey: (dispatcher.UpdateHandler)(0x1644a60)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostIPKey: (dispatcher.UpdateHandler)(0x16446b0)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.IPPoolKey: (dispatcher.UpdateHandler)(0x16446b0)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.WireguardKey: (dispatcher.UpdateHandler)(0x16446b0)
2020-12-17 18:44:37.552 [INFO][43] felix/l3_route_resolver.go 86: Creating L3 route resolver
2020-12-17 18:44:37.552 [INFO][43] felix/l3_route_resolver.go 105: Registering L3 route resolver (node resources on)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ResourceKey: (dispatcher.UpdateHandler)(0x1644790)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.IPPoolKey: (dispatcher.UpdateHandler)(0x16448b0)
2020-12-17 18:44:37.552 [INFO][43] felix/l3_route_resolver.go 116: Registering for L3 route updates routeSource="CalicoIPAM"
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.BlockKey: (dispatcher.UpdateHandler)(0x16449d0)
2020-12-17 18:44:37.552 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.WorkloadEndpointKey: (dispatcher.UpdateHandler)(0x1644940)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ResourceKey: (dispatcher.UpdateHandler)(0x1644d80)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostConfigKey: (dispatcher.UpdateHandler)(0x1644ea0)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.GlobalConfigKey: (dispatcher.UpdateHandler)(0x16445d0)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostConfigKey: (dispatcher.UpdateHandler)(0x16445d0)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ReadyFlagKey: (dispatcher.UpdateHandler)(0x16445d0)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.ProfileLabelsKey: (dispatcher.UpdateHandler)(0x1644bb0)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostIPKey: (dispatcher.UpdateHandler)(0x1644c40)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.WorkloadEndpointKey: (dispatcher.UpdateHandler)(0x1644c40)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostEndpointKey: (dispatcher.UpdateHandler)(0x1644c40)
2020-12-17 18:44:37.553 [INFO][43] felix/dispatcher.go 68: Registering listener for type model.HostConfigKey: (dispatcher.UpdateHandler)(0x1644c40)
2020-12-17 18:44:37.553 [INFO][43] felix/async_calc_graph.go 255: Starting AsyncCalcGraph
2020-12-17 18:44:37.553 [INFO][43] felix/daemon.go 576: Started the processing graph
2020-12-17 18:44:37.554 [INFO][43] felix/watchersyncer.go 127: Sending status update Status=wait-for-ready
2020-12-17 18:44:37.555 [INFO][43] felix/iface_monitor.go 107: Subscribed to netlink updates.
2020-12-17 18:44:37.555 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=1 ifaceName="lo" state="up"
2020-12-17 18:44:37.556 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"127.0.0.0":set.empty{}, "127.0.0.1":set.empty{}, "::1":set.empty{}} ifaceName="lo"
2020-12-17 18:44:37.556 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=2 ifaceName="eth0" state="up"
2020-12-17 18:44:37.559 [INFO][43] felix/watchersyncer.go 147: Starting main event processing loop
2020-12-17 18:44:37.559 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/hostendpoints"
2020-12-17 18:44:37.560 [INFO][43] felix/async_calc_graph.go 137: AsyncCalcGraph running
2020-12-17 18:44:37.560 [INFO][43] felix/daemon.go 954: Reading from dataplane driver pipe...
2020-12-17 18:44:37.562 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"lo", State:"up", Index:1}
2020-12-17 18:44:37.562 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"eth0", State:"up", Index:2}
2020-12-17 18:44:37.562 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ConfigUpdate update from calculation graph msg=config:<key:"CalicoVersion" value:"v3.16.5" > config:<key:"ClusterGUID" value:"962b79cda07b4b00aca27c3644424782" > config:<key:"ClusterType" value:"k8s,bgp,kubeadm,kdd" > config:<key:"DatastoreType" value:"kubernetes" > config:<key:"DefaultEndpointToHostAction" value:"ACCEPT" > config:<key:"FelixHostname" value:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" > config:<key:"HealthEnabled" value:"true" > config:<key:"IpInIpTunnelAddr" value:"192.168.1.1" > config:<key:"Ipv6Support" value:"false" > config:<key:"LogFilePath" value:"None" > config:<key:"LogSeverityFile" value:"None" > config:<key:"LogSeverityScreen" value:"info" > config:<key:"LogSeveritySys" value:"None" > config:<key:"MetadataAddr" value:"None" > config:<key:"ReportingIntervalSecs" value:"0" > config:<key:"VXLANEnabled" value:"true" > 
2020-12-17 18:44:37.562 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"lo", Addrs:set.mapSet{"127.0.0.0":set.empty{}, "127.0.0.1":set.empty{}, "::1":set.empty{}}}
2020-12-17 18:44:37.562 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"lo", Addrs:set.mapSet{"127.0.0.0":set.empty{}, "127.0.0.1":set.empty{}, "::1":set.empty{}}}
2020-12-17 18:44:37.562 [INFO][43] felix/ipsets.go 119: Queueing IP set for creation family="inet" setID="this-host" setType="hash:ip"
2020-12-17 18:44:37.562 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"10.1.0.4":set.empty{}, "fe80::20d:3aff:fe8c:25a1":set.empty{}} ifaceName="eth0"
2020-12-17 18:44:37.562 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=12 ifaceName="cali8fdabebe17d" state="up"
2020-12-17 18:44:37.562 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}} ifaceName="cali8fdabebe17d"
2020-12-17 18:44:37.562 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=13 ifaceName="cali1af37b3231e" state="up"
2020-12-17 18:44:37.563 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}} ifaceName="cali1af37b3231e"
2020-12-17 18:44:37.564 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=33 ifaceName="calied46e14ce85" state="up"
2020-12-17 18:44:37.565 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}} ifaceName="calied46e14ce85"
2020-12-17 18:44:37.565 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=34 ifaceName="cali4d7bdbb746d" state="up"
2020-12-17 18:44:37.566 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}} ifaceName="cali4d7bdbb746d"
2020-12-17 18:44:37.567 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=35 ifaceName="cali1b695bbe160" state="up"
2020-12-17 18:44:37.568 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/clusterinformations"
2020-12-17 18:44:37.568 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/ippools"
2020-12-17 18:44:37.568 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/nodes"
2020-12-17 18:44:37.568 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"eth0", Addrs:set.mapSet{"10.1.0.4":set.empty{}, "fe80::20d:3aff:fe8c:25a1":set.empty{}}}
2020-12-17 18:44:37.568 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"eth0", Addrs:set.mapSet{"10.1.0.4":set.empty{}, "fe80::20d:3aff:fe8c:25a1":set.empty{}}}
2020-12-17 18:44:37.568 [INFO][43] felix/ipsets.go 119: Queueing IP set for creation family="inet" setID="this-host" setType="hash:ip"
2020-12-17 18:44:37.568 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"cali8fdabebe17d", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.568 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"cali8fdabebe17d", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.569 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"cali1af37b3231e", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.569 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"cali1af37b3231e", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.569 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/profiles"
2020-12-17 18:44:37.569 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"calied46e14ce85", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.569 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"calied46e14ce85", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.569 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"cali4d7bdbb746d", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.569 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"cali4d7bdbb746d", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.569 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"cali8fdabebe17d", State:"up", Index:12}
2020-12-17 18:44:37.569 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"cali1af37b3231e", State:"up", Index:13}
2020-12-17 18:44:37.569 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/workloadendpoints"
2020-12-17 18:44:37.569 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"calied46e14ce85", State:"up", Index:33}
2020-12-17 18:44:37.569 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"cali4d7bdbb746d", State:"up", Index:34}
2020-12-17 18:44:37.569 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"cali1b695bbe160", State:"up", Index:35}
2020-12-17 18:44:37.571 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/networkpolicies"
2020-12-17 18:44:37.571 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/networksets"
2020-12-17 18:44:37.571 [INFO][43] felix/daemon.go 673: No driver process to monitor
2020-12-17 18:44:37.571 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/globalnetworksets"
2020-12-17 18:44:37.571 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}} ifaceName="cali1b695bbe160"
2020-12-17 18:44:37.571 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/hostendpoints"
2020-12-17 18:44:37.571 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=37 ifaceName="calid02fed251a7" state="up"
2020-12-17 18:44:37.571 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.572 [INFO][43] felix/watchersyncer.go 127: Sending status update Status=resync
2020-12-17 18:44:37.574 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"cali1b695bbe160", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.574 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"cali1b695bbe160", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.574 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"calid02fed251a7", State:"up", Index:37}
2020-12-17 18:44:37.574 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/felixconfigurations"
2020-12-17 18:44:37.568 [INFO][43] felix/watchercache.go 174: Full resync is required ListRoot="/calico/resources/v3/projectcalico.org/globalnetworkpolicies"
2020-12-17 18:44:37.574 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}} ifaceName="calid02fed251a7"
2020-12-17 18:44:37.575 [INFO][43] felix/int_dataplane.go 813: Linux interface state changed. ifIndex=38 ifaceName="cali8b4acec57bb" state="up"
2020-12-17 18:44:37.575 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"calid02fed251a7", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.576 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"calid02fed251a7", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.576 [INFO][43] felix/int_dataplane.go 1187: Received interface update msg=&intdataplane.ifaceUpdate{Name:"cali8b4acec57bb", State:"up", Index:38}
2020-12-17 18:44:37.576 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}} ifaceName="cali8b4acec57bb"
2020-12-17 18:44:37.581 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/clusterinformations"
2020-12-17 18:44:37.582 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.582 [INFO][43] felix/config_batcher.go 74: Global config update: {{GlobalFelixConfig(name=ClusterGUID) 962b79cda07b4b00aca27c3644424782 374358 <nil> 0s} 1}
2020-12-17 18:44:37.582 [INFO][43] felix/config_batcher.go 74: Global config update: {{GlobalFelixConfig(name=ClusterType) k8s,bgp,kubeadm,kdd 374358 <nil> 0s} 1}
2020-12-17 18:44:37.582 [INFO][43] felix/config_batcher.go 74: Global config update: {{GlobalFelixConfig(name=CalicoVersion) v3.16.5 374358 <nil> 0s} 1}
2020-12-17 18:44:37.583 [INFO][43] felix/felixnodeprocessor.go 208: Using pod cidr
2020-12-17 18:44:37.583 [INFO][43] felix/felixnodeprocessor.go 214: Current CIDRS: [192.168.0.0/24]
2020-12-17 18:44:37.583 [INFO][43] felix/felixnodeprocessor.go 215: Old CIDRS: []
2020-12-17 18:44:37.583 [INFO][43] felix/felixnodeprocessor.go 208: Using pod cidr
2020-12-17 18:44:37.583 [INFO][43] felix/felixnodeprocessor.go 214: Current CIDRS: [192.168.1.0/24]
2020-12-17 18:44:37.583 [INFO][43] felix/felixnodeprocessor.go 215: Old CIDRS: []
2020-12-17 18:44:37.583 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/nodes"
2020-12-17 18:44:37.583 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/networksets"
2020-12-17 18:44:37.583 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.583 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.583 [INFO][43] felix/vxlan_resolver.go 247: Missing vxlan tunnel address for node, cannot send VTEP yet node="boobalan-dev-cni3160-cp-71352-g46kb"
2020-12-17 18:44:37.583 [INFO][43] felix/config_batcher.go 61: Host config update for this host: {{HostConfig(node=boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t,name=IpInIpTunnelAddr) 192.168.1.1 374418 <nil> 0s} 1}
2020-12-17 18:44:37.583 [INFO][43] felix/vxlan_resolver.go 247: Missing vxlan tunnel address for node, cannot send VTEP yet node="boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t"
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"cali8b4acec57bb", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.584 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"cali8b4acec57bb", Addrs:set.mapSet{"fe80::ecee:eeff:feee:eeee":set.empty{}}}
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:REMOTE_TUNNEL dst:"192.168.0.1/32" dst_node_name:"boobalan-dev-cni3160-cp-71352-g46kb" dst_node_ip:"10.0.0.4" tunnel_type:<ipip:true > 
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:REMOTE_HOST dst:"10.0.0.4/32" dst_node_name:"boobalan-dev-cni3160-cp-71352-g46kb" dst_node_ip:"10.0.0.4" 
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:REMOTE_WORKLOAD dst:"192.168.0.0/24" dst_node_name:"boobalan-dev-cni3160-cp-71352-g46kb" dst_node_ip:"10.0.0.4" 
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_TUNNEL dst:"192.168.1.1/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" tunnel_type:<ipip:true > 
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_HOST dst:"10.1.0.4/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" 
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD dst:"192.168.1.0/24" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" 
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1172: Received *proto.HostMetadataUpdate update from calculation graph msg=hostname:"boobalan-dev-cni3160-cp-71352-g46kb" ipv4_addr:"10.0.0.4" 
2020-12-17 18:44:37.584 [INFO][43] felix/int_dataplane.go 1172: Received *proto.HostMetadataUpdate update from calculation graph msg=hostname:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" ipv4_addr:"10.1.0.4" 
2020-12-17 18:44:37.586 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/globalnetworksets"
2020-12-17 18:44:37.587 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/ippools"
2020-12-17 18:44:37.588 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/networkpolicies"
2020-12-17 18:44:37.589 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.589 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.589 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.589 [INFO][43] felix/l3_route_resolver.go 463: Pool is active newType=VXLAN oldType=NONE
2020-12-17 18:44:37.589 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/globalnetworkpolicies"
2020-12-17 18:44:37.593 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.597 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD ip_pool_type:VXLAN dst:"192.168.1.0/24" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true 
2020-12-17 18:44:37.597 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_TUNNEL ip_pool_type:VXLAN dst:"192.168.1.1/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true tunnel_type:<ipip:true > 
2020-12-17 18:44:37.597 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=ip_pool_type:VXLAN dst:"192.168.0.0/16" nat_outgoing:true 
2020-12-17 18:44:37.597 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:REMOTE_WORKLOAD ip_pool_type:VXLAN dst:"192.168.0.0/24" dst_node_name:"boobalan-dev-cni3160-cp-71352-g46kb" dst_node_ip:"10.0.0.4" nat_outgoing:true 
2020-12-17 18:44:37.598 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:REMOTE_TUNNEL ip_pool_type:VXLAN dst:"192.168.0.1/32" dst_node_name:"boobalan-dev-cni3160-cp-71352-g46kb" dst_node_ip:"10.0.0.4" nat_outgoing:true tunnel_type:<ipip:true > 
2020-12-17 18:44:37.598 [INFO][43] felix/int_dataplane.go 1172: Received *proto.IPAMPoolUpdate update from calculation graph msg=id:"192.168.0.0-16" pool:<cidr:"192.168.0.0/16" masquerade:true > 
2020-12-17 18:44:37.599 [INFO][43] felix/felixnodeprocessor.go 208: Using pod cidr
2020-12-17 18:44:37.599 [INFO][43] felix/felixnodeprocessor.go 214: Current CIDRS: [192.168.0.0/24]
2020-12-17 18:44:37.599 [INFO][43] felix/felixnodeprocessor.go 215: Old CIDRS: []
2020-12-17 18:44:37.599 [INFO][43] felix/felixnodeprocessor.go 208: Using pod cidr
2020-12-17 18:44:37.599 [INFO][43] felix/felixnodeprocessor.go 214: Current CIDRS: [192.168.1.0/24]
2020-12-17 18:44:37.600 [INFO][43] felix/felixnodeprocessor.go 215: Old CIDRS: []
2020-12-17 18:44:37.600 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/profiles"
2020-12-17 18:44:37.606 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.606 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/felixconfigurations"
2020-12-17 18:44:37.606 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.613 [INFO][43] felix/config_batcher.go 74: Global config update: {{GlobalFelixConfig(name=LogSeverityScreen) Info 753 <nil> 0s} 1}
2020-12-17 18:44:37.613 [INFO][43] felix/config_batcher.go 74: Global config update: {{GlobalFelixConfig(name=VXLANEnabled) true 753 <nil> 0s} 1}
2020-12-17 18:44:37.613 [INFO][43] felix/config_batcher.go 74: Global config update: {{GlobalFelixConfig(name=ReportingIntervalSecs) 0 753 <nil> 0s} 1}
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"ttl-controller" > labels:<key:"projectcalico.org/name" value:"ttl-controller" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"capi-kubeadm-bootstrap-system" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"calico-kube-controllers" > labels:<key:"projectcalico.org/name" value:"calico-kube-controllers" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"job-controller" > labels:<key:"projectcalico.org/name" value:"job-controller" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"monitoring" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"monitoring" name:"prometheus-node-exporter" > labels:<key:"app" value:"prometheus-node-exporter" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"chart" value:"prometheus-node-exporter-1.8.1" > labels:<key:"heritage" value:"Helm" > labels:<key:"projectcalico.org/name" value:"prometheus-node-exporter" > labels:<key:"release" value:"prometheus-operator-prometheus-operator" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"clusterrole-aggregation-controller" > labels:<key:"projectcalico.org/name" value:"clusterrole-aggregation-controller" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"coredns" > labels:<key:"projectcalico.org/name" value:"coredns" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"generic-garbage-collector" > labels:<key:"projectcalico.org/name" value:"generic-garbage-collector" > 
2020-12-17 18:44:37.613 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"cert-manager" name:"cert-manager-cainjector" > labels:<key:"app" value:"cainjector" > labels:<key:"app.kubernetes.io/component" value:"cainjector" > labels:<key:"app.kubernetes.io/instance" value:"cert-manager" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"app.kubernetes.io/name" value:"cainjector" > labels:<key:"helm.sh/chart" value:"cert-manager-v0.14.0" > labels:<key:"projectcalico.org/name" value:"cert-manager-cainjector" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"default" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"certificate-controller" > labels:<key:"projectcalico.org/name" value:"certificate-controller" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"persistent-volume-binder" > labels:<key:"projectcalico.org/name" value:"persistent-volume-binder" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"pod-garbage-collector" > labels:<key:"projectcalico.org/name" value:"pod-garbage-collector" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"route-controller" > labels:<key:"projectcalico.org/name" value:"route-controller" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"attachdetach-controller" > labels:<key:"projectcalico.org/name" value:"attachdetach-controller" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"pvc-protection-controller" > labels:<key:"projectcalico.org/name" value:"pvc-protection-controller" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kubernetes-dashboard" name:"kubernetes-dashboard" > labels:<key:"k8s-app" value:"kubernetes-dashboard" > labels:<key:"projectcalico.org/name" value:"kubernetes-dashboard" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"monitoring" name:"prometheus-operator-prometheus" > labels:<key:"app" value:"prometheus-operator-prometheus" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"chart" value:"prometheus-operator-8.5.3" > labels:<key:"heritage" value:"Helm" > labels:<key:"projectcalico.org/name" value:"prometheus-operator-prometheus" > labels:<key:"release" value:"prometheus-operator-prometheus-operator" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"token-cleaner" > labels:<key:"projectcalico.org/name" value:"token-cleaner" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kubernetes-dashboard" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"cluster-5fda967f2b5ce46b483a5521" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"expand-controller" > labels:<key:"projectcalico.org/name" value:"expand-controller" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"cluster-5fda967f2b5ce46b483a5521" name:"metrics-server" > labels:<key:"app" value:"metrics-server" > labels:<key:"chart" value:"metrics-server-2.10.0" > labels:<key:"heritage" value:"Helm" > labels:<key:"projectcalico.org/name" value:"metrics-server" > labels:<key:"release" value:"metrics-server" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"bootstrap-signer" > labels:<key:"projectcalico.org/name" value:"bootstrap-signer" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"monitoring" name:"prometheus-operator-alertmanager" > labels:<key:"app" value:"prometheus-operator-alertmanager" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"chart" value:"prometheus-operator-8.5.3" > labels:<key:"heritage" value:"Helm" > labels:<key:"projectcalico.org/name" value:"prometheus-operator-alertmanager" > labels:<key:"release" value:"prometheus-operator-prometheus-operator" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"monitoring" name:"kube-state-metrics" > labels:<key:"app.kubernetes.io/instance" value:"prometheus-operator-prometheus-operator" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"app.kubernetes.io/name" value:"kube-state-metrics" > labels:<key:"helm.sh/chart" value:"kube-state-metrics-2.4.1" > labels:<key:"projectcalico.org/name" value:"kube-state-metrics" > 
2020-12-17 18:44:37.614 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"replicaset-controller" > labels:<key:"projectcalico.org/name" value:"replicaset-controller" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"azure-cloud-provider" > labels:<key:"projectcalico.org/name" value:"azure-cloud-provider" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"disruption-controller" > labels:<key:"projectcalico.org/name" value:"disruption-controller" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"daemon-set-controller" > labels:<key:"projectcalico.org/name" value:"daemon-set-controller" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"horizontal-pod-autoscaler" > labels:<key:"projectcalico.org/name" value:"horizontal-pod-autoscaler" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"capi-kubeadm-control-plane-system" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"capi-webhook-system" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"cert-manager" name:"cert-manager" > labels:<key:"app" value:"cert-manager" > labels:<key:"app.kubernetes.io/component" value:"controller" > labels:<key:"app.kubernetes.io/instance" value:"cert-manager" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"app.kubernetes.io/name" value:"cert-manager" > labels:<key:"helm.sh/chart" value:"cert-manager-v0.14.0" > labels:<key:"projectcalico.org/name" value:"cert-manager" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"endpoint-controller" > labels:<key:"projectcalico.org/name" value:"endpoint-controller" > 
2020-12-17 18:44:37.615 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"service-controller" > labels:<key:"projectcalico.org/name" value:"service-controller" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-public" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"monitoring" name:"grafana" > labels:<key:"app" value:"grafana" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"chart" value:"grafana-4.2.2" > labels:<key:"heritage" value:"Helm" > labels:<key:"projectcalico.org/name" value:"grafana" > labels:<key:"release" value:"prometheus-operator-prometheus-operator" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"cert-manager" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-node-lease" name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"monitoring" name:"prometheus-operator-operator" > labels:<key:"app" value:"prometheus-operator-operator" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"chart" value:"prometheus-operator-8.5.3" > labels:<key:"heritage" value:"Helm" > labels:<key:"projectcalico.org/name" value:"prometheus-operator-operator" > labels:<key:"release" value:"prometheus-operator-prometheus-operator" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"cronjob-controller" > labels:<key:"projectcalico.org/name" value:"cronjob-controller" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"node-controller" > labels:<key:"projectcalico.org/name" value:"node-controller" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"service-account-controller" > labels:<key:"projectcalico.org/name" value:"service-account-controller" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"namespace-controller" > labels:<key:"projectcalico.org/name" value:"namespace-controller" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"pv-protection-controller" > labels:<key:"projectcalico.org/name" value:"pv-protection-controller" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"replication-controller" > labels:<key:"projectcalico.org/name" value:"replication-controller" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"resourcequota-controller" > labels:<key:"projectcalico.org/name" value:"resourcequota-controller" > 
2020-12-17 18:44:37.619 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"cert-manager" name:"cert-manager-webhook" > labels:<key:"app" value:"webhook" > labels:<key:"app.kubernetes.io/component" value:"webhook" > labels:<key:"app.kubernetes.io/instance" value:"cert-manager" > labels:<key:"app.kubernetes.io/managed-by" value:"Helm" > labels:<key:"app.kubernetes.io/name" value:"webhook" > labels:<key:"helm.sh/chart" value:"cert-manager-v0.14.0" > labels:<key:"projectcalico.org/name" value:"cert-manager-webhook" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"calico-node" > labels:<key:"projectcalico.org/name" value:"calico-node" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"deployment-controller" > labels:<key:"projectcalico.org/name" value:"deployment-controller" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"kube-proxy" > labels:<key:"projectcalico.org/name" value:"kube-proxy" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ServiceAccountUpdate update from calculation graph msg=id:<namespace:"kube-system" name:"statefulset-controller" > labels:<key:"projectcalico.org/name" value:"statefulset-controller" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"capi-kubeadm-control-plane-system" > labels:<key:"cluster.x-k8s.io/provider" value:"control-plane-kubeadm" > labels:<key:"control-plane" value:"controller-manager" > labels:<key:"projectcalico.org/name" value:"capi-kubeadm-control-plane-system" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"capi-webhook-system" > labels:<key:"cluster.x-k8s.io/provider" value:"cluster-api" > labels:<key:"control-plane" value:"controller-manager" > labels:<key:"projectcalico.org/name" value:"capi-webhook-system" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"cert-manager" > labels:<key:"projectcalico.org/name" value:"cert-manager" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"kube-public" > labels:<key:"projectcalico.org/name" value:"kube-public" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"kube-system" > labels:<key:"projectcalico.org/name" value:"kube-system" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"kubernetes-dashboard" > labels:<key:"projectcalico.org/name" value:"kubernetes-dashboard" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"capi-kubeadm-bootstrap-system" > labels:<key:"cluster.x-k8s.io/provider" value:"bootstrap-kubeadm" > labels:<key:"control-plane" value:"controller-manager" > labels:<key:"projectcalico.org/name" value:"capi-kubeadm-bootstrap-system" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"default" > labels:<key:"projectcalico.org/name" value:"default" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"kube-node-lease" > labels:<key:"projectcalico.org/name" value:"kube-node-lease" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"monitoring" > labels:<key:"projectcalico.org/name" value:"monitoring" > 
2020-12-17 18:44:37.620 [INFO][43] felix/int_dataplane.go 1172: Received *proto.NamespaceUpdate update from calculation graph msg=id:<name:"cluster-5fda967f2b5ce46b483a5521" > labels:<key:"projectcalico.org/name" value:"cluster-5fda967f2b5ce46b483a5521" > 
2020-12-17 18:44:37.630 [INFO][43] felix/watchercache.go 271: Sending synced update ListRoot="/calico/resources/v3/projectcalico.org/workloadendpoints"
2020-12-17 18:44:37.630 [INFO][43] felix/watchersyncer.go 209: Received InSync event from one of the watcher caches
2020-12-17 18:44:37.630 [INFO][43] felix/calc_graph.go 411: Local endpoint updated id=WorkloadEndpoint(node=boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t, orchestrator=k8s, workload=kubernetes-dashboard/dashboard-metrics-scraper-c79c65bb7-h8btd, name=eth0)
2020-12-17 18:44:37.630 [INFO][43] felix/watchersyncer.go 221: All watchers have sync'd data - sending data and final sync
2020-12-17 18:44:37.630 [INFO][43] felix/watchersyncer.go 127: Sending status update Status=in-sync
2020-12-17 18:44:37.631 [INFO][43] felix/calc_graph.go 411: Local endpoint updated id=WorkloadEndpoint(node=boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t, orchestrator=k8s, workload=kubernetes-dashboard/kubernetes-dashboard-cbff8fbf-sjpx8, name=eth0)
2020-12-17 18:44:37.632 [INFO][43] felix/calc_graph.go 411: Local endpoint updated id=WorkloadEndpoint(node=boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t, orchestrator=k8s, workload=monitoring/alertmanager-prometheus-operator-alertmanager-0, name=eth0)
2020-12-17 18:44:37.632 [INFO][43] felix/calc_graph.go 411: Local endpoint updated id=WorkloadEndpoint(node=boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t, orchestrator=k8s, workload=monitoring/grafana-5c6f8c5dd6-9kd9s, name=eth0)
2020-12-17 18:44:37.632 [INFO][43] felix/calc_graph.go 411: Local endpoint updated id=WorkloadEndpoint(node=boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t, orchestrator=k8s, workload=monitoring/kube-state-metrics-594cd4fff-jrsc6, name=eth0)
2020-12-17 18:44:37.632 [INFO][43] felix/calc_graph.go 411: Local endpoint updated id=WorkloadEndpoint(node=boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t, orchestrator=k8s, workload=monitoring/prometheus-operator-operator-5f58c7c76-czvjd, name=eth0)
2020-12-17 18:44:37.632 [INFO][43] felix/calc_graph.go 411: Local endpoint updated id=WorkloadEndpoint(node=boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t, orchestrator=k8s, workload=monitoring/prometheus-prometheus-operator-prometheus-0, name=eth0)
2020-12-17 18:44:37.632 [INFO][43] felix/config_batcher.go 102: Datamodel in sync, flushing config update
2020-12-17 18:44:37.632 [INFO][43] felix/config_batcher.go 112: Sending config update global: map[CalicoVersion:v3.16.5 ClusterGUID:962b79cda07b4b00aca27c3644424782 ClusterType:k8s,bgp,kubeadm,kdd LogSeverityScreen:Info ReportingIntervalSecs:0 VXLANEnabled:true], host: map[IpInIpTunnelAddr:192.168.1.1].
2020-12-17 18:44:37.632 [INFO][43] felix/async_calc_graph.go 166: First time we've been in sync
2020-12-17 18:44:37.632 [INFO][43] felix/health.go 133: Health of component changed lastReport=health.HealthReport{Live:true, Ready:false} name="async_calc_graph" newReport=&health.HealthReport{Live:true, Ready:true}
2020-12-17 18:44:37.632 [INFO][43] felix/event_sequencer.go 232: Possible config update. global=map[string]string{"CalicoVersion":"v3.16.5", "ClusterGUID":"962b79cda07b4b00aca27c3644424782", "ClusterType":"k8s,bgp,kubeadm,kdd", "LogSeverityScreen":"Info", "ReportingIntervalSecs":"0", "VXLANEnabled":"true"} host=map[string]string{"IpInIpTunnelAddr":"192.168.1.1"}
2020-12-17 18:44:37.632 [INFO][43] felix/config_params.go 335: Merging in config from datastore (global): map[CalicoVersion:v3.16.5 ClusterGUID:962b79cda07b4b00aca27c3644424782 ClusterType:k8s,bgp,kubeadm,kdd LogSeverityScreen:Info ReportingIntervalSecs:0 VXLANEnabled:true]
2020-12-17 18:44:37.632 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: info (from environment variable)
2020-12-17 18:44:37.632 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from environment variable)
2020-12-17 18:44:37.632 [INFO][43] felix/config_params.go 424: Parsing value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.632 [INFO][43] felix/config_params.go 460: Parsed value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.632 [INFO][43] felix/config_params.go 424: Parsing value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.632 [INFO][43] felix/config_params.go 460: Parsed value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityFile: None (from config file)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityFile:  (from config file)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for LogSeveritySys: None (from config file)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for LogSeveritySys:  (from config file)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for MetadataAddr: None (from config file)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for MetadataAddr:  (from config file)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for LogFilePath: None (from config file)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for LogFilePath:  (from config file)
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for IpInIpTunnelAddr: 192.168.1.1 (from datastore (per-host))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for IpInIpTunnelAddr: 192.168.1.1 (from datastore (per-host))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for ReportingIntervalSecs: 0 (from datastore (global))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for ReportingIntervalSecs: 0s (from datastore (global))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for ClusterGUID: 962b79cda07b4b00aca27c3644424782 (from datastore (global))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for ClusterGUID: 962b79cda07b4b00aca27c3644424782 (from datastore (global))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for ClusterType: k8s,bgp,kubeadm,kdd (from datastore (global))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for ClusterType: k8s,bgp,kubeadm,kdd (from datastore (global))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for CalicoVersion: v3.16.5 (from datastore (global))
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 460: Parsed value for CalicoVersion: v3.16.5 (from datastore (global))
2020-12-17 18:44:37.634 [INFO][43] felix/usagerep.go 91: Waiting before first check-in delay=5m1.179s
2020-12-17 18:44:37.633 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: Info (from datastore (global))
2020-12-17 18:44:37.634 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from datastore (global))
2020-12-17 18:44:37.634 [INFO][43] felix/config_params.go 463: Skipping config value for LogSeverityScreen from datastore (global); already have a value from environment variable
2020-12-17 18:44:37.634 [INFO][43] felix/config_params.go 424: Parsing value for VXLANEnabled: true (from datastore (global))
2020-12-17 18:44:37.634 [INFO][43] felix/config_params.go 460: Parsed value for VXLANEnabled: true (from datastore (global))
2020-12-17 18:44:37.634 [INFO][43] felix/config_params.go 335: Merging in config from datastore (per-host): map[IpInIpTunnelAddr:192.168.1.1]
2020-12-17 18:44:37.634 [INFO][43] felix/config_params.go 424: Parsing value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.634 [INFO][43] felix/config_params.go 460: Parsed value for HealthEnabled: true (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for DatastoreType: kubernetes (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for FelixHostname: boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for DefaultEndpointToHostAction: ACCEPT (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: info (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for Ipv6Support: false (from environment variable)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityFile: None (from config file)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityFile:  (from config file)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for LogSeveritySys: None (from config file)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for LogSeveritySys:  (from config file)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for MetadataAddr: None (from config file)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for MetadataAddr:  (from config file)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for LogFilePath: None (from config file)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 441: Value set to 'none', replacing with zero-value: "".
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 460: Parsed value for LogFilePath:  (from config file)
2020-12-17 18:44:37.635 [INFO][43] felix/config_params.go 424: Parsing value for IpInIpTunnelAddr: 192.168.1.1 (from datastore (per-host))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 460: Parsed value for IpInIpTunnelAddr: 192.168.1.1 (from datastore (per-host))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 424: Parsing value for VXLANEnabled: true (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 460: Parsed value for VXLANEnabled: true (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 424: Parsing value for ReportingIntervalSecs: 0 (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 460: Parsed value for ReportingIntervalSecs: 0s (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 424: Parsing value for ClusterGUID: 962b79cda07b4b00aca27c3644424782 (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 460: Parsed value for ClusterGUID: 962b79cda07b4b00aca27c3644424782 (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 424: Parsing value for ClusterType: k8s,bgp,kubeadm,kdd (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 460: Parsed value for ClusterType: k8s,bgp,kubeadm,kdd (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 424: Parsing value for CalicoVersion: v3.16.5 (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 460: Parsed value for CalicoVersion: v3.16.5 (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 424: Parsing value for LogSeverityScreen: Info (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 460: Parsed value for LogSeverityScreen: INFO (from datastore (global))
2020-12-17 18:44:37.636 [INFO][43] felix/config_params.go 463: Skipping config value for LogSeverityScreen from datastore (global); already have a value from environment variable
2020-12-17 18:44:37.638 [INFO][43] felix/async_calc_graph.go 220: First flush after becoming in sync, sending InSync message.
2020-12-17 18:44:37.638 [INFO][43] felix/daemon.go 1121: Datastore now in sync.
2020-12-17 18:44:37.638 [INFO][43] felix/daemon.go 1123: Datastore in sync for first time, sending message to status reporter.
2020-12-17 18:44:37.639 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ActiveProfileUpdate update from calculation graph msg=id:<name:"ksa.monitoring.prometheus-operator-operator" > profile:<> 
2020-12-17 18:44:37.639 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pri-_ERyL_IkS3su-P1bTH_" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.639 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pro-_ERyL_IkS3su-P1bTH_" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.639 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ActiveProfileUpdate update from calculation graph msg=id:<name:"ksa.monitoring.prometheus-operator-prometheus" > profile:<> 
2020-12-17 18:44:37.639 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pri-_O7J4-M6snsf84tdrDz" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.640 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pro-_O7J4-M6snsf84tdrDz" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.640 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ActiveProfileUpdate update from calculation graph msg=id:<name:"kns.kubernetes-dashboard" > profile:<inbound_rules:<action:"allow" rule_id:"Y93ECk5K2W0R1AMm" > outbound_rules:<action:"allow" rule_id:"zi2ucDKmdv5wkbn1" > > 
2020-12-17 18:44:37.640 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pri-_o0lEupLJTvZtfGMPRu" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.640 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pro-_o0lEupLJTvZtfGMPRu" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.640 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ActiveProfileUpdate update from calculation graph msg=id:<name:"ksa.kubernetes-dashboard.kubernetes-dashboard" > profile:<> 
2020-12-17 18:44:37.640 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pri-_uCbaNM8Z9Kvm1UBKzR" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.640 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pro-_uCbaNM8Z9Kvm1UBKzR" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.640 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ActiveProfileUpdate update from calculation graph msg=id:<name:"kns.monitoring" > profile:<inbound_rules:<action:"allow" rule_id:"jOFQEzE71jYZF_M2" > outbound_rules:<action:"allow" rule_id:"P0TxGVrsSB9Pcl4X" > > 
2020-12-17 18:44:37.641 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pri-kns.monitoring" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.642 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pro-kns.monitoring" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.642 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ActiveProfileUpdate update from calculation graph msg=id:<name:"ksa.monitoring.prometheus-operator-alertmanager" > profile:<> 
2020-12-17 18:44:37.642 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pri-_bR2LM9xRSbC7FCgJK3" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.642 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pro-_bR2LM9xRSbC7FCgJK3" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.642 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ActiveProfileUpdate update from calculation graph msg=id:<name:"ksa.monitoring.grafana" > profile:<> 
2020-12-17 18:44:37.642 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pri-_BxgRg8_GP3E2UYD1Y6" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.642 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pro-_BxgRg8_GP3E2UYD1Y6" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.642 [INFO][43] felix/int_dataplane.go 1172: Received *proto.ActiveProfileUpdate update from calculation graph msg=id:<name:"ksa.monitoring.kube-state-metrics" > profile:<> 
2020-12-17 18:44:37.642 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pri-_hLDyoD1gGwOBlEEHjJ" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.642 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-pro-_hLDyoD1gGwOBlEEHjJ" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.642 [INFO][43] felix/int_dataplane.go 1172: Received *proto.WorkloadEndpointUpdate update from calculation graph msg=id:<orchestrator_id:"k8s" workload_id:"monitoring/alertmanager-prometheus-operator-alertmanager-0" endpoint_id:"eth0" > endpoint:<state:"active" name:"calid02fed251a7" profile_ids:"kns.monitoring" profile_ids:"ksa.monitoring.prometheus-operator-alertmanager" ipv4_nets:"192.168.1.34/32" > 
2020-12-17 18:44:37.642 [INFO][43] felix/int_dataplane.go 1172: Received *proto.WorkloadEndpointUpdate update from calculation graph msg=id:<orchestrator_id:"k8s" workload_id:"monitoring/grafana-5c6f8c5dd6-9kd9s" endpoint_id:"eth0" > endpoint:<state:"active" name:"calied46e14ce85" profile_ids:"kns.monitoring" profile_ids:"ksa.monitoring.grafana" ipv4_nets:"192.168.1.30/32" > 
2020-12-17 18:44:37.642 [INFO][43] felix/int_dataplane.go 1172: Received *proto.WorkloadEndpointUpdate update from calculation graph msg=id:<orchestrator_id:"k8s" workload_id:"monitoring/kube-state-metrics-594cd4fff-jrsc6" endpoint_id:"eth0" > endpoint:<state:"active" name:"cali1b695bbe160" profile_ids:"kns.monitoring" profile_ids:"ksa.monitoring.kube-state-metrics" ipv4_nets:"192.168.1.32/32" > 
2020-12-17 18:44:37.642 [INFO][43] felix/int_dataplane.go 1172: Received *proto.WorkloadEndpointUpdate update from calculation graph msg=id:<orchestrator_id:"k8s" workload_id:"monitoring/prometheus-operator-operator-5f58c7c76-czvjd" endpoint_id:"eth0" > endpoint:<state:"active" name:"cali4d7bdbb746d" profile_ids:"kns.monitoring" profile_ids:"ksa.monitoring.prometheus-operator-operator" ipv4_nets:"192.168.1.31/32" > 
2020-12-17 18:44:37.645 [INFO][43] felix/int_dataplane.go 1172: Received *proto.WorkloadEndpointUpdate update from calculation graph msg=id:<orchestrator_id:"k8s" workload_id:"monitoring/prometheus-prometheus-operator-prometheus-0" endpoint_id:"eth0" > endpoint:<state:"active" name:"cali8b4acec57bb" profile_ids:"kns.monitoring" profile_ids:"ksa.monitoring.prometheus-operator-prometheus" ipv4_nets:"192.168.1.35/32" > 
2020-12-17 18:44:37.645 [INFO][43] felix/int_dataplane.go 1172: Received *proto.WorkloadEndpointUpdate update from calculation graph msg=id:<orchestrator_id:"k8s" workload_id:"kubernetes-dashboard/dashboard-metrics-scraper-c79c65bb7-h8btd" endpoint_id:"eth0" > endpoint:<state:"active" name:"cali8fdabebe17d" profile_ids:"kns.kubernetes-dashboard" profile_ids:"ksa.kubernetes-dashboard.kubernetes-dashboard" ipv4_nets:"192.168.1.9/32" > 
2020-12-17 18:44:37.645 [INFO][43] felix/int_dataplane.go 1172: Received *proto.WorkloadEndpointUpdate update from calculation graph msg=id:<orchestrator_id:"k8s" workload_id:"kubernetes-dashboard/kubernetes-dashboard-cbff8fbf-sjpx8" endpoint_id:"eth0" > endpoint:<state:"active" name:"cali1af37b3231e" profile_ids:"kns.kubernetes-dashboard" profile_ids:"ksa.kubernetes-dashboard.kubernetes-dashboard" ipv4_nets:"192.168.1.10/32" > 
2020-12-17 18:44:37.645 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD ip_pool_type:VXLAN dst:"192.168.1.9/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true local_workload:true 
2020-12-17 18:44:37.645 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD ip_pool_type:VXLAN dst:"192.168.1.10/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true local_workload:true 
2020-12-17 18:44:37.645 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD ip_pool_type:VXLAN dst:"192.168.1.34/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true local_workload:true 
2020-12-17 18:44:37.646 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD ip_pool_type:VXLAN dst:"192.168.1.30/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true local_workload:true 
2020-12-17 18:44:37.646 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD ip_pool_type:VXLAN dst:"192.168.1.32/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true local_workload:true 
2020-12-17 18:44:37.646 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD ip_pool_type:VXLAN dst:"192.168.1.31/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true local_workload:true 
2020-12-17 18:44:37.646 [INFO][43] felix/int_dataplane.go 1172: Received *proto.RouteUpdate update from calculation graph msg=type:LOCAL_WORKLOAD ip_pool_type:VXLAN dst:"192.168.1.35/32" dst_node_name:"boobalan-dev-cni3160-worker-pool-1-c4d1-tc52t" dst_node_ip:"10.1.0.4" nat_outgoing:true local_workload:true 
2020-12-17 18:44:37.646 [INFO][43] felix/int_dataplane.go 1172: Received *proto.InSync update from calculation graph msg=
2020-12-17 18:44:37.646 [INFO][43] felix/int_dataplane.go 1180: Datastore in sync, flushing the dataplane for the first time... timeSinceStart=228.731829ms
2020-12-17 18:44:37.646 [INFO][43] felix/int_dataplane.go 1300: Applying dataplane updates
2020-12-17 18:44:37.646 [INFO][43] felix/ipsets.go 119: Queueing IP set for creation family="inet" setID="all-vxlan-net" setType="hash:net"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 353: Workload interface came up, marking for reconfiguration. ifaceName="cali1b695bbe160"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 353: Workload interface came up, marking for reconfiguration. ifaceName="calid02fed251a7"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 353: Workload interface came up, marking for reconfiguration. ifaceName="cali8b4acec57bb"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 353: Workload interface came up, marking for reconfiguration. ifaceName="cali8fdabebe17d"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 353: Workload interface came up, marking for reconfiguration. ifaceName="cali1af37b3231e"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 353: Workload interface came up, marking for reconfiguration. ifaceName="cali4d7bdbb746d"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 353: Workload interface came up, marking for reconfiguration. ifaceName="calied46e14ce85"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 561: Updating per-endpoint chains. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/kube-state-metrics-594cd4fff-jrsc6", EndpointId:"eth0"}
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-tw-cali1b695bbe160" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pri-kns.monitoring"
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pri-_hLDyoD1gGwOBlEEHjJ"
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-fw-cali1b695bbe160" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pro-kns.monitoring"
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pro-_hLDyoD1gGwOBlEEHjJ"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 592: Updating endpoint routes. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/kube-state-metrics-594cd4fff-jrsc6", EndpointId:"eth0"}
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 561: Updating per-endpoint chains. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/prometheus-operator-operator-5f58c7c76-czvjd", EndpointId:"eth0"}
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-tw-cali4d7bdbb746d" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pri-_ERyL_IkS3su-P1bTH_"
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-fw-cali4d7bdbb746d" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.646 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pro-_ERyL_IkS3su-P1bTH_"
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 592: Updating endpoint routes. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/prometheus-operator-operator-5f58c7c76-czvjd", EndpointId:"eth0"}
2020-12-17 18:44:37.646 [INFO][43] felix/endpoint_mgr.go 561: Updating per-endpoint chains. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/prometheus-prometheus-operator-prometheus-0", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-tw-cali8b4acec57bb" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pri-_O7J4-M6snsf84tdrDz"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-fw-cali8b4acec57bb" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pro-_O7J4-M6snsf84tdrDz"
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 592: Updating endpoint routes. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/prometheus-prometheus-operator-prometheus-0", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 561: Updating per-endpoint chains. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"kubernetes-dashboard/dashboard-metrics-scraper-c79c65bb7-h8btd", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-tw-cali8fdabebe17d" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pri-_o0lEupLJTvZtfGMPRu"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pri-_uCbaNM8Z9Kvm1UBKzR"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-fw-cali8fdabebe17d" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pro-_o0lEupLJTvZtfGMPRu"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pro-_uCbaNM8Z9Kvm1UBKzR"
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 592: Updating endpoint routes. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"kubernetes-dashboard/dashboard-metrics-scraper-c79c65bb7-h8btd", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 561: Updating per-endpoint chains. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"kubernetes-dashboard/kubernetes-dashboard-cbff8fbf-sjpx8", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-tw-cali1af37b3231e" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-fw-cali1af37b3231e" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 592: Updating endpoint routes. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"kubernetes-dashboard/kubernetes-dashboard-cbff8fbf-sjpx8", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 561: Updating per-endpoint chains. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/alertmanager-prometheus-operator-alertmanager-0", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-tw-calid02fed251a7" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pri-_bR2LM9xRSbC7FCgJK3"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-fw-calid02fed251a7" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pro-_bR2LM9xRSbC7FCgJK3"
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 592: Updating endpoint routes. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/alertmanager-prometheus-operator-alertmanager-0", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 561: Updating per-endpoint chains. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/grafana-5c6f8c5dd6-9kd9s", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-tw-calied46e14ce85" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pri-_BxgRg8_GP3E2UYD1Y6"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-fw-calied46e14ce85" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-pro-_BxgRg8_GP3E2UYD1Y6"
2020-12-17 18:44:37.647 [INFO][43] felix/endpoint_mgr.go 592: Updating endpoint routes. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/grafana-5c6f8c5dd6-9kd9s", EndpointId:"eth0"}
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-from-wl-dispatch-1" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fw-cali1af37b3231e"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fw-cali1b695bbe160"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-from-wl-dispatch-8" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fw-cali8b4acec57bb"
2020-12-17 18:44:37.647 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fw-cali8fdabebe17d"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-from-wl-dispatch" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-from-wl-dispatch-1"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fw-cali4d7bdbb746d"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-from-wl-dispatch-8"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fw-calid02fed251a7"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-fw-calied46e14ce85"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-to-wl-dispatch-1" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-tw-cali1af37b3231e"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-tw-cali1b695bbe160"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-to-wl-dispatch-8" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-tw-cali8b4acec57bb"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-tw-cali8fdabebe17d"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 496: Queueing update of chain. chainName="cali-to-wl-dispatch" ipVersion=0x4 table="filter"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-to-wl-dispatch-1"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-tw-cali4d7bdbb746d"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-to-wl-dispatch-8"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-tw-calid02fed251a7"
2020-12-17 18:44:37.648 [INFO][43] felix/table.go 570: Chain became referenced, marking it for programming chainName="cali-tw-calied46e14ce85"
2020-12-17 18:44:37.648 [INFO][43] felix/endpoint_mgr.go 1089: Applying /proc/sys configuration to interface. ifaceName="cali1b695bbe160"
2020-12-17 18:44:37.648 [INFO][43] felix/endpoint_mgr.go 1089: Applying /proc/sys configuration to interface. ifaceName="calid02fed251a7"
2020-12-17 18:44:37.648 [INFO][43] felix/endpoint_mgr.go 1089: Applying /proc/sys configuration to interface. ifaceName="cali8b4acec57bb"
... dropped 30 logs ...
2020-12-17 18:44:37.731 [INFO][43] felix/xdp_state.go 561: Finished XDP resync. family=4 resyncDuration=16.636912ms
2020-12-17 18:44:37.731 [INFO][43] felix/wireguard.go 1578: Trying to connect to linkClient
2020-12-17 18:44:37.731 [INFO][43] felix/ipsets.go 306: Resyncing ipsets with dataplane. family="inet"
2020-12-17 18:44:37.731 [INFO][43] felix/route_table.go 408: Trying to connect to netlink
2020-12-17 18:44:37.732 [INFO][43] felix/route_table.go 408: Trying to connect to netlink
2020-12-17 18:44:37.734 [INFO][43] felix/route_table.go 1073: Failed to access interface because it doesn't exist. error=Link not found ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.734 [INFO][43] felix/route_table.go 1141: Failed to get interface; it's down/gone. error=Link not found ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.734 [ERROR][43] felix/route_table.go 920: Failed to get link attributes error=interface not present ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.734 [INFO][43] felix/route_table.go 527: Interface missing, will retry if it appears. ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.736 [INFO][43] felix/route_table.go 408: Trying to connect to netlink
2020-12-17 18:44:37.739 [INFO][43] felix/route_rule.go 182: Trying to connect to netlink
2020-12-17 18:44:37.740 [INFO][43] felix/ipsets.go 356: Finished resync family="inet" numInconsistenciesFound=0 resyncDuration=9.652764ms
2020-12-17 18:44:37.742 [INFO][43] felix/ipsets.go 749: Doing full IP set rewrite family="inet" numMembersInPendingReplace=1 setID="all-ipam-pools"
2020-12-17 18:44:37.742 [INFO][43] felix/ipsets.go 749: Doing full IP set rewrite family="inet" numMembersInPendingReplace=1 setID="masq-ipam-pools"
2020-12-17 18:44:37.742 [INFO][43] felix/ipsets.go 749: Doing full IP set rewrite family="inet" numMembersInPendingReplace=3 setID="this-host"
2020-12-17 18:44:37.742 [INFO][43] felix/ipsets.go 749: Doing full IP set rewrite family="inet" numMembersInPendingReplace=0 setID="all-vxlan-net"
2020-12-17 18:44:37.744 [INFO][43] felix/wireguard.go 558: Public key out of sync or updated ourPublicKey=AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA=
2020-12-17 18:44:37.803 [INFO][43] felix/table.go 592: Loading current iptables state and checking it is correct. ipVersion=0x4 table="raw"
2020-12-17 18:44:37.806 [INFO][43] felix/table.go 592: Loading current iptables state and checking it is correct. ipVersion=0x4 table="nat"
2020-12-17 18:44:37.808 [INFO][43] felix/table.go 592: Loading current iptables state and checking it is correct. ipVersion=0x4 table="mangle"
2020-12-17 18:44:37.812 [INFO][43] felix/table.go 592: Loading current iptables state and checking it is correct. ipVersion=0x4 table="filter"
2020-12-17 18:44:37.822 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{} ifaceName="calico_tmp_A"
2020-12-17 18:44:37.822 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=<nil> ifaceName="calico_tmp_A"
2020-12-17 18:44:37.824 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=set.mapSet{} ifaceName="calico_tmp_B"
2020-12-17 18:44:37.825 [INFO][43] felix/int_dataplane.go 848: Linux interface addrs changed. addrs=<nil> ifaceName="calico_tmp_B"
2020-12-17 18:44:37.828 [INFO][43] felix/status_combiner.go 81: Endpoint up for at least one IP version id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/prometheus-operator-operator-5f58c7c76-czvjd", EndpointId:"eth0"} ipVersion=0x4 status="up"
2020-12-17 18:44:37.828 [INFO][43] felix/status_combiner.go 98: Reporting combined status. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/prometheus-operator-operator-5f58c7c76-czvjd", EndpointId:"eth0"} status="up"
2020-12-17 18:44:37.828 [INFO][43] felix/status_combiner.go 81: Endpoint up for at least one IP version id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/prometheus-prometheus-operator-prometheus-0", EndpointId:"eth0"} ipVersion=0x4 status="up"
2020-12-17 18:44:37.828 [INFO][43] felix/status_combiner.go 98: Reporting combined status. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/prometheus-prometheus-operator-prometheus-0", EndpointId:"eth0"} status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 81: Endpoint up for at least one IP version id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"kubernetes-dashboard/dashboard-metrics-scraper-c79c65bb7-h8btd", EndpointId:"eth0"} ipVersion=0x4 status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 98: Reporting combined status. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"kubernetes-dashboard/dashboard-metrics-scraper-c79c65bb7-h8btd", EndpointId:"eth0"} status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 81: Endpoint up for at least one IP version id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"kubernetes-dashboard/kubernetes-dashboard-cbff8fbf-sjpx8", EndpointId:"eth0"} ipVersion=0x4 status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 98: Reporting combined status. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"kubernetes-dashboard/kubernetes-dashboard-cbff8fbf-sjpx8", EndpointId:"eth0"} status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 81: Endpoint up for at least one IP version id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/alertmanager-prometheus-operator-alertmanager-0", EndpointId:"eth0"} ipVersion=0x4 status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 98: Reporting combined status. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/alertmanager-prometheus-operator-alertmanager-0", EndpointId:"eth0"} status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 81: Endpoint up for at least one IP version id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/grafana-5c6f8c5dd6-9kd9s", EndpointId:"eth0"} ipVersion=0x4 status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 98: Reporting combined status. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/grafana-5c6f8c5dd6-9kd9s", EndpointId:"eth0"} status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 81: Endpoint up for at least one IP version id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/kube-state-metrics-594cd4fff-jrsc6", EndpointId:"eth0"} ipVersion=0x4 status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/status_combiner.go 98: Reporting combined status. id=proto.WorkloadEndpointID{OrchestratorId:"k8s", WorkloadId:"monitoring/kube-state-metrics-594cd4fff-jrsc6", EndpointId:"eth0"} status="up"
2020-12-17 18:44:37.829 [INFO][43] felix/int_dataplane.go 1314: Finished applying updates to dataplane. msecToApply=183.085323
2020-12-17 18:44:37.829 [INFO][43] felix/int_dataplane.go 1320: Completed first update to dataplane. secsSinceStart=0.411900552
2020-12-17 18:44:37.835 [INFO][43] felix/health.go 133: Health of component changed lastReport=health.HealthReport{Live:true, Ready:false} name="int_dataplane" newReport=&health.HealthReport{Live:true, Ready:true}
2020-12-17 18:44:37.835 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"calico_tmp_A", Addrs:set.mapSet{}}
2020-12-17 18:44:37.835 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"calico_tmp_A", Addrs:set.mapSet{}}
2020-12-17 18:44:37.835 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"calico_tmp_A", Addrs:set.Set(nil)}
2020-12-17 18:44:37.835 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"calico_tmp_A", Addrs:set.Set(nil)}
2020-12-17 18:44:37.835 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"calico_tmp_B", Addrs:set.mapSet{}}
2020-12-17 18:44:37.835 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"calico_tmp_B", Addrs:set.mapSet{}}
2020-12-17 18:44:37.835 [INFO][43] felix/int_dataplane.go 1205: Received interface addresses update msg=&intdataplane.ifaceAddrsUpdate{Name:"calico_tmp_B", Addrs:set.Set(nil)}
2020-12-17 18:44:37.835 [INFO][43] felix/hostip_mgr.go 84: Interface addrs changed. update=&intdataplane.ifaceAddrsUpdate{Name:"calico_tmp_B", Addrs:set.Set(nil)}
2020-12-17 18:44:37.835 [INFO][43] felix/int_dataplane.go 1329: Dataplane updates throttled
2020-12-17 18:44:37.835 [INFO][43] felix/int_dataplane.go 1300: Applying dataplane updates
2020-12-17 18:44:37.836 [INFO][43] felix/route_table.go 1073: Failed to access interface because it doesn't exist. error=Link not found ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.836 [INFO][43] felix/route_table.go 1141: Failed to get interface; it's down/gone. error=Link not found ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.836 [ERROR][43] felix/route_table.go 920: Failed to get link attributes error=interface not present ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.836 [INFO][43] felix/route_table.go 527: Interface missing, will retry if it appears. ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.836 [INFO][43] felix/int_dataplane.go 1314: Finished applying updates to dataplane. msecToApply=0.356003
2020-12-17 18:44:37.878 [INFO][43] felix/int_dataplane.go 1300: Applying dataplane updates
2020-12-17 18:44:37.878 [INFO][43] felix/route_table.go 1073: Failed to access interface because it doesn't exist. error=Link not found ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.878 [INFO][43] felix/route_table.go 1141: Failed to get interface; it's down/gone. error=Link not found ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.878 [ERROR][43] felix/route_table.go 920: Failed to get link attributes error=interface not present ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.878 [INFO][43] felix/route_table.go 527: Interface missing, will retry if it appears. ifaceName="vxlan.calico" ifaceRegex="^vxlan.calico$" ipVersion=0x4
2020-12-17 18:44:37.878 [INFO][43] felix/int_dataplane.go 1314: Finished applying updates to dataplane. msecToApply=0.648804

Environment

Operating system : Ubuntu 18.04.5 LTS Kubernetes version : 1.16.15 Calico version : 3.16.5 IPAM type : host-local Cloud : Self-managed on azure

Observations

Tried calico-ipam type on the same environment and that works fine. This issue is seen only when ipam type is host-local and using podCidr from nodes.

lwr20 commented 3 years ago

Is there any particular reason that you want to use host-local ipam? Does calico-ipam not work for your use-case?

brathina-spectro commented 3 years ago

@lwr20 calico-ipam works fine.

Our use case is deploying calico on Kubernetes clusters. The nodes in the Kubernetes clusters are configured with a Pod CIDR range. Calico host-local ipam allows us to use the addresses set in the nodes using Node.Spec.PodCIDR. This way, we can avoid configuring the IP range manually in Calico.

lwr20 commented 3 years ago

But why do you want to use the Node.Spec.PodCIDR?

brathina-spectro commented 3 years ago

@lwr20 : Not sure if I understand your question correctly. But, as I said before, the idea is to use the existing PodCIDR property set in nodes so that, the PodsCIDR IP range need not be configured manually in Calico daemonset. Do you see a problem with this approach ?

lwr20 commented 3 years ago

Background here is that this scenario does not work (as you've discovered). There's some extra code needed to set the VXLAN tunnel up, but at the time it was judged that it wouldn't be needed. I was wondering if you had a particular use case that would justify the work required.

For my part, I'm not sure I understand why configuring the pod-cidr into Calico is a problem for you? I do know that recent versions of Calico will read the pod-cidr out of the kubeadm-config configmap (which obviously assumes that the cluster was set up with kubeadm). But even with versions of Calico that don't support that, we're talking about setting one value in one manifest.

caseydavenport commented 3 years ago

I raised an enhancement request here: https://github.com/projectcalico/calico/issues/4294

VXLAN encap isn't supported with host-local IPAM in Calico today. I'd recommend either using IPIP encap, or switching to Calico IPAM, in the meantime.