Skip to content

Instantly share code, notes, and snippets.

@cehoffman
Created November 30, 2019 04:57
Show Gist options
  • Save cehoffman/ed68eaa7146e79f317aaa7669ed72536 to your computer and use it in GitHub Desktop.
Save cehoffman/ed68eaa7146e79f317aaa7669ed72536 to your computer and use it in GitHub Desktop.
2019-11-30T04:40:29.808896303Z level=info msg="Skipped reading configuration file" reason="Config File \"ciliumd\" Not Found in \"[/root]\"" subsys=daemon
2019-11-30T04:40:29.808979101Z level=info msg=" --access-log=''" subsys=daemon
2019-11-30T04:40:29.808988289Z level=info msg=" --agent-labels=''" subsys=daemon
2019-11-30T04:40:29.808994617Z level=info msg=" --allow-icmp-frag-needed='true'" subsys=daemon
2019-11-30T04:40:29.809000757Z level=info msg=" --allow-localhost='auto'" subsys=daemon
2019-11-30T04:40:29.809006715Z level=info msg=" --annotate-k8s-node='true'" subsys=daemon
2019-11-30T04:40:29.809012663Z level=info msg=" --auto-create-cilium-node-resource='true'" subsys=daemon
2019-11-30T04:40:29.809018658Z level=info msg=" --auto-direct-node-routes='false'" subsys=daemon
2019-11-30T04:40:29.809024775Z level=info msg=" --aws-instance-limit-mapping='map[]'" subsys=daemon
2019-11-30T04:40:29.809030621Z level=info msg=" --blacklist-conflicting-routes='true'" subsys=daemon
2019-11-30T04:40:29.809036557Z level=info msg=" --bpf-compile-debug='false'" subsys=daemon
2019-11-30T04:40:29.809042401Z level=info msg=" --bpf-ct-global-any-max='262144'" subsys=daemon
2019-11-30T04:40:29.809048286Z level=info msg=" --bpf-ct-global-tcp-max='524288'" subsys=daemon
2019-11-30T04:40:29.809054234Z level=info msg=" --bpf-ct-timeout-regular-any='1m0s'" subsys=daemon
2019-11-30T04:40:29.8090601Z level=info msg=" --bpf-ct-timeout-regular-tcp='6h0m0s'" subsys=daemon
2019-11-30T04:40:29.809066089Z level=info msg=" --bpf-ct-timeout-regular-tcp-fin='10s'" subsys=daemon
2019-11-30T04:40:29.809071911Z level=info msg=" --bpf-ct-timeout-regular-tcp-syn='1m0s'" subsys=daemon
2019-11-30T04:40:29.809077666Z level=info msg=" --bpf-ct-timeout-service-any='1m0s'" subsys=daemon
2019-11-30T04:40:29.809083374Z level=info msg=" --bpf-ct-timeout-service-tcp='6h0m0s'" subsys=daemon
2019-11-30T04:40:29.809089265Z level=info msg=" --bpf-nat-global-max='841429'" subsys=daemon
2019-11-30T04:40:29.809094963Z level=info msg=" --bpf-policy-map-max='16384'" subsys=daemon
2019-11-30T04:40:29.809100785Z level=info msg=" --bpf-root=''" subsys=daemon
2019-11-30T04:40:29.809106501Z level=info msg=" --cgroup-root=''" subsys=daemon
2019-11-30T04:40:29.80911306Z level=info msg=" --cluster-id='0'" subsys=daemon
2019-11-30T04:40:29.809124232Z level=info msg=" --cluster-name='home'" subsys=daemon
2019-11-30T04:40:29.809136889Z level=info msg=" --clustermesh-config='/var/lib/cilium/clustermesh/'" subsys=daemon
2019-11-30T04:40:29.809150125Z level=info msg=" --cmdref=''" subsys=daemon
2019-11-30T04:40:29.809158232Z level=info msg=" --config=''" subsys=daemon
2019-11-30T04:40:29.809164235Z level=info msg=" --config-dir='/tmp/cilium/config-map'" subsys=daemon
2019-11-30T04:40:29.809169921Z level=info msg=" --conntrack-garbage-collector-interval='0'" subsys=daemon
2019-11-30T04:40:29.809194072Z level=info msg=" --conntrack-gc-interval='0s'" subsys=daemon
2019-11-30T04:40:29.809205805Z level=info msg=" --container-runtime='none'" subsys=daemon
2019-11-30T04:40:29.809212103Z level=info msg=" --container-runtime-endpoint='map[]'" subsys=daemon
2019-11-30T04:40:29.809218071Z level=info msg=" --datapath-mode='veth'" subsys=daemon
2019-11-30T04:40:29.809223881Z level=info msg=" --debug='true'" subsys=daemon
2019-11-30T04:40:29.809229574Z level=info msg=" --debug-verbose=''" subsys=daemon
2019-11-30T04:40:29.809235125Z level=info msg=" --device='undefined'" subsys=daemon
2019-11-30T04:40:29.809240894Z level=info msg=" --disable-cnp-status-updates='false'" subsys=daemon
2019-11-30T04:40:29.809246671Z level=info msg=" --disable-conntrack='false'" subsys=daemon
2019-11-30T04:40:29.809252275Z level=info msg=" --disable-endpoint-crd='false'" subsys=daemon
2019-11-30T04:40:29.809258091Z level=info msg=" --disable-envoy-version-check='false'" subsys=daemon
2019-11-30T04:40:29.809263818Z level=info msg=" --disable-ipv4='false'" subsys=daemon
2019-11-30T04:40:29.809269421Z level=info msg=" --disable-k8s-services='false'" subsys=daemon
2019-11-30T04:40:29.809274948Z level=info msg=" --egress-masquerade-interfaces=''" subsys=daemon
2019-11-30T04:40:29.809280574Z level=info msg=" --enable-endpoint-health-checking='true'" subsys=daemon
2019-11-30T04:40:29.809286345Z level=info msg=" --enable-endpoint-routes='false'" subsys=daemon
2019-11-30T04:40:29.809292192Z level=info msg=" --enable-health-checking='true'" subsys=daemon
2019-11-30T04:40:29.809298191Z level=info msg=" --enable-host-reachable-services='true'" subsys=daemon
2019-11-30T04:40:29.809303809Z level=info msg=" --enable-ipsec='false'" subsys=daemon
2019-11-30T04:40:29.809309583Z level=info msg=" --enable-ipv4='true'" subsys=daemon
2019-11-30T04:40:29.809315291Z level=info msg=" --enable-ipv6='false'" subsys=daemon
2019-11-30T04:40:29.809321141Z level=info msg=" --enable-k8s-event-handover='false'" subsys=daemon
2019-11-30T04:40:29.8093269Z level=info msg=" --enable-k8s-external-ips='true'" subsys=daemon
2019-11-30T04:40:29.809332681Z level=info msg=" --enable-l7-proxy='true'" subsys=daemon
2019-11-30T04:40:29.809338397Z level=info msg=" --enable-legacy-services='false'" subsys=daemon
2019-11-30T04:40:29.809344228Z level=info msg=" --enable-local-node-route='true'" subsys=daemon
2019-11-30T04:40:29.809349825Z level=info msg=" --enable-node-port='true'" subsys=daemon
2019-11-30T04:40:29.809355521Z level=info msg=" --enable-policy='default'" subsys=daemon
2019-11-30T04:40:29.809361134Z level=info msg=" --enable-selective-regeneration='true'" subsys=daemon
2019-11-30T04:40:29.809366883Z level=info msg=" --enable-tracing='false'" subsys=daemon
2019-11-30T04:40:29.809372477Z level=info msg=" --encrypt-interface=''" subsys=daemon
2019-11-30T04:40:29.809383717Z level=info msg=" --encrypt-node='false'" subsys=daemon
2019-11-30T04:40:29.809390158Z level=info msg=" --endpoint-interface-name-prefix='lxc+'" subsys=daemon
2019-11-30T04:40:29.809396097Z level=info msg=" --endpoint-queue-size='25'" subsys=daemon
2019-11-30T04:40:29.809402377Z level=info msg=" --envoy-log=''" subsys=daemon
2019-11-30T04:40:29.809408157Z level=info msg=" --exclude-local-address=''" subsys=daemon
2019-11-30T04:40:29.809413826Z level=info msg=" --fixed-identity-mapping='map[]'" subsys=daemon
2019-11-30T04:40:29.809419583Z level=info msg=" --flannel-manage-existing-containers='false'" subsys=daemon
2019-11-30T04:40:29.809425243Z level=info msg=" --flannel-master-device=''" subsys=daemon
2019-11-30T04:40:29.809430923Z level=info msg=" --flannel-uninstall-on-exit='false'" subsys=daemon
2019-11-30T04:40:29.809436694Z level=info msg=" --force-local-policy-eval-at-source='true'" subsys=daemon
2019-11-30T04:40:29.809442514Z level=info msg=" --host-reachable-services-protos='udp tcp'" subsys=daemon
2019-11-30T04:40:29.809448258Z level=info msg=" --http-403-msg=''" subsys=daemon
2019-11-30T04:40:29.809454011Z level=info msg=" --http-idle-timeout='0'" subsys=daemon
2019-11-30T04:40:29.809459708Z level=info msg=" --http-max-grpc-timeout='0'" subsys=daemon
2019-11-30T04:40:29.809465401Z level=info msg=" --http-request-timeout='3600'" subsys=daemon
2019-11-30T04:40:29.809471109Z level=info msg=" --http-retry-count='3'" subsys=daemon
2019-11-30T04:40:29.809476645Z level=info msg=" --http-retry-timeout='0'" subsys=daemon
2019-11-30T04:40:29.80948231Z level=info msg=" --identity-allocation-mode='crd'" subsys=daemon
2019-11-30T04:40:29.809488138Z level=info msg=" --identity-change-grace-period='5s'" subsys=daemon
2019-11-30T04:40:29.809493838Z level=info msg=" --install-iptables-rules='true'" subsys=daemon
2019-11-30T04:40:29.809499616Z level=info msg=" --ip-allocation-timeout='2m0s'" subsys=daemon
2019-11-30T04:40:29.809505332Z level=info msg=" --ipam=''" subsys=daemon
2019-11-30T04:40:29.809510932Z level=info msg=" --ipsec-key-file=''" subsys=daemon
2019-11-30T04:40:29.809516536Z level=info msg=" --ipv4-cluster-cidr-mask-size='8'" subsys=daemon
2019-11-30T04:40:29.809522301Z level=info msg=" --ipv4-node='auto'" subsys=daemon
2019-11-30T04:40:29.809527847Z level=info msg=" --ipv4-pod-subnets=''" subsys=daemon
2019-11-30T04:40:29.809533519Z level=info msg=" --ipv4-range='auto'" subsys=daemon
2019-11-30T04:40:29.809539187Z level=info msg=" --ipv4-service-loopback-address='169.254.42.1'" subsys=daemon
2019-11-30T04:40:29.809544972Z level=info msg=" --ipv4-service-range='auto'" subsys=daemon
2019-11-30T04:40:29.80955059Z level=info msg=" --ipv6-cluster-alloc-cidr='f00d::/64'" subsys=daemon
2019-11-30T04:40:29.809560949Z level=info msg=" --ipv6-node='auto'" subsys=daemon
2019-11-30T04:40:29.809567456Z level=info msg=" --ipv6-pod-subnets=''" subsys=daemon
2019-11-30T04:40:29.809573373Z level=info msg=" --ipv6-range='auto'" subsys=daemon
2019-11-30T04:40:29.809578895Z level=info msg=" --ipv6-service-range='auto'" subsys=daemon
2019-11-30T04:40:29.809584681Z level=info msg=" --ipvlan-master-device='undefined'" subsys=daemon
2019-11-30T04:40:29.809590399Z level=info msg=" --k8s-api-server=''" subsys=daemon
2019-11-30T04:40:29.809596904Z level=info msg=" --k8s-force-json-patch='false'" subsys=daemon
2019-11-30T04:40:29.809603099Z level=info msg=" --k8s-kubeconfig-path=''" subsys=daemon
2019-11-30T04:40:29.809608807Z level=info msg=" --k8s-namespace='cilium'" subsys=daemon
2019-11-30T04:40:29.814651128Z level=info msg=" --k8s-require-ipv4-pod-cidr='true'" subsys=daemon
2019-11-30T04:40:29.814676745Z level=info msg=" --k8s-require-ipv6-pod-cidr='false'" subsys=daemon
2019-11-30T04:40:29.814684052Z level=info msg=" --k8s-service-cache-size='128'" subsys=daemon
2019-11-30T04:40:29.814690592Z level=info msg=" --k8s-watcher-endpoint-selector='metadata.name!=kube-scheduler,metadata.name!=kube-controller-manager,metadata.name!=etcd-operator,metadata.name!=gcp-controller-manager'" subsys=daemon
2019-11-30T04:40:29.814697218Z level=info msg=" --k8s-watcher-queue-size='1024'" subsys=daemon
2019-11-30T04:40:29.814703145Z level=info msg=" --keep-bpf-templates='false'" subsys=daemon
2019-11-30T04:40:29.814709184Z level=info msg=" --keep-config='false'" subsys=daemon
2019-11-30T04:40:29.814714993Z level=info msg=" --kvstore=''" subsys=daemon
2019-11-30T04:40:29.814720702Z level=info msg=" --kvstore-connectivity-timeout='2m0s'" subsys=daemon
2019-11-30T04:40:29.814726552Z level=info msg=" --kvstore-lease-ttl='15m0s'" subsys=daemon
2019-11-30T04:40:29.814732273Z level=info msg=" --kvstore-opt='map[]'" subsys=daemon
2019-11-30T04:40:29.814738102Z level=info msg=" --kvstore-periodic-sync='5m0s'" subsys=daemon
2019-11-30T04:40:29.814743875Z level=info msg=" --label-prefix-file=''" subsys=daemon
2019-11-30T04:40:29.814749781Z level=info msg=" --labels=''" subsys=daemon
2019-11-30T04:40:29.814755744Z level=info msg=" --lib-dir='/var/lib/cilium'" subsys=daemon
2019-11-30T04:40:29.814761653Z level=info msg=" --log-driver=''" subsys=daemon
2019-11-30T04:40:29.814767478Z level=info msg=" --log-opt='map[]'" subsys=daemon
2019-11-30T04:40:29.814773396Z level=info msg=" --log-system-load='false'" subsys=daemon
2019-11-30T04:40:29.814779239Z level=info msg=" --masquerade='true'" subsys=daemon
2019-11-30T04:40:29.814785208Z level=info msg=" --max-controller-interval='0'" subsys=daemon
2019-11-30T04:40:29.814791144Z level=info msg=" --metrics=''" subsys=daemon
2019-11-30T04:40:29.814796912Z level=info msg=" --monitor-aggregation='medium'" subsys=daemon
2019-11-30T04:40:29.814814516Z level=info msg=" --monitor-aggregation-flags=''" subsys=daemon
2019-11-30T04:40:29.81482155Z level=info msg=" --monitor-aggregation-interval='5s'" subsys=daemon
2019-11-30T04:40:29.814827739Z level=info msg=" --monitor-queue-size='0'" subsys=daemon
2019-11-30T04:40:29.814833556Z level=info msg=" --mtu='0'" subsys=daemon
2019-11-30T04:40:29.814839138Z level=info msg=" --nat46-range='0:0:0:0:0:FFFF::/96'" subsys=daemon
2019-11-30T04:40:29.814844893Z level=info msg=" --node-port-range=''" subsys=daemon
2019-11-30T04:40:29.814850532Z level=info msg=" --policy-queue-size='100'" subsys=daemon
2019-11-30T04:40:29.814856184Z level=info msg=" --policy-trigger-interval='1s'" subsys=daemon
2019-11-30T04:40:29.814863558Z level=info msg=" --pprof='false'" subsys=daemon
2019-11-30T04:40:29.814869824Z level=info msg=" --preallocate-bpf-maps='false'" subsys=daemon
2019-11-30T04:40:29.81487567Z level=info msg=" --prefilter-device='undefined'" subsys=daemon
2019-11-30T04:40:29.814881561Z level=info msg=" --prefilter-mode='native'" subsys=daemon
2019-11-30T04:40:29.81488747Z level=info msg=" --prepend-iptables-chains='true'" subsys=daemon
2019-11-30T04:40:29.814893467Z level=info msg=" --prometheus-serve-addr=''" subsys=daemon
2019-11-30T04:40:29.814899255Z level=info msg=" --proxy-connect-timeout='1'" subsys=daemon
2019-11-30T04:40:29.814905176Z level=info msg=" --read-cni-conf=''" subsys=daemon
2019-11-30T04:40:29.814910896Z level=info msg=" --restore='true'" subsys=daemon
2019-11-30T04:40:29.814916701Z level=info msg=" --sidecar-http-proxy='false'" subsys=daemon
2019-11-30T04:40:29.814922744Z level=info msg=" --sidecar-istio-proxy-image='cilium/istio_proxy'" subsys=daemon
2019-11-30T04:40:29.814928762Z level=info msg=" --single-cluster-route='false'" subsys=daemon
2019-11-30T04:40:29.814934596Z level=info msg=" --skip-crd-creation='false'" subsys=daemon
2019-11-30T04:40:29.814940367Z level=info msg=" --socket-path='/var/run/cilium/cilium.sock'" subsys=daemon
2019-11-30T04:40:29.814946276Z level=info msg=" --sockops-enable='false'" subsys=daemon
2019-11-30T04:40:29.814952002Z level=info msg=" --state-dir='/var/run/cilium'" subsys=daemon
2019-11-30T04:40:29.814957842Z level=info msg=" --tofqdns-dns-reject-response-code='refused'" subsys=daemon
2019-11-30T04:40:29.814966453Z level=info msg=" --tofqdns-enable-poller='false'" subsys=daemon
2019-11-30T04:40:29.814972464Z level=info msg=" --tofqdns-enable-poller-events='true'" subsys=daemon
2019-11-30T04:40:29.814978559Z level=info msg=" --tofqdns-endpoint-max-ip-per-hostname='50'" subsys=daemon
2019-11-30T04:40:29.814984536Z level=info msg=" --tofqdns-min-ttl='0'" subsys=daemon
2019-11-30T04:40:29.814990458Z level=info msg=" --tofqdns-pre-cache=''" subsys=daemon
2019-11-30T04:40:29.815002052Z level=info msg=" --tofqdns-proxy-port='0'" subsys=daemon
2019-11-30T04:40:29.815008493Z level=info msg=" --tofqdns-proxy-response-max-delay='50ms'" subsys=daemon
2019-11-30T04:40:29.815014332Z level=info msg=" --trace-payloadlen='128'" subsys=daemon
2019-11-30T04:40:29.815019875Z level=info msg=" --tunnel='vxlan'" subsys=daemon
2019-11-30T04:40:29.815025716Z level=info msg=" --version='false'" subsys=daemon
2019-11-30T04:40:29.815031635Z level=info msg=" --write-cni-conf-when-ready=''" subsys=daemon
2019-11-30T04:40:29.815037638Z level=info msg=" _ _ _" subsys=daemon
2019-11-30T04:40:29.815043379Z level=info msg=" ___|_| |_|_ _ _____" subsys=daemon
2019-11-30T04:40:29.815048996Z level=info msg="| _| | | | | | |" subsys=daemon
2019-11-30T04:40:29.815054641Z level=info msg="|___|_|_|_|___|_|_|_|" subsys=daemon
2019-11-30T04:40:29.815062348Z level=info msg="Cilium 1.6.90 dd377de59 2019-11-28T16:23:37+01:00 go version go1.13.4 linux/amd64" subsys=daemon
2019-11-30T04:40:29.844800358Z level=info msg="cilium-envoy version: 7f6cab51ea2f4692a3e1067e1060f42818324bc2/1.12.1/Modified/RELEASE/BoringSSL" subsys=daemon
2019-11-30T04:40:29.944067582Z level=info msg="clang (7.0.0) and kernel (4.19.84) versions: OK!" subsys=linux-datapath
2019-11-30T04:40:29.96206787Z level=info msg="linking environment: OK!" subsys=linux-datapath
2019-11-30T04:40:32.551701285Z level=info msg="bpf_requirements check: OK!" subsys=linux-datapath
2019-11-30T04:40:32.551755935Z level=info msg="bpf_features check: OK!" subsys=linux-datapath
2019-11-30T04:40:32.551764468Z level=debug msg="Detected support for map type Longest prefix match trie" subsys=bpf
2019-11-30T04:40:32.551770832Z level=debug msg="Detected support for map type LRU hash" subsys=bpf
2019-11-30T04:40:32.551777059Z level=debug msg="Skipping support detection for map type Hash" subsys=bpf
2019-11-30T04:40:32.551783022Z level=debug msg="Skipping support detection for map type Array" subsys=bpf
2019-11-30T04:40:32.551795852Z level=debug msg="Skipping support detection for map type Program array" subsys=bpf
2019-11-30T04:40:32.551944566Z level=debug msg="Skipping support detection for map type Event array" subsys=bpf
2019-11-30T04:40:32.551957888Z level=debug msg="Skipping support detection for map type Per-CPU hash" subsys=bpf
2019-11-30T04:40:32.551964157Z level=debug msg="Skipping support detection for map type Per-CPU array" subsys=bpf
2019-11-30T04:40:32.551970228Z level=debug msg="Skipping support detection for map type Stack trace" subsys=bpf
2019-11-30T04:40:32.551976123Z level=debug msg="Skipping support detection for map type Cgroup array" subsys=bpf
2019-11-30T04:40:32.55198202Z level=debug msg="Skipping support detection for map type LRU per-CPU hash" subsys=bpf
2019-11-30T04:40:32.551988011Z level=debug msg="Skipping support detection for map type Array of maps" subsys=bpf
2019-11-30T04:40:32.552007432Z level=debug msg="Skipping support detection for map type Hash of maps" subsys=bpf
2019-11-30T04:40:32.552014542Z level=debug msg="Skipping support detection for map type Device Map" subsys=bpf
2019-11-30T04:40:32.5520206Z level=debug msg="Skipping support detection for map type Socket Map" subsys=bpf
2019-11-30T04:40:32.552026519Z level=debug msg="Skipping support detection for map type CPU Redirect Map" subsys=bpf
2019-11-30T04:40:32.552032454Z level=debug msg="Skipping support detection for map type Unknown" subsys=bpf
2019-11-30T04:40:32.552038339Z level=debug msg="Skipping support detection for map type Socket Hash" subsys=bpf
2019-11-30T04:40:32.55242856Z level=info msg="Detected mounted BPF filesystem at /sys/fs/bpf" subsys=bpf
2019-11-30T04:40:32.55348963Z level=info msg="Valid label prefix configuration:" subsys=labels-filter
2019-11-30T04:40:32.553654142Z level=info msg=" - :io.kubernetes.pod.namespace" subsys=labels-filter
2019-11-30T04:40:32.553669021Z level=info msg=" - :io.cilium.k8s.namespace.labels" subsys=labels-filter
2019-11-30T04:40:32.553675696Z level=info msg=" - :app.kubernetes.io" subsys=labels-filter
2019-11-30T04:40:32.553681894Z level=info msg=" - !:io.kubernetes" subsys=labels-filter
2019-11-30T04:40:32.553687828Z level=info msg=" - !:kubernetes.io" subsys=labels-filter
2019-11-30T04:40:32.55369385Z level=info msg=" - !:.*beta.kubernetes.io" subsys=labels-filter
2019-11-30T04:40:32.553699893Z level=info msg=" - !:k8s.io" subsys=labels-filter
2019-11-30T04:40:32.553705848Z level=info msg=" - !:pod-template-generation" subsys=labels-filter
2019-11-30T04:40:32.55371167Z level=info msg=" - !:pod-template-hash" subsys=labels-filter
2019-11-30T04:40:32.553717502Z level=info msg=" - !:controller-revision-hash" subsys=labels-filter
2019-11-30T04:40:32.553723364Z level=info msg=" - !:annotation.*" subsys=labels-filter
2019-11-30T04:40:32.55372915Z level=info msg=" - !:etcd_node" subsys=labels-filter
2019-11-30T04:40:32.554359706Z level=debug msg="Found default route on node {Ifindex: 2 Dst: <nil> Src: 192.168.1.177 Gw: 192.168.1.250 Flags: [] Table: 254}" subsys=route
2019-11-30T04:40:32.554523209Z level=info msg="Using auto-derived device for BPF node port" interface=eth0 subsys=daemon
2019-11-30T04:40:32.554985036Z level=info msg="Using autogenerated IPv4 allocation range" subsys=node v4Prefix=10.177.0.0/16
2019-11-30T04:40:32.555158664Z level=info msg="Initializing daemon" subsys=daemon
2019-11-30T04:40:32.561548071Z level=info msg="Detected MTU 1500" subsys=mtu
2019-11-30T04:40:32.561889091Z level=debug msg="getting identity cache for identity allocator manager" subsys=identity-cache
2019-11-30T04:40:32.561979812Z level=debug msg="creating new EventQueue" name=repository-change-queue numBufferedEvents=100 subsys=eventqueue
2019-11-30T04:40:32.562004303Z level=debug msg="creating new EventQueue" name=repository-reaction-queue numBufferedEvents=100 subsys=eventqueue
2019-11-30T04:40:32.562328869Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_lxc subsys=bpf
2019-11-30T04:40:32.562419511Z level=debug msg="Opening map in parallel mode" file-path=/sys/fs/bpf/tc/globals/cilium_ipcache name=cilium_ipcache subsys=bpf
2019-11-30T04:40:32.562442967Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_ipcache subsys=bpf
2019-11-30T04:40:32.562605472Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_metrics subsys=bpf
2019-11-30T04:40:32.563526368Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_tunnel_map subsys=bpf
2019-11-30T04:40:32.563663506Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_lb4_services_v2 subsys=bpf
2019-11-30T04:40:32.563900856Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=1m0s
2019-11-30T04:40:32.564023683Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_lb4_backends subsys=bpf
2019-11-30T04:40:32.564138286Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_lb4_reverse_nat subsys=bpf
2019-11-30T04:40:32.564651937Z level=debug msg="Starting new controller" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:32.565724779Z level=debug msg="Controller func execution time: 912.994µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:32.566677395Z level=debug msg="created new LBBackend" backend="{79 {10.2.3.191 {NONE 5432}}}" subsys=loadbalancer
2019-11-30T04:40:32.566698927Z level=debug msg="created new LBBackend" backend="{12 {10.2.2.142 {NONE 53}}}" subsys=loadbalancer
2019-11-30T04:40:32.566706261Z level=debug msg="created new LBBackend" backend="{13 {10.2.2.142 {NONE 9153}}}" subsys=loadbalancer
2019-11-30T04:40:32.566712695Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.566718922Z level=debug msg="created new LBBackend" backend="{20 {10.2.0.253 {NONE 53}}}" subsys=loadbalancer
2019-11-30T04:40:32.56682775Z level=debug msg="created new LBBackend" backend="{21 {10.2.0.253 {NONE 9153}}}" subsys=loadbalancer
2019-11-30T04:40:32.566840167Z level=debug msg="created new LBBackend" backend="{8 {10.2.3.225 {NONE 44134}}}" subsys=loadbalancer
2019-11-30T04:40:32.56684673Z level=debug msg="created new LBBackend" backend="{1 {10.2.4.29 {NONE 8989}}}" subsys=loadbalancer
2019-11-30T04:40:32.566853017Z level=debug msg="created new LBBackend" backend="{86 {192.168.1.175 {NONE 443}}}" subsys=loadbalancer
2019-11-30T04:40:32.566859203Z level=debug msg="created new LBBackend" backend="{83 {192.168.1.177 {NONE 443}}}" subsys=loadbalancer
2019-11-30T04:40:32.566865485Z level=debug msg="created new LBBackend" backend="{3 {10.2.4.31 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.566871542Z level=debug msg="created new LBBackend" backend="{2 {192.168.1.175 {NONE 2379}}}" subsys=loadbalancer
2019-11-30T04:40:32.566877688Z level=debug msg="created new LBBackend" backend="{85 {192.168.1.176 {NONE 443}}}" subsys=loadbalancer
2019-11-30T04:40:32.566985636Z level=debug msg="created new LBBackend" backend="{6 {10.2.5.91 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.566998523Z level=debug msg="created new LBBackend" backend="{7 {192.168.1.185 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.567005113Z level=debug msg="created new LBBackend" backend="{75 {10.2.5.218 {NONE 5432}}}" subsys=loadbalancer
2019-11-30T04:40:32.567011383Z level=debug msg="Restoring backend" backendID=79 l3n4Addr="10.2.3.191:5432" subsys=service
2019-11-30T04:40:32.567017645Z level=debug msg="Restoring backend" backendID=12 l3n4Addr="10.2.2.142:53" subsys=service
2019-11-30T04:40:32.567023905Z level=debug msg="Restoring backend" backendID=13 l3n4Addr="10.2.2.142:9153" subsys=service
2019-11-30T04:40:32.567029911Z level=debug msg="Restoring backend" backendID=17 l3n4Addr="10.2.3.135:32400" subsys=service
2019-11-30T04:40:32.567108422Z level=debug msg="Restoring backend" backendID=20 l3n4Addr="10.2.0.253:53" subsys=service
2019-11-30T04:40:32.567132719Z level=debug msg="Restoring backend" backendID=21 l3n4Addr="10.2.0.253:9153" subsys=service
2019-11-30T04:40:32.567140528Z level=debug msg="Restoring backend" backendID=8 l3n4Addr="10.2.3.225:44134" subsys=service
2019-11-30T04:40:32.56714686Z level=debug msg="Restoring backend" backendID=1 l3n4Addr="10.2.4.29:8989" subsys=service
2019-11-30T04:40:32.567152919Z level=debug msg="Restoring backend" backendID=86 l3n4Addr="192.168.1.175:443" subsys=service
2019-11-30T04:40:32.567159076Z level=debug msg="Restoring backend" backendID=83 l3n4Addr="192.168.1.177:443" subsys=service
2019-11-30T04:40:32.567231917Z level=debug msg="Restoring backend" backendID=3 l3n4Addr="10.2.4.31:8081" subsys=service
2019-11-30T04:40:32.567243537Z level=debug msg="Restoring backend" backendID=2 l3n4Addr="192.168.1.175:2379" subsys=service
2019-11-30T04:40:32.567266428Z level=debug msg="Restoring backend" backendID=85 l3n4Addr="192.168.1.176:443" subsys=service
2019-11-30T04:40:32.567272708Z level=debug msg="Restoring backend" backendID=6 l3n4Addr="10.2.5.91:8081" subsys=service
2019-11-30T04:40:32.567344742Z level=debug msg="Restoring backend" backendID=7 l3n4Addr="192.168.1.185:8081" subsys=service
2019-11-30T04:40:32.567356037Z level=debug msg="Restoring backend" backendID=75 l3n4Addr="10.2.5.218:5432" subsys=service
2019-11-30T04:40:32.567689504Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.177 {NONE 31105}}" subsys=loadbalancer
2019-11-30T04:40:32.567708202Z level=debug msg="created new LBBackend" backend="{3 {10.2.4.31 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.567820039Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.51 {NONE 32400}}" subsys=loadbalancer
2019-11-30T04:40:32.567833418Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.567914436Z level=debug msg="created new L3n4Addr" ipAddr="{0.0.0.0 {NONE 30223}}" subsys=loadbalancer
2019-11-30T04:40:32.567946667Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.568025627Z level=debug msg="created new L3n4Addr" ipAddr="{10.2.2.34 {NONE 31105}}" subsys=loadbalancer
2019-11-30T04:40:32.568050596Z level=debug msg="created new LBBackend" backend="{3 {10.2.4.31 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.568059639Z level=debug msg="created new L3n4Addr" ipAddr="{10.2.2.34 {NONE 30255}}" subsys=loadbalancer
2019-11-30T04:40:32.568066004Z level=debug msg="created new LBBackend" backend="{6 {10.2.5.91 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.568138413Z level=debug msg="created new L3n4Addr" ipAddr="{0.0.0.0 {NONE 32352}}" subsys=loadbalancer
2019-11-30T04:40:32.568149685Z level=debug msg="created new LBBackend" backend="{1 {10.2.4.29 {NONE 8989}}}" subsys=loadbalancer
2019-11-30T04:40:32.56823743Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.54 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.568248908Z level=debug msg="created new LBBackend" backend="{3 {10.2.4.31 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.568345507Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.177 {NONE 32352}}" subsys=loadbalancer
2019-11-30T04:40:32.568368959Z level=debug msg="created new LBBackend" backend="{1 {10.2.4.29 {NONE 8989}}}" subsys=loadbalancer
2019-11-30T04:40:32.56837585Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.4.164 {NONE 44134}}" subsys=loadbalancer
2019-11-30T04:40:32.568459491Z level=debug msg="created new LBBackend" backend="{8 {10.2.3.225 {NONE 44134}}}" subsys=loadbalancer
2019-11-30T04:40:32.568549935Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.26.94 {NONE 5432}}" subsys=loadbalancer
2019-11-30T04:40:32.568561339Z level=debug msg="created new LBBackend" backend="{75 {10.2.5.218 {NONE 5432}}}" subsys=loadbalancer
2019-11-30T04:40:32.568729165Z level=debug msg="created new L3n4Addr" ipAddr="{0.0.0.0 {NONE 30255}}" subsys=loadbalancer
2019-11-30T04:40:32.568742366Z level=debug msg="created new LBBackend" backend="{6 {10.2.5.91 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.568821725Z level=debug msg="created new L3n4Addr" ipAddr="{10.2.2.34 {NONE 32300}}" subsys=loadbalancer
2019-11-30T04:40:32.568844894Z level=debug msg="created new LBBackend" backend="{7 {192.168.1.185 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.568914952Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.52 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.568926305Z level=debug msg="created new LBBackend" backend="{6 {10.2.5.91 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.569020199Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.0.10 {NONE 53}}" subsys=loadbalancer
2019-11-30T04:40:32.569043599Z level=debug msg="created new LBBackend" backend="{20 {10.2.0.253 {NONE 53}}}" subsys=loadbalancer
2019-11-30T04:40:32.56912594Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.177 {NONE 32300}}" subsys=loadbalancer
2019-11-30T04:40:32.569157519Z level=debug msg="created new LBBackend" backend="{7 {192.168.1.185 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.569234329Z level=debug msg="created new L3n4Addr" ipAddr="{0.0.0.0 {NONE 31105}}" subsys=loadbalancer
2019-11-30T04:40:32.569258722Z level=debug msg="created new LBBackend" backend="{3 {10.2.4.31 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.569267935Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.0.15 {NONE 2379}}" subsys=loadbalancer
2019-11-30T04:40:32.569274155Z level=debug msg="created new LBBackend" backend="{2 {192.168.1.175 {NONE 2379}}}" subsys=loadbalancer
2019-11-30T04:40:32.569410535Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.97.96 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.569423778Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.569507921Z level=debug msg="created new L3n4Addr" ipAddr="{10.2.2.34 {NONE 30274}}" subsys=loadbalancer
2019-11-30T04:40:32.569533092Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.569539813Z level=debug msg="created new L3n4Addr" ipAddr="{0.0.0.0 {NONE 32300}}" subsys=loadbalancer
2019-11-30T04:40:32.56960662Z level=debug msg="created new LBBackend" backend="{7 {192.168.1.185 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.569652464Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.0.10 {NONE 53}}" subsys=loadbalancer
2019-11-30T04:40:32.569662372Z level=debug msg="created new LBBackend" backend="{12 {10.2.2.142 {NONE 53}}}" subsys=loadbalancer
2019-11-30T04:40:32.569740261Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.108.85 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.569752152Z level=debug msg="created new LBBackend" backend="{3 {10.2.4.31 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.569853921Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.0.1 {NONE 443}}" subsys=loadbalancer
2019-11-30T04:40:32.569865843Z level=debug msg="created new LBBackend" backend="{85 {192.168.1.176 {NONE 443}}}" subsys=loadbalancer
2019-11-30T04:40:32.569872187Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.46.244 {NONE 2379}}" subsys=loadbalancer
2019-11-30T04:40:32.569878496Z level=debug msg="created new LBBackend" backend="{2 {192.168.1.175 {NONE 2379}}}" subsys=loadbalancer
2019-11-30T04:40:32.569980396Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.97.96 {NONE 32400}}" subsys=loadbalancer
2019-11-30T04:40:32.569992153Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.569998761Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.0.10 {NONE 9153}}" subsys=loadbalancer
2019-11-30T04:40:32.570005009Z level=debug msg="created new LBBackend" backend="{21 {10.2.0.253 {NONE 9153}}}" subsys=loadbalancer
2019-11-30T04:40:32.570159964Z level=debug msg="created new L3n4Addr" ipAddr="{0.0.0.0 {NONE 30274}}" subsys=loadbalancer
2019-11-30T04:40:32.57021353Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.570256517Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.0.10 {NONE 9153}}" subsys=loadbalancer
2019-11-30T04:40:32.570264704Z level=debug msg="created new LBBackend" backend="{13 {10.2.2.142 {NONE 9153}}}" subsys=loadbalancer
2019-11-30T04:40:32.570364511Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.0.1 {NONE 443}}" subsys=loadbalancer
2019-11-30T04:40:32.570375742Z level=debug msg="created new LBBackend" backend="{83 {192.168.1.177 {NONE 443}}}" subsys=loadbalancer
2019-11-30T04:40:32.570382082Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.177 {NONE 30255}}" subsys=loadbalancer
2019-11-30T04:40:32.570388357Z level=debug msg="created new LBBackend" backend="{6 {10.2.5.91 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.57057145Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.51 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.570664041Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.570708582Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.177 {NONE 30274}}" subsys=loadbalancer
2019-11-30T04:40:32.570718341Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.570886531Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.0.1 {NONE 443}}" subsys=loadbalancer
2019-11-30T04:40:32.570898688Z level=debug msg="created new LBBackend" backend="{86 {192.168.1.175 {NONE 443}}}" subsys=loadbalancer
2019-11-30T04:40:32.570905234Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.53 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.570911301Z level=debug msg="created new LBBackend" backend="{1 {10.2.4.29 {NONE 8989}}}" subsys=loadbalancer
2019-11-30T04:40:32.570917514Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.26.94 {NONE 5432}}" subsys=loadbalancer
2019-11-30T04:40:32.570923705Z level=debug msg="created new LBBackend" backend="{79 {10.2.3.191 {NONE 5432}}}" subsys=loadbalancer
2019-11-30T04:40:32.570989571Z level=debug msg="created new L3n4Addr" ipAddr="{10.2.2.34 {NONE 32352}}" subsys=loadbalancer
2019-11-30T04:40:32.570998384Z level=debug msg="created new LBBackend" backend="{1 {10.2.4.29 {NONE 8989}}}" subsys=loadbalancer
2019-11-30T04:40:32.571127823Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.2.207 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.571203626Z level=debug msg="created new LBBackend" backend="{7 {192.168.1.185 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.571214603Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.7.112 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.571220825Z level=debug msg="created new LBBackend" backend="{1 {10.2.4.29 {NONE 8989}}}" subsys=loadbalancer
2019-11-30T04:40:32.571227029Z level=debug msg="created new L3n4Addr" ipAddr="{10.2.2.34 {NONE 30223}}" subsys=loadbalancer
2019-11-30T04:40:32.571325612Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.571487648Z level=debug msg="created new L3n4Addr" ipAddr="{10.3.154.48 {NONE 80}}" subsys=loadbalancer
2019-11-30T04:40:32.571590774Z level=debug msg="created new LBBackend" backend="{6 {10.2.5.91 {NONE 8081}}}" subsys=loadbalancer
2019-11-30T04:40:32.571601952Z level=debug msg="created new L3n4Addr" ipAddr="{192.168.1.177 {NONE 30223}}" subsys=loadbalancer
2019-11-30T04:40:32.571608211Z level=debug msg="created new LBBackend" backend="{17 {10.2.3.135 {NONE 32400}}}" subsys=loadbalancer
2019-11-30T04:40:32.571675318Z level=debug msg="Restoring service" serviceID=28 serviceIP="0.0.0.0:30255" subsys=service
2019-11-30T04:40:32.571713945Z level=debug msg="Restoring service" l3n4Addr="{IP:0.0.0.0 L4Addr:{Protocol:NONE Port:30255}}" subsys=service
2019-11-30T04:40:32.571805437Z level=debug msg="Restoring service" serviceID=39 serviceIP="192.168.1.177:32300" subsys=service
2019-11-30T04:40:32.571817815Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.177 L4Addr:{Protocol:NONE Port:32300}}" subsys=service
2019-11-30T04:40:32.571824258Z level=debug msg="Restoring service" serviceID=1 serviceIP="10.3.97.96:80" subsys=service
2019-11-30T04:40:32.57192822Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.97.96 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.572231583Z level=debug msg="Restoring service" serviceID=43 serviceIP="10.3.0.1:443" subsys=service
2019-11-30T04:40:32.572341313Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.0.1 L4Addr:{Protocol:NONE Port:443}}" subsys=service
2019-11-30T04:40:32.572380059Z level=debug msg="Restoring service" serviceID=26 serviceIP="10.3.154.48:80" subsys=service
2019-11-30T04:40:32.572386832Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.154.48 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.572477859Z level=debug msg="Restoring service" serviceID=30 serviceIP="10.2.2.34:30255" subsys=service
2019-11-30T04:40:32.572574193Z level=debug msg="Restoring service" l3n4Addr="{IP:10.2.2.34 L4Addr:{Protocol:NONE Port:30255}}" subsys=service
2019-11-30T04:40:32.572582132Z level=debug msg="Restoring service" serviceID=37 serviceIP="10.2.2.34:32300" subsys=service
2019-11-30T04:40:32.572694219Z level=debug msg="Restoring service" l3n4Addr="{IP:10.2.2.34 L4Addr:{Protocol:NONE Port:32300}}" subsys=service
2019-11-30T04:40:32.572760366Z level=debug msg="Restoring service" serviceID=29 serviceIP="192.168.1.177:30255" subsys=service
2019-11-30T04:40:32.572770336Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.177 L4Addr:{Protocol:NONE Port:30255}}" subsys=service
2019-11-30T04:40:32.572776804Z level=debug msg="Restoring service" serviceID=11 serviceIP="10.3.7.112:80" subsys=service
2019-11-30T04:40:32.572856896Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.7.112 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.572949922Z level=debug msg="Restoring service" serviceID=4 serviceIP="192.168.1.51:32400" subsys=service
2019-11-30T04:40:32.572998627Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.51 L4Addr:{Protocol:NONE Port:32400}}" subsys=service
2019-11-30T04:40:32.57317159Z level=debug msg="Restoring service" serviceID=20 serviceIP="0.0.0.0:31105" subsys=service
2019-11-30T04:40:32.573184657Z level=debug msg="Restoring service" l3n4Addr="{IP:0.0.0.0 L4Addr:{Protocol:NONE Port:31105}}" subsys=service
2019-11-30T04:40:32.573217124Z level=debug msg="Restoring service" serviceID=38 serviceIP="0.0.0.0:32300" subsys=service
2019-11-30T04:40:32.573228167Z level=debug msg="Restoring service" l3n4Addr="{IP:0.0.0.0 L4Addr:{Protocol:NONE Port:32300}}" subsys=service
2019-11-30T04:40:32.573269587Z level=debug msg="Restoring service" serviceID=18 serviceIP="10.3.108.85:80" subsys=service
2019-11-30T04:40:32.57327629Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.108.85 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.57328441Z level=debug msg="Restoring service" serviceID=17 serviceIP="10.3.46.244:2379" subsys=service
2019-11-30T04:40:32.573290893Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.46.244 L4Addr:{Protocol:NONE Port:2379}}" subsys=service
2019-11-30T04:40:32.573297234Z level=debug msg="Restoring service" serviceID=36 serviceIP="10.3.2.207:80" subsys=service
2019-11-30T04:40:32.573303331Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.2.207 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.573309565Z level=debug msg="Restoring service" serviceID=27 serviceIP="192.168.1.52:80" subsys=service
2019-11-30T04:40:32.573356867Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.52 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.57336857Z level=debug msg="Restoring service" serviceID=24 serviceIP="10.3.0.10:53" subsys=service
2019-11-30T04:40:32.573375104Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.0.10 L4Addr:{Protocol:NONE Port:53}}" subsys=service
2019-11-30T04:40:32.573409882Z level=debug msg="Restoring service" serviceID=10 serviceIP="10.2.2.34:30274" subsys=service
2019-11-30T04:40:32.57349902Z level=debug msg="Restoring service" l3n4Addr="{IP:10.2.2.34 L4Addr:{Protocol:NONE Port:30274}}" subsys=service
2019-11-30T04:40:32.57350812Z level=debug msg="Restoring service" serviceID=9 serviceIP="192.168.1.177:30274" subsys=service
2019-11-30T04:40:32.573514431Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.177 L4Addr:{Protocol:NONE Port:30274}}" subsys=service
2019-11-30T04:40:32.573520737Z level=debug msg="Restoring service" serviceID=15 serviceIP="10.2.2.34:32352" subsys=service
2019-11-30T04:40:32.573527134Z level=debug msg="Restoring service" l3n4Addr="{IP:10.2.2.34 L4Addr:{Protocol:NONE Port:32352}}" subsys=service
2019-11-30T04:40:32.573533422Z level=debug msg="Restoring service" serviceID=6 serviceIP="192.168.1.177:30223" subsys=service
2019-11-30T04:40:32.573539534Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.177 L4Addr:{Protocol:NONE Port:30223}}" subsys=service
2019-11-30T04:40:32.573582456Z level=debug msg="Restoring service" serviceID=13 serviceIP="0.0.0.0:32352" subsys=service
2019-11-30T04:40:32.573592134Z level=debug msg="Restoring service" l3n4Addr="{IP:0.0.0.0 L4Addr:{Protocol:NONE Port:32352}}" subsys=service
2019-11-30T04:40:32.573598254Z level=debug msg="Restoring service" serviceID=19 serviceIP="192.168.1.54:80" subsys=service
2019-11-30T04:40:32.573604493Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.54 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.573610619Z level=debug msg="Restoring service" serviceID=42 serviceIP="10.3.26.94:5432" subsys=service
2019-11-30T04:40:32.573642527Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.26.94 L4Addr:{Protocol:NONE Port:5432}}" subsys=service
2019-11-30T04:40:32.573650393Z level=debug msg="Restoring service" serviceID=41 serviceIP="10.3.0.15:2379" subsys=service
2019-11-30T04:40:32.573656536Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.0.15 L4Addr:{Protocol:NONE Port:2379}}" subsys=service
2019-11-30T04:40:32.573662633Z level=debug msg="Restoring service" serviceID=2 serviceIP="10.3.97.96:32400" subsys=service
2019-11-30T04:40:32.573668842Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.97.96 L4Addr:{Protocol:NONE Port:32400}}" subsys=service
2019-11-30T04:40:32.573675117Z level=debug msg="Restoring service" serviceID=25 serviceIP="10.3.0.10:9153" subsys=service
2019-11-30T04:40:32.573681317Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.0.10 L4Addr:{Protocol:NONE Port:9153}}" subsys=service
2019-11-30T04:40:32.57368932Z level=debug msg="Restoring service" serviceID=5 serviceIP="0.0.0.0:30223" subsys=service
2019-11-30T04:40:32.57369569Z level=debug msg="Restoring service" l3n4Addr="{IP:0.0.0.0 L4Addr:{Protocol:NONE Port:30223}}" subsys=service
2019-11-30T04:40:32.573701796Z level=debug msg="Restoring service" serviceID=40 serviceIP="10.3.4.164:44134" subsys=service
2019-11-30T04:40:32.573727917Z level=debug msg="Restoring service" l3n4Addr="{IP:10.3.4.164 L4Addr:{Protocol:NONE Port:44134}}" subsys=service
2019-11-30T04:40:32.573734467Z level=debug msg="Restoring service" serviceID=22 serviceIP="10.2.2.34:31105" subsys=service
2019-11-30T04:40:32.57374058Z level=debug msg="Restoring service" l3n4Addr="{IP:10.2.2.34 L4Addr:{Protocol:NONE Port:31105}}" subsys=service
2019-11-30T04:40:32.573746528Z level=debug msg="Restoring service" serviceID=14 serviceIP="192.168.1.177:32352" subsys=service
2019-11-30T04:40:32.573752514Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.177 L4Addr:{Protocol:NONE Port:32352}}" subsys=service
2019-11-30T04:40:32.573758691Z level=debug msg="Restoring service" serviceID=7 serviceIP="10.2.2.34:30223" subsys=service
2019-11-30T04:40:32.573764705Z level=debug msg="Restoring service" l3n4Addr="{IP:10.2.2.34 L4Addr:{Protocol:NONE Port:30223}}" subsys=service
2019-11-30T04:40:32.573771231Z level=debug msg="Restoring service" serviceID=21 serviceIP="192.168.1.177:31105" subsys=service
2019-11-30T04:40:32.573777425Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.177 L4Addr:{Protocol:NONE Port:31105}}" subsys=service
2019-11-30T04:40:32.573808103Z level=debug msg="Restoring service" serviceID=8 serviceIP="0.0.0.0:30274" subsys=service
2019-11-30T04:40:32.573816657Z level=debug msg="Restoring service" l3n4Addr="{IP:0.0.0.0 L4Addr:{Protocol:NONE Port:30274}}" subsys=service
2019-11-30T04:40:32.573822938Z level=debug msg="Restoring service" serviceID=3 serviceIP="192.168.1.51:80" subsys=service
2019-11-30T04:40:32.573828978Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.51 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.573835221Z level=debug msg="Restoring service" serviceID=12 serviceIP="192.168.1.53:80" subsys=service
2019-11-30T04:40:32.573841398Z level=debug msg="Restoring service" l3n4Addr="{IP:192.168.1.53 L4Addr:{Protocol:NONE Port:80}}" subsys=service
2019-11-30T04:40:32.573847411Z level=info msg="Restored services from maps" failed=0 restored=36 subsys=service
2019-11-30T04:40:32.573897552Z level=info msg="Removing stale endpoint interfaces" subsys=daemon
2019-11-30T04:40:32.577294704Z level=info msg="Establishing connection to apiserver" host="https://k8s.hsv-a.ceh.im:443" subsys=k8s
2019-11-30T04:40:32.601046749Z level=info msg="Connected to apiserver" subsys=k8s
2019-11-30T04:40:32.608125698Z level=debug msg="Add NodeCiliumInternalIP: 10.2.2.34" k8sNodeID=0a8fbdc7-e26b-11e7-8c06-3a07a724a23f nodeName=k8s-master-2 subsys=k8s
2019-11-30T04:40:32.608180927Z level=debug msg="Missing io.cilium.network.ipv6-cilium-host. Annotation required when IPSec Enabled" k8sNodeID=0a8fbdc7-e26b-11e7-8c06-3a07a724a23f nodeName=k8s-master-2 subsys=k8s
2019-11-30T04:40:32.60818981Z level=debug msg="Empty IPv6 CIDR annotation in node" k8sNodeID=0a8fbdc7-e26b-11e7-8c06-3a07a724a23f nodeName=k8s-master-2 subsys=k8s
2019-11-30T04:40:32.608196752Z level=debug msg="Empty IPv6 health endpoint annotation in node" k8sNodeID=0a8fbdc7-e26b-11e7-8c06-3a07a724a23f nodeName=k8s-master-2 subsys=k8s
2019-11-30T04:40:32.60820339Z level=info msg="Retrieved node information from kubernetes" nodeName=k8s-master-2 subsys=k8s
2019-11-30T04:40:32.608209809Z level=info msg="Received own node information from API server" ipAddr.ipv4=192.168.1.177 ipAddr.ipv6="<nil>" nodeName=k8s-master-2 subsys=k8s v4Prefix=10.2.2.0/24 v6Prefix="<nil>"
2019-11-30T04:40:32.677709719Z level=debug msg="Checking if CRD (CustomResourceDefinition) needs update..." name=CiliumNetworkPolicy/v2 subsys=k8s
2019-11-30T04:40:32.677964851Z level=debug msg="Waiting for CRD (CustomResourceDefinition) to be available..." name=CiliumNetworkPolicy/v2 subsys=k8s
2019-11-30T04:40:33.256215623Z level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=CiliumNetworkPolicy/v2 subsys=k8s
2019-11-30T04:40:33.3218384Z level=debug msg="Checking if CRD (CustomResourceDefinition) needs update..." name=CiliumClusterwideNetworkPolicy/v2 subsys=k8s
2019-11-30T04:40:33.3218707Z level=debug msg="Waiting for CRD (CustomResourceDefinition) to be available..." name=CiliumClusterwideNetworkPolicy/v2 subsys=k8s
2019-11-30T04:40:33.872713748Z level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=CiliumClusterwideNetworkPolicy/v2 subsys=k8s
2019-11-30T04:40:33.877495159Z level=debug msg="Checking if CRD (CustomResourceDefinition) needs update..." name=v2.CiliumEndpoint subsys=k8s
2019-11-30T04:40:33.877515485Z level=info msg="Updating CRD (CustomResourceDefinition)..." name=v2.CiliumEndpoint subsys=k8s
2019-11-30T04:40:34.383548146Z level=debug msg="CRD validation is different, updating it..." name=v2.CiliumEndpoint subsys=k8s
2019-11-30T04:40:34.389988199Z level=debug msg="Waiting for CRD (CustomResourceDefinition) to be available..." name=v2.CiliumEndpoint subsys=k8s
2019-11-30T04:40:34.895702903Z level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=v2.CiliumEndpoint subsys=k8s
2019-11-30T04:40:34.900134313Z level=debug msg="Checking if CRD (CustomResourceDefinition) needs update..." name=v2.CiliumNode subsys=k8s
2019-11-30T04:40:34.900157202Z level=info msg="Updating CRD (CustomResourceDefinition)..." name=v2.CiliumNode subsys=k8s
2019-11-30T04:40:35.407785938Z level=debug msg="CRD validation is different, updating it..." name=v2.CiliumNode subsys=k8s
2019-11-30T04:40:35.416271791Z level=debug msg="Waiting for CRD (CustomResourceDefinition) to be available..." name=v2.CiliumNode subsys=k8s
2019-11-30T04:40:35.921684996Z level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=v2.CiliumNode subsys=k8s
2019-11-30T04:40:35.924900378Z level=debug msg="Checking if CRD (CustomResourceDefinition) needs update..." name=v2.CiliumIdentity subsys=k8s
2019-11-30T04:40:35.924979846Z level=info msg="Updating CRD (CustomResourceDefinition)..." name=v2.CiliumIdentity subsys=k8s
2019-11-30T04:40:36.429891059Z level=debug msg="CRD validation is different, updating it..." name=v2.CiliumIdentity subsys=k8s
2019-11-30T04:40:36.435700849Z level=debug msg="Waiting for CRD (CustomResourceDefinition) to be available..." name=v2.CiliumIdentity subsys=k8s
2019-11-30T04:40:36.940403714Z level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=v2.CiliumIdentity subsys=k8s
2019-11-30T04:40:36.940600354Z level=info msg="k8s mode: Allowing localhost to reach local endpoints" subsys=daemon
2019-11-30T04:40:36.940765528Z level=info msg="Initializing node addressing" subsys=daemon
2019-11-30T04:40:36.941168766Z level=info msg="Restored IPv4 internal node IP: 10.2.2.34" subsys=node
2019-11-30T04:40:36.941356389Z level=info msg="Initializing hostscope IPAM" subsys=ipam v4Prefix=10.2.2.0/24 v6Prefix="<nil>"
2019-11-30T04:40:36.942051972Z level=info msg="Restoring endpoints..." subsys=daemon
2019-11-30T04:40:36.942351032Z level=info msg="Envoy: Starting xDS gRPC server listening on /var/run/cilium/xds.sock" subsys=envoy-manager
2019-11-30T04:40:36.943487083Z level=debug msg="Reading directory" endpointID=624 file-path=/var/run/cilium/state/624/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.943834109Z level=debug msg="Found endpoint C header file" endpointID=624 file-path=/var/run/cilium/state/624/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.94485077Z level=debug msg="Endpoint restoring" code=OK containerID=b37a49753d datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=624 endpointState=restoring identity=5476 ipv4=10.2.2.132 ipv6= k8sPodName=kube-system/hoten-71t7rcjw-2wj2q policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.945002162Z level=debug msg="Reading directory" endpointID=734 file-path=/var/run/cilium/state/734/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.945236994Z level=debug msg="Found endpoint C header file" endpointID=734 file-path=/var/run/cilium/state/734/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.945683863Z level=debug msg="Endpoint restoring" code=OK containerID=2af96594a4 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=734 endpointState=restoring identity=10886 ipv4=10.2.2.142 ipv6= k8sPodName=kube-system/coredns-5bdbfc54cc-2kcpl policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.945844357Z level=debug msg="Reading directory" endpointID=1153 file-path=/var/run/cilium/state/1153/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.946084552Z level=debug msg="Found endpoint C header file" endpointID=1153 file-path=/var/run/cilium/state/1153/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.946531291Z level=debug msg="Endpoint restoring" code=OK containerID=bc4ef6672c datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1153 endpointState=restoring identity=4323 ipv4=10.2.2.252 ipv6= k8sPodName=kube-system/kube-scheduler-649456995-rb8wj policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.946657954Z level=debug msg="Reading directory" endpointID=156 file-path=/var/run/cilium/state/156/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.946880255Z level=debug msg="Found endpoint C header file" endpointID=156 file-path=/var/run/cilium/state/156/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.947325836Z level=debug msg="Endpoint restoring" code=OK containerID=38c6405aa8 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=156 endpointState=restoring identity=18966 ipv4=10.2.2.76 ipv6= k8sPodName=cluo/container-linux-update-agent-8n7gt policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.947475556Z level=debug msg="Reading directory" endpointID=3528 file-path=/var/run/cilium/state/3528/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.947769351Z level=debug msg="Found endpoint C header file" endpointID=3528 file-path=/var/run/cilium/state/3528/lxc_config.h subsys=endpoint
2019-11-30T04:40:36.948211194Z level=debug msg="Endpoint restoring" code=OK containerID=2bf9d6dc98 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3528 endpointState=restoring identity=31630 ipv4=10.2.2.184 ipv6= k8sPodName=kube-system/kube-controller-manager-6db9948795-frsqx policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.94887888Z level=debug msg="Allocated specific IP" ip=10.2.2.132 owner="kube-system/hoten-71t7rcjw-2wj2q [restored]" subsys=ipam
2019-11-30T04:40:36.949048664Z level=debug msg="Restoring endpoint" endpointID=624 k8sPodName=kube-system/hoten-71t7rcjw-2wj2q subsys=daemon
2019-11-30T04:40:36.949185389Z level=debug msg="Restoring endpoint from previous cilium instance" code=OK containerID=b37a49753d datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=624 endpointState=restoring identity=5476 ipv4=10.2.2.132 ipv6= k8sPodName=kube-system/hoten-71t7rcjw-2wj2q policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.949527247Z level=debug msg="Allocated specific IP" ip=10.2.2.142 owner="kube-system/coredns-5bdbfc54cc-2kcpl [restored]" subsys=ipam
2019-11-30T04:40:36.949672027Z level=debug msg="Restoring endpoint" endpointID=734 k8sPodName=kube-system/coredns-5bdbfc54cc-2kcpl subsys=daemon
2019-11-30T04:40:36.94984949Z level=debug msg="Restoring endpoint from previous cilium instance" code=OK containerID=2af96594a4 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=734 endpointState=restoring identity=10886 ipv4=10.2.2.142 ipv6= k8sPodName=kube-system/coredns-5bdbfc54cc-2kcpl policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.950172708Z level=debug msg="Allocated specific IP" ip=10.2.2.252 owner="kube-system/kube-scheduler-649456995-rb8wj [restored]" subsys=ipam
2019-11-30T04:40:36.950287269Z level=debug msg="Restoring endpoint" endpointID=1153 k8sPodName=kube-system/kube-scheduler-649456995-rb8wj subsys=daemon
2019-11-30T04:40:36.95046792Z level=debug msg="Restoring endpoint from previous cilium instance" code=OK containerID=bc4ef6672c datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1153 endpointState=restoring identity=4323 ipv4=10.2.2.252 ipv6= k8sPodName=kube-system/kube-scheduler-649456995-rb8wj policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.9508344Z level=debug msg="Allocated specific IP" ip=10.2.2.76 owner="cluo/container-linux-update-agent-8n7gt [restored]" subsys=ipam
2019-11-30T04:40:36.950992915Z level=debug msg="Restoring endpoint" endpointID=156 k8sPodName=cluo/container-linux-update-agent-8n7gt subsys=daemon
2019-11-30T04:40:36.951178334Z level=debug msg="Restoring endpoint from previous cilium instance" code=OK containerID=38c6405aa8 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=156 endpointState=restoring identity=18966 ipv4=10.2.2.76 ipv6= k8sPodName=cluo/container-linux-update-agent-8n7gt policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.951496363Z level=debug msg="Allocated specific IP" ip=10.2.2.184 owner="kube-system/kube-controller-manager-6db9948795-frsqx [restored]" subsys=ipam
2019-11-30T04:40:36.951873011Z level=debug msg="Restoring endpoint" endpointID=3528 k8sPodName=kube-system/kube-controller-manager-6db9948795-frsqx subsys=daemon
2019-11-30T04:40:36.952028191Z level=debug msg="Restoring endpoint from previous cilium instance" code=OK containerID=2bf9d6dc98 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3528 endpointState=restoring identity=31630 ipv4=10.2.2.184 ipv6= k8sPodName=kube-system/kube-controller-manager-6db9948795-frsqx policyRevision=0 subsys=endpoint type=0
2019-11-30T04:40:36.952193527Z level=info msg="Endpoints restored" failed=0 restored=5 subsys=daemon
2019-11-30T04:40:36.952364956Z level=debug msg="Allocated specific IP" ip=10.2.2.34 owner=router subsys=ipam
2019-11-30T04:40:36.952473628Z level=info msg="Addressing information:" subsys=daemon
2019-11-30T04:40:36.952659503Z level=info msg=" Cluster-Name: home" subsys=daemon
2019-11-30T04:40:36.95279514Z level=info msg=" Cluster-ID: 0" subsys=daemon
2019-11-30T04:40:36.95295396Z level=info msg=" Local node-name: k8s-master-2" subsys=daemon
2019-11-30T04:40:36.953092028Z level=info msg=" Node-IPv6: <nil>" subsys=daemon
2019-11-30T04:40:36.953177482Z level=info msg=" External-Node IPv4: 192.168.1.177" subsys=daemon
2019-11-30T04:40:36.953298432Z level=info msg=" Internal-Node IPv4: 10.2.2.34" subsys=daemon
2019-11-30T04:40:36.95343672Z level=info msg=" Cluster IPv4 prefix: 10.0.0.0/8" subsys=daemon
2019-11-30T04:40:36.953549013Z level=info msg=" IPv4 allocation prefix: 10.2.2.0/24" subsys=daemon
2019-11-30T04:40:36.9537543Z level=info msg=" Loopback IPv4: 169.254.42.1" subsys=daemon
2019-11-30T04:40:36.954147957Z level=info msg=" Local IPv4 addresses:" subsys=daemon
2019-11-30T04:40:36.954317701Z level=info msg=" - 192.168.1.177" subsys=daemon
2019-11-30T04:40:36.954337841Z level=info msg=" - 10.2.2.34" subsys=daemon
2019-11-30T04:40:36.954456719Z level=debug msg="Allocated random IP" ip=10.2.2.5 owner=health subsys=ipam
2019-11-30T04:40:36.954675318Z level=debug msg="IPv4 health endpoint address: 10.2.2.5" subsys=daemon
2019-11-30T04:40:36.95485949Z level=info msg="Annotating k8s node" subsys=daemon v4CiliumHostIP.IPv4=10.2.2.34 v4Prefix=10.2.2.0/24 v4healthIP.IPv4=10.2.2.5 v6CiliumHostIP.IPv6="<nil>" v6Prefix="<nil>" v6healthIP.IPv6="<nil>"
2019-11-30T04:40:36.955022418Z level=debug msg="Updating node annotations with node CIDRs" key=0 nodeName=k8s-master-2 subsys=k8s v4CiliumHostIP.IPv4=10.2.2.34 v4Prefix=10.2.2.0/24 v4healthIP.IPv4=10.2.2.5 v6CiliumHostIP.IPv6="<nil>" v6Prefix="<nil>" v6healthIP.IPv6="<nil>"
2019-11-30T04:40:36.955195157Z level=debug msg="Starting new controller" name=update-k8s-node-annotations subsys=controller uuid=8dab35db-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:36.95606638Z level=debug msg="Received node update event from local: node.Node{Name:\"k8s-master-2\", Cluster:\"home\", IPAddresses:[]node.Address{node.Address{Type:\"InternalIP\", IP:net.IP{0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xff, 0xff, 0xc0, 0xa8, 0x1, 0xb1}}, node.Address{Type:\"CiliumInternalIP\", IP:net.IP{0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xff, 0xff, 0xa, 0x2, 0x2, 0x22}}}, IPv4AllocCIDR:(*cidr.CIDR)(0xc0000d5120), IPv6AllocCIDR:(*cidr.CIDR)(nil), IPv4HealthIP:net.IP{0xa, 0x2, 0x2, 0x5}, IPv6HealthIP:net.IP(nil), ClusterID:0, Source:\"local\", EncryptionKey:0x0}" subsys=nodemanager
2019-11-30T04:40:36.956268035Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:40:36.95642064Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:40:36.956797213Z level=debug msg="Upserting IP into ipcache layer" identity="{health local}" ipAddr=10.2.2.5 key=0 subsys=ipcache
2019-11-30T04:40:36.956983664Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=health ipAddr="{10.2.2.5 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:40:36.957210025Z level=info msg="Initializing identity allocator" subsys=identity-cache
2019-11-30T04:40:36.957963685Z level=info msg="Cluster-ID is not specified, skipping ClusterMesh initialization" subsys=daemon
2019-11-30T04:40:36.958216397Z level=info msg="Adding local node to cluster" subsys=nodediscovery
2019-11-30T04:40:36.958388886Z level=debug msg="Identity allocation backed by CRD" subsys=identity-cache
2019-11-30T04:40:36.958594218Z level=debug msg="Detach BPF Object:" args="[cgroup detach /var/run/cilium/cgroupv2 sock_ops pinned /sys/fs/bpf/bpf_sockops]" bpftool=bpftool subsys=sockops
2019-11-30T04:40:36.980519721Z level=debug msg="Starting new controller" name=template-dir-watcher subsys=controller uuid=8daf0c65-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:36.980878126Z level=debug msg="writing configuration" file-path=netdev_config.h subsys=datapath-loader
2019-11-30T04:40:36.981400169Z level=info msg="Setting up base BPF datapath" subsys=datapath-loader
2019-11-30T04:40:36.981416878Z level=info msg="Setting sysctl net.core.bpf_jit_enable=1" subsys=datapath-loader
2019-11-30T04:40:36.981565473Z level=info msg="Setting sysctl net.ipv4.conf.all.rp_filter=0" subsys=datapath-loader
2019-11-30T04:40:36.98182937Z level=info msg="Setting sysctl kernel.unprivileged_bpf_disabled=1" subsys=datapath-loader
2019-11-30T04:40:37.00428952Z level=debug msg="Controller func execution time: 48.78494ms" name=update-k8s-node-annotations subsys=controller uuid=8dab35db-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:37.004520699Z level=debug msg="Controller run succeeded; waiting for next controller update or stop" name=update-k8s-node-annotations subsys=controller uuid=8dab35db-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:37.082092748Z level=debug msg="Initial list of identities received" subsys=allocator
2019-11-30T04:40:37.566401658Z level=debug msg="Controller func execution time: 361.373µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:42.567528976Z level=debug msg="Controller func execution time: 571.536µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:47.56933278Z level=debug msg="Controller func execution time: 1.010515ms" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:48.01093132Z level=debug msg="Checking local routes for conflicts..." subsys=ipam
2019-11-30T04:40:48.011557019Z level=debug msg="Ignoring route: no destination address" route="{Ifindex: 2 Dst: <nil> Src: 192.168.1.177 Gw: 192.168.1.250 Flags: [] Table: 254}" subsys=ipam
2019-11-30T04:40:48.011589167Z level=debug msg="Ignoring route: points to cilium_host" route="{Ifindex: 5 Dst: 10.2.0.0/24 Src: 10.2.2.34 Gw: 10.2.2.34 Flags: [] Table: 254}" subsys=ipam
2019-11-30T04:40:48.011730498Z level=debug msg="Ignoring route: points to cilium_host" route="{Ifindex: 5 Dst: 10.2.1.0/24 Src: 10.2.2.34 Gw: 10.2.2.34 Flags: [] Table: 254}" subsys=ipam
2019-11-30T04:40:48.011754824Z level=debug msg="Ignoring route: points to cilium_host" route="{Ifindex: 5 Dst: 10.2.2.0/24 Src: 10.2.2.34 Gw: 10.2.2.34 Flags: [] Table: 254}" subsys=ipam
2019-11-30T04:40:48.011763666Z level=debug msg="Ignoring route: points to cilium_host" route="{Ifindex: 5 Dst: 10.2.2.34/32 Src: <nil> Gw: <nil> Flags: [] Table: 254}" subsys=ipam
2019-11-30T04:40:48.01177083Z level=debug msg="Ignoring route: points to cilium_host" route="{Ifindex: 5 Dst: 10.2.3.0/24 Src: 10.2.2.34 Gw: 10.2.2.34 Flags: [] Table: 254}" subsys=ipam
2019-11-30T04:40:48.011920743Z level=debug msg="Ignoring route: points to cilium_host" route="{Ifindex: 5 Dst: 10.2.4.0/24 Src: 10.2.2.34 Gw: 10.2.2.34 Flags: [] Table: 254}" subsys=ipam
2019-11-30T04:40:48.011933896Z level=debug msg="Ignoring route: points to cilium_host" route="{Ifindex: 5 Dst: 10.2.5.0/24 Src: 10.2.2.34 Gw: 10.2.2.34 Flags: [] Table: 254}" subsys=ipam
2019-11-30T04:40:48.011940966Z level=info msg="Blacklisting local route as no-alloc" route=172.17.0.0/16 subsys=ipam
2019-11-30T04:40:48.011947263Z level=info msg="Blacklisting local route as no-alloc" route=192.168.1.0/24 subsys=ipam
2019-11-30T04:40:48.011953559Z level=info msg="Blacklisting local route as no-alloc" route=192.168.1.250/32 subsys=ipam
2019-11-30T04:40:48.016739668Z level=debug msg="Considering removing iptables rule" obj="-P INPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.016771029Z level=debug msg="Considering removing iptables rule" obj="-P FORWARD ACCEPT" subsys=iptables
2019-11-30T04:40:48.016779728Z level=debug msg="Considering removing iptables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.016786097Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_FORWARD" subsys=iptables
2019-11-30T04:40:48.016792457Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_INPUT" subsys=iptables
2019-11-30T04:40:48.016798503Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_OUTPUT" subsys=iptables
2019-11-30T04:40:48.01680486Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER" subsys=iptables
2019-11-30T04:40:48.016811117Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-ISOLATION-STAGE-1" subsys=iptables
2019-11-30T04:40:48.016817246Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-ISOLATION-STAGE-2" subsys=iptables
2019-11-30T04:40:48.016823326Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-USER" subsys=iptables
2019-11-30T04:40:48.016829457Z level=debug msg="Considering removing iptables rule" obj="-N KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.016946708Z level=debug msg="Considering removing iptables rule" obj="-A INPUT -m comment --comment \"cilium-feeder: CILIUM_INPUT\" -j CILIUM_INPUT" subsys=iptables
2019-11-30T04:40:48.016959766Z level=debug msg="Considering removing iptables rule" obj="-A INPUT -j KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.016966359Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -m comment --comment \"cilium-feeder: CILIUM_FORWARD\" -j CILIUM_FORWARD" subsys=iptables
2019-11-30T04:40:48.016973032Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -j DOCKER-USER" subsys=iptables
2019-11-30T04:40:48.016979292Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -j DOCKER-ISOLATION-STAGE-1" subsys=iptables
2019-11-30T04:40:48.016988614Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.017005534Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -o docker0 -j DOCKER" subsys=iptables
2019-11-30T04:40:48.017012805Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -i docker0 ! -o docker0 -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.017019148Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -i docker0 -o docker0 -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.01702542Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT -m comment --comment \"cilium-feeder: CILIUM_OUTPUT\" -j CILIUM_OUTPUT" subsys=iptables
2019-11-30T04:40:48.017031974Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT -j KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.017038319Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -o cilium_host -m comment --comment \"cilium: any->cluster on cilium_host forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.017045288Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -i cilium_host -m comment --comment \"cilium: cluster->any on cilium_host forward accept (nodeport)\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.017125455Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -i lxc+ -m comment --comment \"cilium: cluster->any on lxc+ forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.017150837Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_INPUT ! -d 10.2.2.34/32 -m mark --mark 0x200/0xf00 -m comment --comment \"cilium: ACCEPT for proxy traffic\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.017159383Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_OUTPUT ! -s 10.2.2.34/32 -m mark --mark 0xa00/0xfffffeff -m comment --comment \"cilium: ACCEPT for proxy return traffic\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.017167089Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_OUTPUT -m mark ! --mark 0xe00/0xf00 -m mark ! --mark 0xd00/0xf00 -m mark ! --mark 0xa00/0xe00 -m comment --comment \"cilium: host->any mark as from host\" -j MARK --set-xmark 0xc00/0xf00" subsys=iptables
2019-11-30T04:40:48.017174306Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2" subsys=iptables
2019-11-30T04:40:48.017180779Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-1 -j RETURN" subsys=iptables
2019-11-30T04:40:48.017186971Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP" subsys=iptables
2019-11-30T04:40:48.017193088Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-2 -j RETURN" subsys=iptables
2019-11-30T04:40:48.017199109Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-USER -j RETURN" subsys=iptables
2019-11-30T04:40:48.017205337Z level=debug msg="Considering removing iptables rule" obj="-A KUBE-FIREWALL -m comment --comment \"kubernetes firewall for dropping marked packets\" -m mark --mark 0x8000/0x8000 -j DROP" subsys=iptables
2019-11-30T04:40:48.03216646Z level=debug msg="Considering removing iptables rule" obj="-P PREROUTING ACCEPT" subsys=iptables
2019-11-30T04:40:48.032366717Z level=debug msg="Considering removing iptables rule" obj="-P INPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.032538732Z level=debug msg="Considering removing iptables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.03272256Z level=debug msg="Considering removing iptables rule" obj="-P POSTROUTING ACCEPT" subsys=iptables
2019-11-30T04:40:48.032877125Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_OUTPUT_nat" subsys=iptables
2019-11-30T04:40:48.033033473Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_POST_nat" subsys=iptables
2019-11-30T04:40:48.03321443Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_PRE_nat" subsys=iptables
2019-11-30T04:40:48.033387513Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER" subsys=iptables
2019-11-30T04:40:48.033562153Z level=debug msg="Considering removing iptables rule" obj="-N KUBE-MARK-DROP" subsys=iptables
2019-11-30T04:40:48.033770035Z level=debug msg="Considering removing iptables rule" obj="-N KUBE-MARK-MASQ" subsys=iptables
2019-11-30T04:40:48.033930815Z level=debug msg="Considering removing iptables rule" obj="-N KUBE-POSTROUTING" subsys=iptables
2019-11-30T04:40:48.034086309Z level=debug msg="Considering removing iptables rule" obj="-A PREROUTING -m comment --comment \"cilium-feeder: CILIUM_PRE_nat\" -j CILIUM_PRE_nat" subsys=iptables
2019-11-30T04:40:48.034305177Z level=debug msg="Removing iptables rule" obj="[-w 5 -t nat -D PREROUTING -m comment --comment cilium-feeder: CILIUM_PRE_nat -j CILIUM_PRE_nat]" subsys=iptables
2019-11-30T04:40:48.036201101Z level=debug msg="Considering removing iptables rule" obj="-A PREROUTING -m addrtype --dst-type LOCAL -j DOCKER" subsys=iptables
2019-11-30T04:40:48.036376455Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT -m comment --comment \"cilium-feeder: CILIUM_OUTPUT_nat\" -j CILIUM_OUTPUT_nat" subsys=iptables
2019-11-30T04:40:48.036576266Z level=debug msg="Removing iptables rule" obj="[-w 5 -t nat -D OUTPUT -m comment --comment cilium-feeder: CILIUM_OUTPUT_nat -j CILIUM_OUTPUT_nat]" subsys=iptables
2019-11-30T04:40:48.038581099Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT ! -d 127.0.0.0/8 -m addrtype --dst-type LOCAL -j DOCKER" subsys=iptables
2019-11-30T04:40:48.03878841Z level=debug msg="Considering removing iptables rule" obj="-A POSTROUTING -m comment --comment \"cilium-feeder: CILIUM_POST_nat\" -j CILIUM_POST_nat" subsys=iptables
2019-11-30T04:40:48.039001511Z level=debug msg="Removing iptables rule" obj="[-w 5 -t nat -D POSTROUTING -m comment --comment cilium-feeder: CILIUM_POST_nat -j CILIUM_POST_nat]" subsys=iptables
2019-11-30T04:40:48.041099377Z level=debug msg="Considering removing iptables rule" obj="-A POSTROUTING -m comment --comment \"kubernetes postrouting rules\" -j KUBE-POSTROUTING" subsys=iptables
2019-11-30T04:40:48.04126572Z level=debug msg="Considering removing iptables rule" obj="-A POSTROUTING -s 172.17.0.0/16 ! -o docker0 -j MASQUERADE" subsys=iptables
2019-11-30T04:40:48.041454514Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_POST_nat -s 10.2.2.0/24 ! -d 10.2.2.0/24 ! -o cilium_+ -m comment --comment \"cilium masquerade non-cluster\" -j MASQUERADE" subsys=iptables
2019-11-30T04:40:48.041938355Z level=debug msg="Removing iptables rule" obj="[-w 5 -t nat -D CILIUM_POST_nat -s 10.2.2.0/24 ! -d 10.2.2.0/24 ! -o cilium_+ -m comment --comment cilium masquerade non-cluster -j MASQUERADE]" subsys=iptables
2019-11-30T04:40:48.043736696Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_POST_nat ! -o cilium_host -m comment --comment \"exclude non-cilium_host traffic from masquerade\" -j RETURN" subsys=iptables
2019-11-30T04:40:48.043974765Z level=debug msg="Removing iptables rule" obj="[-w 5 -t nat -D CILIUM_POST_nat ! -o cilium_host -m comment --comment exclude non-cilium_host traffic from masquerade -j RETURN]" subsys=iptables
2019-11-30T04:40:48.045859874Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_POST_nat -m mark --mark 0xa00/0xe00 -m comment --comment \"exclude proxy return traffic from masquarade\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.046071Z level=debug msg="Removing iptables rule" obj="[-w 5 -t nat -D CILIUM_POST_nat -m mark --mark 0xa00/0xe00 -m comment --comment exclude proxy return traffic from masquarade -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.048059644Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_POST_nat ! -s 10.2.2.34/32 ! -d 10.2.2.0/24 -o cilium_host -m comment --comment \"cilium host->cluster masquerade\" -j SNAT --to-source 10.2.2.34" subsys=iptables
2019-11-30T04:40:48.048276053Z level=debug msg="Removing iptables rule" obj="[-w 5 -t nat -D CILIUM_POST_nat ! -s 10.2.2.34/32 ! -d 10.2.2.0/24 -o cilium_host -m comment --comment cilium host->cluster masquerade -j SNAT --to-source 10.2.2.34]" subsys=iptables
2019-11-30T04:40:48.050049472Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_POST_nat -s 127.0.0.1/32 -o cilium_host -m comment --comment \"cilium host->cluster from 127.0.0.1 masquerade\" -j SNAT --to-source 10.2.2.34" subsys=iptables
2019-11-30T04:40:48.050295198Z level=debug msg="Removing iptables rule" obj="[-w 5 -t nat -D CILIUM_POST_nat -s 127.0.0.1/32 -o cilium_host -m comment --comment cilium host->cluster from 127.0.0.1 masquerade -j SNAT --to-source 10.2.2.34]" subsys=iptables
2019-11-30T04:40:48.052204735Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER -i docker0 -j RETURN" subsys=iptables
2019-11-30T04:40:48.05237931Z level=debug msg="Considering removing iptables rule" obj="-A KUBE-MARK-DROP -j MARK --set-xmark 0x8000/0x8000" subsys=iptables
2019-11-30T04:40:48.05253165Z level=debug msg="Considering removing iptables rule" obj="-A KUBE-MARK-MASQ -j MARK --set-xmark 0x4000/0x4000" subsys=iptables
2019-11-30T04:40:48.052705478Z level=debug msg="Considering removing iptables rule" obj="-A KUBE-POSTROUTING -m comment --comment \"kubernetes service traffic requiring SNAT\" -m mark --mark 0x4000/0x4000 -j MASQUERADE" subsys=iptables
2019-11-30T04:40:48.055519325Z level=debug msg="Considering removing iptables rule" obj="-P PREROUTING ACCEPT" subsys=iptables
2019-11-30T04:40:48.055751382Z level=debug msg="Considering removing iptables rule" obj="-P INPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.05594192Z level=debug msg="Considering removing iptables rule" obj="-P FORWARD ACCEPT" subsys=iptables
2019-11-30T04:40:48.056124052Z level=debug msg="Considering removing iptables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.056273655Z level=debug msg="Considering removing iptables rule" obj="-P POSTROUTING ACCEPT" subsys=iptables
2019-11-30T04:40:48.056429309Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_POST_mangle" subsys=iptables
2019-11-30T04:40:48.056581986Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_PRE_mangle" subsys=iptables
2019-11-30T04:40:48.063211651Z level=debug msg="Considering removing iptables rule" obj="-A PREROUTING -m comment --comment \"cilium-feeder: CILIUM_PRE_mangle\" -j CILIUM_PRE_mangle" subsys=iptables
2019-11-30T04:40:48.063453368Z level=debug msg="Removing iptables rule" obj="[-w 5 -t mangle -D PREROUTING -m comment --comment cilium-feeder: CILIUM_PRE_mangle -j CILIUM_PRE_mangle]" subsys=iptables
2019-11-30T04:40:48.0657132Z level=debug msg="Considering removing iptables rule" obj="-A POSTROUTING -m comment --comment \"cilium-feeder: CILIUM_POST_mangle\" -j CILIUM_POST_mangle" subsys=iptables
2019-11-30T04:40:48.065941917Z level=debug msg="Removing iptables rule" obj="[-w 5 -t mangle -D POSTROUTING -m comment --comment cilium-feeder: CILIUM_POST_mangle -j CILIUM_POST_mangle]" subsys=iptables
2019-11-30T04:40:48.067759087Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_PRE_mangle -m socket --transparent --nowildcard -m comment --comment \"cilium: any->pod redirect proxied traffic to host proxy\" -j MARK --set-xmark 0x200/0xffffffff" subsys=iptables
2019-11-30T04:40:48.067999931Z level=debug msg="Removing iptables rule" obj="[-w 5 -t mangle -D CILIUM_PRE_mangle -m socket --transparent --nowildcard -m comment --comment cilium: any->pod redirect proxied traffic to host proxy -j MARK --set-xmark 0x200/0xffffffff]" subsys=iptables
2019-11-30T04:40:48.07013405Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_PRE_mangle -p tcp -m mark --mark 0x5880200 -m comment --comment \"cilium: TPROXY to host cilium-dns-egress proxy\" -j TPROXY --on-port 34821 --on-ip 0.0.0.0 --tproxy-mark 0x200/0xffffffff" subsys=iptables
2019-11-30T04:40:48.070413031Z level=debug msg="Removing iptables rule" obj="[-w 5 -t mangle -D CILIUM_PRE_mangle -p tcp -m mark --mark 0x5880200 -m comment --comment cilium: TPROXY to host cilium-dns-egress proxy -j TPROXY --on-port 34821 --on-ip 0.0.0.0 --tproxy-mark 0x200/0xffffffff]" subsys=iptables
2019-11-30T04:40:48.072850725Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_PRE_mangle -p udp -m mark --mark 0x5880200 -m comment --comment \"cilium: TPROXY to host cilium-dns-egress proxy\" -j TPROXY --on-port 34821 --on-ip 0.0.0.0 --tproxy-mark 0x200/0xffffffff" subsys=iptables
2019-11-30T04:40:48.073093122Z level=debug msg="Removing iptables rule" obj="[-w 5 -t mangle -D CILIUM_PRE_mangle -p udp -m mark --mark 0x5880200 -m comment --comment cilium: TPROXY to host cilium-dns-egress proxy -j TPROXY --on-port 34821 --on-ip 0.0.0.0 --tproxy-mark 0x200/0xffffffff]" subsys=iptables
2019-11-30T04:40:48.077332287Z level=debug msg="Considering removing iptables rule" obj="-P PREROUTING ACCEPT" subsys=iptables
2019-11-30T04:40:48.077521793Z level=debug msg="Considering removing iptables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.077720868Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_OUTPUT_raw" subsys=iptables
2019-11-30T04:40:48.077897117Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_PRE_raw" subsys=iptables
2019-11-30T04:40:48.078055793Z level=debug msg="Considering removing iptables rule" obj="-A PREROUTING -m comment --comment \"cilium-feeder: CILIUM_PRE_raw\" -j CILIUM_PRE_raw" subsys=iptables
2019-11-30T04:40:48.078238977Z level=debug msg="Removing iptables rule" obj="[-w 5 -t raw -D PREROUTING -m comment --comment cilium-feeder: CILIUM_PRE_raw -j CILIUM_PRE_raw]" subsys=iptables
2019-11-30T04:40:48.080031159Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT -m comment --comment \"cilium-feeder: CILIUM_OUTPUT_raw\" -j CILIUM_OUTPUT_raw" subsys=iptables
2019-11-30T04:40:48.080263562Z level=debug msg="Removing iptables rule" obj="[-w 5 -t raw -D OUTPUT -m comment --comment cilium-feeder: CILIUM_OUTPUT_raw -j CILIUM_OUTPUT_raw]" subsys=iptables
2019-11-30T04:40:48.082068876Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_OUTPUT_raw ! -s 10.2.2.34/32 -m mark --mark 0xa00/0xfffffeff -m comment --comment \"cilium: NOTRACK for proxy return traffic\" -j NOTRACK" subsys=iptables
2019-11-30T04:40:48.082324302Z level=debug msg="Removing iptables rule" obj="[-w 5 -t raw -D CILIUM_OUTPUT_raw ! -s 10.2.2.34/32 -m mark --mark 0xa00/0xfffffeff -m comment --comment cilium: NOTRACK for proxy return traffic -j NOTRACK]" subsys=iptables
2019-11-30T04:40:48.084491244Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_PRE_raw ! -d 10.2.2.34/32 -m mark --mark 0x200/0xf00 -m comment --comment \"cilium: NOTRACK for proxy traffic\" -j NOTRACK" subsys=iptables
2019-11-30T04:40:48.084750507Z level=debug msg="Removing iptables rule" obj="[-w 5 -t raw -D CILIUM_PRE_raw ! -d 10.2.2.34/32 -m mark --mark 0x200/0xf00 -m comment --comment cilium: NOTRACK for proxy traffic -j NOTRACK]" subsys=iptables
2019-11-30T04:40:48.090073717Z level=debug msg="Considering removing iptables rule" obj="-P INPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.090258668Z level=debug msg="Considering removing iptables rule" obj="-P FORWARD ACCEPT" subsys=iptables
2019-11-30T04:40:48.0905086Z level=debug msg="Considering removing iptables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.090744991Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_FORWARD" subsys=iptables
2019-11-30T04:40:48.090932512Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_INPUT" subsys=iptables
2019-11-30T04:40:48.091141181Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_OUTPUT" subsys=iptables
2019-11-30T04:40:48.091318548Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_TRANSIENT_FORWARD" subsys=iptables
2019-11-30T04:40:48.091552186Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER" subsys=iptables
2019-11-30T04:40:48.091727722Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-ISOLATION-STAGE-1" subsys=iptables
2019-11-30T04:40:48.091924787Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-ISOLATION-STAGE-2" subsys=iptables
2019-11-30T04:40:48.092122926Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-USER" subsys=iptables
2019-11-30T04:40:48.092299324Z level=debug msg="Considering removing iptables rule" obj="-N KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.092511603Z level=debug msg="Considering removing iptables rule" obj="-A INPUT -m comment --comment \"cilium-feeder: CILIUM_INPUT\" -j CILIUM_INPUT" subsys=iptables
2019-11-30T04:40:48.092803785Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D INPUT -m comment --comment cilium-feeder: CILIUM_INPUT -j CILIUM_INPUT]" subsys=iptables
2019-11-30T04:40:48.094759652Z level=debug msg="Considering removing iptables rule" obj="-A INPUT -j KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.094952352Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -m comment --comment \"cilium-feeder: CILIUM_TRANSIENT_FORWARD\" -j CILIUM_TRANSIENT_FORWARD" subsys=iptables
2019-11-30T04:40:48.095145077Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -m comment --comment \"cilium-feeder: CILIUM_FORWARD\" -j CILIUM_FORWARD" subsys=iptables
2019-11-30T04:40:48.095357902Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D FORWARD -m comment --comment cilium-feeder: CILIUM_FORWARD -j CILIUM_FORWARD]" subsys=iptables
2019-11-30T04:40:48.097355645Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -j DOCKER-USER" subsys=iptables
2019-11-30T04:40:48.097586859Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -j DOCKER-ISOLATION-STAGE-1" subsys=iptables
2019-11-30T04:40:48.09780556Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.097975897Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -o docker0 -j DOCKER" subsys=iptables
2019-11-30T04:40:48.098211633Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -i docker0 ! -o docker0 -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.098369046Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -i docker0 -o docker0 -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.09866829Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT -m comment --comment \"cilium-feeder: CILIUM_OUTPUT\" -j CILIUM_OUTPUT" subsys=iptables
2019-11-30T04:40:48.098859237Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D OUTPUT -m comment --comment cilium-feeder: CILIUM_OUTPUT -j CILIUM_OUTPUT]" subsys=iptables
2019-11-30T04:40:48.100843268Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT -j KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.101024621Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -o cilium_host -m comment --comment \"cilium: any->cluster on cilium_host forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.101307538Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_FORWARD -o cilium_host -m comment --comment cilium: any->cluster on cilium_host forward accept -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.10321004Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -i cilium_host -m comment --comment \"cilium: cluster->any on cilium_host forward accept (nodeport)\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.103428731Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_FORWARD -i cilium_host -m comment --comment cilium: cluster->any on cilium_host forward accept (nodeport) -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.105453425Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -i lxc+ -m comment --comment \"cilium: cluster->any on lxc+ forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.105711448Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_FORWARD -i lxc+ -m comment --comment cilium: cluster->any on lxc+ forward accept -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.10765081Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_INPUT ! -d 10.2.2.34/32 -m mark --mark 0x200/0xf00 -m comment --comment \"cilium: ACCEPT for proxy traffic\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.107928102Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_INPUT ! -d 10.2.2.34/32 -m mark --mark 0x200/0xf00 -m comment --comment cilium: ACCEPT for proxy traffic -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.110061445Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_OUTPUT ! -s 10.2.2.34/32 -m mark --mark 0xa00/0xfffffeff -m comment --comment \"cilium: ACCEPT for proxy return traffic\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.110272597Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_OUTPUT ! -s 10.2.2.34/32 -m mark --mark 0xa00/0xfffffeff -m comment --comment cilium: ACCEPT for proxy return traffic -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.112980274Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_OUTPUT -m mark ! --mark 0xe00/0xf00 -m mark ! --mark 0xd00/0xf00 -m mark ! --mark 0xa00/0xe00 -m comment --comment \"cilium: host->any mark as from host\" -j MARK --set-xmark 0xc00/0xf00" subsys=iptables
2019-11-30T04:40:48.113211346Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_OUTPUT -m mark ! --mark 0xe00/0xf00 -m mark ! --mark 0xd00/0xf00 -m mark ! --mark 0xa00/0xe00 -m comment --comment cilium: host->any mark as from host -j MARK --set-xmark 0xc00/0xf00]" subsys=iptables
2019-11-30T04:40:48.116296215Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_TRANSIENT_FORWARD -o cilium_host -m comment --comment \"cilium (transient): any->cluster on cilium_host forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.116495762Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_TRANSIENT_FORWARD -i cilium_host -m comment --comment \"cilium (transient): cluster->any on cilium_host forward accept (nodeport)\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.116745861Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_TRANSIENT_FORWARD -i lxc+ -m comment --comment \"cilium (transient): cluster->any on lxc+ forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.11697475Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2" subsys=iptables
2019-11-30T04:40:48.117208521Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-1 -j RETURN" subsys=iptables
2019-11-30T04:40:48.11736613Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP" subsys=iptables
2019-11-30T04:40:48.117553785Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-2 -j RETURN" subsys=iptables
2019-11-30T04:40:48.117979566Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-USER -j RETURN" subsys=iptables
2019-11-30T04:40:48.118172012Z level=debug msg="Considering removing iptables rule" obj="-A KUBE-FIREWALL -m comment --comment \"kubernetes firewall for dropping marked packets\" -m mark --mark 0x8000/0x8000 -j DROP" subsys=iptables
2019-11-30T04:40:48.120497098Z level=debug msg="Considering removing ip6tables rule" obj="-P PREROUTING ACCEPT" subsys=iptables
2019-11-30T04:40:48.120702527Z level=debug msg="Considering removing ip6tables rule" obj="-P INPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.120955357Z level=debug msg="Considering removing ip6tables rule" obj="-P FORWARD ACCEPT" subsys=iptables
2019-11-30T04:40:48.121158314Z level=debug msg="Considering removing ip6tables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.121313845Z level=debug msg="Considering removing ip6tables rule" obj="-P POSTROUTING ACCEPT" subsys=iptables
2019-11-30T04:40:48.123445192Z level=debug msg="Considering removing ip6tables rule" obj="-P PREROUTING ACCEPT" subsys=iptables
2019-11-30T04:40:48.123650758Z level=debug msg="Considering removing ip6tables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.125609581Z level=debug msg="Considering removing ip6tables rule" obj="-P INPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.125835232Z level=debug msg="Considering removing ip6tables rule" obj="-P FORWARD ACCEPT" subsys=iptables
2019-11-30T04:40:48.126030955Z level=debug msg="Considering removing ip6tables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.211337431Z level=debug msg="Considering removing iptables rule" obj="-P INPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.211581891Z level=debug msg="Considering removing iptables rule" obj="-P FORWARD ACCEPT" subsys=iptables
2019-11-30T04:40:48.211821449Z level=debug msg="Considering removing iptables rule" obj="-P OUTPUT ACCEPT" subsys=iptables
2019-11-30T04:40:48.212018666Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_FORWARD" subsys=iptables
2019-11-30T04:40:48.212179759Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_INPUT" subsys=iptables
2019-11-30T04:40:48.212368098Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_OUTPUT" subsys=iptables
2019-11-30T04:40:48.212557185Z level=debug msg="Considering removing iptables rule" obj="-N CILIUM_TRANSIENT_FORWARD" subsys=iptables
2019-11-30T04:40:48.212761624Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER" subsys=iptables
2019-11-30T04:40:48.212965192Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-ISOLATION-STAGE-1" subsys=iptables
2019-11-30T04:40:48.213152703Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-ISOLATION-STAGE-2" subsys=iptables
2019-11-30T04:40:48.213349617Z level=debug msg="Considering removing iptables rule" obj="-N DOCKER-USER" subsys=iptables
2019-11-30T04:40:48.213545686Z level=debug msg="Considering removing iptables rule" obj="-N KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.213836377Z level=debug msg="Considering removing iptables rule" obj="-A INPUT -m comment --comment \"cilium-feeder: CILIUM_INPUT\" -j CILIUM_INPUT" subsys=iptables
2019-11-30T04:40:48.214004583Z level=debug msg="Considering removing iptables rule" obj="-A INPUT -j KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.214195917Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -m comment --comment \"cilium-feeder: CILIUM_FORWARD\" -j CILIUM_FORWARD" subsys=iptables
2019-11-30T04:40:48.214384364Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -m comment --comment \"cilium-feeder: CILIUM_TRANSIENT_FORWARD\" -j CILIUM_TRANSIENT_FORWARD" subsys=iptables
2019-11-30T04:40:48.214712199Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D FORWARD -m comment --comment cilium-feeder: CILIUM_TRANSIENT_FORWARD -j CILIUM_TRANSIENT_FORWARD]" subsys=iptables
2019-11-30T04:40:48.216593672Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -j DOCKER-USER" subsys=iptables
2019-11-30T04:40:48.21682Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -j DOCKER-ISOLATION-STAGE-1" subsys=iptables
2019-11-30T04:40:48.21704767Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.217302612Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -o docker0 -j DOCKER" subsys=iptables
2019-11-30T04:40:48.217506291Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -i docker0 ! -o docker0 -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.217687268Z level=debug msg="Considering removing iptables rule" obj="-A FORWARD -i docker0 -o docker0 -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.218052324Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT -m comment --comment \"cilium-feeder: CILIUM_OUTPUT\" -j CILIUM_OUTPUT" subsys=iptables
2019-11-30T04:40:48.21824386Z level=debug msg="Considering removing iptables rule" obj="-A OUTPUT -j KUBE-FIREWALL" subsys=iptables
2019-11-30T04:40:48.218442917Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -o cilium_host -m comment --comment \"cilium: any->cluster on cilium_host forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.218677063Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -i cilium_host -m comment --comment \"cilium: cluster->any on cilium_host forward accept (nodeport)\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.218845186Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_FORWARD -i lxc+ -m comment --comment \"cilium: cluster->any on lxc+ forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.219080835Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_INPUT ! -d 10.2.2.34/32 -m mark --mark 0x200/0xf00 -m comment --comment \"cilium: ACCEPT for proxy traffic\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.2192959Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_OUTPUT ! -s 10.2.2.34/32 -m mark --mark 0xa00/0xfffffeff -m comment --comment \"cilium: ACCEPT for proxy return traffic\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.219488106Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_OUTPUT -m mark ! --mark 0xe00/0xf00 -m mark ! --mark 0xd00/0xf00 -m mark ! --mark 0xa00/0xe00 -m comment --comment \"cilium: host->any mark as from host\" -j MARK --set-xmark 0xc00/0xf00" subsys=iptables
2019-11-30T04:40:48.219821172Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_TRANSIENT_FORWARD -o cilium_host -m comment --comment \"cilium (transient): any->cluster on cilium_host forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.220073379Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_TRANSIENT_FORWARD -o cilium_host -m comment --comment cilium (transient): any->cluster on cilium_host forward accept -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.222521088Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_TRANSIENT_FORWARD -i cilium_host -m comment --comment \"cilium (transient): cluster->any on cilium_host forward accept (nodeport)\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.222773476Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_TRANSIENT_FORWARD -i cilium_host -m comment --comment cilium (transient): cluster->any on cilium_host forward accept (nodeport) -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.224782566Z level=debug msg="Considering removing iptables rule" obj="-A CILIUM_TRANSIENT_FORWARD -i lxc+ -m comment --comment \"cilium (transient): cluster->any on lxc+ forward accept\" -j ACCEPT" subsys=iptables
2019-11-30T04:40:48.225186051Z level=debug msg="Removing iptables rule" obj="[-w 5 -t filter -D CILIUM_TRANSIENT_FORWARD -i lxc+ -m comment --comment cilium (transient): cluster->any on lxc+ forward accept -j ACCEPT]" subsys=iptables
2019-11-30T04:40:48.227160632Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2" subsys=iptables
2019-11-30T04:40:48.227513478Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-1 -j RETURN" subsys=iptables
2019-11-30T04:40:48.227800353Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP" subsys=iptables
2019-11-30T04:40:48.228088574Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-ISOLATION-STAGE-2 -j RETURN" subsys=iptables
2019-11-30T04:40:48.2283457Z level=debug msg="Considering removing iptables rule" obj="-A DOCKER-USER -j RETURN" subsys=iptables
2019-11-30T04:40:48.228608024Z level=debug msg="Considering removing iptables rule" obj="-A KUBE-FIREWALL -m comment --comment \"kubernetes firewall for dropping marked packets\" -m mark --mark 0x8000/0x8000 -j DROP" subsys=iptables
2019-11-30T04:40:48.233031871Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=192.168.1.177 key=0 subsys=ipcache
2019-11-30T04:40:48.233342971Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{192.168.1.177 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:40:48.233781386Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:40:48.23403504Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:40:48.234314021Z level=debug msg="Upserting IP into ipcache layer" identity="{world local}" ipAddr=0.0.0.0/0 key=0 subsys=ipcache
2019-11-30T04:40:48.234558337Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=world ipAddr="{0.0.0.0 00000000}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:40:48.234821096Z level=debug msg="Starting new controller" name=sync-endpoints-and-host-ips subsys=controller uuid=94645780-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:48.235641822Z level=info msg="Serving cilium node monitor v1.2 API at unix:///var/run/cilium/monitor1_2.sock" subsys=monitor-agent
2019-11-30T04:40:48.235859291Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=192.168.1.177 key=0 subsys=ipcache
2019-11-30T04:40:48.235874145Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{192.168.1.177 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:40:48.236283566Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:40:48.236335952Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:40:48.236343386Z level=debug msg="Upserting IP into ipcache layer" identity="{world local}" ipAddr=0.0.0.0/0 key=0 subsys=ipcache
2019-11-30T04:40:48.236349686Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=world ipAddr="{0.0.0.0 00000000}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:40:48.236356251Z level=debug msg="Controller func execution time: 1.207807ms" name=sync-endpoints-and-host-ips subsys=controller uuid=94645780-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:48.236668175Z level=info msg="Starting IP identity watcher" subsys=ipcache
2019-11-30T04:40:48.236682557Z level=debug msg="Starting new controller" name=dns-garbage-collector-job subsys=controller uuid=94649b96-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:48.23668924Z level=debug msg="DNS Proxy port is configured to 0. A random port will be assigned by the OS." subsys=fqdn/dnsproxy
2019-11-30T04:40:48.237108277Z level=debug msg="Controller func execution time: 24.005µs" name=dns-garbage-collector-job subsys=controller uuid=94649b96-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:48.237312814Z level=debug msg="DNS Proxy bound to address" address="[::]:40435" subsys=fqdn/dnsproxy
2019-11-30T04:40:48.237717121Z level=debug msg="Considering updating proxy port rules for cilium-dns-egress:40435 (old: 0)" proxy port name=cilium-dns-egress subsys=proxy
2019-11-30T04:40:48.237902764Z level=debug msg="Adding new proxy port rules for cilium-dns-egress:40435" proxy port name=cilium-dns-egress subsys=proxy
2019-11-30T04:40:48.243918965Z level=info msg="Validating configured node address ranges" subsys=daemon
2019-11-30T04:40:48.244151785Z level=info msg="Starting connection tracking garbage collector" subsys=daemon
2019-11-30T04:40:48.24455912Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_ct4_global subsys=bpf
2019-11-30T04:40:48.244794559Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_snat_v4_external subsys=bpf
2019-11-30T04:40:48.276226271Z level=debug msg="Unregistered BPF map" path=/sys/fs/bpf/tc/globals/cilium_snat_v4_external subsys=bpf
2019-11-30T04:40:48.276597693Z level=debug msg="Deleted filtered entries from map" count=1008 file-path=/sys/fs/bpf/tc/globals/cilium_ct4_global subsys=ct-gc
2019-11-30T04:40:48.27684635Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_ct_any4_global subsys=bpf
2019-11-30T04:40:48.27707881Z level=debug msg="Registered BPF map" path=/sys/fs/bpf/tc/globals/cilium_snat_v4_external subsys=bpf
2019-11-30T04:40:48.296122576Z level=debug msg="Unregistered BPF map" path=/sys/fs/bpf/tc/globals/cilium_snat_v4_external subsys=bpf
2019-11-30T04:40:48.296331669Z level=debug msg="Deleted filtered entries from map" count=623 file-path=/sys/fs/bpf/tc/globals/cilium_ct_any4_global subsys=ct-gc
2019-11-30T04:40:48.296557099Z level=debug msg="Unregistered BPF map" path=/sys/fs/bpf/tc/globals/cilium_ct_any4_global subsys=bpf
2019-11-30T04:40:48.296850393Z level=debug msg="Unregistered BPF map" path=/sys/fs/bpf/tc/globals/cilium_ct4_global subsys=bpf
2019-11-30T04:40:48.297130432Z level=info msg="Initial scan of connection tracking completed" subsys=ct-gc
2019-11-30T04:40:48.297183244Z level=info msg="Enabling k8s event listener" subsys=k8s-watcher
2019-11-30T04:40:48.297640333Z level=info msg="Conntrack garbage collector interval recalculated" deleteRatio=0.002376556396484375 newInterval=7m30s subsys=map-ct
2019-11-30T04:40:48.297871554Z level=info msg="Datapath signal listener running" subsys=signal
2019-11-30T04:40:48.298904445Z level=debug msg="waiting for cache to synchronize" kubernetesResource="networking.k8s.io/v1::NetworkPolicy" subsys=k8s-watcher
2019-11-30T04:40:48.299473559Z level=debug msg="waiting for cache to synchronize" kubernetesResource="core/v1::Service" subsys=k8s-watcher
2019-11-30T04:40:48.2998927Z level=debug msg="waiting for cache to synchronize" kubernetesResource="core/v1::Endpoint" subsys=k8s-watcher
2019-11-30T04:40:48.300304107Z level=debug msg="waiting for cache to synchronize" kubernetesResource="cilium/v2::CiliumNetworkPolicy" subsys=k8s-watcher
2019-11-30T04:40:48.300698248Z level=debug msg="waiting for cache to synchronize" kubernetesResource="cilium/v2::CiliumClusterwideNetworkPolicy" subsys=k8s-watcher
2019-11-30T04:40:48.302225343Z level=debug msg="waiting for cache to synchronize" kubernetesResource="core/v1::Namespace" subsys=k8s-watcher
2019-11-30T04:40:48.302262407Z level=debug msg="waiting for cache to synchronize" kubernetesResource="cilium/v2::CiliumNode" subsys=k8s-watcher
2019-11-30T04:40:48.302271086Z level=debug msg="waiting for cache to synchronize" kubernetesResource="cilium/v2::CiliumEndpoint" subsys=k8s-watcher
2019-11-30T04:40:48.302277518Z level=debug msg="waiting for cache to synchronize" kubernetesResource="core/v1::Pods" subsys=k8s-watcher
2019-11-30T04:40:48.302320963Z level=info msg="Skipping kvstore configuration" subsys=daemon
2019-11-30T04:40:48.302362264Z level=info msg="Waiting until all pre-existing resources related to policy have been received" subsys=k8s-watcher
2019-11-30T04:40:52.570386119Z level=debug msg="Controller func execution time: 342.182µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:40:57.57107293Z level=debug msg="Controller func execution time: 396.272µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:02.572112046Z level=debug msg="Controller func execution time: 535.275µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:07.57360293Z level=debug msg="Controller func execution time: 431.126µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:12.574793082Z level=debug msg="Controller func execution time: 1.114823ms" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:17.575393799Z level=debug msg="Controller func execution time: 365.793µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:22.576261476Z level=debug msg="Controller func execution time: 482.62µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:27.577078089Z level=debug msg="Controller func execution time: 450.87µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:32.564451274Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=41.588830833s
2019-11-30T04:41:32.577477002Z level=debug msg="Controller func execution time: 348.872µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:37.578983253Z level=debug msg="Controller func execution time: 1.067915ms" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:42.580105884Z level=debug msg="Controller func execution time: 451.401µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:47.5810487Z level=debug msg="Controller func execution time: 607.493µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:48.237683226Z level=debug msg="Controller func execution time: 44.499µs" name=dns-garbage-collector-job subsys=controller uuid=94649b96-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:48.24103699Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=192.168.1.177 key=0 subsys=ipcache
2019-11-30T04:41:48.241148709Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{192.168.1.177 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:41:48.241165686Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:41:48.24117369Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:41:48.241181779Z level=debug msg="Upserting IP into ipcache layer" identity="{world local}" ipAddr=0.0.0.0/0 key=0 subsys=ipcache
2019-11-30T04:41:48.241188993Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=world ipAddr="{0.0.0.0 00000000}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:41:48.241196327Z level=debug msg="Controller func execution time: 4.49709ms" name=sync-endpoints-and-host-ips subsys=controller uuid=94645780-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:52.582408861Z level=debug msg="Controller func execution time: 365.779µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:41:57.583229493Z level=debug msg="Controller func execution time: 503.214µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:02.584233876Z level=debug msg="Controller func execution time: 439.401µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:07.585701658Z level=debug msg="Controller func execution time: 959.48µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:12.586252348Z level=debug msg="Controller func execution time: 434.555µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:14.154650795Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=41.588830833s
2019-11-30T04:42:17.5869882Z level=debug msg="Controller func execution time: 396.739µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:22.587556755Z level=debug msg="Controller func execution time: 369.744µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:27.588309417Z level=debug msg="Controller func execution time: 359.712µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:32.589662506Z level=debug msg="Controller func execution time: 611.098µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:37.590683305Z level=debug msg="Controller func execution time: 437.438µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:42.591318071Z level=debug msg="Controller func execution time: 355.08µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:47.592520333Z level=debug msg="Controller func execution time: 993.897µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:48.238442469Z level=debug msg="Controller func execution time: 52.247µs" name=dns-garbage-collector-job subsys=controller uuid=94649b96-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:48.247209887Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=192.168.1.177 key=0 subsys=ipcache
2019-11-30T04:42:48.248437915Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{192.168.1.177 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:42:48.248485734Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:42:48.248498637Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:42:48.248506164Z level=debug msg="Upserting IP into ipcache layer" identity="{world local}" ipAddr=0.0.0.0/0 key=0 subsys=ipcache
2019-11-30T04:42:48.248513254Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=world ipAddr="{0.0.0.0 00000000}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:42:48.248520286Z level=debug msg="Controller func execution time: 7.139937ms" name=sync-endpoints-and-host-ips subsys=controller uuid=94645780-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:52.59306136Z level=debug msg="Controller func execution time: 341.991µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:42:55.745493291Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=41.588830833s
2019-11-30T04:42:57.594029643Z level=debug msg="Controller func execution time: 529.752µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:02.595708743Z level=debug msg="Controller func execution time: 424.676µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:07.596567409Z level=debug msg="Controller func execution time: 526.043µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:12.598023525Z level=debug msg="Controller func execution time: 511.98µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:17.599289212Z level=debug msg="Controller func execution time: 1.018638ms" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:22.599975269Z level=debug msg="Controller func execution time: 521.529µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:27.600707654Z level=debug msg="Controller func execution time: 420.862µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:32.601064543Z level=debug msg="Controller func execution time: 358.885µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:37.335593349Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=41.588830833s
2019-11-30T04:43:37.602022939Z level=debug msg="Controller func execution time: 443.839µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:42.602813547Z level=debug msg="Controller func execution time: 456.261µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:47.603433354Z level=debug msg="Controller func execution time: 360.331µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:48.239118559Z level=debug msg="Controller func execution time: 44.793µs" name=dns-garbage-collector-job subsys=controller uuid=94649b96-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:48.250245323Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=192.168.1.177 key=0 subsys=ipcache
2019-11-30T04:43:48.251734534Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{192.168.1.177 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:43:48.25178964Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:43:48.251803845Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:43:48.251811983Z level=debug msg="Upserting IP into ipcache layer" identity="{world local}" ipAddr=0.0.0.0/0 key=0 subsys=ipcache
2019-11-30T04:43:48.25181936Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=world ipAddr="{0.0.0.0 00000000}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:43:48.251826659Z level=debug msg="Controller func execution time: 2.835618ms" name=sync-endpoints-and-host-ips subsys=controller uuid=94645780-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:52.60468489Z level=debug msg="Controller func execution time: 943.714µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:43:57.605473397Z level=debug msg="Controller func execution time: 447.29µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:02.605986351Z level=debug msg="Controller func execution time: 381.989µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:07.607055018Z level=debug msg="Controller func execution time: 523.378µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:12.607583859Z level=debug msg="Controller func execution time: 448.451µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:17.608321945Z level=debug msg="Controller func execution time: 368.835µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:18.925207611Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=41.588830833s
2019-11-30T04:44:22.608920345Z level=debug msg="Controller func execution time: 325.208µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:27.610777939Z level=debug msg="Controller func execution time: 966.798µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:32.612075147Z level=debug msg="Controller func execution time: 453.289µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:37.613236999Z level=debug msg="Controller func execution time: 606.101µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:42.614416439Z level=debug msg="Controller func execution time: 478.741µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:47.61558622Z level=debug msg="Controller func execution time: 443.359µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:48.241612633Z level=debug msg="Controller func execution time: 37.073µs" name=dns-garbage-collector-job subsys=controller uuid=94649b96-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:48.253314178Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=192.168.1.177 key=0 subsys=ipcache
2019-11-30T04:44:48.253664475Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{192.168.1.177 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:44:48.25453521Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:44:48.254576917Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:44:48.25591953Z level=debug msg="Upserting IP into ipcache layer" identity="{world local}" ipAddr=0.0.0.0/0 key=0 subsys=ipcache
2019-11-30T04:44:48.255944135Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=world ipAddr="{0.0.0.0 00000000}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:44:48.255953404Z level=debug msg="Controller func execution time: 3.926653ms" name=sync-endpoints-and-host-ips subsys=controller uuid=94645780-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:52.616956199Z level=debug msg="Controller func execution time: 855.591µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:44:57.617500021Z level=debug msg="Controller func execution time: 379.901µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:00.51558363Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=41.588830833s
2019-11-30T04:45:02.618326838Z level=debug msg="Controller func execution time: 345.769µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:07.619156993Z level=debug msg="Controller func execution time: 480.246µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:12.62024339Z level=debug msg="Controller func execution time: 552.798µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:17.620946181Z level=debug msg="Controller func execution time: 417.233µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:22.622812824Z level=debug msg="Controller func execution time: 1.0498ms" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:27.623731569Z level=debug msg="Controller func execution time: 461.398µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:32.624323749Z level=debug msg="Controller func execution time: 333.632µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:37.625516056Z level=debug msg="Controller func execution time: 705.635µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:42.109747759Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=41.588830833s
2019-11-30T04:45:42.626826148Z level=debug msg="Controller func execution time: 937.135µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:47.627336303Z level=debug msg="Controller func execution time: 425.017µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:48.242100177Z level=debug msg="Controller func execution time: 42.389µs" name=dns-garbage-collector-job subsys=controller uuid=94649b96-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:48.258791783Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=192.168.1.177 key=0 subsys=ipcache
2019-11-30T04:45:48.258821444Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{192.168.1.177 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:45:48.258829618Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:45:48.25883634Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:45:48.258843375Z level=debug msg="Upserting IP into ipcache layer" identity="{world local}" ipAddr=0.0.0.0/0 key=0 subsys=ipcache
2019-11-30T04:45:48.258850094Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=world ipAddr="{0.0.0.0 00000000}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:45:48.258856815Z level=debug msg="Controller func execution time: 2.782438ms" name=sync-endpoints-and-host-ips subsys=controller uuid=94645780-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:52.62797806Z level=debug msg="Controller func execution time: 383.428µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:45:57.628747765Z level=debug msg="Controller func execution time: 376.492µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:02.629725352Z level=debug msg="Controller func execution time: 339.978µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:07.63129598Z level=debug msg="Controller func execution time: 686.203µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:12.631851833Z level=debug msg="Controller func execution time: 349.65µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:17.633779563Z level=debug msg="Controller func execution time: 911.027µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:22.634463083Z level=debug msg="Controller func execution time: 458.653µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:23.699510202Z level=debug msg="Performing regular background work" subsys=nodemanager syncInterval=41.588830833s
2019-11-30T04:46:27.635318199Z level=debug msg="Controller func execution time: 440.695µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:32.635778644Z level=debug msg="Controller func execution time: 373.881µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:37.636720111Z level=debug msg="Controller func execution time: 494.126µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:42.637655764Z level=debug msg="Controller func execution time: 328.672µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:47.638513294Z level=debug msg="Controller func execution time: 384.551µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:48.242455754Z level=debug msg="Controller func execution time: 37.982µs" name=dns-garbage-collector-job subsys=controller uuid=94649b96-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:48.260742994Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=192.168.1.177 key=0 subsys=ipcache
2019-11-30T04:46:48.26081197Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{192.168.1.177 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:46:48.261224634Z level=debug msg="Upserting IP into ipcache layer" identity="{host local}" ipAddr=10.2.2.34 key=0 subsys=ipcache
2019-11-30T04:46:48.261252638Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=host ipAddr="{10.2.2.34 ffffffff}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:46:48.261260591Z level=debug msg="Upserting IP into ipcache layer" identity="{world local}" ipAddr=0.0.0.0/0 key=0 subsys=ipcache
2019-11-30T04:46:48.261267465Z level=debug msg="Daemon notified of IP-Identity cache state change" identity=world ipAddr="{0.0.0.0 00000000}" modification=Upsert subsys=datapath-ipcache
2019-11-30T04:46:48.261274329Z level=debug msg="Controller func execution time: 2.425985ms" name=sync-endpoints-and-host-ips subsys=controller uuid=94645780-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:52.639320758Z level=debug msg="Controller func execution time: 304.532µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:46:57.641524153Z level=debug msg="Controller func execution time: 1.656011ms" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:47:02.641859232Z level=debug msg="Controller func execution time: 323.278µs" name=metricsmap-bpf-prom-sync subsys=controller uuid=8b0d42fc-132b-11ea-b958-26c6b08ddf2d
2019-11-30T04:47:02.705811213Z level=info msg="Exiting due to signal" signal=terminated subsys=daemon
2019-11-30T04:47:02.705851893Z level=debug msg="canceling context in signal handler" subsys=daemon
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment