Docker Community Forums

Share and learn in the Docker community.

Docker verion 18.06 - CentOS7 - Start up fails

docker

(Rkmani78) #1

I have a freshly installed Docker 18.06 on a Linux CentOS VM. I have used the directLVM configurations in /etc/docker/daemon.json as per the documentation. When i start the docker, it throws error mentioned below and exits.

Client:
Version: 18.06.1-ce-rc2
API version: 1.38
Go version: go1.10.3
Git commit: e2e08f8
Built: Wed Aug 15 01:28:43 2018
OS/Arch: linux/amd64
Experimental: false
Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running?
Unable to get the Server version here.

Error:

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.snapshotter.v1.overlayfs”…” type=io.containerd.snapshotter.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=warning msg=“failed to load plugin io.containerd.snapshotter.v1.overlayfs” error="/mnt/docker/containerd/daemon/io.containerd.snapshotter.v1.overlayfs does not support d_type. If the backing filesystem is xfs, please reformat with ftype=1 to enable d_type support"

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.snapshotter.v1.zfs”…” type=io.containerd.snapshotter.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=warning msg=“failed to load plugin io.containerd.snapshotter.v1.zfs” error=“path /mnt/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.metadata.v1.bolt”…” type=io.containerd.metadata.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=warning msg=“could not use snapshotter overlayfs in metadata plugin” error="/mnt/docker/containerd/daemon/io.containerd.snapshotter.v1.overlayfs does not support d_type. If the backing filesystem is xfs, please reformat with ftype=1 to enable d_type support"

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=warning msg=“could not use snapshotter zfs in metadata plugin” error=“path /mnt/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=warning msg=“could not use snapshotter btrfs in metadata plugin” error=“path /mnt/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs must be a btrfs filesystem to be used with the btrfs snapshotter”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=warning msg=“could not use snapshotter aufs in metadata plugin” error=“modprobe aufs failed: “modprobe: FATAL: Module aufs not found.\n”: exit status 1”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.differ.v1.walking”…” type=io.containerd.differ.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.gc.v1.scheduler”…” type=io.containerd.gc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.service.v1.containers-service”…” type=io.containerd.service.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.service.v1.content-service”…” type=io.containerd.service.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.service.v1.diff-service”…” type=io.containerd.service.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.service.v1.images-service”…” type=io.containerd.service.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.service.v1.leases-service”…” type=io.containerd.service.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.service.v1.namespaces-service”…” type=io.containerd.service.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.service.v1.snapshots-service”…” type=io.containerd.service.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.monitor.v1.cgroups”…” type=io.containerd.monitor.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.runtime.v1.linux”…” type=io.containerd.runtime.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.service.v1.tasks-service”…” type=io.containerd.service.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.containers”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.content”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.diff”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.events”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.healthcheck”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.images”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.leases”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.namespaces”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.snapshots”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.tasks”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.version”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“loading plugin “io.containerd.grpc.v1.introspection”…” type=io.containerd.grpc.v1

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=serving… address="/var/run/docker/containerd/docker-containerd-debug.sock"

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=serving… address="/var/run/docker/containerd/docker-containerd.sock"

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“containerd successfully booted in 0.005101s”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.616154234-04:00” level=info msg=“pickfirstBalancer: HandleSubConnStateChange: 0xc42022dbe0, READY” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=serving… address="/var/run/docker/containerd/docker-containerd.sock"

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40-04:00” level=info msg=“containerd successfully booted in 0.005101s”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.616154234-04:00” level=info msg=“pickfirstBalancer: HandleSubConnStateChange: 0xc42022dbe0, READY” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618029179-04:00” level=debug msg=“Golang’s threads limit set to 228510”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618638163-04:00” level=info msg=“parsed scheme: “unix”” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618650523-04:00” level=info msg=“scheme “unix” not registered, fallback to default scheme” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.616154234-04:00” level=info msg=“pickfirstBalancer: HandleSubConnStateChange: 0xc42022dbe0, READY” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618029179-04:00” level=debug msg=“Golang’s threads limit set to 228510”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618638163-04:00” level=info msg=“parsed scheme: “unix”” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618650523-04:00” level=info msg=“scheme “unix” not registered, fallback to default scheme” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618678657-04:00” level=info msg=“ccResolverWrapper: sending new addresses to cc: [{unix:///var/run/docker/containerd/docker-containerd.sock 0 <nil>}]” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618692476-04:00” level=info msg=“ClientConn switching balancer to “pick_first”” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618721849-04:00” level=info msg=“pickfirstBalancer: HandleSubConnStateChange: 0xc42036a7f0, CONNECTING” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618834527-04:00” level=info msg=“pickfirstBalancer: HandleSubConnStateChange: 0xc42036a7f0, READY” module=grpc

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618889701-04:00” level=debug msg=“Using default logging driver json-file”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.618901761-04:00” level=debug msg="[graphdriver] trying provided driver: devicemapper"

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.620167437-04:00” level=debug msg=“kernel dm driver version is 4.27.0” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.620201995-04:00” level=debug msg=“Deferred removal support enabled.” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.620209925-04:00” level=debug msg=“Deferred deletion support enabled.” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.620293431-04:00” level=debug msg=“processing event stream” module=libcontainerd namespace=plugins.moby

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.620357427-04:00” level=debug msg=“Setting dm.thinpooldev to “docker-thinpool”” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.620374968-04:00” level=debug msg=“Generated prefix: docker-253:1-202505486” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.620387291-04:00” level=debug msg=“Checking for existence of the pool docker-thinpool” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.621746996-04:00” level=debug msg=“loadDeviceFilesOnStart()” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.621787138-04:00” level=debug msg=“Loading data for file /mnt/docker/devicemapper/metadata/base” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.621850878-04:00” level=debug msg=“Skipping file /mnt/docker/devicemapper/metadata/deviceset-metadata” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.621862317-04:00” level=debug msg=“Skipping file /mnt/docker/devicemapper/metadata/transaction-metadata” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.621868686-04:00” level=debug msg=“loadDeviceFilesOnStart() END” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.621876388-04:00” level=debug msg=“constructDeviceIDMap()” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.621897676-04:00” level=debug msg=“Added deviceId=2 to DeviceIdMap” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.621902978-04:00” level=debug msg=“constructDeviceIDMap() END” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.622015033-04:00” level=debug msg=“Removing uninitialized base image” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.622025914-04:00” level=debug msg=“DeleteDevice START(hash= syncDelete=true)” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.622032884-04:00” level=debug msg=“issueDiscard START(device: ).” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.622038279-04:00” level=debug msg=“activateDeviceIfNeeded()” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.622044679-04:00” level=debug msg=“cancelDeferredRemovalIfNeeded START(docker-253:1-202505486-base)” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.622070584-04:00” level=debug msg=“cancelDeferredRemovalIfNeeded END(docker-253:1-202505486-base)” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.622243722-04:00” level=debug msg=“Worker to cleanup deleted devices started” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.641637524-04:00” level=debug msg=“issueDiscard END(device: ).” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.641665854-04:00” level=debug msg=“deactivateDevice START()” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.641709703-04:00” level=debug msg=“devicemapper: RemoveDeviceDeferred START(docker-253:1-202505486-base)”

Aug 22 19:15:40 centos7-x64-template systemd-udevd: inotify_add_watch(7, /dev/dm-5, 10) failed: No such file or directory

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.646254686-04:00” level=debug msg=“devicemapper: RemoveDeviceDeferred END(docker-253:1-202505486-base)”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.646272544-04:00” level=debug msg=“deactivateDevice END()” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.647483302-04:00” level=debug msg=“unregisterDevice()” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.647769876-04:00” level=debug msg=“DeleteDevice END(hash= syncDelete=true)” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.647788162-04:00” level=debug msg=“Initializing base device-mapper thin volume” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.648269813-04:00” level=debug msg=“devicemapper: CreateDevice(poolName=/dev/mapper/docker-thinpool, deviceID=3)”

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.648745112-04:00” level=debug msg=“Registering device (id 3) with FS size 10737418240” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.648763873-04:00” level=debug msg=“registerDevice(3, )” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.649443942-04:00” level=debug msg=“Creating filesystem on base device-mapper thin volume” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.649461504-04:00” level=debug msg=“activateDeviceIfNeeded()” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.649468520-04:00” level=debug msg=“cancelDeferredRemovalIfNeeded START(docker-253:1-202505486-base)” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.649496983-04:00” level=debug msg=“cancelDeferredRemovalIfNeeded END(docker-253:1-202505486-base)” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template kernel: bio: create slab <bio-2> at 2

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.657798973-04:00” level=info msg=“Creating filesystem xfs on device docker-253:1-202505486-base, mkfs args: [-m crc=0,finobt=0 /dev/mapper/docker-253:1-202505486-base]” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.658512032-04:00” level=info msg=“Error while creating filesystem xfs on device docker-253:1-202505486-base: exit status 1” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.658549133-04:00” level=debug msg=“Error device setupBaseImage: exit status 1” storage-driver=devicemapper

Aug 22 19:15:40 centos7-x64-template dockerd: time=“2018-08-22T19:15:40.658725931-04:00” level=debug msg=“Cleaning up old mountid : start.”

Aug 22 19:15:40 centos7-x64-template dockerd: Error starting daemon: error initializing graphdriver: exit status 1

Aug 22 19:15:40 centos7-x64-template systemd: docker.service: main process exited, code=exited, status=1/FAILURE

Aug 22 19:15:40 centos7-x64-template systemd: Failed to start Docker Application Container Engine.

Aug 22 19:15:40 centos7-x64-template systemd: Unit docker.service entered failed state.

Aug 22 19:15:40 centos7-x64-template systemd: docker.service failed.

Aug 22 19:15:40 centos7-x64-template systemd: docker.service holdoff time over, scheduling restart.

Aug 22 19:15:40 centos7-x64-template systemd: Cannot add dependency job for unit firewalld.service, ignoring: Unit is masked.

Aug 22 19:15:40 centos7-x64-template systemd: start request repeated too quickly for docker.service

Aug 22 19:15:40 centos7-x64-template systemd: Failed to start Docker Application Container Engine.

Aug 22 19:15:40 centos7-x64-template systemd: Unit docker.service entered failed state.

Aug 22 19:15:40 centos7-x64-template systemd: docker.service failed.

Aug 22 19:20:01 centos7-x64-template systemd: Started Session 6 of user root.

Aug 22 19:20:01 centos7-x64-template systemd: Starting Session 6 of user root.

Here is the content of /etc/docker/daemon.json:

{
“graph”: “/mnt/docker”,
“debug”: true,
“storage-driver”: “devicemapper”,
“storage-opts”: [
“dm.directlvm_device=/dev/sda3”,
“dm.thinp_percent=95”,
“dm.thinp_metapercent=1”,
“dm.thinp_autoextend_threshold=80”,
“dm.thinp_autoextend_percent=20”,
“dm.directlvm_device_force=true”
]

}

Any help on this to fix this issue would be much appreciated.

Thanks,
Mani