=== RUN TestRunningBinaryUpgrade
=== PAUSE TestRunningBinaryUpgrade
=== CONT TestRunningBinaryUpgrade
version_upgrade_test.go:133: (dbg) Run: /tmp/minikube-v1.6.2.1833754889.exe start -p running-upgrade-629827 --memory=2200 --vm-driver=kvm2
version_upgrade_test.go:133: (dbg) Done: /tmp/minikube-v1.6.2.1833754889.exe start -p running-upgrade-629827 --memory=2200 --vm-driver=kvm2 : (1m40.360746887s)
version_upgrade_test.go:143: (dbg) Run: out/minikube-linux-amd64 start -p running-upgrade-629827 --memory=2200 --alsologtostderr -v=1 --driver=kvm2
E1212 20:35:07.321214 16518 cert_rotation.go:168] key failed with : open /home/jenkins/minikube-integration/17734-9184/.minikube/profiles/addons-687850/client.crt: no such file or directory
version_upgrade_test.go:143: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p running-upgrade-629827 --memory=2200 --alsologtostderr -v=1 --driver=kvm2 : exit status 90 (35.967504442s)
-- stdout --
* [running-upgrade-629827] minikube v1.32.0 on Ubuntu 20.04 (kvm/amd64)
- MINIKUBE_LOCATION=17734
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- KUBECONFIG=/home/jenkins/minikube-integration/17734-9184/kubeconfig
- MINIKUBE_HOME=/home/jenkins/minikube-integration/17734-9184/.minikube
- MINIKUBE_BIN=out/minikube-linux-amd64
- MINIKUBE_FORCE_SYSTEMD=
* Kubernetes 1.28.4 is now available. If you would like to upgrade, specify: --kubernetes-version=v1.28.4
* Using the kvm2 driver based on existing profile
* Starting control plane node running-upgrade-629827 in cluster running-upgrade-629827
* Updating the running kvm2 "running-upgrade-629827" VM ...
-- /stdout --
** stderr **
I1212 20:34:41.738391 39910 out.go:296] Setting OutFile to fd 1 ...
I1212 20:34:41.738723 39910 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1212 20:34:41.738735 39910 out.go:309] Setting ErrFile to fd 2...
I1212 20:34:41.738742 39910 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1212 20:34:41.739027 39910 root.go:338] Updating PATH: /home/jenkins/minikube-integration/17734-9184/.minikube/bin
I1212 20:34:41.739746 39910 out.go:303] Setting JSON to false
I1212 20:34:41.741004 39910 start.go:128] hostinfo: {"hostname":"ubuntu-20-agent-3","uptime":4637,"bootTime":1702408645,"procs":229,"os":"linux","platform":"ubuntu","platformFamily":"debian","platformVersion":"20.04","kernelVersion":"5.15.0-1047-gcp","kernelArch":"x86_64","virtualizationSystem":"kvm","virtualizationRole":"guest","hostId":"591c9f12-2938-3743-e2bf-c56a050d43d1"}
I1212 20:34:41.741143 39910 start.go:138] virtualization: kvm guest
I1212 20:34:41.743513 39910 out.go:177] * [running-upgrade-629827] minikube v1.32.0 on Ubuntu 20.04 (kvm/amd64)
I1212 20:34:41.745696 39910 out.go:177] - MINIKUBE_LOCATION=17734
I1212 20:34:41.747209 39910 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I1212 20:34:41.748590 39910 out.go:177] - KUBECONFIG=/home/jenkins/minikube-integration/17734-9184/kubeconfig
I1212 20:34:41.745663 39910 notify.go:220] Checking for updates...
I1212 20:34:41.751881 39910 out.go:177] - MINIKUBE_HOME=/home/jenkins/minikube-integration/17734-9184/.minikube
I1212 20:34:41.753259 39910 out.go:177] - MINIKUBE_BIN=out/minikube-linux-amd64
I1212 20:34:41.754677 39910 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I1212 20:34:41.756670 39910 config.go:182] Loaded profile config "running-upgrade-629827": Driver=, ContainerRuntime=docker, KubernetesVersion=v1.17.0
I1212 20:34:41.756689 39910 start_flags.go:694] config upgrade: Driver=kvm2
I1212 20:34:41.756702 39910 start_flags.go:706] config upgrade: KicBaseImage=gcr.io/k8s-minikube/kicbase-builds:v0.0.42-1702334074-17764@sha256:242468f3f874ac6982f8a024f9c4a97f957667e2ee92ef27b2ae70cc267db401
I1212 20:34:41.756802 39910 profile.go:148] Saving config to /home/jenkins/minikube-integration/17734-9184/.minikube/profiles/running-upgrade-629827/config.json ...
I1212 20:34:41.757629 39910 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1212 20:34:41.757681 39910 main.go:141] libmachine: Launching plugin server for driver kvm2
I1212 20:34:41.776818 39910 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:46867
I1212 20:34:41.777264 39910 main.go:141] libmachine: () Calling .GetVersion
I1212 20:34:41.777912 39910 main.go:141] libmachine: Using API Version 1
I1212 20:34:41.777935 39910 main.go:141] libmachine: () Calling .SetConfigRaw
I1212 20:34:41.778299 39910 main.go:141] libmachine: () Calling .GetMachineName
I1212 20:34:41.778499 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:34:41.780612 39910 out.go:177] * Kubernetes 1.28.4 is now available. If you would like to upgrade, specify: --kubernetes-version=v1.28.4
I1212 20:34:41.782072 39910 driver.go:392] Setting default libvirt URI to qemu:///system
I1212 20:34:41.782503 39910 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1212 20:34:41.782548 39910 main.go:141] libmachine: Launching plugin server for driver kvm2
I1212 20:34:41.802760 39910 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:34193
I1212 20:34:41.803532 39910 main.go:141] libmachine: () Calling .GetVersion
I1212 20:34:41.804255 39910 main.go:141] libmachine: Using API Version 1
I1212 20:34:41.804291 39910 main.go:141] libmachine: () Calling .SetConfigRaw
I1212 20:34:41.804650 39910 main.go:141] libmachine: () Calling .GetMachineName
I1212 20:34:41.804853 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:34:41.854687 39910 out.go:177] * Using the kvm2 driver based on existing profile
I1212 20:34:41.856232 39910 start.go:298] selected driver: kvm2
I1212 20:34:41.856249 39910 start.go:902] validating driver "kvm2" against &{Name:running-upgrade-629827 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.6.0.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.42-1702334074-17764@sha256:242468f3f874ac6982f8a024f9c4a97f957667e2ee92ef27b2ae70cc267db401 Memory:2200 CPUs:2 DiskSize:20000 VMDriver:kvm2 Driver:kvm2 HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:0 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser: SSHKey: SSHPort:0 KubernetesConfig:{KubernetesVersion:v1.17.0 Clust
erName: Namespace: APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI: NodeIP: NodePort:8443 NodeName:} Nodes:[{Name:minikube IP:192.168.50.111 Port:8443 KubernetesVersion:v1.17.0 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[] StartHostTimeout:0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString: Mount9PVersion: MountGID: MountIP: MountMSize:0 MountOptions:[] MountPort:0 MountType: MountUID: BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAu
thSock: SSHAgentPID:0 AutoPauseInterval:0s GPUs:}
I1212 20:34:41.856364 39910 start.go:913] status for kvm2: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I1212 20:34:41.857339 39910 install.go:52] acquiring lock: {Name:mk900956b073697a4aa6c80a27c6bb0742a99a53 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.857414 39910 install.go:117] Validating docker-machine-driver-kvm2, PATH=/home/jenkins/minikube-integration/17734-9184/.minikube/bin:/home/jenkins/workspace/KVM_Linux_integration/out/:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games:/usr/local/go/bin:/home/jenkins/go/bin:/usr/local/bin/:/usr/local/go/bin/:/home/jenkins/go/bin
I1212 20:34:41.878640 39910 install.go:137] /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2 version is 1.32.0
I1212 20:34:41.879116 39910 cni.go:84] Creating CNI manager for ""
I1212 20:34:41.879137 39910 cni.go:162] CNI unnecessary in this configuration, recommending no CNI
I1212 20:34:41.879154 39910 start_flags.go:323] config:
{Name:running-upgrade-629827 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.6.0.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.42-1702334074-17764@sha256:242468f3f874ac6982f8a024f9c4a97f957667e2ee92ef27b2ae70cc267db401 Memory:2200 CPUs:2 DiskSize:20000 VMDriver:kvm2 Driver:kvm2 HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:0 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser: SSHKey: SSHPort:0 KubernetesConfig:{KubernetesVersion:v1.17.0 ClusterName: Namespace: APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[]
DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI: NodeIP: NodePort:8443 NodeName:} Nodes:[{Name:minikube IP:192.168.50.111 Port:8443 KubernetesVersion:v1.17.0 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[] StartHostTimeout:0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString: Mount9PVersion: MountGID: MountIP: MountMSize:0 MountOptions:[] MountPort:0 MountType: MountUID: BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 AutoPauseInterval:0s GPUs:}
I1212 20:34:41.879374 39910 iso.go:125] acquiring lock: {Name:mk43ef969cf334b742d000b2b02661e41d53ab4c Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.881230 39910 out.go:177] * Starting control plane node running-upgrade-629827 in cluster running-upgrade-629827
I1212 20:34:41.882595 39910 preload.go:132] Checking if preload exists for k8s version v1.17.0 and runtime docker
W1212 20:34:41.908087 39910 preload.go:115] https://storage.googleapis.com/minikube-preloaded-volume-tarballs/v18/v1.17.0/preloaded-images-k8s-v18-v1.17.0-docker-overlay2-amd64.tar.lz4 status code: 404
I1212 20:34:41.908236 39910 profile.go:148] Saving config to /home/jenkins/minikube-integration/17734-9184/.minikube/profiles/running-upgrade-629827/config.json ...
I1212 20:34:41.908315 39910 cache.go:107] acquiring lock: {Name:mk108a203b1074e94c5beb53758fe2b66e99a3af Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.908406 39910 cache.go:115] /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/gcr.io/k8s-minikube/storage-provisioner_v5 exists
I1212 20:34:41.908416 39910 cache.go:96] cache image "gcr.io/k8s-minikube/storage-provisioner:v5" -> "/home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/gcr.io/k8s-minikube/storage-provisioner_v5" took 113.697µs
I1212 20:34:41.908427 39910 cache.go:80] save to tar file gcr.io/k8s-minikube/storage-provisioner:v5 -> /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/gcr.io/k8s-minikube/storage-provisioner_v5 succeeded
I1212 20:34:41.908443 39910 cache.go:107] acquiring lock: {Name:mkf98ea5cc4d6ac2f918d7612d1478ab9864daea Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.908527 39910 start.go:365] acquiring machines lock for running-upgrade-629827: {Name:mk91afc3902f1b1dd7f1f288d2203759ece59cc1 Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I1212 20:34:41.908542 39910 image.go:134] retrieving image: registry.k8s.io/kube-apiserver:v1.17.0
I1212 20:34:41.908703 39910 cache.go:107] acquiring lock: {Name:mk29c77a144c56a64b15b01eb4c5dda8e0e10e06 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.908773 39910 image.go:134] retrieving image: registry.k8s.io/kube-controller-manager:v1.17.0
I1212 20:34:41.908876 39910 cache.go:107] acquiring lock: {Name:mkaec13fb7f48c68b06ac94f5f5914cab2a2380d Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.908943 39910 image.go:134] retrieving image: registry.k8s.io/kube-scheduler:v1.17.0
I1212 20:34:41.909013 39910 cache.go:107] acquiring lock: {Name:mk4904bdb09d6f9890fc1b5d9ad539f53649cf3f Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.909093 39910 image.go:134] retrieving image: registry.k8s.io/coredns:1.6.5
I1212 20:34:41.909215 39910 cache.go:107] acquiring lock: {Name:mk880e48228f4376c566f0ad77bceedcc0f44f87 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.909287 39910 image.go:134] retrieving image: registry.k8s.io/kube-proxy:v1.17.0
I1212 20:34:41.909384 39910 cache.go:107] acquiring lock: {Name:mk5c06bc162b87e2eea6e17c7af5eb7ed395ea20 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.909439 39910 image.go:134] retrieving image: registry.k8s.io/pause:3.1
I1212 20:34:41.909519 39910 cache.go:107] acquiring lock: {Name:mkc98d664cca6c93bb8e648525645c5b49d4b4ea Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 20:34:41.909587 39910 image.go:134] retrieving image: registry.k8s.io/etcd:3.4.3-0
I1212 20:34:41.910490 39910 image.go:177] daemon lookup for registry.k8s.io/coredns:1.6.5: Error response from daemon: No such image: registry.k8s.io/coredns:1.6.5
I1212 20:34:41.910916 39910 image.go:177] daemon lookup for registry.k8s.io/etcd:3.4.3-0: Error response from daemon: No such image: registry.k8s.io/etcd:3.4.3-0
I1212 20:34:41.911035 39910 image.go:177] daemon lookup for registry.k8s.io/pause:3.1: Error response from daemon: No such image: registry.k8s.io/pause:3.1
I1212 20:34:41.911210 39910 image.go:177] daemon lookup for registry.k8s.io/kube-controller-manager:v1.17.0: Error response from daemon: No such image: registry.k8s.io/kube-controller-manager:v1.17.0
I1212 20:34:41.911290 39910 image.go:177] daemon lookup for registry.k8s.io/kube-proxy:v1.17.0: Error response from daemon: No such image: registry.k8s.io/kube-proxy:v1.17.0
I1212 20:34:41.911338 39910 image.go:177] daemon lookup for registry.k8s.io/kube-apiserver:v1.17.0: Error response from daemon: No such image: registry.k8s.io/kube-apiserver:v1.17.0
I1212 20:34:41.912540 39910 image.go:177] daemon lookup for registry.k8s.io/kube-scheduler:v1.17.0: Error response from daemon: No such image: registry.k8s.io/kube-scheduler:v1.17.0
I1212 20:34:42.075537 39910 cache.go:162] opening: /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/pause_3.1
I1212 20:34:42.088893 39910 cache.go:162] opening: /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-controller-manager_v1.17.0
I1212 20:34:42.092688 39910 cache.go:162] opening: /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-apiserver_v1.17.0
I1212 20:34:42.101163 39910 cache.go:162] opening: /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-scheduler_v1.17.0
I1212 20:34:42.104105 39910 cache.go:162] opening: /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/etcd_3.4.3-0
I1212 20:34:42.105753 39910 cache.go:162] opening: /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/coredns_1.6.5
I1212 20:34:42.116544 39910 cache.go:162] opening: /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-proxy_v1.17.0
I1212 20:34:42.262000 39910 cache.go:157] /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/pause_3.1 exists
I1212 20:34:42.262092 39910 cache.go:96] cache image "registry.k8s.io/pause:3.1" -> "/home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/pause_3.1" took 352.707892ms
I1212 20:34:42.262108 39910 cache.go:80] save to tar file registry.k8s.io/pause:3.1 -> /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/pause_3.1 succeeded
I1212 20:34:42.529202 39910 cache.go:157] /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/coredns_1.6.5 exists
I1212 20:34:42.529285 39910 cache.go:96] cache image "registry.k8s.io/coredns:1.6.5" -> "/home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/coredns_1.6.5" took 620.276192ms
I1212 20:34:42.529305 39910 cache.go:80] save to tar file registry.k8s.io/coredns:1.6.5 -> /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/coredns_1.6.5 succeeded
I1212 20:34:42.754609 39910 cache.go:157] /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-scheduler_v1.17.0 exists
I1212 20:34:42.754639 39910 cache.go:96] cache image "registry.k8s.io/kube-scheduler:v1.17.0" -> "/home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-scheduler_v1.17.0" took 845.764246ms
I1212 20:34:42.754654 39910 cache.go:80] save to tar file registry.k8s.io/kube-scheduler:v1.17.0 -> /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-scheduler_v1.17.0 succeeded
I1212 20:34:43.018096 39910 cache.go:157] /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-controller-manager_v1.17.0 exists
I1212 20:34:43.018133 39910 cache.go:96] cache image "registry.k8s.io/kube-controller-manager:v1.17.0" -> "/home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-controller-manager_v1.17.0" took 1.109432312s
I1212 20:34:43.018151 39910 cache.go:80] save to tar file registry.k8s.io/kube-controller-manager:v1.17.0 -> /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-controller-manager_v1.17.0 succeeded
I1212 20:34:43.045652 39910 cache.go:157] /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-apiserver_v1.17.0 exists
I1212 20:34:43.045690 39910 cache.go:96] cache image "registry.k8s.io/kube-apiserver:v1.17.0" -> "/home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-apiserver_v1.17.0" took 1.137250318s
I1212 20:34:43.045709 39910 cache.go:80] save to tar file registry.k8s.io/kube-apiserver:v1.17.0 -> /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-apiserver_v1.17.0 succeeded
I1212 20:34:43.258861 39910 cache.go:157] /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-proxy_v1.17.0 exists
I1212 20:34:43.258897 39910 cache.go:96] cache image "registry.k8s.io/kube-proxy:v1.17.0" -> "/home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-proxy_v1.17.0" took 1.349684639s
I1212 20:34:43.258912 39910 cache.go:80] save to tar file registry.k8s.io/kube-proxy:v1.17.0 -> /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/kube-proxy_v1.17.0 succeeded
I1212 20:34:43.531460 39910 cache.go:157] /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/etcd_3.4.3-0 exists
I1212 20:34:43.531492 39910 cache.go:96] cache image "registry.k8s.io/etcd:3.4.3-0" -> "/home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/etcd_3.4.3-0" took 1.621973828s
I1212 20:34:43.531507 39910 cache.go:80] save to tar file registry.k8s.io/etcd:3.4.3-0 -> /home/jenkins/minikube-integration/17734-9184/.minikube/cache/images/amd64/registry.k8s.io/etcd_3.4.3-0 succeeded
I1212 20:34:43.531528 39910 cache.go:87] Successfully saved all images to host disk.
I1212 20:34:55.438475 39910 start.go:369] acquired machines lock for "running-upgrade-629827" in 13.52992027s
I1212 20:34:55.438533 39910 start.go:96] Skipping create...Using existing machine configuration
I1212 20:34:55.438541 39910 fix.go:54] fixHost starting: minikube
I1212 20:34:55.438952 39910 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1212 20:34:55.438992 39910 main.go:141] libmachine: Launching plugin server for driver kvm2
I1212 20:34:55.455368 39910 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:41745
I1212 20:34:55.455748 39910 main.go:141] libmachine: () Calling .GetVersion
I1212 20:34:55.456192 39910 main.go:141] libmachine: Using API Version 1
I1212 20:34:55.456222 39910 main.go:141] libmachine: () Calling .SetConfigRaw
I1212 20:34:55.456569 39910 main.go:141] libmachine: () Calling .GetMachineName
I1212 20:34:55.456772 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:34:55.456920 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetState
I1212 20:34:55.458790 39910 fix.go:102] recreateIfNeeded on running-upgrade-629827: state=Running err=<nil>
W1212 20:34:55.458814 39910 fix.go:128] unexpected machine state, will restart: <nil>
I1212 20:34:55.505903 39910 out.go:177] * Updating the running kvm2 "running-upgrade-629827" VM ...
I1212 20:34:55.656079 39910 machine.go:88] provisioning docker machine ...
I1212 20:34:55.656129 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:34:55.656437 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetMachineName
I1212 20:34:55.656624 39910 buildroot.go:166] provisioning hostname "running-upgrade-629827"
I1212 20:34:55.656641 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetMachineName
I1212 20:34:55.656771 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:34:55.659764 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:55.660214 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:34:55.660249 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:55.660417 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:34:55.660601 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:55.660796 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:55.660920 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:34:55.661087 39910 main.go:141] libmachine: Using SSH client type: native
I1212 20:34:55.661451 39910 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808ea0] 0x80bb80 <nil> [] 0s} 192.168.50.111 22 <nil> <nil>}
I1212 20:34:55.661467 39910 main.go:141] libmachine: About to run SSH command:
sudo hostname running-upgrade-629827 && echo "running-upgrade-629827" | sudo tee /etc/hostname
I1212 20:34:55.796912 39910 main.go:141] libmachine: SSH cmd err, output: <nil>: running-upgrade-629827
I1212 20:34:55.796936 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:34:55.799762 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:55.800123 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:34:55.800153 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:55.800387 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:34:55.800599 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:55.800773 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:55.800902 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:34:55.801043 39910 main.go:141] libmachine: Using SSH client type: native
I1212 20:34:55.801502 39910 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808ea0] 0x80bb80 <nil> [] 0s} 192.168.50.111 22 <nil> <nil>}
I1212 20:34:55.801522 39910 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\srunning-upgrade-629827' /etc/hosts; then
if grep -xq '127.0.1.1\s.*' /etc/hosts; then
sudo sed -i 's/^127.0.1.1\s.*/127.0.1.1 running-upgrade-629827/g' /etc/hosts;
else
echo '127.0.1.1 running-upgrade-629827' | sudo tee -a /etc/hosts;
fi
fi
I1212 20:34:55.929181 39910 main.go:141] libmachine: SSH cmd err, output: <nil>:
I1212 20:34:55.929210 39910 buildroot.go:172] set auth options {CertDir:/home/jenkins/minikube-integration/17734-9184/.minikube CaCertPath:/home/jenkins/minikube-integration/17734-9184/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/17734-9184/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/17734-9184/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/17734-9184/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/17734-9184/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/17734-9184/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/17734-9184/.minikube}
I1212 20:34:55.929247 39910 buildroot.go:174] setting up certificates
I1212 20:34:55.929277 39910 provision.go:83] configureAuth start
I1212 20:34:55.929293 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetMachineName
I1212 20:34:55.929555 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetIP
I1212 20:34:55.932099 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:55.932423 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:34:55.932471 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:55.932574 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:34:55.935082 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:55.935561 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:34:55.935591 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:55.935765 39910 provision.go:138] copyHostCerts
I1212 20:34:55.935822 39910 exec_runner.go:144] found /home/jenkins/minikube-integration/17734-9184/.minikube/key.pem, removing ...
I1212 20:34:55.935834 39910 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17734-9184/.minikube/key.pem
I1212 20:34:55.935895 39910 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17734-9184/.minikube/certs/key.pem --> /home/jenkins/minikube-integration/17734-9184/.minikube/key.pem (1675 bytes)
I1212 20:34:55.936010 39910 exec_runner.go:144] found /home/jenkins/minikube-integration/17734-9184/.minikube/ca.pem, removing ...
I1212 20:34:55.936021 39910 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17734-9184/.minikube/ca.pem
I1212 20:34:55.936042 39910 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17734-9184/.minikube/certs/ca.pem --> /home/jenkins/minikube-integration/17734-9184/.minikube/ca.pem (1082 bytes)
I1212 20:34:55.936094 39910 exec_runner.go:144] found /home/jenkins/minikube-integration/17734-9184/.minikube/cert.pem, removing ...
I1212 20:34:55.936100 39910 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17734-9184/.minikube/cert.pem
I1212 20:34:55.936118 39910 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17734-9184/.minikube/certs/cert.pem --> /home/jenkins/minikube-integration/17734-9184/.minikube/cert.pem (1123 bytes)
I1212 20:34:55.936159 39910 provision.go:112] generating server cert: /home/jenkins/minikube-integration/17734-9184/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/17734-9184/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/17734-9184/.minikube/certs/ca-key.pem org=jenkins.running-upgrade-629827 san=[192.168.50.111 192.168.50.111 localhost 127.0.0.1 minikube running-upgrade-629827]
I1212 20:34:56.155684 39910 provision.go:172] copyRemoteCerts
I1212 20:34:56.155750 39910 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I1212 20:34:56.155778 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:34:56.158935 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:56.159340 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:34:56.159369 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:56.159606 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:34:56.159783 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:56.159883 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:34:56.159962 39910 sshutil.go:53] new ssh client: &{IP:192.168.50.111 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17734-9184/.minikube/machines/running-upgrade-629827/id_rsa Username:docker}
I1212 20:34:56.259750 39910 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17734-9184/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I1212 20:34:56.275309 39910 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17734-9184/.minikube/machines/server.pem --> /etc/docker/server.pem (1241 bytes)
I1212 20:34:56.292010 39910 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17734-9184/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1679 bytes)
I1212 20:34:56.308146 39910 provision.go:86] duration metric: configureAuth took 378.850963ms
I1212 20:34:56.308176 39910 buildroot.go:189] setting minikube options for container-runtime
I1212 20:34:56.308370 39910 config.go:182] Loaded profile config "running-upgrade-629827": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.17.0
I1212 20:34:56.308400 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:34:56.308682 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:34:56.311509 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:56.311940 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:34:56.311973 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:56.312147 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:34:56.312341 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:56.312549 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:56.312690 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:34:56.312882 39910 main.go:141] libmachine: Using SSH client type: native
I1212 20:34:56.313194 39910 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808ea0] 0x80bb80 <nil> [] 0s} 192.168.50.111 22 <nil> <nil>}
I1212 20:34:56.313213 39910 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I1212 20:34:56.450851 39910 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I1212 20:34:56.450875 39910 buildroot.go:70] root file system type: tmpfs
I1212 20:34:56.451010 39910 provision.go:309] Updating docker unit: /lib/systemd/system/docker.service ...
I1212 20:34:56.451041 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:34:56.454093 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:56.454556 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:34:56.454584 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:56.454752 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:34:56.454957 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:56.455120 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:56.455246 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:34:56.455461 39910 main.go:141] libmachine: Using SSH client type: native
I1212 20:34:56.455902 39910 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808ea0] 0x80bb80 <nil> [] 0s} 192.168.50.111 22 <nil> <nil>}
I1212 20:34:56.455970 39910 main.go:141] libmachine: About to run SSH command:
sudo mkdir -p /lib/systemd/system && printf %s "[Unit]
Description=Docker Application Container Engine
Documentation=https://docs.docker.com
After=network.target minikube-automount.service docker.socket
Requires= minikube-automount.service docker.socket
StartLimitBurst=3
StartLimitIntervalSec=60
[Service]
Type=notify
Restart=on-failure
# This file is a systemd drop-in unit that inherits from the base dockerd configuration.
# The base configuration already specifies an 'ExecStart=...' command. The first directive
# here is to clear out that command inherited from the base configuration. Without this,
# the command from the base configuration and the command specified here are treated as
# a sequence of commands, which is not the desired behavior, nor is it valid -- systemd
# will catch this invalid input and refuse to start the service with an error like:
# Service has more than one ExecStart= setting, which is only allowed for Type=oneshot services.
# NOTE: default-ulimit=nofile is set to an arbitrary number for consistency with other
# container runtimes. If left unlimited, it may result in OOM issues with MySQL.
ExecStart=
ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:2376 -H unix:///var/run/docker.sock --default-ulimit=nofile=1048576:1048576 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=kvm2 --insecure-registry 10.96.0.0/12
ExecReload=/bin/kill -s HUP \$MAINPID
# Having non-zero Limit*s causes performance problems due to accounting overhead
# in the kernel. We recommend using cgroups to do container-local accounting.
LimitNOFILE=infinity
LimitNPROC=infinity
LimitCORE=infinity
# Uncomment TasksMax if your systemd version supports it.
# Only systemd 226 and above support this version.
TasksMax=infinity
TimeoutStartSec=0
# set delegate yes so that systemd does not reset the cgroups of docker containers
Delegate=yes
# kill only the docker process, not all processes in the cgroup
KillMode=process
[Install]
WantedBy=multi-user.target
" | sudo tee /lib/systemd/system/docker.service.new
I1212 20:34:56.590772 39910 main.go:141] libmachine: SSH cmd err, output: <nil>: [Unit]
Description=Docker Application Container Engine
Documentation=https://docs.docker.com
After=network.target minikube-automount.service docker.socket
Requires= minikube-automount.service docker.socket
StartLimitBurst=3
StartLimitIntervalSec=60
[Service]
Type=notify
Restart=on-failure
# This file is a systemd drop-in unit that inherits from the base dockerd configuration.
# The base configuration already specifies an 'ExecStart=...' command. The first directive
# here is to clear out that command inherited from the base configuration. Without this,
# the command from the base configuration and the command specified here are treated as
# a sequence of commands, which is not the desired behavior, nor is it valid -- systemd
# will catch this invalid input and refuse to start the service with an error like:
# Service has more than one ExecStart= setting, which is only allowed for Type=oneshot services.
# NOTE: default-ulimit=nofile is set to an arbitrary number for consistency with other
# container runtimes. If left unlimited, it may result in OOM issues with MySQL.
ExecStart=
ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:2376 -H unix:///var/run/docker.sock --default-ulimit=nofile=1048576:1048576 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=kvm2 --insecure-registry 10.96.0.0/12
ExecReload=/bin/kill -s HUP $MAINPID
# Having non-zero Limit*s causes performance problems due to accounting overhead
# in the kernel. We recommend using cgroups to do container-local accounting.
LimitNOFILE=infinity
LimitNPROC=infinity
LimitCORE=infinity
# Uncomment TasksMax if your systemd version supports it.
# Only systemd 226 and above support this version.
TasksMax=infinity
TimeoutStartSec=0
# set delegate yes so that systemd does not reset the cgroups of docker containers
Delegate=yes
# kill only the docker process, not all processes in the cgroup
KillMode=process
[Install]
WantedBy=multi-user.target
I1212 20:34:56.590815 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:34:56.594331 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:56.594811 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:34:56.594857 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:34:56.595002 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:34:56.595196 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:56.595346 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:34:56.595498 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:34:56.595663 39910 main.go:141] libmachine: Using SSH client type: native
I1212 20:34:56.595985 39910 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808ea0] 0x80bb80 <nil> [] 0s} 192.168.50.111 22 <nil> <nil>}
I1212 20:34:56.596011 39910 main.go:141] libmachine: About to run SSH command:
sudo diff -u /lib/systemd/system/docker.service /lib/systemd/system/docker.service.new || { sudo mv /lib/systemd/system/docker.service.new /lib/systemd/system/docker.service; sudo systemctl -f daemon-reload && sudo systemctl -f enable docker && sudo systemctl -f restart docker; }
I1212 20:35:10.441753 39910 main.go:141] libmachine: SSH cmd err, output: <nil>: --- /lib/systemd/system/docker.service
+++ /lib/systemd/system/docker.service.new
@@ -3,9 +3,12 @@
Documentation=https://docs.docker.com
After=network.target minikube-automount.service docker.socket
Requires= minikube-automount.service docker.socket
+StartLimitBurst=3
+StartLimitIntervalSec=60
[Service]
Type=notify
+Restart=on-failure
@@ -21,7 +24,7 @@
# container runtimes. If left unlimited, it may result in OOM issues with MySQL.
ExecStart=
ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:2376 -H unix:///var/run/docker.sock --default-ulimit=nofile=1048576:1048576 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=kvm2 --insecure-registry 10.96.0.0/12
-ExecReload=/bin/kill -s HUP
+ExecReload=/bin/kill -s HUP $MAINPID
# Having non-zero Limit*s causes performance problems due to accounting overhead
# in the kernel. We recommend using cgroups to do container-local accounting.
Created symlink /etc/systemd/system/multi-user.target.wants/docker.service → /usr/lib/systemd/system/docker.service.
I1212 20:35:10.441851 39910 machine.go:91] provisioned docker machine in 14.78573385s
I1212 20:35:10.441870 39910 start.go:300] post-start starting for "running-upgrade-629827" (driver="kvm2")
I1212 20:35:10.441885 39910 start.go:329] creating required directories: [/etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs]
I1212 20:35:10.441910 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:35:10.442889 39910 ssh_runner.go:195] Run: sudo mkdir -p /etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs
I1212 20:35:10.442925 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:35:10.446220 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.446711 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:35:10.446747 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.446979 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:35:10.447178 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:35:10.447322 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:35:10.447454 39910 sshutil.go:53] new ssh client: &{IP:192.168.50.111 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17734-9184/.minikube/machines/running-upgrade-629827/id_rsa Username:docker}
I1212 20:35:10.544421 39910 ssh_runner.go:195] Run: cat /etc/os-release
I1212 20:35:10.549469 39910 info.go:137] Remote host: Buildroot 2019.02.7
I1212 20:35:10.549495 39910 filesync.go:126] Scanning /home/jenkins/minikube-integration/17734-9184/.minikube/addons for local assets ...
I1212 20:35:10.549558 39910 filesync.go:126] Scanning /home/jenkins/minikube-integration/17734-9184/.minikube/files for local assets ...
I1212 20:35:10.549647 39910 filesync.go:149] local asset: /home/jenkins/minikube-integration/17734-9184/.minikube/files/etc/ssl/certs/165182.pem -> 165182.pem in /etc/ssl/certs
I1212 20:35:10.549762 39910 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I1212 20:35:10.556557 39910 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17734-9184/.minikube/files/etc/ssl/certs/165182.pem --> /etc/ssl/certs/165182.pem (1708 bytes)
I1212 20:35:10.572019 39910 start.go:303] post-start completed in 130.133224ms
I1212 20:35:10.572047 39910 fix.go:56] fixHost completed within 15.133504862s
I1212 20:35:10.572072 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:35:10.574578 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.574908 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:35:10.574938 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.575084 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:35:10.575298 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:35:10.575475 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:35:10.575649 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:35:10.575851 39910 main.go:141] libmachine: Using SSH client type: native
I1212 20:35:10.576356 39910 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808ea0] 0x80bb80 <nil> [] 0s} 192.168.50.111 22 <nil> <nil>}
I1212 20:35:10.576373 39910 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I1212 20:35:10.705169 39910 main.go:141] libmachine: SSH cmd err, output: <nil>: 1702413310.700479908
I1212 20:35:10.705199 39910 fix.go:206] guest clock: 1702413310.700479908
I1212 20:35:10.705210 39910 fix.go:219] Guest: 2023-12-12 20:35:10.700479908 +0000 UTC Remote: 2023-12-12 20:35:10.572051938 +0000 UTC m=+28.902797924 (delta=128.42797ms)
I1212 20:35:10.705234 39910 fix.go:190] guest clock delta is within tolerance: 128.42797ms
I1212 20:35:10.705240 39910 start.go:83] releasing machines lock for "running-upgrade-629827", held for 15.266728192s
I1212 20:35:10.705265 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:35:10.705608 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetIP
I1212 20:35:10.709037 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.709545 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:35:10.709573 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.709835 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:35:10.710442 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:35:10.710642 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .DriverName
I1212 20:35:10.710716 39910 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I1212 20:35:10.710751 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:35:10.710823 39910 ssh_runner.go:195] Run: cat /version.json
I1212 20:35:10.710836 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHHostname
I1212 20:35:10.714607 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.715242 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:35:10.715265 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.715554 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:35:10.715784 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:35:10.715953 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.715985 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:35:10.716123 39910 sshutil.go:53] new ssh client: &{IP:192.168.50.111 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17734-9184/.minikube/machines/running-upgrade-629827/id_rsa Username:docker}
I1212 20:35:10.716645 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHPort
I1212 20:35:10.716665 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:ab:b4:0c", ip: ""} in network minikube-net: {Iface:virbr2 ExpiryTime:2023-12-12 21:33:31 +0000 UTC Type:0 Mac:52:54:00:ab:b4:0c Iaid: IPaddr:192.168.50.111 Prefix:24 Hostname:running-upgrade-629827 Clientid:01:52:54:00:ab:b4:0c}
I1212 20:35:10.716680 39910 main.go:141] libmachine: (running-upgrade-629827) DBG | domain running-upgrade-629827 has defined IP address 192.168.50.111 and MAC address 52:54:00:ab:b4:0c in network minikube-net
I1212 20:35:10.716791 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHKeyPath
I1212 20:35:10.716957 39910 main.go:141] libmachine: (running-upgrade-629827) Calling .GetSSHUsername
I1212 20:35:10.717101 39910 sshutil.go:53] new ssh client: &{IP:192.168.50.111 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17734-9184/.minikube/machines/running-upgrade-629827/id_rsa Username:docker}
W1212 20:35:10.811668 39910 start.go:419] Unable to open version.json: cat /version.json: Process exited with status 1
stdout:
stderr:
cat: /version.json: No such file or directory
I1212 20:35:10.811744 39910 ssh_runner.go:195] Run: systemctl --version
I1212 20:35:10.834924 39910 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W1212 20:35:10.842839 39910 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I1212 20:35:10.842925 39910 ssh_runner.go:195] Run: sudo find /etc/cni/net.d -maxdepth 1 -type f -name *bridge* -not -name *podman* -not -name *.mk_disabled -printf "%p, " -exec sh -c "sudo sed -i -r -e '/"dst": ".*:.*"/d' -e 's|^(.*)"dst": (.*)[,*]$|\1"dst": \2|g' -e '/"subnet": ".*:.*"/d' -e 's|^(.*)"subnet": ".*"(.*)[,*]$|\1"subnet": "10.244.0.0/16"\2|g' {}" ;
I1212 20:35:10.851976 39910 ssh_runner.go:195] Run: sudo find /etc/cni/net.d -maxdepth 1 -type f -name *podman* -not -name *.mk_disabled -printf "%p, " -exec sh -c "sudo sed -i -r -e 's|^(.*)"subnet": ".*"(.*)$|\1"subnet": "10.244.0.0/16"\2|g' -e 's|^(.*)"gateway": ".*"(.*)$|\1"gateway": "10.244.0.1"\2|g' {}" ;
I1212 20:35:10.859424 39910 cni.go:305] no active bridge cni configs found in "/etc/cni/net.d" - nothing to configure
I1212 20:35:10.859454 39910 start.go:475] detecting cgroup driver to use...
I1212 20:35:10.859594 39910 ssh_runner.go:195] Run: /bin/bash -c "sudo mkdir -p /etc && printf %s "runtime-endpoint: unix:///run/containerd/containerd.sock
" | sudo tee /etc/crictl.yaml"
I1212 20:35:10.882127 39910 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)sandbox_image = .*$|\1sandbox_image = "registry.k8s.io/pause:3.1"|' /etc/containerd/config.toml"
I1212 20:35:10.890428 39910 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)restrict_oom_score_adj = .*$|\1restrict_oom_score_adj = false|' /etc/containerd/config.toml"
I1212 20:35:10.897039 39910 containerd.go:145] configuring containerd to use "cgroupfs" as cgroup driver...
I1212 20:35:10.897087 39910 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I1212 20:35:10.903815 39910 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runtime.v1.linux"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I1212 20:35:10.911120 39910 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I1212 20:35:10.917690 39910 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I1212 20:35:10.924141 39910 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I1212 20:35:10.934591 39910 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)conf_dir = .*$|\1conf_dir = "/etc/cni/net.d"|g' /etc/containerd/config.toml"
I1212 20:35:10.944605 39910 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I1212 20:35:10.962394 39910 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I1212 20:35:10.972224 39910 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1212 20:35:11.091449 39910 ssh_runner.go:195] Run: sudo systemctl restart containerd
I1212 20:35:11.131610 39910 start.go:475] detecting cgroup driver to use...
I1212 20:35:11.131698 39910 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I1212 20:35:11.149171 39910 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1212 20:35:11.167856 39910 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I1212 20:35:11.216372 39910 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1212 20:35:11.231640 39910 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1212 20:35:11.244913 39910 ssh_runner.go:195] Run: /bin/bash -c "sudo mkdir -p /etc && printf %s "runtime-endpoint: unix:///var/run/dockershim.sock
" | sudo tee /etc/crictl.yaml"
I1212 20:35:11.258903 39910 ssh_runner.go:195] Run: which cri-dockerd
I1212 20:35:11.263479 39910 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I1212 20:35:11.271521 39910 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I1212 20:35:11.285247 39910 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I1212 20:35:11.408205 39910 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I1212 20:35:11.553639 39910 docker.go:560] configuring docker to use "cgroupfs" as cgroup driver...
I1212 20:35:11.553794 39910 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (130 bytes)
I1212 20:35:11.570171 39910 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1212 20:35:11.704454 39910 ssh_runner.go:195] Run: sudo systemctl restart docker
I1212 20:35:17.583802 39910 ssh_runner.go:235] Completed: sudo systemctl restart docker: (5.879311844s)
I1212 20:35:17.583915 39910 ssh_runner.go:195] Run: sudo journalctl --no-pager -u docker
I1212 20:35:17.621624 39910 out.go:177]
W1212 20:35:17.623222 39910 out.go:239] X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart docker: Process exited with status 1
stdout:
stderr:
Job for docker.service failed because the control process exited with error code.
See "systemctl status docker.service" and "journalctl -xe" for details.
sudo journalctl --no-pager -u docker:
-- stdout --
-- Logs begin at Tue 2023-12-12 20:33:28 UTC, end at Tue 2023-12-12 20:35:17 UTC. --
Dec 12 20:33:42 running-upgrade-629827 systemd[1]: Starting Docker Application Container Engine...
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.820851557Z" level=info msg="Starting up"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822642518Z" level=info msg="libcontainerd: started new containerd process" pid=2094
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822753288Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822787519Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822832593Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822871976Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.854692916Z" level=info msg="starting containerd" revision=b34a5c8af56e510852c35414db4c1f4fa6172339 version=v1.2.10
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.855022900Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.855127287Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.855466709Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.btrfs" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.855530783Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.856720203Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.aufs" error="modprobe aufs failed: "modprobe: FATAL: Module aufs not found in directory /lib/modules/4.19.81\n": exit status 1"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.856794725Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.856891660Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857040955Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857324593Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857386441Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857451902Z" level=warning msg="could not use snapshotter btrfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857486440Z" level=warning msg="could not use snapshotter aufs in metadata plugin" error="modprobe aufs failed: "modprobe: FATAL: Module aufs not found in directory /lib/modules/4.19.81\n": exit status 1"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857514799Z" level=warning msg="could not use snapshotter zfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866349328Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866440916Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866548925Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866599723Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866640832Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866682766Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866718460Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866750275Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866782941Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866814408Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866943107Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867036122Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867488991Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867566248Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867623305Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867663107Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867702986Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867736084Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867766635Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867798750Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867834629Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867866785Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867896205Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867960641Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867997382Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868034862Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868069010Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868300254Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868373851Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868409738Z" level=info msg="containerd successfully booted in 0.014502s"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.876517019Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.876593639Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.876640204Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.876684894Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.878217163Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.878285702Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.878328286Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.878373225Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905684757Z" level=warning msg="Your kernel does not support cgroup blkio weight"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905705150Z" level=warning msg="Your kernel does not support cgroup blkio weight_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905710987Z" level=warning msg="Your kernel does not support cgroup blkio throttle.read_bps_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905716421Z" level=warning msg="Your kernel does not support cgroup blkio throttle.write_bps_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905721967Z" level=warning msg="Your kernel does not support cgroup blkio throttle.read_iops_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905730852Z" level=warning msg="Your kernel does not support cgroup blkio throttle.write_iops_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905936357Z" level=info msg="Loading containers: start."
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.993908505Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address"
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.050221650Z" level=info msg="Loading containers: done."
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.075323992Z" level=info msg="Docker daemon" commit=633a0ea838 graphdriver(s)=overlay2 version=19.03.5
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.075487547Z" level=info msg="Daemon has completed initialization"
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.105933075Z" level=info msg="API listen on /var/run/docker.sock"
Dec 12 20:33:43 running-upgrade-629827 systemd[1]: Started Docker Application Container Engine.
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.106939745Z" level=info msg="API listen on [::]:2376"
Dec 12 20:34:25 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:25.961995327Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d995d10857c7c87dab3f04f0417b4e6866041cc28266136e1e6b89b33c75e383/shim.sock" debug=false pid=3649
Dec 12 20:34:25 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:25.978020275Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/82e8820b282d2662ab2f8c0123d106f88c32f450f39f56e0cecd58aaa795e590/shim.sock" debug=false pid=3660
Dec 12 20:34:25 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:25.995306431Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/c5843a22b79114c31baee33a22a6269abb3f6860cb981ddb129973af7945572f/shim.sock" debug=false pid=3672
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.212438064Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d40dccab848eb74feca0e59ebf5213a346f89ffe7f78901d5dfa8ab6eefb2866/shim.sock" debug=false pid=3729
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.366461250Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/c98e2b3562bcc22f9f096efe004140064bb04ea27e87c1b9302302379cfff428/shim.sock" debug=false pid=3772
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.761908902Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/7875ca2dd284fcbe5f105724f1e61129e2e0024cbc08c0087459e513aee52f8d/shim.sock" debug=false pid=3888
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.769776714Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b/shim.sock" debug=false pid=3892
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.811818614Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/a9e407f022632328dffb89823646d79c52fdddb5ef9758e91175bc5c612c41b9/shim.sock" debug=false pid=3917
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.887692001Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/e8fa8c69b14d72811a56503546bc10f3e7d51bcff2bc91dbbdd799006b7950c8/shim.sock" debug=false pid=3944
Dec 12 20:34:27 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:27.238980686Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/581635acfc07fff800068eb58b44fa5545fc295db9ced8927e97340888ace818/shim.sock" debug=false pid=4036
Dec 12 20:34:50 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:50.061406982Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/957a85467238da7f331d31b90e65904633e1397fed1c1c2f82037e9579feb11e/shim.sock" debug=false pid=4888
Dec 12 20:34:50 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:50.380433530Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/6a65c6cde12634406215925024ff7efbfde31970a2fae1cee138b3c78abb457b/shim.sock" debug=false pid=4972
Dec 12 20:34:51 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:51.191404872Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/57f84dfaea1a0124887221fe4ca42cdd70874479d537762331073aeea78fdc3c/shim.sock" debug=false pid=5079
Dec 12 20:34:51 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:51.537057015Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/62c374217b1ad49a0d7530baf875f9832704c0da60beec1b4ae581e989960d43/shim.sock" debug=false pid=5123
Dec 12 20:34:53 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:53.263852853Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d677d72bac3f0594f543e62b9681132ee2e111495d05d02bc0b15613d23a211a/shim.sock" debug=false pid=5192
Dec 12 20:34:53 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:53.298776447Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/eb60920661e01aa761786ef8aa9018a81c0ca3c8c08abe69a1dcbcf02689feeb/shim.sock" debug=false pid=5213
Dec 12 20:34:53 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:53.905298621Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/7f528adae78da7b2eb5940e40a583002dc16c8f725f92ea5a39ad99cb5002001/shim.sock" debug=false pid=5337
Dec 12 20:34:54 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:54.008270385Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/9c63e302c50f7cb61eeb9961ad896ee5ac273bcffef35c4fd07e7b41c4f7acbb/shim.sock" debug=false pid=5359
Dec 12 20:34:57 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:57.052970296Z" level=info msg="Processing signal 'terminated'"
Dec 12 20:34:57 running-upgrade-629827 systemd[1]: Stopping Docker Application Container Engine...
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.150594991Z" level=info msg="shim reaped" id=c5843a22b79114c31baee33a22a6269abb3f6860cb981ddb129973af7945572f
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.160749386Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.238266936Z" level=info msg="shim reaped" id=581635acfc07fff800068eb58b44fa5545fc295db9ced8927e97340888ace818
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.252446840Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.264945738Z" level=warning msg="581635acfc07fff800068eb58b44fa5545fc295db9ced8927e97340888ace818 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/581635acfc07fff800068eb58b44fa5545fc295db9ced8927e97340888ace818/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.281896204Z" level=info msg="shim reaped" id=62c374217b1ad49a0d7530baf875f9832704c0da60beec1b4ae581e989960d43
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.286021046Z" level=info msg="shim reaped" id=d677d72bac3f0594f543e62b9681132ee2e111495d05d02bc0b15613d23a211a
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.291998282Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.292382378Z" level=warning msg="62c374217b1ad49a0d7530baf875f9832704c0da60beec1b4ae581e989960d43 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/62c374217b1ad49a0d7530baf875f9832704c0da60beec1b4ae581e989960d43/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.301118185Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.333734505Z" level=info msg="shim reaped" id=eb60920661e01aa761786ef8aa9018a81c0ca3c8c08abe69a1dcbcf02689feeb
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.336039393Z" level=info msg="shim reaped" id=d995d10857c7c87dab3f04f0417b4e6866041cc28266136e1e6b89b33c75e383
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.349581322Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.353351589Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.359579185Z" level=info msg="shim reaped" id=e8fa8c69b14d72811a56503546bc10f3e7d51bcff2bc91dbbdd799006b7950c8
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.370002277Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.370416037Z" level=warning msg="e8fa8c69b14d72811a56503546bc10f3e7d51bcff2bc91dbbdd799006b7950c8 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/e8fa8c69b14d72811a56503546bc10f3e7d51bcff2bc91dbbdd799006b7950c8/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.376604126Z" level=info msg="shim reaped" id=d40dccab848eb74feca0e59ebf5213a346f89ffe7f78901d5dfa8ab6eefb2866
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.382758026Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.414235213Z" level=info msg="shim reaped" id=82e8820b282d2662ab2f8c0123d106f88c32f450f39f56e0cecd58aaa795e590
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.432859500Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.452402678Z" level=info msg="shim reaped" id=957a85467238da7f331d31b90e65904633e1397fed1c1c2f82037e9579feb11e
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.453407457Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.454254607Z" level=info msg="shim reaped" id=c98e2b3562bcc22f9f096efe004140064bb04ea27e87c1b9302302379cfff428
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.455025974Z" level=info msg="shim reaped" id=6a65c6cde12634406215925024ff7efbfde31970a2fae1cee138b3c78abb457b
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.455688323Z" level=info msg="shim reaped" id=57f84dfaea1a0124887221fe4ca42cdd70874479d537762331073aeea78fdc3c
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.464631848Z" level=warning msg="6a65c6cde12634406215925024ff7efbfde31970a2fae1cee138b3c78abb457b cleanup: failed to unmount IPC: umount /var/lib/docker/containers/6a65c6cde12634406215925024ff7efbfde31970a2fae1cee138b3c78abb457b/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.467270697Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.468412977Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.468514822Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.472465659Z" level=info msg="shim reaped" id=7875ca2dd284fcbe5f105724f1e61129e2e0024cbc08c0087459e513aee52f8d
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.484252472Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.484312395Z" level=info msg="shim reaped" id=a9e407f022632328dffb89823646d79c52fdddb5ef9758e91175bc5c612c41b9
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.484451983Z" level=warning msg="7875ca2dd284fcbe5f105724f1e61129e2e0024cbc08c0087459e513aee52f8d cleanup: failed to unmount IPC: umount /var/lib/docker/containers/7875ca2dd284fcbe5f105724f1e61129e2e0024cbc08c0087459e513aee52f8d/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.500660521Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.501270944Z" level=warning msg="a9e407f022632328dffb89823646d79c52fdddb5ef9758e91175bc5c612c41b9 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/a9e407f022632328dffb89823646d79c52fdddb5ef9758e91175bc5c612c41b9/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.958620108Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/363e4cd9226d5ccb3df9aeabdbadcd5027356560fc10f10e52c4cbd5f804c3f4/shim.sock" debug=false pid=6151
Dec 12 20:34:59 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:59.355359057Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a/shim.sock" debug=false pid=6215
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.534629358Z" level=info msg="shim reaped" id=7f528adae78da7b2eb5940e40a583002dc16c8f725f92ea5a39ad99cb5002001
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.544009556Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.544296964Z" level=warning msg="7f528adae78da7b2eb5940e40a583002dc16c8f725f92ea5a39ad99cb5002001 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/7f528adae78da7b2eb5940e40a583002dc16c8f725f92ea5a39ad99cb5002001/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.625785770Z" level=info msg="shim reaped" id=9c63e302c50f7cb61eeb9961ad896ee5ac273bcffef35c4fd07e7b41c4f7acbb
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.634589299Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.634731327Z" level=warning msg="9c63e302c50f7cb61eeb9961ad896ee5ac273bcffef35c4fd07e7b41c4f7acbb cleanup: failed to unmount IPC: umount /var/lib/docker/containers/9c63e302c50f7cb61eeb9961ad896ee5ac273bcffef35c4fd07e7b41c4f7acbb/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:05 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:05.159917140Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/00a28756f87c5896ae83bc66f307752e82ededd0b053185be24deef5bb6e4c00/shim.sock" debug=false pid=6377
Dec 12 20:35:05 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:05.519537050Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd/shim.sock" debug=false pid=6437
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.037028516Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/14a6adf71ce3ba464cf0ac5b8221f057121127d85eb9f1cdf3442aa5d4003beb/shim.sock" debug=false pid=6488
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.302068624Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049/shim.sock" debug=false pid=6532
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.441092570Z" level=info msg="Container 9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b failed to exit within 10 seconds of signal 15 - using the force"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.572894189Z" level=info msg="shim reaped" id=9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.581320594Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.581681311Z" level=warning msg="9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b cleanup: failed to unmount IPC: umount /var/lib/docker/containers/9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.649082859Z" level=info msg="Daemon shutdown complete"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.649280483Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.649362639Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.649671359Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.697350133Z" level=warning msg="failed to get endpoint_count map for scope local: open : no such file or directory"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.704522067Z" level=warning msg="9d3f07435acc85bc9259baced851b55e491ad2c8e3f6ef82752ea69391d73faf cleanup: failed to unmount IPC: umount /var/lib/docker/containers/9d3f07435acc85bc9259baced851b55e491ad2c8e3f6ef82752ea69391d73faf/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.715051844Z" level=error msg="9d3f07435acc85bc9259baced851b55e491ad2c8e3f6ef82752ea69391d73faf cleanup: failed to delete container from containerd: grpc: the client connection is closing: unknown"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.715363187Z" level=error msg="Handler for POST /containers/9d3f07435acc85bc9259baced851b55e491ad2c8e3f6ef82752ea69391d73faf/start returned error: failed to update store for object type *libnetwork.endpoint: open : no such file or directory"
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Succeeded.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: Stopped Docker Application Container Engine.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6151 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6215 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6377 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6437 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6488 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6532 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: Starting Docker Application Container Engine...
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.704682697Z" level=info msg="Starting up"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708366312Z" level=info msg="libcontainerd: started new containerd process" pid=6640
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708422961Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708432743Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708448242Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708464085Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.739061316Z" level=info msg="starting containerd" revision=b34a5c8af56e510852c35414db4c1f4fa6172339 version=v1.2.10
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.739561450Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.739902429Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.740223341Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.btrfs" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.740298315Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.741657959Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.aufs" error="modprobe aufs failed: "modprobe: FATAL: Module aufs not found in directory /lib/modules/4.19.81\n": exit status 1"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.741699332Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.742100089Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.742611532Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.742963078Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743015797Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743037743Z" level=warning msg="could not use snapshotter btrfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743046729Z" level=warning msg="could not use snapshotter aufs in metadata plugin" error="modprobe aufs failed: "modprobe: FATAL: Module aufs not found in directory /lib/modules/4.19.81\n": exit status 1"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743057007Z" level=warning msg="could not use snapshotter zfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743305133Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743359530Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743424443Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743438941Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743448268Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743458205Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743467462Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743477212Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743486426Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743495430Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.758847185Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.759123100Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.760696805Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.760940984Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761004838Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761017660Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761027481Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761035306Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761043147Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761051861Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761059866Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761068031Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761079959Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761106398Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761115683Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761124506Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761132668Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761323524Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761349680Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761356576Z" level=info msg="containerd successfully booted in 0.023288s"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.775550345Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.775607895Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.775637034Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.775650458Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.777116386Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.777233209Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.777301286Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.777323446Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.783782593Z" level=info msg="[graphdriver] using prior storage driver: overlay2"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817882934Z" level=warning msg="Your kernel does not support cgroup blkio weight"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817944441Z" level=warning msg="Your kernel does not support cgroup blkio weight_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817955808Z" level=warning msg="Your kernel does not support cgroup blkio throttle.read_bps_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817961643Z" level=warning msg="Your kernel does not support cgroup blkio throttle.write_bps_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817971345Z" level=warning msg="Your kernel does not support cgroup blkio throttle.read_iops_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817976822Z" level=warning msg="Your kernel does not support cgroup blkio throttle.write_iops_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.818126188Z" level=info msg="Loading containers: start."
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.693060566Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.693389454Z" level=warning msg="8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a cleanup: failed to unmount IPC: umount /var/lib/docker/containers/8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.724294246Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.768626895Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.769038379Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.786794894Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=363e4cd9226d5ccb3df9aeabdbadcd5027356560fc10f10e52c4cbd5f804c3f4 path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/363e4cd9226d5ccb3df9aeabdbadcd5027356560fc10f10e52c4cbd5f804c3f4"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.788391041Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.793413515Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.800113695Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.834949770Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=14a6adf71ce3ba464cf0ac5b8221f057121127d85eb9f1cdf3442aa5d4003beb path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/14a6adf71ce3ba464cf0ac5b8221f057121127d85eb9f1cdf3442aa5d4003beb"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.835556365Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.840800858Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=00a28756f87c5896ae83bc66f307752e82ededd0b053185be24deef5bb6e4c00 path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/00a28756f87c5896ae83bc66f307752e82ededd0b053185be24deef5bb6e4c00"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.841365961Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.990880176Z" level=info msg="Removing stale sandbox 1e15b463c566a8432a3c5ec92950453d278fd60674f7d5599316c76b75615f85 (14a6adf71ce3ba464cf0ac5b8221f057121127d85eb9f1cdf3442aa5d4003beb)"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.994625127Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint d074412b6cd4aefd033d2391a00703547aa749819011f25da3c57f38c354ad47 4ca41a8018600b0c411e46cd966dff87fa3d48dae007da0aa1457d0dae00a879], retrying...."
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.146026307Z" level=info msg="Removing stale sandbox 576292ab1f519034a3633c427100598fdcd33b477a1feb40668b06302d28fe4e (00a28756f87c5896ae83bc66f307752e82ededd0b053185be24deef5bb6e4c00)"
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.152451105Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 96759cab9504c2a6eaf1d7fecc2f9f12b01c9489f1e1aeb5dfa0577fb3971472 afd85b6940ff195a3529d9e6f2b16bef284d77eb53677aca944323dcdd332bf7], retrying...."
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.269898667Z" level=info msg="Removing stale sandbox 9ed0e6b99940947b65bb03e4b8d82a9b2839357b0239c0a7a3265560fb645f31 (363e4cd9226d5ccb3df9aeabdbadcd5027356560fc10f10e52c4cbd5f804c3f4)"
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.272810151Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint d074412b6cd4aefd033d2391a00703547aa749819011f25da3c57f38c354ad47 1300bd6709eb0b79ce12cf15f37b7ebf8157404d2e02f69770f84dd268f237ed], retrying...."
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.287608807Z" level=info msg="There are old running containers, the network config will not take affect"
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.365376421Z" level=info msg="Loading containers: done."
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.396743421Z" level=info msg="Docker daemon" commit=633a0ea838 graphdriver(s)=overlay2 version=19.03.5
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.396912159Z" level=info msg="Daemon has completed initialization"
Dec 12 20:35:10 running-upgrade-629827 systemd[1]: Started Docker Application Container Engine.
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.436569209Z" level=info msg="API listen on /var/run/docker.sock"
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.436794473Z" level=info msg="API listen on [::]:2376"
Dec 12 20:35:11 running-upgrade-629827 systemd[1]: Stopping Docker Application Container Engine...
Dec 12 20:35:11 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:11.715036273Z" level=info msg="Processing signal 'terminated'"
Dec 12 20:35:12 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:12.028855931Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:12 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:12.029694639Z" level=warning msg="5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:12 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:12.069280616Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049 path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049"
Dec 12 20:35:12 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:12.070272433Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:13 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:13.646937381Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/56ec2298e699fd43c29e925b43bd453758a7a42871dff6e485453ef2ebb98794/shim.sock" debug=false pid=7252
Dec 12 20:35:13 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:13.659998772Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/1e2627cdb77dc2b44cf9ecb4d12b87d328f2928a65af47750fe4bed0395c4fe9/shim.sock" debug=false pid=7260
Dec 12 20:35:13 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:13.930519094Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/a0d1981f09615ef1174b9d97b8e2bf6b83e4b98c9ac943f8ff1fed812e2da752/shim.sock" debug=false pid=7339
Dec 12 20:35:14 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:14.891402824Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/2604df3c238438847c1c92a61b0ac00671fb1d7596c78f4d7eae035c43c21559/shim.sock" debug=false pid=7389
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.182020291Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d8472ad890b1efc57a32ec7f9f03b46ae77bd0fb8d45a10e22f215ded5db5296/shim.sock" debug=false pid=7462
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.278385505Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.278815439Z" level=warning msg="88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd cleanup: failed to unmount IPC: umount /var/lib/docker/containers/88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.300080986Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.300729278Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.512974161Z" level=info msg="Daemon shutdown complete"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.513109406Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.513203344Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.513301299Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.534708273Z" level=warning msg="8badff5c8bbb267aa42cbe9e65ea0fbd40e7ee9d6620d0b2bdf2a32a08c1a552 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/8badff5c8bbb267aa42cbe9e65ea0fbd40e7ee9d6620d0b2bdf2a32a08c1a552/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.542492079Z" level=error msg="8badff5c8bbb267aa42cbe9e65ea0fbd40e7ee9d6620d0b2bdf2a32a08c1a552 cleanup: failed to delete container from containerd: grpc: the client connection is closing: unknown"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.542587942Z" level=error msg="Handler for POST /containers/8badff5c8bbb267aa42cbe9e65ea0fbd40e7ee9d6620d0b2bdf2a32a08c1a552/start returned error: grpc: the client connection is closing: unknown"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.558938564Z" level=warning msg="failed to retrieve containerd version: rpc error: code = Canceled desc = grpc: the client connection is closing"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.560032832Z" level=warning msg="failed to get endpoint_count map for scope local: open : no such file or directory"
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Succeeded.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: Stopped Docker Application Container Engine.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7252 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7260 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7339 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7389 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7462 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: Starting Docker Application Container Engine...
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.572440352Z" level=info msg="Starting up"
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.574649717Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.574701935Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.574731362Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.574748569Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.575012415Z" level=warning msg="grpc: addrConn.createTransport failed to connect to {unix:///run/containerd/containerd.sock 0 <nil>}. Err :connection error: desc = \"transport: Error while dialing dial unix /run/containerd/containerd.sock: connect: connection refused\". Reconnecting..." module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": all SubConns are in TransientFailure, latest connection error: connection error: desc = "transport: Error while dialing dial unix /run/containerd/containerd.sock: connect: connection refused": unavailable
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Failed with result 'exit-code'.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: Failed to start Docker Application Container Engine.
-- /stdout --
X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart docker: Process exited with status 1
stdout:
stderr:
Job for docker.service failed because the control process exited with error code.
See "systemctl status docker.service" and "journalctl -xe" for details.
sudo journalctl --no-pager -u docker:
-- stdout --
-- Logs begin at Tue 2023-12-12 20:33:28 UTC, end at Tue 2023-12-12 20:35:17 UTC. --
Dec 12 20:33:42 running-upgrade-629827 systemd[1]: Starting Docker Application Container Engine...
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.820851557Z" level=info msg="Starting up"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822642518Z" level=info msg="libcontainerd: started new containerd process" pid=2094
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822753288Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822787519Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822832593Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.822871976Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.854692916Z" level=info msg="starting containerd" revision=b34a5c8af56e510852c35414db4c1f4fa6172339 version=v1.2.10
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.855022900Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.855127287Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.855466709Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.btrfs" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.855530783Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.856720203Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.aufs" error="modprobe aufs failed: "modprobe: FATAL: Module aufs not found in directory /lib/modules/4.19.81\n": exit status 1"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.856794725Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.856891660Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857040955Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857324593Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857386441Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857451902Z" level=warning msg="could not use snapshotter btrfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857486440Z" level=warning msg="could not use snapshotter aufs in metadata plugin" error="modprobe aufs failed: "modprobe: FATAL: Module aufs not found in directory /lib/modules/4.19.81\n": exit status 1"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.857514799Z" level=warning msg="could not use snapshotter zfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866349328Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866440916Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866548925Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866599723Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866640832Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866682766Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866718460Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866750275Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866782941Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866814408Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.866943107Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867036122Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867488991Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867566248Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867623305Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867663107Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867702986Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867736084Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867766635Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867798750Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867834629Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867866785Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867896205Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867960641Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.867997382Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868034862Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868069010Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868300254Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868373851Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.868409738Z" level=info msg="containerd successfully booted in 0.014502s"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.876517019Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.876593639Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.876640204Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.876684894Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.878217163Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.878285702Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.878328286Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.878373225Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905684757Z" level=warning msg="Your kernel does not support cgroup blkio weight"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905705150Z" level=warning msg="Your kernel does not support cgroup blkio weight_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905710987Z" level=warning msg="Your kernel does not support cgroup blkio throttle.read_bps_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905716421Z" level=warning msg="Your kernel does not support cgroup blkio throttle.write_bps_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905721967Z" level=warning msg="Your kernel does not support cgroup blkio throttle.read_iops_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905730852Z" level=warning msg="Your kernel does not support cgroup blkio throttle.write_iops_device"
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.905936357Z" level=info msg="Loading containers: start."
Dec 12 20:33:42 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:42.993908505Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address"
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.050221650Z" level=info msg="Loading containers: done."
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.075323992Z" level=info msg="Docker daemon" commit=633a0ea838 graphdriver(s)=overlay2 version=19.03.5
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.075487547Z" level=info msg="Daemon has completed initialization"
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.105933075Z" level=info msg="API listen on /var/run/docker.sock"
Dec 12 20:33:43 running-upgrade-629827 systemd[1]: Started Docker Application Container Engine.
Dec 12 20:33:43 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:33:43.106939745Z" level=info msg="API listen on [::]:2376"
Dec 12 20:34:25 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:25.961995327Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d995d10857c7c87dab3f04f0417b4e6866041cc28266136e1e6b89b33c75e383/shim.sock" debug=false pid=3649
Dec 12 20:34:25 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:25.978020275Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/82e8820b282d2662ab2f8c0123d106f88c32f450f39f56e0cecd58aaa795e590/shim.sock" debug=false pid=3660
Dec 12 20:34:25 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:25.995306431Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/c5843a22b79114c31baee33a22a6269abb3f6860cb981ddb129973af7945572f/shim.sock" debug=false pid=3672
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.212438064Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d40dccab848eb74feca0e59ebf5213a346f89ffe7f78901d5dfa8ab6eefb2866/shim.sock" debug=false pid=3729
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.366461250Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/c98e2b3562bcc22f9f096efe004140064bb04ea27e87c1b9302302379cfff428/shim.sock" debug=false pid=3772
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.761908902Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/7875ca2dd284fcbe5f105724f1e61129e2e0024cbc08c0087459e513aee52f8d/shim.sock" debug=false pid=3888
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.769776714Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b/shim.sock" debug=false pid=3892
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.811818614Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/a9e407f022632328dffb89823646d79c52fdddb5ef9758e91175bc5c612c41b9/shim.sock" debug=false pid=3917
Dec 12 20:34:26 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:26.887692001Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/e8fa8c69b14d72811a56503546bc10f3e7d51bcff2bc91dbbdd799006b7950c8/shim.sock" debug=false pid=3944
Dec 12 20:34:27 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:27.238980686Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/581635acfc07fff800068eb58b44fa5545fc295db9ced8927e97340888ace818/shim.sock" debug=false pid=4036
Dec 12 20:34:50 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:50.061406982Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/957a85467238da7f331d31b90e65904633e1397fed1c1c2f82037e9579feb11e/shim.sock" debug=false pid=4888
Dec 12 20:34:50 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:50.380433530Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/6a65c6cde12634406215925024ff7efbfde31970a2fae1cee138b3c78abb457b/shim.sock" debug=false pid=4972
Dec 12 20:34:51 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:51.191404872Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/57f84dfaea1a0124887221fe4ca42cdd70874479d537762331073aeea78fdc3c/shim.sock" debug=false pid=5079
Dec 12 20:34:51 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:51.537057015Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/62c374217b1ad49a0d7530baf875f9832704c0da60beec1b4ae581e989960d43/shim.sock" debug=false pid=5123
Dec 12 20:34:53 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:53.263852853Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d677d72bac3f0594f543e62b9681132ee2e111495d05d02bc0b15613d23a211a/shim.sock" debug=false pid=5192
Dec 12 20:34:53 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:53.298776447Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/eb60920661e01aa761786ef8aa9018a81c0ca3c8c08abe69a1dcbcf02689feeb/shim.sock" debug=false pid=5213
Dec 12 20:34:53 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:53.905298621Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/7f528adae78da7b2eb5940e40a583002dc16c8f725f92ea5a39ad99cb5002001/shim.sock" debug=false pid=5337
Dec 12 20:34:54 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:54.008270385Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/9c63e302c50f7cb61eeb9961ad896ee5ac273bcffef35c4fd07e7b41c4f7acbb/shim.sock" debug=false pid=5359
Dec 12 20:34:57 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:57.052970296Z" level=info msg="Processing signal 'terminated'"
Dec 12 20:34:57 running-upgrade-629827 systemd[1]: Stopping Docker Application Container Engine...
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.150594991Z" level=info msg="shim reaped" id=c5843a22b79114c31baee33a22a6269abb3f6860cb981ddb129973af7945572f
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.160749386Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.238266936Z" level=info msg="shim reaped" id=581635acfc07fff800068eb58b44fa5545fc295db9ced8927e97340888ace818
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.252446840Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.264945738Z" level=warning msg="581635acfc07fff800068eb58b44fa5545fc295db9ced8927e97340888ace818 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/581635acfc07fff800068eb58b44fa5545fc295db9ced8927e97340888ace818/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.281896204Z" level=info msg="shim reaped" id=62c374217b1ad49a0d7530baf875f9832704c0da60beec1b4ae581e989960d43
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.286021046Z" level=info msg="shim reaped" id=d677d72bac3f0594f543e62b9681132ee2e111495d05d02bc0b15613d23a211a
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.291998282Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.292382378Z" level=warning msg="62c374217b1ad49a0d7530baf875f9832704c0da60beec1b4ae581e989960d43 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/62c374217b1ad49a0d7530baf875f9832704c0da60beec1b4ae581e989960d43/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.301118185Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.333734505Z" level=info msg="shim reaped" id=eb60920661e01aa761786ef8aa9018a81c0ca3c8c08abe69a1dcbcf02689feeb
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.336039393Z" level=info msg="shim reaped" id=d995d10857c7c87dab3f04f0417b4e6866041cc28266136e1e6b89b33c75e383
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.349581322Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.353351589Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.359579185Z" level=info msg="shim reaped" id=e8fa8c69b14d72811a56503546bc10f3e7d51bcff2bc91dbbdd799006b7950c8
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.370002277Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.370416037Z" level=warning msg="e8fa8c69b14d72811a56503546bc10f3e7d51bcff2bc91dbbdd799006b7950c8 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/e8fa8c69b14d72811a56503546bc10f3e7d51bcff2bc91dbbdd799006b7950c8/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.376604126Z" level=info msg="shim reaped" id=d40dccab848eb74feca0e59ebf5213a346f89ffe7f78901d5dfa8ab6eefb2866
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.382758026Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.414235213Z" level=info msg="shim reaped" id=82e8820b282d2662ab2f8c0123d106f88c32f450f39f56e0cecd58aaa795e590
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.432859500Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.452402678Z" level=info msg="shim reaped" id=957a85467238da7f331d31b90e65904633e1397fed1c1c2f82037e9579feb11e
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.453407457Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.454254607Z" level=info msg="shim reaped" id=c98e2b3562bcc22f9f096efe004140064bb04ea27e87c1b9302302379cfff428
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.455025974Z" level=info msg="shim reaped" id=6a65c6cde12634406215925024ff7efbfde31970a2fae1cee138b3c78abb457b
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.455688323Z" level=info msg="shim reaped" id=57f84dfaea1a0124887221fe4ca42cdd70874479d537762331073aeea78fdc3c
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.464631848Z" level=warning msg="6a65c6cde12634406215925024ff7efbfde31970a2fae1cee138b3c78abb457b cleanup: failed to unmount IPC: umount /var/lib/docker/containers/6a65c6cde12634406215925024ff7efbfde31970a2fae1cee138b3c78abb457b/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.467270697Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.468412977Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.468514822Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.472465659Z" level=info msg="shim reaped" id=7875ca2dd284fcbe5f105724f1e61129e2e0024cbc08c0087459e513aee52f8d
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.484252472Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.484312395Z" level=info msg="shim reaped" id=a9e407f022632328dffb89823646d79c52fdddb5ef9758e91175bc5c612c41b9
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.484451983Z" level=warning msg="7875ca2dd284fcbe5f105724f1e61129e2e0024cbc08c0087459e513aee52f8d cleanup: failed to unmount IPC: umount /var/lib/docker/containers/7875ca2dd284fcbe5f105724f1e61129e2e0024cbc08c0087459e513aee52f8d/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.500660521Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.501270944Z" level=warning msg="a9e407f022632328dffb89823646d79c52fdddb5ef9758e91175bc5c612c41b9 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/a9e407f022632328dffb89823646d79c52fdddb5ef9758e91175bc5c612c41b9/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:34:58 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:58.958620108Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/363e4cd9226d5ccb3df9aeabdbadcd5027356560fc10f10e52c4cbd5f804c3f4/shim.sock" debug=false pid=6151
Dec 12 20:34:59 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:34:59.355359057Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a/shim.sock" debug=false pid=6215
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.534629358Z" level=info msg="shim reaped" id=7f528adae78da7b2eb5940e40a583002dc16c8f725f92ea5a39ad99cb5002001
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.544009556Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.544296964Z" level=warning msg="7f528adae78da7b2eb5940e40a583002dc16c8f725f92ea5a39ad99cb5002001 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/7f528adae78da7b2eb5940e40a583002dc16c8f725f92ea5a39ad99cb5002001/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.625785770Z" level=info msg="shim reaped" id=9c63e302c50f7cb61eeb9961ad896ee5ac273bcffef35c4fd07e7b41c4f7acbb
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.634589299Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:02 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:02.634731327Z" level=warning msg="9c63e302c50f7cb61eeb9961ad896ee5ac273bcffef35c4fd07e7b41c4f7acbb cleanup: failed to unmount IPC: umount /var/lib/docker/containers/9c63e302c50f7cb61eeb9961ad896ee5ac273bcffef35c4fd07e7b41c4f7acbb/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:05 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:05.159917140Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/00a28756f87c5896ae83bc66f307752e82ededd0b053185be24deef5bb6e4c00/shim.sock" debug=false pid=6377
Dec 12 20:35:05 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:05.519537050Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd/shim.sock" debug=false pid=6437
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.037028516Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/14a6adf71ce3ba464cf0ac5b8221f057121127d85eb9f1cdf3442aa5d4003beb/shim.sock" debug=false pid=6488
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.302068624Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049/shim.sock" debug=false pid=6532
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.441092570Z" level=info msg="Container 9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b failed to exit within 10 seconds of signal 15 - using the force"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.572894189Z" level=info msg="shim reaped" id=9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.581320594Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.581681311Z" level=warning msg="9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b cleanup: failed to unmount IPC: umount /var/lib/docker/containers/9950bf55c0a07f1d252b8b0c4199c172d7eb27e8b5f8232396eac53ebe58167b/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.649082859Z" level=info msg="Daemon shutdown complete"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.649280483Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.649362639Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.649671359Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.697350133Z" level=warning msg="failed to get endpoint_count map for scope local: open : no such file or directory"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.704522067Z" level=warning msg="9d3f07435acc85bc9259baced851b55e491ad2c8e3f6ef82752ea69391d73faf cleanup: failed to unmount IPC: umount /var/lib/docker/containers/9d3f07435acc85bc9259baced851b55e491ad2c8e3f6ef82752ea69391d73faf/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.715051844Z" level=error msg="9d3f07435acc85bc9259baced851b55e491ad2c8e3f6ef82752ea69391d73faf cleanup: failed to delete container from containerd: grpc: the client connection is closing: unknown"
Dec 12 20:35:07 running-upgrade-629827 dockerd[2087]: time="2023-12-12T20:35:07.715363187Z" level=error msg="Handler for POST /containers/9d3f07435acc85bc9259baced851b55e491ad2c8e3f6ef82752ea69391d73faf/start returned error: failed to update store for object type *libnetwork.endpoint: open : no such file or directory"
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Succeeded.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: Stopped Docker Application Container Engine.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6151 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6215 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6377 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6437 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6488 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 6532 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:08 running-upgrade-629827 systemd[1]: Starting Docker Application Container Engine...
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.704682697Z" level=info msg="Starting up"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708366312Z" level=info msg="libcontainerd: started new containerd process" pid=6640
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708422961Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708432743Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708448242Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.708464085Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.739061316Z" level=info msg="starting containerd" revision=b34a5c8af56e510852c35414db4c1f4fa6172339 version=v1.2.10
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.739561450Z" level=info msg="loading plugin "io.containerd.content.v1.content"..." type=io.containerd.content.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.739902429Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.btrfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.740223341Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.btrfs" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.740298315Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.aufs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.741657959Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.aufs" error="modprobe aufs failed: "modprobe: FATAL: Module aufs not found in directory /lib/modules/4.19.81\n": exit status 1"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.741699332Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.native"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.742100089Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.overlayfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.742611532Z" level=info msg="loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.742963078Z" level=info msg="skip loading plugin "io.containerd.snapshotter.v1.zfs"..." type=io.containerd.snapshotter.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743015797Z" level=info msg="loading plugin "io.containerd.metadata.v1.bolt"..." type=io.containerd.metadata.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743037743Z" level=warning msg="could not use snapshotter btrfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743046729Z" level=warning msg="could not use snapshotter aufs in metadata plugin" error="modprobe aufs failed: "modprobe: FATAL: Module aufs not found in directory /lib/modules/4.19.81\n": exit status 1"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743057007Z" level=warning msg="could not use snapshotter zfs in metadata plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743305133Z" level=info msg="loading plugin "io.containerd.differ.v1.walking"..." type=io.containerd.differ.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743359530Z" level=info msg="loading plugin "io.containerd.gc.v1.scheduler"..." type=io.containerd.gc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743424443Z" level=info msg="loading plugin "io.containerd.service.v1.containers-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743438941Z" level=info msg="loading plugin "io.containerd.service.v1.content-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743448268Z" level=info msg="loading plugin "io.containerd.service.v1.diff-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743458205Z" level=info msg="loading plugin "io.containerd.service.v1.images-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743467462Z" level=info msg="loading plugin "io.containerd.service.v1.leases-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743477212Z" level=info msg="loading plugin "io.containerd.service.v1.namespaces-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743486426Z" level=info msg="loading plugin "io.containerd.service.v1.snapshots-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.743495430Z" level=info msg="loading plugin "io.containerd.runtime.v1.linux"..." type=io.containerd.runtime.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.758847185Z" level=info msg="loading plugin "io.containerd.runtime.v2.task"..." type=io.containerd.runtime.v2
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.759123100Z" level=info msg="loading plugin "io.containerd.monitor.v1.cgroups"..." type=io.containerd.monitor.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.760696805Z" level=info msg="loading plugin "io.containerd.service.v1.tasks-service"..." type=io.containerd.service.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.760940984Z" level=info msg="loading plugin "io.containerd.internal.v1.restart"..." type=io.containerd.internal.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761004838Z" level=info msg="loading plugin "io.containerd.grpc.v1.containers"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761017660Z" level=info msg="loading plugin "io.containerd.grpc.v1.content"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761027481Z" level=info msg="loading plugin "io.containerd.grpc.v1.diff"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761035306Z" level=info msg="loading plugin "io.containerd.grpc.v1.events"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761043147Z" level=info msg="loading plugin "io.containerd.grpc.v1.healthcheck"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761051861Z" level=info msg="loading plugin "io.containerd.grpc.v1.images"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761059866Z" level=info msg="loading plugin "io.containerd.grpc.v1.leases"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761068031Z" level=info msg="loading plugin "io.containerd.grpc.v1.namespaces"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761079959Z" level=info msg="loading plugin "io.containerd.internal.v1.opt"..." type=io.containerd.internal.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761106398Z" level=info msg="loading plugin "io.containerd.grpc.v1.snapshots"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761115683Z" level=info msg="loading plugin "io.containerd.grpc.v1.tasks"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761124506Z" level=info msg="loading plugin "io.containerd.grpc.v1.version"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761132668Z" level=info msg="loading plugin "io.containerd.grpc.v1.introspection"..." type=io.containerd.grpc.v1
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761323524Z" level=info msg=serving... address="/var/run/docker/containerd/containerd-debug.sock"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761349680Z" level=info msg=serving... address="/var/run/docker/containerd/containerd.sock"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.761356576Z" level=info msg="containerd successfully booted in 0.023288s"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.775550345Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.775607895Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.775637034Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.775650458Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.777116386Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.777233209Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.777301286Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.777323446Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.783782593Z" level=info msg="[graphdriver] using prior storage driver: overlay2"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817882934Z" level=warning msg="Your kernel does not support cgroup blkio weight"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817944441Z" level=warning msg="Your kernel does not support cgroup blkio weight_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817955808Z" level=warning msg="Your kernel does not support cgroup blkio throttle.read_bps_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817961643Z" level=warning msg="Your kernel does not support cgroup blkio throttle.write_bps_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817971345Z" level=warning msg="Your kernel does not support cgroup blkio throttle.read_iops_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.817976822Z" level=warning msg="Your kernel does not support cgroup blkio throttle.write_iops_device"
Dec 12 20:35:08 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:08.818126188Z" level=info msg="Loading containers: start."
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.693060566Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.693389454Z" level=warning msg="8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a cleanup: failed to unmount IPC: umount /var/lib/docker/containers/8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.724294246Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.768626895Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/8314bc49106156107dc1ea6d4b04c799e0a57c9d5e26b2ea5ec75d049182839a"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.769038379Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.786794894Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=363e4cd9226d5ccb3df9aeabdbadcd5027356560fc10f10e52c4cbd5f804c3f4 path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/363e4cd9226d5ccb3df9aeabdbadcd5027356560fc10f10e52c4cbd5f804c3f4"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.788391041Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.793413515Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.800113695Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.834949770Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=14a6adf71ce3ba464cf0ac5b8221f057121127d85eb9f1cdf3442aa5d4003beb path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/14a6adf71ce3ba464cf0ac5b8221f057121127d85eb9f1cdf3442aa5d4003beb"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.835556365Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.840800858Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=00a28756f87c5896ae83bc66f307752e82ededd0b053185be24deef5bb6e4c00 path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/00a28756f87c5896ae83bc66f307752e82ededd0b053185be24deef5bb6e4c00"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.841365961Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.990880176Z" level=info msg="Removing stale sandbox 1e15b463c566a8432a3c5ec92950453d278fd60674f7d5599316c76b75615f85 (14a6adf71ce3ba464cf0ac5b8221f057121127d85eb9f1cdf3442aa5d4003beb)"
Dec 12 20:35:09 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:09.994625127Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint d074412b6cd4aefd033d2391a00703547aa749819011f25da3c57f38c354ad47 4ca41a8018600b0c411e46cd966dff87fa3d48dae007da0aa1457d0dae00a879], retrying...."
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.146026307Z" level=info msg="Removing stale sandbox 576292ab1f519034a3633c427100598fdcd33b477a1feb40668b06302d28fe4e (00a28756f87c5896ae83bc66f307752e82ededd0b053185be24deef5bb6e4c00)"
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.152451105Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 96759cab9504c2a6eaf1d7fecc2f9f12b01c9489f1e1aeb5dfa0577fb3971472 afd85b6940ff195a3529d9e6f2b16bef284d77eb53677aca944323dcdd332bf7], retrying...."
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.269898667Z" level=info msg="Removing stale sandbox 9ed0e6b99940947b65bb03e4b8d82a9b2839357b0239c0a7a3265560fb645f31 (363e4cd9226d5ccb3df9aeabdbadcd5027356560fc10f10e52c4cbd5f804c3f4)"
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.272810151Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint d074412b6cd4aefd033d2391a00703547aa749819011f25da3c57f38c354ad47 1300bd6709eb0b79ce12cf15f37b7ebf8157404d2e02f69770f84dd268f237ed], retrying...."
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.287608807Z" level=info msg="There are old running containers, the network config will not take affect"
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.365376421Z" level=info msg="Loading containers: done."
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.396743421Z" level=info msg="Docker daemon" commit=633a0ea838 graphdriver(s)=overlay2 version=19.03.5
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.396912159Z" level=info msg="Daemon has completed initialization"
Dec 12 20:35:10 running-upgrade-629827 systemd[1]: Started Docker Application Container Engine.
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.436569209Z" level=info msg="API listen on /var/run/docker.sock"
Dec 12 20:35:10 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:10.436794473Z" level=info msg="API listen on [::]:2376"
Dec 12 20:35:11 running-upgrade-629827 systemd[1]: Stopping Docker Application Container Engine...
Dec 12 20:35:11 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:11.715036273Z" level=info msg="Processing signal 'terminated'"
Dec 12 20:35:12 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:12.028855931Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:12 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:12.029694639Z" level=warning msg="5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:12 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:12.069280616Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049 path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/5e96f302742ef30151b77494e783cc562027f2c8ef1e90997f8572d4653e0049"
Dec 12 20:35:12 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:12.070272433Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:13 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:13.646937381Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/56ec2298e699fd43c29e925b43bd453758a7a42871dff6e485453ef2ebb98794/shim.sock" debug=false pid=7252
Dec 12 20:35:13 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:13.659998772Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/1e2627cdb77dc2b44cf9ecb4d12b87d328f2928a65af47750fe4bed0395c4fe9/shim.sock" debug=false pid=7260
Dec 12 20:35:13 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:13.930519094Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/a0d1981f09615ef1174b9d97b8e2bf6b83e4b98c9ac943f8ff1fed812e2da752/shim.sock" debug=false pid=7339
Dec 12 20:35:14 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:14.891402824Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/2604df3c238438847c1c92a61b0ac00671fb1d7596c78f4d7eae035c43c21559/shim.sock" debug=false pid=7389
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.182020291Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d8472ad890b1efc57a32ec7f9f03b46ae77bd0fb8d45a10e22f215ded5db5296/shim.sock" debug=false pid=7462
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.278385505Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.278815439Z" level=warning msg="88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd cleanup: failed to unmount IPC: umount /var/lib/docker/containers/88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.300080986Z" level=warning msg="unmount task rootfs" error="no such file or directory" id=88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd path="/var/run/docker/containerd/daemon/io.containerd.runtime.v1.linux/moby/88952dba5a3f5e8be9f978277e6090ca31ad221071326f0eca56909144c82afd"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.300729278Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.512974161Z" level=info msg="Daemon shutdown complete"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.513109406Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.513203344Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.513301299Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.534708273Z" level=warning msg="8badff5c8bbb267aa42cbe9e65ea0fbd40e7ee9d6620d0b2bdf2a32a08c1a552 cleanup: failed to unmount IPC: umount /var/lib/docker/containers/8badff5c8bbb267aa42cbe9e65ea0fbd40e7ee9d6620d0b2bdf2a32a08c1a552/mounts/shm, flags: 0x2: no such file or directory"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.542492079Z" level=error msg="8badff5c8bbb267aa42cbe9e65ea0fbd40e7ee9d6620d0b2bdf2a32a08c1a552 cleanup: failed to delete container from containerd: grpc: the client connection is closing: unknown"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.542587942Z" level=error msg="Handler for POST /containers/8badff5c8bbb267aa42cbe9e65ea0fbd40e7ee9d6620d0b2bdf2a32a08c1a552/start returned error: grpc: the client connection is closing: unknown"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.558938564Z" level=warning msg="failed to retrieve containerd version: rpc error: code = Canceled desc = grpc: the client connection is closing"
Dec 12 20:35:16 running-upgrade-629827 dockerd[6632]: time="2023-12-12T20:35:16.560032832Z" level=warning msg="failed to get endpoint_count map for scope local: open : no such file or directory"
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Succeeded.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: Stopped Docker Application Container Engine.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7252 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7260 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7339 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7389 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Found left-over process 7462 (containerd-shim) in control group while starting unit. Ignoring.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: Starting Docker Application Container Engine...
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.572440352Z" level=info msg="Starting up"
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.574649717Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.574701935Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.574731362Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 <nil>}] <nil>}" module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.574748569Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: time="2023-12-12T20:35:17.575012415Z" level=warning msg="grpc: addrConn.createTransport failed to connect to {unix:///run/containerd/containerd.sock 0 <nil>}. Err :connection error: desc = \"transport: Error while dialing dial unix /run/containerd/containerd.sock: connect: connection refused\". Reconnecting..." module=grpc
Dec 12 20:35:17 running-upgrade-629827 dockerd[7537]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": all SubConns are in TransientFailure, latest connection error: connection error: desc = "transport: Error while dialing dial unix /run/containerd/containerd.sock: connect: connection refused": unavailable
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: docker.service: Failed with result 'exit-code'.
Dec 12 20:35:17 running-upgrade-629827 systemd[1]: Failed to start Docker Application Container Engine.
-- /stdout --
W1212 20:35:17.623517 39910 out.go:239] *
*
W1212 20:35:17.624495 39910 out.go:239] ╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I1212 20:35:17.626310 39910 out.go:177]
** /stderr **
version_upgrade_test.go:145: upgrade from v1.6.2 to HEAD failed: out/minikube-linux-amd64 start -p running-upgrade-629827 --memory=2200 --alsologtostderr -v=1 --driver=kvm2 : exit status 90
panic.go:523: *** TestRunningBinaryUpgrade FAILED at 2023-12-12 20:35:17.689973233 +0000 UTC m=+2310.488072726
helpers_test.go:222: -----------------------post-mortem--------------------------------
helpers_test.go:239: (dbg) Run: out/minikube-linux-amd64 status --format={{.Host}} -p running-upgrade-629827 -n running-upgrade-629827
helpers_test.go:239: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p running-upgrade-629827 -n running-upgrade-629827: exit status 6 (254.953426ms)
-- stdout --
Running
WARNING: Your kubectl is pointing to stale minikube-vm.
To fix the kubectl context, run `minikube update-context`
-- /stdout --
** stderr **
E1212 20:35:17.933241 40214 status.go:415] kubeconfig endpoint: extract IP: "running-upgrade-629827" does not appear in /home/jenkins/minikube-integration/17734-9184/kubeconfig
** /stderr **
helpers_test.go:239: status error: exit status 6 (may be ok)
helpers_test.go:241: "running-upgrade-629827" host is not running, skipping log retrieval (state="Running\nWARNING: Your kubectl is pointing to stale minikube-vm.\nTo fix the kubectl context, run `minikube update-context`")
helpers_test.go:175: Cleaning up "running-upgrade-629827" profile ...
helpers_test.go:178: (dbg) Run: out/minikube-linux-amd64 delete -p running-upgrade-629827
helpers_test.go:178: (dbg) Done: out/minikube-linux-amd64 delete -p running-upgrade-629827: (1.294690412s)
--- FAIL: TestRunningBinaryUpgrade (139.02s)