cilium-log-20200109-140027

gistfile1.txt

2020-01-09T13:57:28.334076081+01:00 level=info msg="Skipped reading configuration file" reason="Config File \"ciliumd\" Not Found in \"[/root]\"" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --access-log=''" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --agent-labels=''" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --allow-localhost='auto'" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --annotate-k8s-node='true'" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --auto-create-cilium-node-resource='true'" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --auto-direct-node-routes='false'" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --blacklist-conflicting-routes='true'" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --bpf-compile-debug='false'" subsys=daemon
2020-01-09T13:57:28.334142876+01:00 level=info msg="  --bpf-ct-global-any-max='262144'" subsys=daemon
2020-01-09T13:57:28.334150192+01:00 level=info msg="  --bpf-ct-global-tcp-max='524288'" subsys=daemon
2020-01-09T13:57:28.334150192+01:00 level=info msg="  --bpf-ct-timeout-regular-any='1m0s'" subsys=daemon
2020-01-09T13:57:28.334173006+01:00 level=info msg="  --bpf-ct-timeout-regular-tcp='6h0m0s'" subsys=daemon
2020-01-09T13:57:28.334173006+01:00 level=info msg="  --bpf-ct-timeout-regular-tcp-fin='10s'" subsys=daemon
2020-01-09T13:57:28.334178071+01:00 level=info msg="  --bpf-ct-timeout-regular-tcp-syn='1m0s'" subsys=daemon
2020-01-09T13:57:28.33418279+01:00 level=info msg="  --bpf-ct-timeout-service-any='1m0s'" subsys=daemon
2020-01-09T13:57:28.334187188+01:00 level=info msg="  --bpf-ct-timeout-service-tcp='6h0m0s'" subsys=daemon
2020-01-09T13:57:28.334191729+01:00 level=info msg="  --bpf-nat-global-max='841429'" subsys=daemon
2020-01-09T13:57:28.334197163+01:00 level=info msg="  --bpf-policy-map-max='16384'" subsys=daemon
2020-01-09T13:57:28.334202624+01:00 level=info msg="  --bpf-root=''" subsys=daemon
2020-01-09T13:57:28.334207095+01:00 level=info msg="  --cgroup-root=''" subsys=daemon
2020-01-09T13:57:28.334211607+01:00 level=info msg="  --cluster-id='0'" subsys=daemon
2020-01-09T13:57:28.334216061+01:00 level=info msg="  --cluster-name='default'" subsys=daemon
2020-01-09T13:57:28.33422211+01:00 level=info msg="  --clustermesh-config='/var/lib/cilium/clustermesh/'" subsys=daemon
2020-01-09T13:57:28.3342275+01:00 level=info msg="  --cmdref=''" subsys=daemon
2020-01-09T13:57:28.334231955+01:00 level=info msg="  --config=''" subsys=daemon
2020-01-09T13:57:28.334236438+01:00 level=info msg="  --config-dir='/tmp/cilium/config-map'" subsys=daemon
2020-01-09T13:57:28.334241772+01:00 level=info msg="  --conntrack-garbage-collector-interval='0'" subsys=daemon
2020-01-09T13:57:28.334247107+01:00 level=info msg="  --conntrack-gc-interval='0s'" subsys=daemon
2020-01-09T13:57:28.334251535+01:00 level=info msg="  --container-runtime='none'" subsys=daemon
2020-01-09T13:57:28.334262479+01:00 level=info msg="  --container-runtime-endpoint='map[]'" subsys=daemon
2020-01-09T13:57:28.334267083+01:00 level=info msg="  --datapath-mode='veth'" subsys=daemon
2020-01-09T13:57:28.334271455+01:00 level=info msg="  --debug='false'" subsys=daemon
2020-01-09T13:57:28.334276786+01:00 level=info msg="  --debug-verbose=''" subsys=daemon
2020-01-09T13:57:28.334281177+01:00 level=info msg="  --device='undefined'" subsys=daemon
2020-01-09T13:57:28.334286468+01:00 level=info msg="  --disable-cnp-status-updates='false'" subsys=daemon
2020-01-09T13:57:28.334291781+01:00 level=info msg="  --disable-conntrack='false'" subsys=daemon
2020-01-09T13:57:28.334297129+01:00 level=info msg="  --disable-endpoint-crd='false'" subsys=daemon
2020-01-09T13:57:28.334306018+01:00 level=info msg="  --disable-envoy-version-check='false'" subsys=daemon
2020-01-09T13:57:28.334306018+01:00 level=info msg="  --disable-ipv4='false'" subsys=daemon
2020-01-09T13:57:28.334311622+01:00 level=info msg="  --disable-k8s-services='false'" subsys=daemon
2020-01-09T13:57:28.334317+01:00 level=info msg="  --docker='unix:///var/run/docker.sock'" subsys=daemon
2020-01-09T13:57:28.334322314+01:00 level=info msg="  --egress-masquerade-interfaces=''" subsys=daemon
2020-01-09T13:57:28.334327603+01:00 level=info msg="  --enable-endpoint-health-checking='true'" subsys=daemon
2020-01-09T13:57:28.334331986+01:00 level=info msg="  --enable-endpoint-routes='false'" subsys=daemon
2020-01-09T13:57:28.334337281+01:00 level=info msg="  --enable-health-checking='true'" subsys=daemon
2020-01-09T13:57:28.334342688+01:00 level=info msg="  --enable-host-reachable-services='false'" subsys=daemon
2020-01-09T13:57:28.334348054+01:00 level=info msg="  --enable-ipsec='false'" subsys=daemon
2020-01-09T13:57:28.334352409+01:00 level=info msg="  --enable-ipv4='true'" subsys=daemon
2020-01-09T13:57:28.334356789+01:00 level=info msg="  --enable-ipv6='false'" subsys=daemon
2020-01-09T13:57:28.334362071+01:00 level=info msg="  --enable-k8s-event-handover='false'" subsys=daemon
2020-01-09T13:57:28.334367361+01:00 level=info msg="  --enable-l7-proxy='true'" subsys=daemon
2020-01-09T13:57:28.334372733+01:00 level=info msg="  --enable-legacy-services='false'" subsys=daemon
2020-01-09T13:57:28.334377117+01:00 level=info msg="  --enable-node-port='false'" subsys=daemon
2020-01-09T13:57:28.334381522+01:00 level=info msg="  --enable-policy='default'" subsys=daemon
2020-01-09T13:57:28.334386804+01:00 level=info msg="  --enable-selective-regeneration='true'" subsys=daemon
2020-01-09T13:57:28.334392085+01:00 level=info msg="  --enable-tracing='false'" subsys=daemon
2020-01-09T13:57:28.334396457+01:00 level=info msg="  --encrypt-interface=''" subsys=daemon
2020-01-09T13:57:28.334401758+01:00 level=info msg="  --encrypt-node='false'" subsys=daemon
2020-01-09T13:57:28.334407117+01:00 level=info msg="  --endpoint-interface-name-prefix='lxc+'" subsys=daemon
2020-01-09T13:57:28.334411501+01:00 level=info msg="  --endpoint-queue-size='25'" subsys=daemon
2020-01-09T13:57:28.334415858+01:00 level=info msg="  --envoy-log=''" subsys=daemon
2020-01-09T13:57:28.334427048+01:00 level=info msg="  --exclude-local-address=''" subsys=daemon
2020-01-09T13:57:28.33443167+01:00 level=info msg="  --fixed-identity-mapping='map[]'" subsys=daemon
2020-01-09T13:57:28.334436972+01:00 level=info msg="  --flannel-manage-existing-containers='false'" subsys=daemon
2020-01-09T13:57:28.33444238+01:00 level=info msg="  --flannel-master-device=''" subsys=daemon
2020-01-09T13:57:28.334446781+01:00 level=info msg="  --flannel-uninstall-on-exit='false'" subsys=daemon
2020-01-09T13:57:28.334452071+01:00 level=info msg="  --force-local-policy-eval-at-source='true'" subsys=daemon
2020-01-09T13:57:28.334468842+01:00 level=info msg="  --host-reachable-services-protos=''" subsys=daemon
2020-01-09T13:57:28.334473458+01:00 level=info msg="  --http-403-msg=''" subsys=daemon
2020-01-09T13:57:28.334477906+01:00 level=info msg="  --http-idle-timeout='0'" subsys=daemon
2020-01-09T13:57:28.334482307+01:00 level=info msg="  --http-max-grpc-timeout='0'" subsys=daemon
2020-01-09T13:57:28.334487608+01:00 level=info msg="  --http-request-timeout='3600'" subsys=daemon
2020-01-09T13:57:28.334492015+01:00 level=info msg="  --http-retry-count='3'" subsys=daemon
2020-01-09T13:57:28.334497328+01:00 level=info msg="  --http-retry-timeout='0'" subsys=daemon
2020-01-09T13:57:28.334502631+01:00 level=info msg="  --identity-allocation-mode='crd'" subsys=daemon
2020-01-09T13:57:28.334508499+01:00 level=info msg="  --identity-change-grace-period='5s'" subsys=daemon
2020-01-09T13:57:28.334512961+01:00 level=info msg="  --install-iptables-rules='true'" subsys=daemon
2020-01-09T13:57:28.334517434+01:00 level=info msg="  --ip-allocation-timeout='2m0s'" subsys=daemon
2020-01-09T13:57:28.334522765+01:00 level=info msg="  --ipam=''" subsys=daemon
2020-01-09T13:57:28.334527205+01:00 level=info msg="  --ipsec-key-file=''" subsys=daemon
2020-01-09T13:57:28.334532577+01:00 level=info msg="  --ipv4-cluster-cidr-mask-size='8'" subsys=daemon
2020-01-09T13:57:28.334537901+01:00 level=info msg="  --ipv4-node='auto'" subsys=daemon
2020-01-09T13:57:28.334548354+01:00 level=info msg="  --ipv4-pod-subnets=''" subsys=daemon
2020-01-09T13:57:28.334553051+01:00 level=info msg="  --ipv4-range='auto'" subsys=daemon
2020-01-09T13:57:28.334558341+01:00 level=info msg="  --ipv4-service-loopback-address='169.254.42.1'" subsys=daemon
2020-01-09T13:57:28.334563626+01:00 level=info msg="  --ipv4-service-range='auto'" subsys=daemon
2020-01-09T13:57:28.334569022+01:00 level=info msg="  --ipv6-cluster-alloc-cidr='f00d::/64'" subsys=daemon
2020-01-09T13:57:28.334584062+01:00 level=info msg="  --ipv6-node='auto'" subsys=daemon
2020-01-09T13:57:28.334588317+01:00 level=info msg="  --ipv6-pod-subnets=''" subsys=daemon
2020-01-09T13:57:28.334592593+01:00 level=info msg="  --ipv6-range='auto'" subsys=daemon
2020-01-09T13:57:28.334596859+01:00 level=info msg="  --ipv6-service-range='auto'" subsys=daemon
2020-01-09T13:57:28.334601122+01:00 level=info msg="  --ipvlan-master-device='undefined'" subsys=daemon
2020-01-09T13:57:28.334606362+01:00 level=info msg="  --k8s-api-server=''" subsys=daemon
2020-01-09T13:57:28.334611552+01:00 level=info msg="  --k8s-force-json-patch='false'" subsys=daemon
2020-01-09T13:57:28.334616684+01:00 level=info msg="  --k8s-kubeconfig-path=''" subsys=daemon
2020-01-09T13:57:28.334621872+01:00 level=info msg="  --k8s-namespace='kube-system'" subsys=daemon
2020-01-09T13:57:28.334627083+01:00 level=info msg="  --k8s-require-ipv4-pod-cidr='false'" subsys=daemon
2020-01-09T13:57:28.334632225+01:00 level=info msg="  --k8s-require-ipv6-pod-cidr='false'" subsys=daemon
2020-01-09T13:57:28.334637362+01:00 level=info msg="  --k8s-service-cache-size='128'" subsys=daemon
2020-01-09T13:57:28.334650285+01:00 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
2020-01-09T13:57:28.334654882+01:00 level=info msg="  --k8s-watcher-queue-size='1024'" subsys=daemon
2020-01-09T13:57:28.334660044+01:00 level=info msg="  --keep-bpf-templates='false'" subsys=daemon
2020-01-09T13:57:28.334665264+01:00 level=info msg="  --keep-config='false'" subsys=daemon
2020-01-09T13:57:28.334669564+01:00 level=info msg="  --kvstore=''" subsys=daemon
2020-01-09T13:57:28.334674743+01:00 level=info msg="  --kvstore-connectivity-timeout='2m0s'" subsys=daemon
2020-01-09T13:57:28.334679947+01:00 level=info msg="  --kvstore-lease-ttl='15m0s'" subsys=daemon
2020-01-09T13:57:28.334685112+01:00 level=info msg="  --kvstore-opt='map[]'" subsys=daemon
2020-01-09T13:57:28.334690295+01:00 level=info msg="  --kvstore-periodic-sync='5m0s'" subsys=daemon
2020-01-09T13:57:28.334694602+01:00 level=info msg="  --label-prefix-file=''" subsys=daemon
2020-01-09T13:57:28.334699884+01:00 level=info msg="  --labels=''" subsys=daemon
2020-01-09T13:57:28.334705106+01:00 level=info msg="  --lb=''" subsys=daemon
2020-01-09T13:57:28.334709413+01:00 level=info msg="  --lib-dir='/var/lib/cilium'" subsys=daemon
2020-01-09T13:57:28.334720098+01:00 level=info msg="  --log-driver=''" subsys=daemon
2020-01-09T13:57:28.334726059+01:00 level=info msg="  --log-opt='map[]'" subsys=daemon
2020-01-09T13:57:28.334730467+01:00 level=info msg="  --log-system-load='false'" subsys=daemon
2020-01-09T13:57:28.334734771+01:00 level=info msg="  --masquerade='true'" subsys=daemon
2020-01-09T13:57:28.334739121+01:00 level=info msg="  --max-controller-interval='0'" subsys=daemon
2020-01-09T13:57:28.334744278+01:00 level=info msg="  --metrics=''" subsys=daemon
2020-01-09T13:57:28.334749537+01:00 level=info msg="  --monitor-aggregation='medium'" subsys=daemon
2020-01-09T13:57:28.334753832+01:00 level=info msg="  --monitor-queue-size='0'" subsys=daemon
2020-01-09T13:57:28.33475902+01:00 level=info msg="  --mtu='0'" subsys=daemon
2020-01-09T13:57:28.33476422+01:00 level=info msg="  --nat46-range='0:0:0:0:0:FFFF::/96'" subsys=daemon
2020-01-09T13:57:28.334777749+01:00 level=info msg="  --node-port-range=''" subsys=daemon
2020-01-09T13:57:28.334782288+01:00 level=info msg="  --policy-queue-size='100'" subsys=daemon
2020-01-09T13:57:28.334787454+01:00 level=info msg="  --policy-trigger-interval='1s'" subsys=daemon
2020-01-09T13:57:28.334792804+01:00 level=info msg="  --pprof='false'" subsys=daemon
2020-01-09T13:57:28.334797113+01:00 level=info msg="  --preallocate-bpf-maps='false'" subsys=daemon
2020-01-09T13:57:28.334802283+01:00 level=info msg="  --prefilter-device='undefined'" subsys=daemon
2020-01-09T13:57:28.334807563+01:00 level=info msg="  --prefilter-mode='native'" subsys=daemon
2020-01-09T13:57:28.334811865+01:00 level=info msg="  --prepend-iptables-chains='true'" subsys=daemon
2020-01-09T13:57:28.334817032+01:00 level=info msg="  --prometheus-serve-addr=''" subsys=daemon
2020-01-09T13:57:28.334822192+01:00 level=info msg="  --proxy-connect-timeout='1'" subsys=daemon
2020-01-09T13:57:28.334826474+01:00 level=info msg="  --read-cni-conf=''" subsys=daemon
2020-01-09T13:57:28.334831761+01:00 level=info msg="  --restore='true'" subsys=daemon
2020-01-09T13:57:28.334836951+01:00 level=info msg="  --sidecar-http-proxy='false'" subsys=daemon
2020-01-09T13:57:28.33484225+01:00 level=info msg="  --sidecar-istio-proxy-image='cilium/istio_proxy'" subsys=daemon
2020-01-09T13:57:28.334846553+01:00 level=info msg="  --single-cluster-route='false'" subsys=daemon
2020-01-09T13:57:28.33485175+01:00 level=info msg="  --skip-crd-creation='false'" subsys=daemon
2020-01-09T13:57:28.334856934+01:00 level=info msg="  --socket-path='/var/run/cilium/cilium.sock'" subsys=daemon
2020-01-09T13:57:28.334862098+01:00 level=info msg="  --sockops-enable='false'" subsys=daemon
2020-01-09T13:57:28.33486638+01:00 level=info msg="  --state-dir='/var/run/cilium'" subsys=daemon
2020-01-09T13:57:28.334871617+01:00 level=info msg="  --tofqdns-dns-reject-response-code='refused'" subsys=daemon
2020-01-09T13:57:28.334876809+01:00 level=info msg="  --tofqdns-enable-poller='false'" subsys=daemon
2020-01-09T13:57:28.334882008+01:00 level=info msg="  --tofqdns-enable-poller-events='true'" subsys=daemon
2020-01-09T13:57:28.334887206+01:00 level=info msg="  --tofqdns-endpoint-max-ip-per-hostname='50'" subsys=daemon
2020-01-09T13:57:28.334892388+01:00 level=info msg="  --tofqdns-min-ttl='0'" subsys=daemon
2020-01-09T13:57:28.33489667+01:00 level=info msg="  --tofqdns-pre-cache=''" subsys=daemon
2020-01-09T13:57:28.334901813+01:00 level=info msg="  --tofqdns-proxy-port='0'" subsys=daemon
2020-01-09T13:57:28.334906988+01:00 level=info msg="  --tofqdns-proxy-response-max-delay='50ms'" subsys=daemon
2020-01-09T13:57:28.334912218+01:00 level=info msg="  --trace-payloadlen='128'" subsys=daemon
2020-01-09T13:57:28.334916498+01:00 level=info msg="  --tunnel='vxlan'" subsys=daemon
2020-01-09T13:57:28.334921734+01:00 level=info msg="  --version='false'" subsys=daemon
2020-01-09T13:57:28.334927193+01:00 level=info msg="  --write-cni-conf-when-ready=''" subsys=daemon
2020-01-09T13:57:28.334931594+01:00 level=info msg="     _ _ _" subsys=daemon
2020-01-09T13:57:28.334936137+01:00 level=info msg=" ___|_| |_|_ _ _____" subsys=daemon
2020-01-09T13:57:28.334936137+01:00 level=info msg="|  _| | | | | |     |" subsys=daemon
2020-01-09T13:57:28.334941523+01:00 level=info msg="|___|_|_|_|___|_|_|_|" subsys=daemon
2020-01-09T13:57:28.334952118+01:00 level=info msg="Cilium 1.6.5 88642ed70 2019-12-16T07:21:37-08:00 go version go1.12.14 linux/amd64" subsys=daemon
2020-01-09T13:57:28.345724053+01:00 level=info msg="cilium-envoy  version: 9e8d7bb5e02d6038d6cf0ec3f28bf4019f3c7d79/1.12.2/Modified/RELEASE/BoringSSL" subsys=daemon
2020-01-09T13:57:28.395989558+01:00 level=info msg="clang (7.0.0) and kernel (4.12.14) versions: OK!" subsys=daemon
2020-01-09T13:57:28.404372517+01:00 level=info msg="linking environment: OK!" subsys=daemon
2020-01-09T13:57:29.570197519+01:00 level=info msg="bpf_requirements check: OK!" subsys=daemon
2020-01-09T13:57:29.570197519+01:00 level=info msg="bpf_features check: OK!" subsys=daemon
2020-01-09T13:57:29.570412229+01:00 level=warning msg="BPF filesystem is going to be mounted automatically in /run/cilium/bpffs. However, it probably means that Cilium is running inside container and BPFFS is not mounted on the host. for more information, see: https://cilium.link/err-bpf-mount" subsys=bpf
2020-01-09T13:57:29.570482747+01:00 level=warning msg="================================= WARNING ==========================================" subsys=bpf
2020-01-09T13:57:29.570482747+01:00 level=warning msg="BPF filesystem is not mounted. This will lead to network disruption when Cilium pods" subsys=bpf
2020-01-09T13:57:29.570482747+01:00 level=warning msg="are restarted. Ensure that the BPF filesystem is mounted in the host." subsys=bpf
2020-01-09T13:57:29.570482747+01:00 level=warning msg="https://docs.cilium.io/en/stable/kubernetes/requirements/#mounted-bpf-filesystem" subsys=bpf
2020-01-09T13:57:29.570502878+01:00 level=warning msg="====================================================================================" subsys=bpf
2020-01-09T13:57:29.570502878+01:00 level=info msg="Mounting BPF filesystem at /run/cilium/bpffs" subsys=bpf
2020-01-09T13:57:29.570542248+01:00 level=info msg="Detected mounted BPF filesystem at /run/cilium/bpffs" subsys=bpf
2020-01-09T13:57:29.57079748+01:00 level=info msg="Valid label prefix configuration:" subsys=labels-filter
2020-01-09T13:57:29.57079748+01:00 level=info msg=" - :io.kubernetes.pod.namespace" subsys=labels-filter
2020-01-09T13:57:29.57079748+01:00 level=info msg=" - :io.cilium.k8s.namespace.labels" subsys=labels-filter
2020-01-09T13:57:29.57079748+01:00 level=info msg=" - :app.kubernetes.io" subsys=labels-filter
2020-01-09T13:57:29.57079748+01:00 level=info msg=" - !:io.kubernetes" subsys=labels-filter
2020-01-09T13:57:29.57079748+01:00 level=info msg=" - !:kubernetes.io" subsys=labels-filter
2020-01-09T13:57:29.57079748+01:00 level=info msg=" - !:.*beta.kubernetes.io" subsys=labels-filter
2020-01-09T13:57:29.570818525+01:00 level=info msg=" - !:k8s.io" subsys=labels-filter
2020-01-09T13:57:29.570818525+01:00 level=info msg=" - !:pod-template-generation" subsys=labels-filter
2020-01-09T13:57:29.570818525+01:00 level=info msg=" - !:pod-template-hash" subsys=labels-filter
2020-01-09T13:57:29.570818525+01:00 level=info msg=" - !:controller-revision-hash" subsys=labels-filter
2020-01-09T13:57:29.570818525+01:00 level=info msg=" - !:annotation.*" subsys=labels-filter
2020-01-09T13:57:29.570818525+01:00 level=info msg=" - !:etcd_node" subsys=labels-filter
2020-01-09T13:57:29.57083593+01:00 level=info msg="Initializing daemon" subsys=daemon
2020-01-09T13:57:29.593181206+01:00 level=info msg="Detected MTU 1500" subsys=mtu
2020-01-09T13:57:29.596044801+01:00 level=info msg="Restore service IDs from BPF maps" duration="174.894µs" failed=0 removed=0 restored=0 skipped=0 subsys=daemon
2020-01-09T13:57:29.596044801+01:00 level=info msg="Removing stale endpoint interfaces" subsys=daemon
2020-01-09T13:57:29.59676679+01:00 level=info msg="Establishing connection to apiserver" host="https://10.96.0.1:443" subsys=k8s
2020-01-09T13:57:29.604091149+01:00 level=info msg="Connected to apiserver" subsys=k8s
2020-01-09T13:57:29.605910283+01:00 level=info msg="Retrieved node information from kubernetes" nodeName=bpf-devel subsys=k8s
2020-01-09T13:57:29.605929328+01:00 level=info msg="Received own node information from API server" ipAddr.ipv4=192.168.122.20 ipAddr.ipv6="<nil>" nodeName=bpf-devel subsys=k8s v4Prefix=10.20.0.0/16 v6Prefix="<nil>"
2020-01-09T13:57:30.417469399+01:00 level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=CiliumNetworkPolicy/v2 subsys=k8s
2020-01-09T13:57:30.419760956+01:00 level=info msg="Updating CRD (CustomResourceDefinition)..." name=v2.CiliumEndpoint subsys=k8s
2020-01-09T13:57:31.745438084+01:00 level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=v2.CiliumEndpoint subsys=k8s
2020-01-09T13:57:31.748385505+01:00 level=info msg="Updating CRD (CustomResourceDefinition)..." name=v2.CiliumNode subsys=k8s
2020-01-09T13:57:32.76111365+01:00 level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=v2.CiliumNode subsys=k8s
2020-01-09T13:57:32.764337152+01:00 level=info msg="Updating CRD (CustomResourceDefinition)..." name=v2.CiliumIdentity subsys=k8s
2020-01-09T13:57:33.780695835+01:00 level=info msg="CRD (CustomResourceDefinition) is installed and up-to-date" name=v2.CiliumIdentity subsys=k8s
2020-01-09T13:57:33.780749646+01:00 level=info msg="k8s mode: Allowing localhost to reach local endpoints" subsys=daemon
2020-01-09T13:57:33.780749646+01:00 level=info msg="Initializing node addressing" subsys=daemon
2020-01-09T13:57:33.784026189+01:00 level=info msg="Initializing hostscope IPAM" subsys=ipam v4Prefix=10.20.0.0/16 v6Prefix="<nil>"
2020-01-09T13:57:33.784084769+01:00 level=info msg="Restoring endpoints..." subsys=daemon
2020-01-09T13:57:33.784454178+01:00 level=info msg="No old endpoints found." subsys=daemon
2020-01-09T13:57:33.784520544+01:00 level=info msg="Addressing information:" subsys=daemon
2020-01-09T13:57:33.784520544+01:00 level=info msg="  Cluster-Name: default" subsys=daemon
2020-01-09T13:57:33.784536542+01:00 level=info msg="  Cluster-ID: 0" subsys=daemon
2020-01-09T13:57:33.784536542+01:00 level=info msg="  Local node-name: bpf-devel" subsys=daemon
2020-01-09T13:57:33.784562448+01:00 level=info msg="  Node-IPv6: <nil>" subsys=daemon
2020-01-09T13:57:33.784632457+01:00 level=info msg="  External-Node IPv4: 192.168.122.20" subsys=daemon
2020-01-09T13:57:33.784632457+01:00 level=info msg="  Internal-Node IPv4: 10.20.71.203" subsys=daemon
2020-01-09T13:57:33.784672376+01:00 level=info msg="  Cluster IPv4 prefix: 10.0.0.0/8" subsys=daemon
2020-01-09T13:57:33.784672376+01:00 level=info msg="  IPv4 allocation prefix: 10.20.0.0/16" subsys=daemon
2020-01-09T13:57:33.784685829+01:00 level=info msg="  Loopback IPv4: 169.254.42.1" subsys=daemon
2020-01-09T13:57:33.784841716+01:00 level=info msg="  Local IPv4 addresses:" subsys=daemon
2020-01-09T13:57:33.784841716+01:00 level=info msg="  - 192.168.122.20" subsys=daemon
2020-01-09T13:57:33.784927705+01:00 level=info msg="Annotating k8s node" subsys=daemon v4CiliumHostIP.IPv4=10.20.71.203 v4Prefix=10.20.0.0/16 v4healthIP.IPv4=10.20.175.40 v6CiliumHostIP.IPv6="<nil>" v6Prefix="<nil>" v6healthIP.IPv6="<nil>"
2020-01-09T13:57:33.785143572+01:00 level=info msg="Initializing identity allocator" subsys=identity-cache
2020-01-09T13:57:33.785176932+01:00 level=info msg="Cluster-ID is not specified, skipping ClusterMesh initialization" subsys=daemon
2020-01-09T13:57:33.794293852+01:00 level=info msg="Adding local node to cluster" subsys=nodediscovery
2020-01-09T13:57:33.794946244+01:00 level=info msg="Setting up base BPF datapath" subsys=daemon
2020-01-09T13:57:33.809760244+01:00 level=info msg="regenerating all endpoints" reason="one or more identities created or deleted" subsys=endpoint-manager
2020-01-09T13:57:35.616397456+01:00 level=info msg="Blacklisting local route as no-alloc" route=172.17.0.0/16 subsys=ipam
2020-01-09T13:57:35.616477673+01:00 level=info msg="Blacklisting local route as no-alloc" route=192.168.122.0/24 subsys=ipam
2020-01-09T13:57:35.635814749+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t filter -F CILIUM_INPUT]" subsys=iptables
2020-01-09T13:57:35.636595557+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t filter -X CILIUM_INPUT]" subsys=iptables
2020-01-09T13:57:35.637210458+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t filter -F CILIUM_OUTPUT]" subsys=iptables
2020-01-09T13:57:35.637838347+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t filter -X CILIUM_OUTPUT]" subsys=iptables
2020-01-09T13:57:35.638886778+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t raw -F CILIUM_OUTPUT_raw]" subsys=iptables
2020-01-09T13:57:35.639825368+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t raw -X CILIUM_OUTPUT_raw]" subsys=iptables
2020-01-09T13:57:35.640814601+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t nat -F CILIUM_POST_nat]" subsys=iptables
2020-01-09T13:57:35.641794688+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t nat -X CILIUM_POST_nat]" subsys=iptables
2020-01-09T13:57:35.642874487+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t nat -F CILIUM_OUTPUT_nat]" subsys=iptables
2020-01-09T13:57:35.643858828+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t nat -X CILIUM_OUTPUT_nat]" subsys=iptables
2020-01-09T13:57:35.644805741+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t nat -F CILIUM_PRE_nat]" subsys=iptables
2020-01-09T13:57:35.645753669+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t nat -X CILIUM_PRE_nat]" subsys=iptables
2020-01-09T13:57:35.64646382+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t mangle -F CILIUM_POST_mangle]" subsys=iptables
2020-01-09T13:57:35.647236505+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t mangle -X CILIUM_POST_mangle]" subsys=iptables
2020-01-09T13:57:35.648226473+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t mangle -F CILIUM_PRE_mangle]" subsys=iptables
2020-01-09T13:57:35.648960196+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t mangle -X CILIUM_PRE_mangle]" subsys=iptables
2020-01-09T13:57:35.651635488+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t raw -F CILIUM_PRE_raw]" subsys=iptables
2020-01-09T13:57:35.652755794+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t raw -X CILIUM_PRE_raw]" subsys=iptables
2020-01-09T13:57:35.654074524+01:00 level=warning msg="Unable to flush Cilium iptables chain" error="exit status 1" obj="[-w 5 -t filter -F CILIUM_FORWARD]" subsys=iptables
2020-01-09T13:57:35.654815835+01:00 level=warning msg="Unable to delete Cilium iptables chain" error="exit status 1" obj="[-w 5 -t filter -X CILIUM_FORWARD]" subsys=iptables
2020-01-09T13:57:35.696574418+01:00 level=info msg="Setting sysctl net.core.bpf_jit_enable=1" subsys=daemon
2020-01-09T13:57:35.696611308+01:00 level=info msg="Setting sysctl net.ipv4.conf.all.rp_filter=0" subsys=daemon
2020-01-09T13:57:35.696628368+01:00 level=info msg="Setting sysctl net.ipv6.conf.all.disable_ipv6=0" subsys=daemon
2020-01-09T13:57:35.697145952+01:00 level=info msg="Serving cilium node monitor v1.2 API at unix:///var/run/cilium/monitor1_2.sock" subsys=monitor-agent
2020-01-09T13:57:35.697627084+01:00 level=info msg="Envoy: Starting xDS gRPC server listening on /var/run/cilium/xds.sock" subsys=envoy-manager
2020-01-09T13:57:35.697672737+01:00 level=info msg="Starting IP identity watcher" subsys=ipcache
2020-01-09T13:57:35.706291146+01:00 level=info msg="Validating configured node address ranges" subsys=daemon
2020-01-09T13:57:35.706334252+01:00 level=info msg="Starting connection tracking garbage collector" subsys=daemon
2020-01-09T13:57:35.706516285+01:00 level=info msg="Initial scan of connection tracking completed" subsys=endpoint-manager
2020-01-09T13:57:35.70652869+01:00 level=info msg="Enabling k8s event listener" subsys=daemon
2020-01-09T13:57:35.706579665+01:00 level=info msg="Datapath signal listener running" subsys=signal
2020-01-09T13:57:35.709029417+01:00 level=info msg="Skipping kvstore configuration" subsys=daemon
2020-01-09T13:57:35.711315127+01:00 level=info msg="Waiting until all pre-existing resources related to policy have been received" subsys=daemon
2020-01-09T13:57:35.809745239+01:00 level=info msg="All pre-existing resources related to policy have been received; continuing" subsys=daemon
2020-01-09T13:57:35.809745239+01:00 level=info msg="Regenerating restored endpoints" numRestored=0 subsys=daemon
2020-01-09T13:57:35.809815729+01:00 level=info msg="Launching Cilium health daemon" subsys=daemon
2020-01-09T13:57:35.809978301+01:00 level=info msg="Finished regenerating restored endpoints" regenerated=0 subsys=daemon total=0
2020-01-09T13:57:35.839855995+01:00 level=info msg="Launching Cilium health endpoint" subsys=daemon
2020-01-09T13:57:35.877117248+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:57:35.908484136+01:00 level=info msg="Initializing Cilium API" subsys=daemon
2020-01-09T13:57:35.917764338+01:00 level=info msg="Daemon initialization completed" bootstrapTime=7.585941169s subsys=daemon
2020-01-09T13:57:35.917892238+01:00 level=info msg="Serving cilium at unix:///var/run/cilium/cilium.sock" subsys=daemon
2020-01-09T13:57:36.024552505+01:00 level=info msg="New endpoint" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=297 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:57:36.024552505+01:00 level=info msg="Resolving identity labels (blocking)" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=297 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=kured,k8s:io.kubernetes.pod.namespace=kube-system,k8s:name=kured" ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:57:36.024552505+01:00 level=info msg="Reusing existing global key" key="k8s:io.cilium.k8s.policy.cluster=default;k8s:io.cilium.k8s.policy.serviceaccount=kured;k8s:io.kubernetes.pod.namespace=kube-system;k8s:name=kured;" subsys=allocator
2020-01-09T13:57:36.072920107+01:00 level=info msg="Identity of endpoint changed" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=297 identity=49793 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=kured,k8s:io.kubernetes.pod.namespace=kube-system,k8s:name=kured" ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc oldIdentity="no identity" subsys=endpoint
2020-01-09T13:57:36.073147836+01:00 level=info msg="Waiting for endpoint to be generated" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=297 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=daemon
2020-01-09T13:57:36.294040267+01:00 level=info msg="New endpoint" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3114 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:57:36.294040267+01:00 level=info msg="Resolving identity labels (blocking)" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3114 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=coredns,k8s:io.kubernetes.pod.namespace=kube-system,k8s:k8s-app=kube-dns" ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:57:36.294040267+01:00 level=info msg="Identity of endpoint changed" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3114 identity=104 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=coredns,k8s:io.kubernetes.pod.namespace=kube-system,k8s:k8s-app=kube-dns" ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h oldIdentity="no identity" subsys=endpoint
2020-01-09T13:57:36.294040267+01:00 level=info msg="Waiting for endpoint to be generated" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3114 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=daemon
2020-01-09T13:57:36.355934252+01:00 level=info msg="New endpoint" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1451 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:57:36.357473873+01:00 level=info msg="Resolving identity labels (blocking)" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1451 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=coredns,k8s:io.kubernetes.pod.namespace=kube-system,k8s:k8s-app=kube-dns" ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:57:36.357473873+01:00 level=info msg="Identity of endpoint changed" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1451 identity=104 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=coredns,k8s:io.kubernetes.pod.namespace=kube-system,k8s:k8s-app=kube-dns" ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj oldIdentity="no identity" subsys=endpoint
2020-01-09T13:57:36.357473873+01:00 level=info msg="Waiting for endpoint to be generated" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1451 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=daemon
2020-01-09T13:57:36.483653219+01:00 level=info msg="Compiled new BPF template" BPFCompilationTime=407.288396ms file-path=/var/run/cilium/state/templates/e5b5f92f0eb7770a6e891c3606f51c0776f4b90c/bpf_lxc.o subsys=datapath-loader
2020-01-09T13:57:36.887584849+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3340 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:57:36.887584849+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3340 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:57:36.887584849+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3340 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:57:38.894971653+01:00 level=info msg="Serving cilium health at unix:///var/run/cilium/health.sock" subsys=health-server
2020-01-09T13:57:57.140296103+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcfe2d362c1764 ingress prio 1 handle 1 bpf da obj 3114_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg="Skipped 19624616 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:57:57.140296103+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:57:57.140372734+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:57.140417422+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:57.140417422+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:57:57.140417422+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:57:57.140417422+01:00 level=warning subsys=datapath-loader
2020-01-09T13:57:57.140417422+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:57:57.140417422+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:57:57.141176151+01:00 level=warning msg="JoinEP: Failed to load program" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" file-path=3114_next/bpf_lxc.o identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=datapath-loader veth=lxcfe2d362c1764
2020-01-09T13:57:57.141176151+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:57:57.141220605+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 file-path=3114_next_fail identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:57:57.141278837+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=20.656840887s bpfWaitForELF=189.109236ms bpfWriteELF="101.716µs" buildDuration=20.847246811s containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h mapSync="17.563µs" policyCalculation="37.326µs" prepareBuild="154.52µs" proxyConfiguration="1.721µs" proxyPolicyCalculation="11.081µs" proxyWaitForAck=0s reason="updated security labels" subsys=endpoint waitingForCTClean="160.01µs" waitingForLock="1.618µs"
2020-01-09T13:57:57.141375857+01:00 level=error msg="endpoint regeneration failed" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:57:58.244715359+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcbb58dd70ae72 ingress prio 1 handle 1 bpf da obj 297_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg="Skipped 19625033 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:57:58.244715359+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning subsys=datapath-loader
2020-01-09T13:57:58.244812934+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:57:58.244870733+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:57:58.24647195+01:00 level=warning msg="JoinEP: Failed to load program" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" file-path=297_next/bpf_lxc.o identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=datapath-loader veth=lxcbb58dd70ae72
2020-01-09T13:57:58.24647195+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:57:58.24647195+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 file-path=297_next_fail identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:57:58.246548398+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=407.288396ms bpfLoadProg=21.761153188s bpfWaitForELF=407.8483ms bpfWriteELF="295.856µs" buildDuration=22.173140628s containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc mapSync="73.395µs" policyCalculation="114.176µs" prepareBuild=1.071078ms proxyConfiguration="4.064µs" proxyPolicyCalculation="180.025µs" proxyWaitForAck=0s reason="updated security labels" subsys=endpoint waitingForCTClean="539.044µs" waitingForLock="1.523µs"
2020-01-09T13:57:58.246629543+01:00 level=error msg="endpoint regeneration failed" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:58:18.766077669+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxc_health ingress prio 1 handle 1 bpf da obj 3340_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="Skipped 19624416 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:58:18.766077669+01:00 level=warning msg="JoinEP: Failed to load program" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3340 error="Failed to load tc filter: exit status 1" file-path=3340_next/bpf_lxc.o identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=datapath-loader veth=lxc_health
2020-01-09T13:58:18.766077669+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3340 error="Failed to load tc filter: exit status 1" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:18.766077669+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3340 file-path=3340_next_fail identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:18.766077669+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=20.509753702s bpfWaitForELF="2.987µs" bpfWriteELF="91.779µs" buildDuration=20.51192183s containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3340 error="Failed to load tc filter: exit status 1" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ mapSync="18.959µs" policyCalculation="50.144µs" prepareBuild="142.23µs" proxyConfiguration="1.768µs" proxyPolicyCalculation="11.011µs" proxyWaitForAck=0s reason="updated security labels" subsys=endpoint waitingForCTClean=1.097883ms waitingForLock=827ns
2020-01-09T13:58:18.766077669+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3340 error="Failed to load tc filter: exit status 1" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:19.895871194+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxc7b49e966c8f6 ingress prio 1 handle 1 bpf da obj 1451_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:58:19.895871194+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:19.895871194+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:58:19.895871194+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:58:19.895871194+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:58:19.895871194+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:58:19.895914629+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:58:19.895914629+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:19.895914629+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:58:19.895914629+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:19.895914629+01:00 level=warning msg="Skipped 19624626 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:58:19.895914629+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:58:19.895949686+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:19.895955875+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:58:19.89601358+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:19.896018696+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:58:19.89603377+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:58:19.896071341+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:19.896084484+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:58:19.896101238+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:58:19.896105895+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:58:19.896122228+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:58:19.896160407+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:19.89617431+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:58:19.8961892+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:58:19.896194705+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:58:19.89621063+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:58:19.896216037+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:58:19.896228712+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:58:19.896241153+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:58:19.896254232+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:58:19.8962671+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:58:19.896278192+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:58:19.896283667+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:58:19.896299666+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:58:19.896304988+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:58:19.89632003+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:58:19.896358694+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:19.896397692+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:19.896404092+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:58:19.896418285+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:58:19.896430136+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:19.896446711+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:58:19.896452591+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:58:19.902218758+01:00 level=warning msg="JoinEP: Failed to load program" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="Failed to load tc filter: exit status 1" file-path=1451_next/bpf_lxc.o identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=datapath-loader veth=lxc7b49e966c8f6
2020-01-09T13:58:19.902242181+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:58:19.90229819+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 file-path=1451_next_fail identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:58:19.902402266+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=22.758940674s bpfWaitForELF="2.859µs" bpfWriteELF="90.283µs" buildDuration=22.760967145s containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj mapSync="18.814µs" policyCalculation="26.714µs" prepareBuild="137.85µs" proxyConfiguration="1.846µs" proxyPolicyCalculation="12.139µs" proxyWaitForAck=0s reason="updated security labels" subsys=endpoint waitingForCTClean=1.166067ms waitingForLock=566ns
2020-01-09T13:58:19.902517124+01:00 level=error msg="endpoint regeneration failed" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:58:37.903635068+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3340 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:37.903678474+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3340 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:37.904112998+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3340 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:38.128862826+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:58:38.645493968+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcfe2d362c1764 ingress prio 1 handle 1 bpf da obj 3114_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:58:38.645558592+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:38.645574472+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:58:38.645586523+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:58:38.645597525+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:58:38.645608983+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:58:38.64562058+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:58:38.645630894+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:38.645641753+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:58:38.645652336+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:38.645663856+01:00 level=warning msg="Skipped 19624616 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:58:38.645674638+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:58:38.645696604+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:38.645707874+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:58:38.645730308+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:38.645741277+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:58:38.645752246+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:58:38.645770328+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:38.645781328+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:58:38.6457929+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:58:38.645803748+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:58:38.645814605+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:58:38.645832249+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:38.645843011+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:58:38.645853716+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:58:38.645864493+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:58:38.645875145+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:58:38.645885809+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:58:38.645896449+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:58:38.645908706+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:58:38.645919479+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:58:38.645930169+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:58:38.645940799+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:58:38.645951674+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:58:38.645962312+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:58:38.645973038+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:58:38.645983949+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:58:38.646036976+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:38.646059604+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:38.646077342+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:58:38.646089062+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:58:38.646099196+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:38.646109929+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:58:38.646120685+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:58:38.646990025+01:00 level=warning msg="JoinEP: Failed to load program" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" file-path=3114_next/bpf_lxc.o identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=datapath-loader veth=lxcfe2d362c1764
2020-01-09T13:58:38.647037499+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:58:38.647083817+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 file-path=3114_next_fail identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:58:38.647209464+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=19.886541435s bpfWaitForELF="3.591µs" bpfWriteELF="99.592µs" buildDuration=19.888403588s containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h mapSync="1.782µs" policyCalculation="3.184µs" prepareBuild="161.222µs" proxyConfiguration="1.955µs" proxyPolicyCalculation="13.626µs" proxyWaitForAck=0s reason="retrying regeneration" subsys=endpoint waitingForCTClean=1.073905ms waitingForLock="1.284µs"
2020-01-09T13:58:38.647298755+01:00 level=error msg="endpoint regeneration failed" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:58:39.145985303+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=154 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:39.14627493+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=154 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:39.146377642+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=154 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:58:41.169263962+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=154 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:41.169768741+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=154 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:41.169840239+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=154 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:41.226048345+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:58:42.23960171+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3969 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:42.239693872+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3969 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:42.239739001+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3969 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:58:43.869133067+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcbb58dd70ae72 ingress prio 1 handle 1 bpf da obj 297_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:58:43.869186577+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:43.869201024+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:58:43.869212406+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:58:43.869223733+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:58:43.86924814+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:58:43.869263325+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:58:43.86927398+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:43.869284642+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:58:43.869295017+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:43.869307431+01:00 level=warning msg="Skipped 19625033 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:58:43.86932054+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:58:43.869342434+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:43.869354539+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:58:43.869374596+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:43.869385574+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:58:43.869396576+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:58:43.869424011+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:43.869435615+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:58:43.869446475+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:58:43.869457268+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:58:43.869468014+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:58:43.86949054+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:43.869507886+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:58:43.869519117+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:58:43.869529755+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:58:43.869540391+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:58:43.869550991+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:58:43.869561495+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:58:43.869576557+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:58:43.869591039+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:58:43.869601999+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:58:43.869612615+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:58:43.869623444+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:58:43.869634008+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:58:43.869644564+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:58:43.869659523+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:58:43.86968237+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:43.869700451+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:58:43.869711311+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:58:43.869722453+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:58:43.869732503+01:00 level=warning subsys=datapath-loader
2020-01-09T13:58:43.869751718+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:58:43.869762945+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:58:43.875277236+01:00 level=warning msg="JoinEP: Failed to load program" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" file-path=297_next/bpf_lxc.o identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=datapath-loader veth=lxcbb58dd70ae72
2020-01-09T13:58:43.875338376+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:58:43.875391969+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 file-path=297_next_fail identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:58:43.875505045+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=23.963754788s bpfWaitForELF="3.676µs" bpfWriteELF="106.294µs" buildDuration=23.972991158s containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc mapSync="1.2µs" policyCalculation="2.792µs" prepareBuild=7.090907ms proxyConfiguration="1.989µs" proxyPolicyCalculation="12.908µs" proxyWaitForAck=0s reason="retrying regeneration" subsys=endpoint waitingForCTClean=1.491535ms waitingForLock="1.306µs"
2020-01-09T13:58:43.87558454+01:00 level=error msg="endpoint regeneration failed" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:58:45.265882391+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3969 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:45.267312627+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3969 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:45.267456573+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3969 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:45.307260293+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:58:46.326327455+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=2731 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:46.326443611+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=2731 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:46.326520559+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=2731 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:58:50.351444993+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=2731 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:50.351444993+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=2731 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:50.35252287+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=2731 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:50.383652261+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:58:51.398341951+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=899 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:51.398467982+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=899 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:51.398524851+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=899 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:58:56.431573231+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=899 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:56.431862129+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=899 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:56.43214474+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=899 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:56.476685782+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:58:57.503535623+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1583 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:57.503635264+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1583 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:58:57.503709717+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1583 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:59:01.558444678+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxc7b49e966c8f6 ingress prio 1 handle 1 bpf da obj 1451_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="Skipped 19624626 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:59:01.558444678+01:00 level=warning msg="JoinEP: Failed to load program" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="Failed to load tc filter: exit status 1" file-path=1451_next/bpf_lxc.o identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=datapath-loader veth=lxc7b49e966c8f6
2020-01-09T13:59:01.558444678+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:01.558444678+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 file-path=1451_next_fail identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:01.558444678+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=22.908215441s bpfWaitForELF="2.789µs" bpfWriteELF="94.795µs" buildDuration=22.910064436s containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj mapSync="1.642µs" policyCalculation="3.494µs" prepareBuild="136.442µs" proxyConfiguration="1.666µs" proxyPolicyCalculation="11.58µs" proxyWaitForAck=0s reason="retrying regeneration" subsys=endpoint waitingForCTClean=1.122563ms waitingForLock="1.073µs"
2020-01-09T13:59:01.558444678+01:00 level=error msg="endpoint regeneration failed" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="Failed to load tc2020-01-09T13:59:01.558492293+01:00  filter: exit status 1" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:02.505554369+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1583 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:02.505554369+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1583 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:02.506370683+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1583 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:02.550243196+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:59:03.566067292+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=418 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:03.566199324+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=418 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:03.566250379+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=418 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:59:06.31397209+01:00 level=warning msg="unable to queue endpoint build" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="context canceled" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:06.316087349+01:00 level=error msg="endpoint regeneration failed" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="context canceled" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:06.317446957+01:00 level=info msg="Removed endpoint" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:06.317446957+01:00 level=warning msg="Creation of endpoint failed" containerID=f54adea217 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1451 error="timeout while waiting for initial endpoint generation to complete" identity=104 ipv4=10.20.191.183 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=daemon
2020-01-09T13:59:07.799966098+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcfe2d362c1764 ingress prio 1 handle 1 bpf da obj 3114_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:59:07.799966098+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:07.799966098+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:59:07.800000195+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:59:07.800000195+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:59:07.800000195+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:59:07.800000195+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:59:07.800000195+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:07.800006253+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:59:07.800010881+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:07.800033066+01:00 level=warning msg="Skipped 19624616 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:59:07.800047172+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:59:07.800067206+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:07.800081584+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:59:07.80011816+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:07.800130285+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:59:07.800143104+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:59:07.800185477+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:07.80019856+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:59:07.800217404+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:59:07.800222064+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:59:07.800227441+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:59:07.800268031+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:07.800272786+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:07.800289862+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:59:07.800317568+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:59:07.80033417+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:07.800338757+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:59:07.800352249+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:07.800357729+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:59:07.800371459+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:07.800376935+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:59:07.800390514+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:59:07.800402171+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:59:07.800414532+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:59:07.800426457+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:59:07.80043976+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:59:07.80047729+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:07.800517872+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:07.800529686+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:59:07.800544149+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:59:07.800549738+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:07.800559988+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:59:07.80056543+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:59:07.803719646+01:00 level=warning msg="JoinEP: Failed to load program" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" file-path=3114_next/bpf_lxc.o identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=datapath-loader veth=lxcfe2d362c1764
2020-01-09T13:59:07.803744576+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:59:07.803817968+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 file-path=3114_next_fail identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:59:07.804076148+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=23.926421934s bpfWaitForELF="3.701µs" bpfWriteELF="105.454µs" buildDuration=23.928363736s containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h mapSync="1.429µs" policyCalculation="2.994µs" prepareBuild="142.829µs" proxyConfiguration="1.839µs" proxyPolicyCalculation="11.565µs" proxyWaitForAck=0s reason="retrying regeneration" subsys=endpoint waitingForCTClean=1.066539ms waitingForLock=531ns
2020-01-09T13:59:07.804237848+01:00 level=error msg="endpoint regeneration failed" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:59:07.809692747+01:00 level=info msg="Removed endpoint" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:59:07.80978489+01:00 level=warning msg="Creation of endpoint failed" containerID=975aebaf74 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=3114 error="timeout while waiting for initial endpoint generation to complete" identity=104 ipv4=10.20.236.0 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=daemon
2020-01-09T13:59:10.215420502+01:00 level=info msg="New endpoint" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1687 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:10.215420502+01:00 level=info msg="Resolving identity labels (blocking)" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1687 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=coredns,k8s:io.kubernetes.pod.namespace=kube-system,k8s:k8s-app=kube-dns" ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:10.215420502+01:00 level=info msg="Identity of endpoint changed" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1687 identity=104 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=coredns,k8s:io.kubernetes.pod.namespace=kube-system,k8s:k8s-app=kube-dns" ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj oldIdentity="no identity" subsys=endpoint
2020-01-09T13:59:10.215420502+01:00 level=info msg="Waiting for endpoint to be generated" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1687 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=daemon
2020-01-09T13:59:10.346032243+01:00 level=info msg="New endpoint" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=395 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:59:10.346032243+01:00 level=info msg="Resolving identity labels (blocking)" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=395 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=coredns,k8s:io.kubernetes.pod.namespace=kube-system,k8s:k8s-app=kube-dns" ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:59:10.346032243+01:00 level=info msg="Identity of endpoint changed" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=395 identity=104 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=coredns,k8s:io.kubernetes.pod.namespace=kube-system,k8s:k8s-app=kube-dns" ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h oldIdentity="no identity" subsys=endpoint
2020-01-09T13:59:10.346032243+01:00 level=info msg="Waiting for endpoint to be generated" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=395 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=daemon
2020-01-09T13:59:23.332719383+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcbb58dd70ae72 ingress prio 1 handle 1 bpf da obj 297_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg="Skipped 19625033 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:23.332719383+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:59:23.332784857+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:59:23.332830213+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:59:23.333687784+01:00 level=warning msg="JoinEP: Failed to load program" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" file-path=297_next/bpf_lxc.o identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=datapath-loader veth=lxcbb58dd70ae72
2020-01-09T13:59:23.33381631+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:59:23.333963921+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 file-path=297_next_fail identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:59:23.334326223+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=21.774413252s bpfWaitForELF="3.079µs" bpfWriteELF="95.29µs" buildDuration=21.776702042s containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc mapSync="1.44µs" policyCalculation="2.248µs" prepareBuild="132.568µs" proxyConfiguration="1.628µs" proxyPolicyCalculation="10.947µs" proxyWaitForAck=0s reason="retrying regeneration" subsys=endpoint waitingForCTClean=1.244095ms waitingForLock=590ns
2020-01-09T13:59:23.334805981+01:00 level=info msg="Releasing key" key="[k8s:io.cilium.k8s.policy.cluster=default k8s:io.cilium.k8s.policy.serviceaccount=kured k8s:io.kubernetes.pod.namespace=kube-system k8s:name=kured]" subsys=allocator
2020-01-09T13:59:23.344189084+01:00 level=info msg="Removed endpoint" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:59:23.344235299+01:00 level=warning msg="Creation of endpoint failed" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="timeout while waiting for initial endpoint generation to complete" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=daemon
2020-01-09T13:59:23.344426947+01:00 level=error msg="endpoint regeneration failed" containerID=fd1eef4d7a datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=297 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.207.21 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:59:30.641833733+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxc_health ingress prio 1 handle 1 bpf da obj 418_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:30.641833733+01:00 level=warning msg="Skipped 19624416 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:30.641899938+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:59:30.641938458+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:59:30.642265638+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:30.642308294+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:30.642308294+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:59:30.642308294+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:59:30.642308294+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:30.642308294+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:59:30.642308294+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:59:30.654719938+01:00 level=warning msg="JoinEP: Failed to load program" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=418 error="Failed to load tc filter: exit status 1" file-path=418_next/bpf_lxc.o identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=datapath-loader veth=lxc_health
2020-01-09T13:59:30.654719938+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=418 error="Failed to load tc filter: exit status 1" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:30.654763006+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=418 file-path=418_next_fail identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:30.654846129+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=22.845358011s bpfWaitForELF="6.245µs" bpfWriteELF="201.483µs" buildDuration=22.84843487s containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=418 error="Failed to load tc filter: exit status 1" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ mapSync="28.05µs" policyCalculation="51.791µs" prepareBuild="265.422µs" proxyConfiguration="2.405µs" proxyPolicyCalculation="17.456µs" proxyWaitForAck=0s reason="updated security labels" subsys=endpoint waitingForCTClean=1.525776ms waitingForLock="1.353µs"
2020-01-09T13:59:30.654935519+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=418 error="Failed to load tc filter: exit status 1" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:30.660832937+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=418 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:30.965647856+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:59:31.983381174+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1073 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:31.983487271+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1073 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:31.983555219+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1073 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:59:36.349366219+01:00 level=info msg="New endpoint" containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1286 ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:59:36.349458512+01:00 level=info msg="Resolving identity labels (blocking)" containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1286 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=kured,k8s:io.kubernetes.pod.namespace=kube-system,k8s:name=kured" ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T13:59:36.349578825+01:00 level=info msg="Reusing existing global key" key="k8s:io.cilium.k8s.policy.cluster=default;k8s:io.cilium.k8s.policy.serviceaccount=kured;k8s:io.kubernetes.pod.namespace=kube-system;k8s:name=kured;" subsys=allocator
2020-01-09T13:59:36.382017098+01:00 level=info msg="Identity of endpoint changed" containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1286 identity=49793 identityLabels="k8s:io.cilium.k8s.policy.cluster=default,k8s:io.cilium.k8s.policy.serviceaccount=kured,k8s:io.kubernetes.pod.namespace=kube-system,k8s:name=kured" ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc oldIdentity="no identity" subsys=endpoint
2020-01-09T13:59:36.382131768+01:00 level=info msg="Waiting for endpoint to be generated" containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1286 ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=daemon
2020-01-09T13:59:40.017255459+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1073 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:40.017675924+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1073 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:40.017740713+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1073 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:40.072242958+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:59:41.08371909+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=961 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:41.083763504+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=961 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:41.08380257+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=961 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:59:45.502748791+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcff01ce075ac7 ingress prio 1 handle 1 bpf da obj 1687_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="Skipped 19624626 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:59:45.502748791+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:59:45.502831125+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:59:45.503578317+01:00 level=warning msg="JoinEP: Failed to load program" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 error="Failed to load tc filter: exit status 1" file-path=1687_next/bpf_lxc.o identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=datapath-loader veth=lxcff01ce075ac7
2020-01-09T13:59:45.503578317+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:45.503607461+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 file-path=1687_next_fail identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:45.503675843+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=22.149433266s bpfWaitForELF="3.625µs" bpfWriteELF="134.841µs" buildDuration=22.159169669s containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj mapSync="18.043µs" policyCalculation="40.557µs" prepareBuild="628.533µs" proxyConfiguration="1.797µs" proxyPolicyCalculation="11.775µs" proxyWaitForAck=0s reason="updated security labels" subsys=endpoint waitingForCTClean=8.295268ms waitingForLock="1.315µs"
2020-01-09T13:59:45.503739864+01:00 level=error msg="endpoint regeneration failed" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T13:59:50.09849511+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=961 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:50.09849511+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=961 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:50.099152994+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=961 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:50.167152571+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T13:59:51.181849755+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3009 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:51.181947478+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3009 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T13:59:51.181999656+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3009 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T13:59:52.54074223+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxc87f7caec159c ingress prio 1 handle 1 bpf da obj 395_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T13:59:52.54074223+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:52.540776844+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T13:59:52.540776844+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T13:59:52.540776844+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T13:59:52.540776844+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T13:59:52.540776844+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T13:59:52.540776844+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:52.54079144+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T13:59:52.54079144+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:52.540806163+01:00 level=warning msg="Skipped 19624621 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T13:59:52.540811003+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T13:59:52.540831361+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:52.540837294+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T13:59:52.540871027+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:52.540876735+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T13:59:52.54088807+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T13:59:52.540938258+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:52.540938258+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T13:59:52.540944138+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T13:59:52.540956238+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T13:59:52.540968096+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T13:59:52.541015176+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:52.541022458+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:52.541027809+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T13:59:52.541039818+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T13:59:52.541045319+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:52.54107973+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T13:59:52.54107973+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T13:59:52.541086388+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T13:59:52.54109234+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T13:59:52.541097218+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T13:59:52.541102401+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T13:59:52.541115157+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T13:59:52.541120709+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T13:59:52.541131375+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T13:59:52.541142541+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T13:59:52.541173057+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:52.541204644+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T13:59:52.541209523+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T13:59:52.541224358+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T13:59:52.541224358+01:00 level=warning subsys=datapath-loader
2020-01-09T13:59:52.541236548+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T13:59:52.541247938+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T13:59:52.543620291+01:00 level=warning msg="JoinEP: Failed to load program" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 error="Failed to load tc filter: exit status 1" file-path=395_next/bpf_lxc.o identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=datapath-loader veth=lxc87f7caec159c
2020-01-09T13:59:52.543645898+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:59:52.543717194+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 file-path=395_next_fail identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T13:59:52.543879827+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=21.884803715s bpfWaitForELF="11.057µs" bpfWriteELF="170.622µs" buildDuration=21.888234522s containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h mapSync="27.52µs" policyCalculation="48.895µs" prepareBuild="292.927µs" proxyConfiguration="3.03µs" proxyPolicyCalculation="14.407µs" proxyWaitForAck=0s reason="updated security labels" subsys=endpoint waitingForCTClean=1.834603ms waitingForLock="1.377µs"
2020-01-09T13:59:52.544027033+01:00 level=error msg="endpoint regeneration failed" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T14:00:01.199985963+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3009 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:01.199985963+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3009 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:01.200322642+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3009 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:01.231449918+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T14:00:02.250735417+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3110 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:02.250843888+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3110 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:02.250918814+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3110 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T14:00:07.908899909+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcf548ad836dd6 ingress prio 1 handle 1 bpf da obj 1286_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T14:00:07.908899909+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:07.908935133+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T14:00:07.908935133+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T14:00:07.908935133+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T14:00:07.908941591+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T14:00:07.908958623+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T14:00:07.908958623+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:07.908964278+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T14:00:07.908982627+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:07.909050553+01:00 level=warning msg="Skipped 19625033 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T14:00:07.909050553+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T14:00:07.909050553+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:07.909050553+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T14:00:07.909153+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:07.909153+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T14:00:07.909153+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T14:00:07.909153+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:07.909159544+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T14:00:07.909247551+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T14:00:07.909247551+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T14:00:07.909247551+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T14:00:07.909247551+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:07.909247551+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T14:00:07.909247551+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T14:00:07.909247551+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T14:00:07.909257148+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T14:00:07.909343816+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T14:00:07.909350502+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T14:00:07.909438078+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:07.909438078+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:07.909438078+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T14:00:07.909438078+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T14:00:07.909444552+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:07.909529854+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T14:00:07.909529854+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T14:00:07.912097029+01:00 level=warning msg="JoinEP: Failed to load program" containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1286 error="Failed to load tc filter: exit status 1" file-path=1286_next/bpf_lxc.o identity=49793 ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=datapath-loader veth=lxcf548ad836dd6
2020-01-09T14:00:07.912122933+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1286 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T14:00:07.912216659+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1286 file-path=1286_next_fail identity=49793 ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T14:00:07.912445249+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=22.403802878s bpfWaitForELF="6.333µs" bpfWriteELF="235.433µs" buildDuration=22.408545936s containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1286 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc mapSync="44.51µs" policyCalculation="83.741µs" prepareBuild="418.538µs" proxyConfiguration="3.645µs" proxyPolicyCalculation="24.001µs" proxyWaitForAck=0s reason="updated security labels" subsys=endpoint waitingForCTClean=2.347218ms waitingForLock="2.087µs"
2020-01-09T14:00:07.912722351+01:00 level=error msg="endpoint regeneration failed" containerID=fa42774e25 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1286 error="Failed to load tc filter: exit status 1" identity=49793 ipv4=10.20.74.59 ipv6= k8sPodName=kube-system/kured-qdgpc subsys=endpoint
2020-01-09T14:00:13.262936229+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3110 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:13.262936229+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3110 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:13.263889153+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=3110 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:13.311660844+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T14:00:14.321869396+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1928 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:14.321974319+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1928 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:14.32202781+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1928 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T14:00:15.159076271+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxcff01ce075ac7 ingress prio 1 handle 1 bpf da obj 1687_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T14:00:15.15913489+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:15.15914898+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T14:00:15.159160303+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T14:00:15.159170946+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T14:00:15.159186515+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T14:00:15.15920891+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T14:00:15.159219742+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:15.159230313+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T14:00:15.159240251+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:15.159251368+01:00 level=warning msg="Skipped 19624626 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T14:00:15.159261672+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T14:00:15.159280277+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:15.159294856+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T14:00:15.159315243+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:15.159325978+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T14:00:15.159336867+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T14:00:15.159354417+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:15.159373415+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T14:00:15.159384491+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T14:00:15.159395011+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T14:00:15.159405507+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T14:00:15.159423217+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:15.159441217+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T14:00:15.159456586+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T14:00:15.15946744+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T14:00:15.159477974+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T14:00:15.159488326+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T14:00:15.159498613+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T14:00:15.159508944+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T14:00:15.159522943+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T14:00:15.159538208+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T14:00:15.15954895+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T14:00:15.159559534+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T14:00:15.159569835+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T14:00:15.15958075+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T14:00:15.159591409+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T14:00:15.159614592+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:15.159635805+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:15.159646688+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T14:00:15.159657644+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T14:00:15.159667499+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:15.159677897+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T14:00:15.159688316+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T14:00:15.160546906+01:00 level=warning msg="JoinEP: Failed to load program" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 error="Failed to load tc filter: exit status 1" file-path=1687_next/bpf_lxc.o identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=datapath-loader veth=lxcff01ce075ac7
2020-01-09T14:00:15.160589888+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T14:00:15.16064378+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 file-path=1687_next_fail identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T14:00:15.160758428+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=22.614793743s bpfWaitForELF="3.486µs" bpfWriteELF="99.598µs" buildDuration=22.616730015s containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj mapSync="1.451µs" policyCalculation="3.048µs" prepareBuild="187.373µs" proxyConfiguration="1.788µs" proxyPolicyCalculation="13.691µs" proxyWaitForAck=0s reason="retrying regeneration" subsys=endpoint waitingForCTClean=1.086908ms waitingForLock="1.529µs"
2020-01-09T14:00:15.160842502+01:00 level=error msg="endpoint regeneration failed" containerID=6d504edcfd datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=1687 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.15.119 ipv6= k8sPodName=kube-system/coredns-6955765f44-fpflj subsys=endpoint
2020-01-09T14:00:26.352518644+01:00 level=warning msg="unable to queue endpoint build" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1928 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:26.352518644+01:00 level=error msg="endpoint regeneration failed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1928 error="context canceled" identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:26.355727673+01:00 level=info msg="Removed endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=1928 identity=4 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:26.391144435+01:00 level=info msg="Spawning health endpoint with command \"ip\" [\"netns\" \"exec\" \"cilium-health\" \"cilium-health-responder\" \"--pidfile\" \"/var/run/cilium/state/health-endpoint.pid\"]" subsys=cilium-health-launcher
2020-01-09T14:00:27.405392093+01:00 level=info msg="New endpoint" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=171 ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:27.405486383+01:00 level=info msg="Resolving identity labels (blocking)" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=171 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ subsys=endpoint
2020-01-09T14:00:27.405528175+01:00 level=info msg="Identity of endpoint changed" containerID= datapathPolicyRevision=0 desiredPolicyRevision=0 endpointID=171 identity=4 identityLabels="reserved:health" ipv4=10.20.175.40 ipv6= k8sPodName=/ oldIdentity="no identity" subsys=endpoint
2020-01-09T14:00:32.28586523+01:00 level=error msg="Command execution failed" cmd="[tc filter replace dev lxc87f7caec159c ingress prio 1 handle 1 bpf da obj 395_next/bpf_lxc.o sec from-container]" error="exit status 1" subsys=datapath-loader
2020-01-09T14:00:32.285908996+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:32.285923543+01:00 level=warning msg="Prog section 'from-container' rejected: Argument list too long (7)!" subsys=datapath-loader
2020-01-09T14:00:32.285939427+01:00 level=warning msg=" - Type:         3" subsys=datapath-loader
2020-01-09T14:00:32.285950317+01:00 level=warning msg=" - Attach Type:  0" subsys=datapath-loader
2020-01-09T14:00:32.28596125+01:00 level=warning msg=" - Instructions: 2559 (0 over limit)" subsys=datapath-loader
2020-01-09T14:00:32.285977987+01:00 level=warning msg=" - License:      GPL" subsys=datapath-loader
2020-01-09T14:00:32.286013665+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:32.286029487+01:00 level=warning msg="Verifier analysis:" subsys=datapath-loader
2020-01-09T14:00:32.286040552+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:32.286052053+01:00 level=warning msg="Skipped 19624621 bytes, use 'verb' option for the full verbose log." subsys=datapath-loader
2020-01-09T14:00:32.286062644+01:00 level=warning msg="[...]" subsys=datapath-loader
2020-01-09T14:00:32.286077115+01:00 level=warning msg="000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:32.286088009+01:00 level=warning msg="1117: (63) *(u32 *)(r7 +48) = r0" subsys=datapath-loader
2020-01-09T14:00:32.286108481+01:00 level=warning msg=" R0=inv(id=0) R1=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv0 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:32.286119263+01:00 level=warning msg="1118: (b7) r8 = 128" subsys=datapath-loader
2020-01-09T14:00:32.286130029+01:00 level=warning msg="1119: (69) r1 = *(u16 *)(r7 +38)" subsys=datapath-loader
2020-01-09T14:00:32.286150921+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R2=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=00000000 fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:32.28616193+01:00 level=warning msg="1120: (6b) *(u16 *)(r10 -160) = r1" subsys=datapath-loader
2020-01-09T14:00:32.286172667+01:00 level=warning msg="1121: (69) r1 = *(u16 *)(r10 -158)" subsys=datapath-loader
2020-01-09T14:00:32.286183263+01:00 level=warning msg="1122: (57) r1 &= 65528" subsys=datapath-loader
2020-01-09T14:00:32.286200767+01:00 level=warning msg="1123: (69) r2 = *(u16 *)(r7 +36)" subsys=datapath-loader
2020-01-09T14:00:32.286220957+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv0 R2_w=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R3=inv(id=0,umax_value=4294967295,var_off=(0x0; 0xffffffff)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9=inv(id=0) R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=000000mm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:32.286233863+01:00 level=warning msg="1124: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T14:00:32.286245257+01:00 level=warning msg="1125: (77) r3 >>= 3" subsys=datapath-loader
2020-01-09T14:00:32.286255915+01:00 level=warning msg="1126: (57) r3 &= 1" subsys=datapath-loader
2020-01-09T14:00:32.286272318+01:00 level=warning msg="1127: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T14:00:32.286287833+01:00 level=warning msg="1128: (77) r2 >>= 4" subsys=datapath-loader
2020-01-09T14:00:32.286299038+01:00 level=warning msg="1129: (bf) r3 = r2" subsys=datapath-loader
2020-01-09T14:00:32.286309628+01:00 level=warning msg="1130: (57) r3 &= 2" subsys=datapath-loader
2020-01-09T14:00:32.286321072+01:00 level=warning msg="1131: (4f) r1 |= r3" subsys=datapath-loader
2020-01-09T14:00:32.286331675+01:00 level=warning msg="1132: (57) r2 &= 4" subsys=datapath-loader
2020-01-09T14:00:32.286342265+01:00 level=warning msg="1133: (4f) r1 |= r2" subsys=datapath-loader
2020-01-09T14:00:32.286357718+01:00 level=warning msg="1134: (6b) *(u16 *)(r10 -158) = r1" subsys=datapath-loader
2020-01-09T14:00:32.286372336+01:00 level=warning msg="1135: (b7) r9 = 1" subsys=datapath-loader
2020-01-09T14:00:32.28638333+01:00 level=warning msg="1136: (b7) r1 = 1" subsys=datapath-loader
2020-01-09T14:00:32.2863942+01:00 level=warning msg="1137: (db) lock *(u64 *)(r7 +16) += r1" subsys=datapath-loader
2020-01-09T14:00:32.286413398+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:32.28643109+01:00 level=warning msg=" R0=inv(id=0) R1_w=inv1 R2_w=inv(id=0,umax_value=4,var_off=(0x0; 0x4)) R3_w=inv(id=0,umax_value=2,var_off=(0x0; 0x2)) R4=inv(id=0,umax_value=255,var_off=(0x0; 0xff)) R6=ctx(id=0,off=0,imm=0) R7=map_value(id=0,off=0,ks=14,vs=56,imm=0) R8=inv128 R9_w=inv1 R10=fp0,call_-1 fp-40=????0000 fp-96=??????mm fp-104=??mmmmmm fp-112=mmmmmmmm fp-120=??mmmmmm fp-128=????mmmm fp-136=mmmmmmmm fp-144=00000000 fp-152=00000000 fp-160=0000mmmm fp-184=???????m fp-192=mmmmmmmm fp-200=00000000 fp-208=00000000 fp-216=00000000 fp-224=00000000 fp-232=mmmmmmmm fp-240=mmmmmmmm fp-248=mmmmmmmm fp-256=mmmmmmmm fp-264=mmmmmmmm fp-272=00000000" subsys=datapath-loader
2020-01-09T14:00:32.286451511+01:00 level=warning msg="1138: (61) r1 = *(u32 *)(r6 +0)" subsys=datapath-loader
2020-01-09T14:00:32.286467648+01:00 level=warning msg="BPF program is too large. Processed 131073 insn" subsys=datapath-loader
2020-01-09T14:00:32.286479512+01:00 level=warning subsys=datapath-loader
2020-01-09T14:00:32.286490306+01:00 level=warning msg="Error fetching program/map!" subsys=datapath-loader
2020-01-09T14:00:32.28650092+01:00 level=warning msg="Unable to load program" subsys=datapath-loader
2020-01-09T14:00:32.287337445+01:00 level=warning msg="JoinEP: Failed to load program" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 error="Failed to load tc filter: exit status 1" file-path=395_next/bpf_lxc.o identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=datapath-loader veth=lxc87f7caec159c
2020-01-09T14:00:32.287378506+01:00 level=error msg="Error while rewriting endpoint BPF program" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T14:00:32.287431975+01:00 level=warning msg="generating BPF for endpoint failed, keeping stale directory." containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 file-path=395_next_fail identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint
2020-01-09T14:00:32.287544687+01:00 level=warning msg="Regeneration of endpoint failed" bpfCompilation=0s bpfLoadProg=24.372919877s bpfWaitForELF="18.29µs" bpfWriteELF="118.732µs" buildDuration=24.374943802s containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h mapSync="1.31µs" policyCalculation="2.79µs" prepareBuild="201.887µs" proxyConfiguration="2.152µs" proxyPolicyCalculation="13.639µs" proxyWaitForAck=0s reason="retrying regeneration" subsys=endpoint waitingForCTClean=1.13992ms waitingForLock="1.505µs"
2020-01-09T14:00:32.287634343+01:00 level=error msg="endpoint regeneration failed" containerID=eb718a0530 datapathPolicyRevision=0 desiredPolicyRevision=1 endpointID=395 error="Failed to load tc filter: exit status 1" identity=104 ipv4=10.20.177.15 ipv6= k8sPodName=kube-system/coredns-6955765f44-vhf6h subsys=endpoint