Oct 28 08:51:36 truenas dockerd[7154]: time="2022-10-28T08:51:36.155903866+01:00" level=warning msg="Your kernel does not support CPU realtime scheduler" Oct 28 08:51:36 truenas dockerd[7154]: time="2022-10-28T08:51:36.155960418+01:00" level=warning msg="Your kernel does not support cgroup blkio weight" Oct 28 08:51:36 truenas dockerd[7154]: time="2022-10-28T08:51:36.155977853+01:00" level=warning msg="Your kernel does not support cgroup blkio weight_device" Oct 28 08:51:36 truenas dockerd[7154]: time="2022-10-28T08:51:36.156870916+01:00" level=info msg="Loading containers: start." Oct 28 08:51:36 truenas dockerd[7154]: time="2022-10-28T08:51:36.797086643+01:00" level=info msg="Loading containers: done." Oct 28 08:51:36 truenas dockerd[7154]: time="2022-10-28T08:51:36.893044146+01:00" level=info msg="Docker daemon" commit=224916af6c-unsupported graphdriver(s)=zfs version=dev Oct 28 08:51:36 truenas dockerd[7154]: time="2022-10-28T08:51:36.894024097+01:00" level=info msg="Daemon has completed initialization" Oct 28 08:51:37 truenas dockerd[7154]: time="2022-10-28T08:51:37.037316522+01:00" level=info msg="API listen on /run/docker.sock" Oct 28 08:52:31 truenas dockerd[7188]: time="2022-10-28T08:52:31.187352869+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/c7842738e288f3c7a91b56bdd0053f83d7e4a4d6c47ce62474b7955b5782571c pid=9774 Oct 28 08:52:36 truenas dockerd[7188]: time="2022-10-28T08:52:36.612099629+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/1bdaf0c857198a2ab51204477885ca7bd72593651298b3d1598091f87af3cc0e pid=9978 Oct 28 08:52:40 truenas dockerd[7188]: time="2022-10-28T08:52:40.302468941+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/a5dbbb5e20b892b3e651122fe563f64b1a4d6b22b47f400630e583899004da40 pid=10210 Oct 28 08:52:49 truenas dockerd[7188]: time="2022-10-28T08:52:49.104564623+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/61b6d21373f6880d99dde6f0016f07890e86f3d5aa00559e7b6b6185470acf65 pid=10675 Oct 28 08:52:54 truenas dockerd[7188]: time="2022-10-28T08:52:54.903014558+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/b182759358a3a42c11ef0fe445a33210889632de5607f800cc94407bfa8c2f9a pid=10917 Oct 28 08:52:58 truenas dockerd[7188]: time="2022-10-28T08:52:58.484830487+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/4a7afdb28b65cfb51c3b7a3876ded73d3cc9e2f813f3f15ca57975e1fdc61b51 pid=11067 Oct 28 08:53:09 truenas dockerd[7188]: time="2022-10-28T08:53:09.704397741+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/1d1c4e88a1297176b7624c143a08394917df60d238e04f033d6bf19bf268b9df pid=11647 Oct 28 08:53:14 truenas dockerd[7188]: time="2022-10-28T08:53:14.282318011+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/39167250ccacba42c062452a905d80769c8c569bf5d3b3c2b2b35047e59ab3e3 pid=11923 Oct 28 08:53:20 truenas dockerd[7188]: time="2022-10-28T08:53:20.206149279+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/5489e88f74018bd203a95b55f6de96a8ff3240648bdec3604c26d0affc9fc092 pid=12475 Oct 28 08:53:26 truenas dockerd[7188]: time="2022-10-28T08:53:26.114990948+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/130818517b8c7efb03a0365e2781316ff3e3877d5a764746b94a11d8421acebc pid=13071 Oct 28 08:53:35 truenas dockerd[7188]: time="2022-10-28T08:53:35.227198552+01:00" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/607a701bc8f2f04b4cc04cd0a34b9b9144fc3ed3c8995b824174a530b69e4cd8 pid=13730 Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.393111352Z" level=info msg="Starting up" Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.400169149Z" level=info msg="libcontainerd: started new containerd process" pid=7278 Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.400905178Z" level=info msg="parsed scheme: \"unix\"" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.401077643Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.401141050Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.401188561Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.669605178Z" level=info msg="starting containerd" revision=7b11cfaabd73bb80907dd23182b9347b4245eb5d version=1.4.12 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.702555210Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.702887922Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.705740282Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.10.142+truenas\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.705784474Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.706305483Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /mnt/SmallPool/ix-applications/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (zfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.706336553Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.706550134Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.706575522Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.706669228Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.707246817Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.713988655Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.714105551Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.714127362Z" level=info msg="metadata content store policy set" policy=shared Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.716700813Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.716873081Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717412926Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717496515Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717548557Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717576931Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717638379Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717687098Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717725675Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717766758Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717788481Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.717983168Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.718579168Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.720433679Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.720515860Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721268132Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721344764Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721394448Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721417860Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721445152Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721463209Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721481514Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721514425Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721534767Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721711493Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721774397Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721797973Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.721815292Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.722685431Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.722793965Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.722877362Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock Oct 31 08:32:26 truenas dockerd[7278]: time="2022-10-31T08:32:26.722913754Z" level=info msg="containerd successfully booted in 0.109536s" Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.743142155Z" level=info msg="parsed scheme: \"unix\"" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.743181981Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.743219700Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.743243309Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.800488733Z" level=info msg="parsed scheme: \"unix\"" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.800533160Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.800566049Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Oct 31 08:32:26 truenas dockerd[7241]: time="2022-10-31T08:32:26.800581497Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Oct 31 08:32:27 truenas dockerd[7241]: time="2022-10-31T08:32:27.099928695Z" level=info msg="[graphdriver] using prior storage driver: zfs" Oct 31 08:32:29 truenas dockerd[7241]: time="2022-10-31T08:32:29.010832887Z" level=warning msg="Your kernel does not support CPU realtime scheduler" Oct 31 08:32:29 truenas dockerd[7241]: time="2022-10-31T08:32:29.010874106Z" level=warning msg="Your kernel does not support cgroup blkio weight" Oct 31 08:32:29 truenas dockerd[7241]: time="2022-10-31T08:32:29.010885425Z" level=warning msg="Your kernel does not support cgroup blkio weight_device" Oct 31 08:32:29 truenas dockerd[7241]: time="2022-10-31T08:32:29.011473422Z" level=info msg="Loading containers: start." Oct 31 08:32:29 truenas dockerd[7241]: time="2022-10-31T08:32:29.900042551Z" level=info msg="Loading containers: done." Oct 31 08:32:30 truenas dockerd[7241]: time="2022-10-31T08:32:30.004321334Z" level=info msg="Docker daemon" commit=224916af6c-unsupported graphdriver(s)=zfs version=dev Oct 31 08:32:30 truenas dockerd[7241]: time="2022-10-31T08:32:30.005370169Z" level=info msg="Daemon has completed initialization" Oct 31 08:32:31 truenas dockerd[7241]: time="2022-10-31T08:32:31.135102832Z" level=info msg="API listen on /run/docker.sock" Oct 31 08:33:31 truenas dockerd[7278]: time="2022-10-31T08:33:31.782516880Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/db15b4ebfd9c20f465892b8453ad28ca9d518f358a7ecae518dacb9a89b0d121 pid=10154 Oct 31 08:33:35 truenas dockerd[7278]: time="2022-10-31T08:33:35.024400006Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/90ee247a13ad9c19d5724f2c4b572b716678a71ae6d33224e74ee401720b4f72 pid=10260 Oct 31 08:33:38 truenas dockerd[7278]: time="2022-10-31T08:33:38.873365222Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/970efaa0c4d69f403097ad94870a85449cc5f612b45e82de3cf9b277da310723 pid=10511 Oct 31 08:33:49 truenas dockerd[7278]: time="2022-10-31T08:33:49.730948600Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/e9f2d0c976e9dc7c8b05cf4cc0b38fb79bbfcf847c9fba002b591ec0dad2b933 pid=11098 Oct 31 08:33:52 truenas dockerd[7278]: time="2022-10-31T08:33:52.606564933Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/9fc942d8352fb4e0300979a655b05da0d58296c9ef1cead1bddb3f8d4efd2960 pid=11305 Oct 31 08:33:56 truenas dockerd[7278]: time="2022-10-31T08:33:56.356128412Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/919dbde33548b22d566827396304dd40876064fc75d2734711bcfc7f16c7f756 pid=11495 Oct 31 08:34:09 truenas dockerd[7278]: time="2022-10-31T08:34:09.582213024Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/0e9cd01b9d033eb212202e14489aea3ece9fb9bed856c1ec51925a4ca8b3152f pid=12169 Oct 31 08:34:11 truenas dockerd[7278]: time="2022-10-31T08:34:11.563621916Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/62d030e45bfffb3d9d29bc8f04edf79f060dcd52ddb3758a465cd56b3270fe9b pid=12363 Oct 31 08:34:18 truenas dockerd[7278]: time="2022-10-31T08:34:18.430423999Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/177cfa455a1273e3dd01c96193f691308febf0006e71e4a27df83f2ea2ebabaa pid=13049 Oct 31 08:34:24 truenas dockerd[7278]: time="2022-10-31T08:34:24.057377928Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/c50456ec0b39cb34b109a76a61c437277113967f50cd3a64993bcd805333da0d pid=13631 Oct 31 08:34:32 truenas dockerd[7278]: time="2022-10-31T08:34:32.594273743Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/cb8ac574bb1c3b36ec6971c6522ee810cb8434e533f4dad6d9270f0a9006a1a4 pid=14226 Nov 1 08:10:58 truenas dockerd[7124]: time="2022-11-01T08:10:58.619445767Z" level=info msg="Starting up" Nov 1 08:10:58 truenas dockerd[7124]: time="2022-11-01T08:10:58.625455237Z" level=info msg="libcontainerd: started new containerd process" pid=7222 Nov 1 08:10:58 truenas dockerd[7124]: time="2022-11-01T08:10:58.626241920Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 1 08:10:58 truenas dockerd[7124]: time="2022-11-01T08:10:58.626400518Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 1 08:10:58 truenas dockerd[7124]: time="2022-11-01T08:10:58.626460060Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 1 08:10:58 truenas dockerd[7124]: time="2022-11-01T08:10:58.626513742Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.935436020Z" level=info msg="starting containerd" revision=7b11cfaabd73bb80907dd23182b9347b4245eb5d version=1.4.12 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.966952744Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.970658944Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.974517425Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.10.142+truenas\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.974571714Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.975154784Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /mnt/SmallPool/ix-applications/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (zfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.975185906Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.976125049Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.976158561Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.976266278Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.976703703Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.982861843Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.982966509Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 1 08:10:58 truenas dockerd[7222]: time="2022-11-01T08:10:58.982989228Z" level=info msg="metadata content store policy set" policy=shared Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.002542981Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.002612500Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.002798459Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003034851Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003077420Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003097880Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003151088Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003184126Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003220545Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003257054Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003276396Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.003493272Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.004055630Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.005873491Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.005923802Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.006817940Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007008139Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007057349Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007080257Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007109291Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007130565Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007147794Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007164474Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007180647Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007298454Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007344479Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007364385Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.007380781Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.008031030Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.008096838Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.008158077Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock Nov 1 08:10:59 truenas dockerd[7222]: time="2022-11-01T08:10:59.008186482Z" level=info msg="containerd successfully booted in 0.145308s" Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.026999764Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.027032523Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.027055452Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.027069539Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.044686007Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.044733159Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.044761211Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.044775759Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 1 08:10:59 truenas dockerd[7124]: time="2022-11-01T08:10:59.268851187Z" level=info msg="[graphdriver] using prior storage driver: zfs" Nov 1 08:11:00 truenas dockerd[7124]: time="2022-11-01T08:11:00.822332143Z" level=warning msg="Your kernel does not support CPU realtime scheduler" Nov 1 08:11:00 truenas dockerd[7124]: time="2022-11-01T08:11:00.822378826Z" level=warning msg="Your kernel does not support cgroup blkio weight" Nov 1 08:11:00 truenas dockerd[7124]: time="2022-11-01T08:11:00.822397437Z" level=warning msg="Your kernel does not support cgroup blkio weight_device" Nov 1 08:11:00 truenas dockerd[7124]: time="2022-11-01T08:11:00.823300252Z" level=info msg="Loading containers: start." Nov 1 08:11:01 truenas dockerd[7124]: time="2022-11-01T08:11:01.808352432Z" level=info msg="Loading containers: done." Nov 1 08:11:01 truenas dockerd[7124]: time="2022-11-01T08:11:01.909063977Z" level=info msg="Docker daemon" commit=224916af6c-unsupported graphdriver(s)=zfs version=dev Nov 1 08:11:01 truenas dockerd[7124]: time="2022-11-01T08:11:01.910013970Z" level=info msg="Daemon has completed initialization" Nov 1 08:11:02 truenas dockerd[7124]: time="2022-11-01T08:11:02.048315019Z" level=info msg="API listen on /run/docker.sock" Nov 1 08:11:54 truenas dockerd[7222]: time="2022-11-01T08:11:54.032808818Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/6eba4a3fbff6553378110cfdd1ebc27f005be26b0103231f427af9c1323c4414 pid=9647 Nov 1 08:11:59 truenas dockerd[7222]: time="2022-11-01T08:11:59.684144948Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/4acc1fe6727be5a1b95a1efe583a6e5565820b9b418c849d368eafe0fab55ba0 pid=9873 Nov 1 08:12:03 truenas dockerd[7222]: time="2022-11-01T08:12:03.377475961Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/1ca8df1ad2ceac73544161f608b73a5015d7fd4561b975fe1a151937b8930c76 pid=10073 Nov 1 08:12:11 truenas dockerd[7222]: time="2022-11-01T08:12:11.844061234Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/15c132f5ae6ecf13117170a95748d88e5063d2c7416d37815a7d9baf74c45a6a pid=10684 Nov 1 08:12:18 truenas dockerd[7222]: time="2022-11-01T08:12:18.272654528Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/aa0b3f1cfd6872e0e4ec361f370fe8d58e7082a8b9e42adb89b906aadf3654e6 pid=10951 Nov 1 08:12:21 truenas dockerd[7222]: time="2022-11-01T08:12:21.274352510Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/5a28753b15e371650087ae1065ed9af36d5900ea646c0febc551eabc4fbef645 pid=11082 Nov 1 08:12:30 truenas dockerd[7222]: time="2022-11-01T08:12:30.529436875Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/1c0bcbeb7bd9468a8489534492d4ec24cf7ed77758cfbedf9c1dfd80f09b8523 pid=11589 Nov 1 08:12:34 truenas dockerd[7222]: time="2022-11-01T08:12:34.084041643Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/83725475a4dd0d6d13d2953c3b3422c7e0ac227917b53581b0a307d2c62d1c1a pid=11915 Nov 1 08:12:40 truenas dockerd[7222]: time="2022-11-01T08:12:40.627306318Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/2d67fc2e007d3ef132b8431618e44ab477875dd8634c2b91217babf8e05e6c9e pid=12555 Nov 1 08:12:46 truenas dockerd[7222]: time="2022-11-01T08:12:46.214262365Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/f8d4b05d58cd94ad61cd317183f4da566985e7ac07170b2822c4ad9855b8a0a7 pid=13151 Nov 1 08:12:55 truenas dockerd[7222]: time="2022-11-01T08:12:55.112996766Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/c8522b17bff4ea99a6cac7f8966eef27d41bbedb3268ae7f9ab28c193c31d54b pid=13816 Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.186764444Z" level=info msg="Starting up" Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.195184940Z" level=info msg="libcontainerd: started new containerd process" pid=7295 Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.196151730Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.196372744Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.196446294Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.196500382Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.472345761Z" level=info msg="starting containerd" revision=7b11cfaabd73bb80907dd23182b9347b4245eb5d version=1.4.12 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.507423952Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.550999963Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.554074882Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.10.142+truenas\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.554123229Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.554596313Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /mnt/SmallPool/ix-applications/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (zfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.554623737Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.555574762Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.555606925Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.555702891Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.556231612Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.562453580Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.562563442Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.562582906Z" level=info msg="metadata content store policy set" policy=shared Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605365918Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605436749Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605536095Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605736440Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605759530Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605785452Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605834643Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605868396Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605905831Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605957431Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.605979998Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.606181960Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.606663201Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.608213681Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.608262496Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.608716147Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.608910535Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.608948652Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.608967933Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.608986598Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.609007147Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.609023994Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.609040779Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.609057343Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.609213610Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.609273097Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.609295232Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.609313720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.610004169Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.610072703Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.610147440Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock Nov 2 08:48:49 truenas dockerd[7295]: time="2022-11-02T08:48:49.610178358Z" level=info msg="containerd successfully booted in 0.192186s" Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.629784360Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.629834498Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.629874218Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.629898431Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.687748878Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.687801895Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.687845872Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.687867552Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 08:48:49 truenas dockerd[7255]: time="2022-11-02T08:48:49.882128378Z" level=info msg="[graphdriver] using prior storage driver: zfs" Nov 2 08:48:51 truenas dockerd[7255]: time="2022-11-02T08:48:51.811466672Z" level=warning msg="Your kernel does not support CPU realtime scheduler" Nov 2 08:48:51 truenas dockerd[7255]: time="2022-11-02T08:48:51.811508296Z" level=warning msg="Your kernel does not support cgroup blkio weight" Nov 2 08:48:51 truenas dockerd[7255]: time="2022-11-02T08:48:51.811521163Z" level=warning msg="Your kernel does not support cgroup blkio weight_device" Nov 2 08:48:51 truenas dockerd[7255]: time="2022-11-02T08:48:51.812298500Z" level=info msg="Loading containers: start." Nov 2 08:48:53 truenas dockerd[7255]: time="2022-11-02T08:48:53.609110736Z" level=info msg="Loading containers: done." Nov 2 08:48:53 truenas dockerd[7255]: time="2022-11-02T08:48:53.703107410Z" level=info msg="Docker daemon" commit=224916af6c-unsupported graphdriver(s)=zfs version=dev Nov 2 08:48:53 truenas dockerd[7255]: time="2022-11-02T08:48:53.704088171Z" level=info msg="Daemon has completed initialization" Nov 2 08:48:54 truenas dockerd[7255]: time="2022-11-02T08:48:54.204868832Z" level=info msg="API listen on /run/docker.sock" Nov 2 08:49:46 truenas dockerd[7295]: time="2022-11-02T08:49:46.717829513Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/247f870dd53bcb6992f47fb1736785a613eca8b6e4a2e420c08f1a0e95058cfb pid=9963 Nov 2 08:49:52 truenas dockerd[7295]: time="2022-11-02T08:49:52.043894652Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/b2ba544b990b5fa88b0d91f189bbb7ab225f91177302f47667ed0718970c1a69 pid=10230 Nov 2 08:49:53 truenas dockerd[7295]: time="2022-11-02T08:49:53.442544700Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/95282f353b8de830c0c499155d49dd1f98ebe202b1039b63ee99366adf8f10e4 pid=10355 Nov 2 08:50:03 truenas dockerd[7295]: time="2022-11-02T08:50:03.329619146Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/8220bcf1b97b4be2914315abe42014a931a77168e26a711ce95b193ad2a050e5 pid=10995 Nov 2 08:50:08 truenas dockerd[7295]: time="2022-11-02T08:50:08.036287587Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/15dcb0950fdf3cd1b9ddbc7716729ab940b2b6ead15be3c57fe0de2ea3626f5b pid=11229 Nov 2 08:50:09 truenas dockerd[7295]: time="2022-11-02T08:50:09.698698936Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/fe65829c6ec5672ebf53b4685cad629f16e2648e6389bb15a90f12902d7d864e pid=11326 Nov 2 08:50:20 truenas dockerd[7295]: time="2022-11-02T08:50:20.846223840Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/71653a4d304368282e98d238f9fcd9a20723a49fead13ba1caf6588559284e3b pid=11877 Nov 2 08:50:24 truenas dockerd[7295]: time="2022-11-02T08:50:24.049689671Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/53112e26361538eef9f01fa6b5ba029e36467e811c860e564c7b5f10b7536ccc pid=12159 Nov 2 08:50:30 truenas dockerd[7295]: time="2022-11-02T08:50:30.546573924Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/79a0aab9816dd4a912d2161f3716b774fb2c04de0d324d4c3cbb386bbf443b2d pid=12783 Nov 2 08:50:36 truenas dockerd[7295]: time="2022-11-02T08:50:36.503453272Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/5d54f95196f97789a0edf33199f1aa02f58fbe19d76ee1d6ca020179728791eb pid=13371 Nov 2 08:50:42 truenas dockerd[7295]: time="2022-11-02T08:50:42.153354303Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/9b2eaa9640ae7e14cc92b871d8a5446ccbd262a6803865178f2271400fe03ef3 pid=13957 Nov 2 16:48:53 truenas dockerd[7255]: time="2022-11-02T16:48:53.601268975Z" level=info msg="Processing signal 'terminated'" Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.512479572Z" level=info msg="Starting up" Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.520456178Z" level=info msg="libcontainerd: started new containerd process" pid=7179 Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.521261377Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.521303556Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.521372202Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.521434671Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.758350200Z" level=info msg="starting containerd" revision=7b11cfaabd73bb80907dd23182b9347b4245eb5d version=1.4.12 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.792640503Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.804330160Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.807319271Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.10.142+truenas\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.807385360Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.808026246Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /mnt/SmallPool/ix-applications/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (zfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.808068424Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.809041788Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.809076890Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.809241990Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.809741086Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.815499803Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.815609850Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.815637008Z" level=info msg="metadata content store policy set" policy=shared Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.842320712Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.843228301Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.843788993Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.843904335Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.843972713Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.844018931Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.844086943Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.844142761Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.844196521Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.844251245Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.844287639Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.844561625Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.845223828Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.847399625Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.847459990Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.847591978Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.847755652Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.847911733Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.847938745Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.847966230Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.847986069Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.848006800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.848024091Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.848043696Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.848177339Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.848226596Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.848255649Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.848274345Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.848925382Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.849005609Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.849067537Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock Nov 2 17:19:22 truenas dockerd[7179]: time="2022-11-02T17:19:22.849093744Z" level=info msg="containerd successfully booted in 0.120958s" Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.867714473Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.867776331Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.867837809Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.867879701Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.890092791Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.890132346Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.890159899Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:19:22 truenas dockerd[7144]: time="2022-11-02T17:19:22.890175059Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:19:23 truenas dockerd[7144]: time="2022-11-02T17:19:23.132857008Z" level=info msg="[graphdriver] using prior storage driver: zfs" Nov 2 17:19:24 truenas dockerd[7144]: time="2022-11-02T17:19:24.110072064Z" level=warning msg="Your kernel does not support CPU realtime scheduler" Nov 2 17:19:24 truenas dockerd[7144]: time="2022-11-02T17:19:24.110102028Z" level=warning msg="Your kernel does not support cgroup blkio weight" Nov 2 17:19:24 truenas dockerd[7144]: time="2022-11-02T17:19:24.110112028Z" level=warning msg="Your kernel does not support cgroup blkio weight_device" Nov 2 17:19:24 truenas dockerd[7144]: time="2022-11-02T17:19:24.110897951Z" level=info msg="Loading containers: start." Nov 2 17:19:25 truenas dockerd[7144]: time="2022-11-02T17:19:25.651969378Z" level=info msg="Loading containers: done." Nov 2 17:19:25 truenas dockerd[7144]: time="2022-11-02T17:19:25.763494542Z" level=info msg="Docker daemon" commit=224916af6c-unsupported graphdriver(s)=zfs version=dev Nov 2 17:19:25 truenas dockerd[7144]: time="2022-11-02T17:19:25.763976947Z" level=info msg="Daemon has completed initialization" Nov 2 17:19:26 truenas dockerd[7144]: time="2022-11-02T17:19:26.220417443Z" level=info msg="API listen on /run/docker.sock" Nov 2 17:20:31 truenas dockerd[7179]: time="2022-11-02T17:20:31.979653443Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/a3e16336bbaa1a3d2941df52c3030dc58bd4de669e9ff1085aec9044fc94d5b4 pid=10881 Nov 2 17:20:37 truenas dockerd[7179]: time="2022-11-02T17:20:37.410954094Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/547375f47425b4a03d55db03ec887a3b35c15c21516c4019925e8acb344ce3fd pid=11165 Nov 2 17:20:37 truenas dockerd[7179]: time="2022-11-02T17:20:37.696307225Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/6c7af75a15477e5a98670274d8dde604322540d7b921993301a5f3226b9f1c44 pid=11220 Nov 2 17:20:46 truenas dockerd[7179]: time="2022-11-02T17:20:46.525067622Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/53449f387730c9ba11199e33fed40cb3a13d70d8bd3920a643da3502b39c8aa5 pid=12013 Nov 2 17:20:53 truenas dockerd[7179]: time="2022-11-02T17:20:53.189375397Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/c096730de4b00bbb2632072b8eb458506f30f8bd3afbd1f77bf2aacb51306da4 pid=12293 Nov 2 17:20:53 truenas dockerd[7179]: time="2022-11-02T17:20:53.476468519Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/f4e25eb3a49b1d044b98b45ddca9b21242a79bae9bb2f6e202b5fc271d3e8af3 pid=12337 Nov 2 17:21:04 truenas dockerd[7179]: time="2022-11-02T17:21:04.802315537Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/770e0c4a4c2fc745317b7d5c81f247c69eb097b634cbfd2e730b72031c037d2e pid=12988 Nov 2 17:21:07 truenas dockerd[7179]: time="2022-11-02T17:21:07.714546810Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/408847f75ccc4a939d1bd222390c740850bbc317a03e0adefaf07dc878aa6ec6 pid=13304 Nov 2 17:21:13 truenas dockerd[7179]: time="2022-11-02T17:21:13.539766169Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/68a1d94e783ee09efd33881bb9a3807eb3d4fc5e9c1b70f7f04e82261f73932d pid=13888 Nov 2 17:21:18 truenas dockerd[7179]: time="2022-11-02T17:21:18.919189781Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/3f0227eced2bd2295c8534054dd963066f6f062a505cf9b178ddea81456e0143 pid=14460 Nov 2 17:21:24 truenas dockerd[7179]: time="2022-11-02T17:21:24.332921902Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/53639a059c0c489f3f3c19c73e597234c5fd0de225b5f85b3ab07b16e9481e7f pid=15079 Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.222170817Z" level=info msg="Starting up" Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.230140614Z" level=info msg="libcontainerd: started new containerd process" pid=7087 Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.230906916Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.230942405Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.230996330Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.231046344Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.585680221Z" level=info msg="starting containerd" revision=7b11cfaabd73bb80907dd23182b9347b4245eb5d version=1.4.12 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.615379105Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.636583877Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.639329122Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.10.142+truenas\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.639384002Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.639916350Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /mnt/SmallPool/ix-applications/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (zfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.639952653Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.640897665Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.640937587Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.641039894Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.641487841Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.647527983Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.697126242Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.697180016Z" level=info msg="metadata content store policy set" policy=shared Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.721277097Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.721482377Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722196401Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722473587Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722536796Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722561194Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722606966Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722641696Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722677575Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722712388Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.722733902Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.723112680Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.723657646Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.725439947Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.725506157Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726305149Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726498593Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726537609Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726557539Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726575294Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726597153Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726614411Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726630772Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726648406Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726811201Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726884690Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726910531Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.726928427Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.727668591Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.727761654Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.727837277Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock Nov 2 17:29:45 truenas dockerd[7087]: time="2022-11-02T17:29:45.727864707Z" level=info msg="containerd successfully booted in 0.284445s" Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.744407925Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.744449903Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.744488493Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.744512827Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.772271667Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.772314426Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.772340406Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.772356019Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:29:45 truenas dockerd[7047]: time="2022-11-02T17:29:45.988041828Z" level=info msg="[graphdriver] using prior storage driver: zfs" Nov 2 17:29:47 truenas dockerd[7047]: time="2022-11-02T17:29:47.708184424Z" level=warning msg="Your kernel does not support CPU realtime scheduler" Nov 2 17:29:47 truenas dockerd[7047]: time="2022-11-02T17:29:47.708235390Z" level=warning msg="Your kernel does not support cgroup blkio weight" Nov 2 17:29:47 truenas dockerd[7047]: time="2022-11-02T17:29:47.708253398Z" level=warning msg="Your kernel does not support cgroup blkio weight_device" Nov 2 17:29:47 truenas dockerd[7047]: time="2022-11-02T17:29:47.709131549Z" level=info msg="Loading containers: start." Nov 2 17:29:48 truenas dockerd[7047]: time="2022-11-02T17:29:48.411020187Z" level=info msg="Loading containers: done." Nov 2 17:29:48 truenas dockerd[7047]: time="2022-11-02T17:29:48.500886797Z" level=info msg="Docker daemon" commit=224916af6c-unsupported graphdriver(s)=zfs version=dev Nov 2 17:29:48 truenas dockerd[7047]: time="2022-11-02T17:29:48.501855224Z" level=info msg="Daemon has completed initialization" Nov 2 17:29:49 truenas dockerd[7047]: time="2022-11-02T17:29:49.455735792Z" level=info msg="API listen on /run/docker.sock" Nov 2 17:30:44 truenas dockerd[7087]: time="2022-11-02T17:30:44.251269462Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/bfc6341c81c17d32989f332359586a9b9c5da06055769632c55577ed90c044c4 pid=9636 Nov 2 17:30:49 truenas dockerd[7087]: time="2022-11-02T17:30:49.526330021Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/e9828288cd6b67602c86e04d805accd4ede1172cb67cc014f232632d0cdbd97d pid=9838 Nov 2 17:30:50 truenas dockerd[7087]: time="2022-11-02T17:30:50.203646785Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/43cff5ff65a4501017ffcc6c6ff5d6ec6370730c006d80a53464f96686c9f13b pid=9902 Nov 2 17:31:00 truenas dockerd[7087]: time="2022-11-02T17:31:00.703552440Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/6a9b4977726789d0392b4e3c194c1276d56a6767a2f2d32be352460798c73f00 pid=10573 Nov 2 17:31:04 truenas dockerd[7087]: time="2022-11-02T17:31:04.519096244Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/6ba19c3e53e62c17c9ac15392a678d6454d770b3d2b780a67a377aa373f13640 pid=10771 Nov 2 17:31:04 truenas dockerd[7087]: time="2022-11-02T17:31:04.836334399Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/aa9d62a8cb2cc49f9717d1e2b00997cb02f497b0d069124591513e7d67583059 pid=10813 Nov 2 17:31:17 truenas dockerd[7087]: time="2022-11-02T17:31:17.269254191Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/5a08d07d4a8da0a0fa5267227729176b1cce53790168642e5f577318334a4344 pid=11508 Nov 2 17:31:20 truenas dockerd[7087]: time="2022-11-02T17:31:20.057852351Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/abc2db939643d2969d86476d407fa417a343965c0eb581e45025cdcba0787086 pid=11736 Nov 2 17:31:25 truenas dockerd[7087]: time="2022-11-02T17:31:25.930733921Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/da893650d1d5eae433fc7c965865220aeb31ebe8d916a47c988389d6a667dca0 pid=12295 Nov 2 17:31:31 truenas dockerd[7087]: time="2022-11-02T17:31:31.469753771Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/8e51070f798a5bdb4869a24005fa6caa2b181af08e22575d749b167d681b860d pid=12883 Nov 2 17:31:37 truenas dockerd[7087]: time="2022-11-02T17:31:37.347859984Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/7c7383b7081da997e33ef0ec44c96e681555f1a3366219e8490e0d449e9ac258 pid=13461 Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.046815513Z" level=info msg="Starting up" Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.054446231Z" level=info msg="libcontainerd: started new containerd process" pid=7016 Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.055236450Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.055450969Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.055523470Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.055577131Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.390417864Z" level=info msg="starting containerd" revision=7b11cfaabd73bb80907dd23182b9347b4245eb5d version=1.4.12 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.420240137Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.453130387Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.456018162Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.10.142+truenas\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.456074602Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.456611304Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /mnt/SmallPool/ix-applications/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (zfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.456641115Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.457573120Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.457602090Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.457699571Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.458139198Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.464215269Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.492950575Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.493007560Z" level=info msg="metadata content store policy set" policy=shared Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.596280698Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.596359413Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.596988737Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597252228Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597283056Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597322736Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597387131Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597441222Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597495263Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597547648Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597579694Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.597838366Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.598172837Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.599990475Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.600100217Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601152987Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601212103Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601257606Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601281414Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601298429Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601315104Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601331706Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601351779Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601368029Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601517534Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601569075Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601589406Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.601605066Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.602203739Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.602326049Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.602401262Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock Nov 2 17:43:21 truenas dockerd[7016]: time="2022-11-02T17:43:21.602443210Z" level=info msg="containerd successfully booted in 0.324337s" Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.621373108Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.621424530Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.621464984Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.621498074Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.626171848Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.626199308Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.626230021Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock 0 }] }" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.626244828Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 2 17:43:21 truenas dockerd[6971]: time="2022-11-02T17:43:21.827033419Z" level=info msg="[graphdriver] using prior storage driver: zfs" Nov 2 17:43:23 truenas dockerd[6971]: time="2022-11-02T17:43:23.553394866Z" level=warning msg="Your kernel does not support CPU realtime scheduler" Nov 2 17:43:23 truenas dockerd[6971]: time="2022-11-02T17:43:23.553435255Z" level=warning msg="Your kernel does not support cgroup blkio weight" Nov 2 17:43:23 truenas dockerd[6971]: time="2022-11-02T17:43:23.553445200Z" level=warning msg="Your kernel does not support cgroup blkio weight_device" Nov 2 17:43:23 truenas dockerd[6971]: time="2022-11-02T17:43:23.554133251Z" level=info msg="Loading containers: start." Nov 2 17:43:24 truenas dockerd[6971]: time="2022-11-02T17:43:24.549691650Z" level=info msg="Loading containers: done." Nov 2 17:43:24 truenas dockerd[6971]: time="2022-11-02T17:43:24.645360427Z" level=info msg="Docker daemon" commit=224916af6c-unsupported graphdriver(s)=zfs version=dev Nov 2 17:43:24 truenas dockerd[6971]: time="2022-11-02T17:43:24.646248997Z" level=info msg="Daemon has completed initialization" Nov 2 17:43:25 truenas dockerd[6971]: time="2022-11-02T17:43:25.752772612Z" level=info msg="API listen on /run/docker.sock" Nov 2 17:44:25 truenas dockerd[7016]: time="2022-11-02T17:44:25.609997170Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/00373e41d3f941cd55fdb6a7f41b8230fe910efcd81841b2ce0803e75baf7152 pid=9734 Nov 2 17:44:33 truenas dockerd[7016]: time="2022-11-02T17:44:33.046704451Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/6b9aa15fcb7a0c57903e3023398d69c1eca3cd5678612f08113a61fdcfa4723f pid=10004 Nov 2 17:44:37 truenas dockerd[7016]: time="2022-11-02T17:44:37.682704459Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/49851ec83aa05e3dc2758ce23d3492bdd0176788b0d69e831fc1fbeb316e0186 pid=10293 Nov 2 17:44:47 truenas dockerd[7016]: time="2022-11-02T17:44:47.125368322Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/ecc941f50587df13fb98c9c101ecd3a10cb6c255528fb98026ba85bbc151063e pid=10772 Nov 2 17:44:53 truenas dockerd[7016]: time="2022-11-02T17:44:53.233561227Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/1c1c8271988aaf533592509f243b685f4ae2661f01132d284d325fad333021c3 pid=11077 Nov 2 17:44:57 truenas dockerd[7016]: time="2022-11-02T17:44:57.803621372Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/60718bc7bd2f23f74d2a19684dda54e915296413b4ad25cd525ce1eec89649fe pid=11282 Nov 2 17:45:07 truenas dockerd[7016]: time="2022-11-02T17:45:07.800577439Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/bcb557bd496695fc4f883405981fb5d99cc236e3f6dabab38f75aa798a2902fa pid=11864 Nov 2 17:45:10 truenas dockerd[7016]: time="2022-11-02T17:45:10.282769051Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/858025d926c08504dea59e3f8b755a18367d8f79679ec1b547b7cfd4a524dbf3 pid=12130 Nov 2 17:45:16 truenas dockerd[7016]: time="2022-11-02T17:45:16.366054733Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/bb630d4c58ffe2c208c436afef927b51afae3a902ef7c8541c169a1c692ea36e pid=12733 Nov 2 17:45:25 truenas dockerd[7016]: time="2022-11-02T17:45:25.343800517Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/5319a98d01fc26794d736e12be11c10a7332e2baddeb53e2994f1263d0a786cd pid=13424 Nov 2 17:45:32 truenas dockerd[7016]: time="2022-11-02T17:45:32.014393947Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/424a091c35d4da943130f1feeee0f203dccfc24197862b742255d1e6a843b19b pid=14126