Error running docker - Fangtooth Nightly

Description

Fangtooth Nightly, updated
Virtualization (New)
Container Debian 12

root@truecommand:~# ./truecommand.sh
85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc
docker: Error response from daemon: failed to create shim task: OCI runtime create failed: runc create failed: unable to start container process: error during container init: error mounting "proc" to rootfs at "/proc": mount proc:/proc (via /proc/self/fd/6), flags: 0xe: permission denied: unknown.
root@truecommand:~#

Session ID: 8e2d48f6-9ed2-82c0-4503-d3a62c3bb50b

Problem/Justification

None

Impact

None

Activity

Show:

Bug Clerk January 20, 2025 at 3:46 PM

This issue has now been closed. Comments made after this point may not be viewed by the TrueNAS Teams. Please open a new issue if you have found a problem or need to re-engage with the TrueNAS Engineering Teams.

Ian Kester-Haney January 17, 2025 at 4:10 AM

You can close this one. It works on latest update.

William Gryzbowski January 16, 2025 at 5:13 PM

I am not sure what you are reporting on, this does not seem to be a truenas problem.

Did you try another container?

Bonnie Follweiler January 13, 2025 at 8:26 PM

Good afternoon ,

I have moved this ticket into our queue to review.

An engineering representative will update with any further questions or details in the near future.

Ian Kester-Haney January 13, 2025 at 6:33 PM

Here is my basic script.

cat ./truecommand.sh
docker run --detach -v "/root/truecommand:/data" -p 80:80 -p 443:443 ixsystems/truecommand

A bit long, here is a journal dump right after triggering.

 

 

Jan 13 16:34:47 truecommand systemdÆ1Å: var-lib-docker-overlay2-d0670052fef44a2e39a6b16fb383d8fa562adf0f63d88aeaa21aaabf9125f21f-merged.mount: Deactivated successfully.
Jan 13 16:34:47 truecommand dockerdÆ197Å: time="2025-01-13T16:34:47.408414160Z" level=error msg="dbb463d09c63820160ea600d13189b5bc8662823503da993625d787ce593e14a cleanup: failed to delete container from containerd: no such container"
Jan 13 16:35:07 truecommand dockerdÆ197Å: time="2025-01-13T16:35:07.168499207Z" level=error msg="Not continuing with pull after error: errors:Øndenied: requested access to the resource is deniedØnunauthorized: authentication requiredØn"
Jan 13 16:35:07 truecommand dockerdÆ197Å: time="2025-01-13T16:35:07.168557940Z" level=info msg="Ignoring extra error returned from registry: unauthorized: authentication required"
Jan 13 16:35:25 truecommand dockerdÆ197Å: time="2025-01-13T16:35:25.277481833Z" level=error msg="Not continuing with pull after error: errors:Øndenied: requested access to the resource is deniedØnunauthorized: authentication requiredØn"
Jan 13 16:35:25 truecommand dockerdÆ197Å: time="2025-01-13T16:35:25.277536442Z" level=info msg="Ignoring extra error returned from registry: unauthorized: authentication required"
Jan 13 16:36:26 truecommand systemdÆ1Å: var-lib-docker-overlay2-ec468da86452cccdabb43df8096a367be0571d1af9fbb990795478359954b6f3Øx2dinit-merged.mount: Deactivated successfully.
Jan 13 16:36:29 truecommand systemd-networkdÆ164Å: veth2a645b9: Link UP
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.222591671Z" level=info msg="loading plugin Ø"io.containerd.event.v1.publisherØ"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.222828828Z" level=info msg="loading plugin Ø"io.containerd.internal.v1.shutdownØ"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.222869565Z" level=info msg="loading plugin Ø"io.containerd.ttrpc.v1.taskØ"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.223160409Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635 pid=572 runtime=io.containerd.runc.v2
Jan 13 16:36:29 truecommand systemdÆ1Å: run-docker-runtimeØx2drunc-moby-0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635-runc.7eDLps.mount: Deactivated successfully.
Jan 13 16:36:29 truecommand systemdÆ1Å: Started docker-0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635.scope - libcontainer container 0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635.
Jan 13 16:36:29 truecommand systemdÆ1Å: docker-0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635.scope: Deactivated successfully.
Jan 13 16:36:29 truecommand systemdÆ1Å: Stopped docker-0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635.scope - libcontainer container 0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635.
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.330373940Z" level=info msg="shim disconnected" id=0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.330575023Z" level=warning msg="cleaning up after shim disconnected" id=0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635 namespace=moby
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.330703436Z" level=info msg="cleaning up dead shim"
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.342258392Z" level=warning msg="cleanup warnings time=Ø"2025-01-13T16:36:29ZØ" level=info msg=Ø"starting signal loopØ" namespace=moby pid=601 runtime=io.containerd.runc.v2Øntime=Ø"2025-01-13T16:36:29ZØ" level=warning msg=Ø"failed to read init pid fileØ" error=Ø"open /run/containerd/io.containerd.runtime.v2.task/moby/0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635/init.pid: no such file or directoryØ" runtime=io.containerd.runc.v2Øn"
Jan 13 16:36:29 truecommand containerdÆ184Å: time="2025-01-13T16:36:29.342938174Z" level=error msg="copy shim log" error="read /proc/self/fd/13: file already closed"
Jan 13 16:36:29 truecommand dockerdÆ197Å: time="2025-01-13T16:36:29.348108801Z" level=error msg="stream copy error: reading from a closed fifo"
Jan 13 16:36:29 truecommand dockerdÆ197Å: time="2025-01-13T16:36:29.348289779Z" level=error msg="stream copy error: reading from a closed fifo"
Jan 13 16:36:29 truecommand systemd-networkdÆ164Å: veth2a645b9: Link DOWN
Jan 13 16:36:29 truecommand systemdÆ1Å: var-lib-docker-overlay2-ec468da86452cccdabb43df8096a367be0571d1af9fbb990795478359954b6f3-merged.mount: Deactivated successfully.
Jan 13 16:36:29 truecommand dockerdÆ197Å: time="2025-01-13T16:36:29.947340924Z" level=error msg="0debd665bec47d4b2dddcc5a47c1dac653e1e67217950c9bc4a4cbeccd421635 cleanup: failed to delete container from containerd: no such container"
Jan 13 16:48:21 truecommand systemdÆ1Å: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories...
Jan 13 16:48:21 truecommand systemdÆ1Å: systemd-tmpfiles-clean.service: Deactivated successfully.
Jan 13 16:48:21 truecommand systemdÆ1Å: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories.
Jan 13 16:58:49 truecommand systemdÆ1Å: var-lib-docker-overlay2-7cb2adb18dc713ffe8cf270a279e61468db32d7393fe64d9c982256a0b06d508Øx2dinit-merged.mount: Deactivated successfully.
Jan 13 16:58:50 truecommand systemd-networkdÆ164Å: veth5ead88b: Link UP
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.614379037Z" level=info msg="loading plugin Ø"io.containerd.event.v1.publisherØ"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.614687389Z" level=info msg="loading plugin Ø"io.containerd.internal.v1.shutdownØ"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.614738587Z" level=info msg="loading plugin Ø"io.containerd.ttrpc.v1.taskØ"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.616126703Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5 pid=722 runtime=io.containerd.runc.v2
Jan 13 16:58:50 truecommand systemdÆ1Å: Started docker-5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5.scope - libcontainer container 5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5.
Jan 13 16:58:50 truecommand systemdÆ1Å: docker-5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5.scope: Deactivated successfully.
Jan 13 16:58:50 truecommand systemdÆ1Å: Stopped docker-5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5.scope - libcontainer container 5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5.
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.684647478Z" level=info msg="shim disconnected" id=5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.684886240Z" level=warning msg="cleaning up after shim disconnected" id=5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5 namespace=moby
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.684995010Z" level=info msg="cleaning up dead shim"
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.697461347Z" level=warning msg="cleanup warnings time=Ø"2025-01-13T16:58:50ZØ" level=info msg=Ø"starting signal loopØ" namespace=moby pid=750 runtime=io.containerd.runc.v2Øntime=Ø"2025-01-13T16:58:50ZØ" level=warning msg=Ø"failed to read init pid fileØ" error=Ø"open /run/containerd/io.containerd.runtime.v2.task/moby/5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5/init.pid: no such file or directoryØ" runtime=io.containerd.runc.v2Øn"
Jan 13 16:58:50 truecommand containerdÆ184Å: time="2025-01-13T16:58:50.698095643Z" level=error msg="copy shim log" error="read /proc/self/fd/13: file already closed"
Jan 13 16:58:50 truecommand dockerdÆ197Å: time="2025-01-13T16:58:50.698814304Z" level=error msg="stream copy error: reading from a closed fifo"
Jan 13 16:58:50 truecommand dockerdÆ197Å: time="2025-01-13T16:58:50.699284947Z" level=error msg="stream copy error: reading from a closed fifo"
Jan 13 16:58:51 truecommand systemd-networkdÆ164Å: veth5ead88b: Link DOWN
Jan 13 16:58:51 truecommand systemdÆ1Å: var-lib-docker-overlay2-7cb2adb18dc713ffe8cf270a279e61468db32d7393fe64d9c982256a0b06d508-merged.mount: Deactivated successfully.
Jan 13 16:58:51 truecommand dockerdÆ197Å: time="2025-01-13T16:58:51.369038164Z" level=error msg="5041c1d75d707a3ee0f3da8c216ecfd4f2de443d670be8e0f5ebd42a615613e5 cleanup: failed to delete container from containerd: no such container"
Jan 13 18:16:43 truecommand systemdÆ1Å: var-lib-docker-overlay2-0d0b1ef97f17ae396ca63a9a7067c90466ffa995287e7690a369f663b3f3a077Øx2dinit-merged.mount: Deactivated successfully.
Jan 13 18:16:44 truecommand systemd-networkdÆ164Å: vethd4c801c: Link UP
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.150461970Z" level=info msg="loading plugin Ø"io.containerd.event.v1.publisherØ"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.150593166Z" level=info msg="loading plugin Ø"io.containerd.internal.v1.shutdownØ"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.150607929Z" level=info msg="loading plugin Ø"io.containerd.ttrpc.v1.taskØ"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.150917403Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc pid=854 runtime=io.containerd.runc.v2
Jan 13 18:16:45 truecommand systemdÆ1Å: Started docker-85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc.scope - libcontainer container 85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc.
Jan 13 18:16:45 truecommand systemdÆ1Å: docker-85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc.scope: Deactivated successfully.
Jan 13 18:16:45 truecommand systemdÆ1Å: Stopped docker-85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc.scope - libcontainer container 85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc.
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.237474843Z" level=info msg="shim disconnected" id=85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.237957954Z" level=warning msg="cleaning up after shim disconnected" id=85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc namespace=moby
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.238229506Z" level=info msg="cleaning up dead shim"
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.252149726Z" level=warning msg="cleanup warnings time=Ø"2025-01-13T18:16:45ZØ" level=info msg=Ø"starting signal loopØ" namespace=moby pid=882 runtime=io.containerd.runc.v2Øntime=Ø"2025-01-13T18:16:45ZØ" level=warning msg=Ø"failed to read init pid fileØ" error=Ø"open /run/containerd/io.containerd.runtime.v2.task/moby/85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc/init.pid: no such file or directoryØ" runtime=io.containerd.runc.v2Øn"
Jan 13 18:16:45 truecommand containerdÆ184Å: time="2025-01-13T18:16:45.253039264Z" level=error msg="copy shim log" error="read /proc/self/fd/13: file already closed"
Jan 13 18:16:45 truecommand dockerdÆ197Å: time="2025-01-13T18:16:45.253849933Z" level=error msg="stream copy error: reading from a closed fifo"
Jan 13 18:16:45 truecommand dockerdÆ197Å: time="2025-01-13T18:16:45.255056466Z" level=error msg="stream copy error: reading from a closed fifo"
Jan 13 18:16:45 truecommand systemd-networkdÆ164Å: vethd4c801c: Link DOWN
Jan 13 18:16:45 truecommand systemdÆ1Å: var-lib-docker-overlay2-0d0b1ef97f17ae396ca63a9a7067c90466ffa995287e7690a369f663b3f3a077-merged.mount: Deactivated successfully.
Jan 13 18:16:45 truecommand dockerdÆ197Å: time="2025-01-13T18:16:45.784315158Z" level=error msg="85a2d9b4b14167a035409f7cdff6cbc792868abc2b34f95453f0c94b574796dc cleanup: failed to delete container from containerd: no such container"
Jan 13 18:30:50 truecommand systemdÆ1Å: var-lib-docker-overlay2-7ed5eab9e746a5694f2dab76e19485fbd5ab3f652f47dd98a6fcd5e3ff53644eØx2dinit-merged.mount: Deactivated successfully.
Jan 13 18:30:55 truecommand systemd-networkdÆ164Å: veth9e7472e: Link UP
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.307680522Z" level=info msg="loading plugin Ø"io.containerd.event.v1.publisherØ"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.308350442Z" level=info msg="loading plugin Ø"io.containerd.internal.v1.shutdownØ"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.308391617Z" level=info msg="loading plugin Ø"io.containerd.ttrpc.v1.taskØ"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.308650358Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/853168f2eb76fc87bce6d413971541f7f0182958d3e26eb28ed0a01532b9e2dc pid=1003 runtime=io.containerd.runc.v2
Jan 13 18:30:55 truecommand systemdÆ1Å: Started docker-853168f2eb76fc87bce6d413971541f7f0182958d3e26eb28ed0a01532b9e2dc.scope - libcontainer container 853168f2eb76fc87bce6d413971541f7f0182958d3e26eb28ed0a01532b9e2dc.
Jan 13 18:30:55 truecommand systemdÆ1Å: docker-853168f2eb76fc87bce6d413971541f7f0182958d3e26eb28ed0a01532b9e2dc.scope: Deactivated successfully.
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.388131247Z" level=info msg="shim disconnected" id=853168f2eb76fc87bce6d413971541f7f0182958d3e26eb28ed0a01532b9e2dc
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.388340989Z" level=warning msg="cleaning up after shim disconnected" id=853168f2eb76fc87bce6d413971541f7f0182958d3e26eb28ed0a01532b9e2dc namespace=moby
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.388358828Z" level=info msg="cleaning up dead shim"
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.404279390Z" level=warning msg="cleanup warnings time=Ø"2025-01-13T18:30:55ZØ" level=info msg=Ø"starting signal loopØ" namespace=moby pid=1031 runtime=io.containerd.runc.v2Øntime=Ø"2025-01-13T18:30:55ZØ" level=warning msg=Ø"failed to read init pid fileØ" error=Ø"open /run/containerd/io.containerd.runtime.v2.task/moby/853168f2eb76fc87bce6d413971541f7f0182958d3e26eb28ed0a01532b9e2dc/init.pid: no such file or directoryØ" runtime=io.containerd.runc.v2Øn"
Jan 13 18:30:55 truecommand containerdÆ184Å: time="2025-01-13T18:30:55.404994266Z" level=error msg="copy shim log" error="read /proc/self/fd/13: file already closed"
Jan 13 18:30:55 truecommand dockerdÆ197Å: time="2025-01-13T18:30:55.405654077Z" level=error msg="stream copy error: reading from a closed fifo"
Jan 13 18:30:55 truecommand dockerdÆ197Å: time="2025-01-13T18:30:55.412099852Z" level=error msg="stream copy error: reading from a closed fifo"
Jan 13 18:30:55 truecommand systemd-networkdÆ164Å: veth9e7472e: Link DOWN
Jan 13 18:30:55 truecommand systemdÆ1Å: var-lib-docker-overlay2-7ed5eab9e746a5694f2dab76e19485fbd5ab3f652f47dd98a6fcd5e3ff53644e-merged.mount: Deactivated successfully.
Jan 13 18:30:56 truecommand dockerdÆ197Å: time="2025-01-13T18:30:56.016673436Z" level=error msg="853168f2eb76fc87bce6d413971541f7f0182958d3e26eb28ed0a01532b9e2dc cleanup: failed to delete container from containerd: no such container"
rootÄtruecommand:ü#

Not Applicable

Assignee

Reporter

Labels

Components

Fix versions

Affects versions

Priority

Created January 13, 2025 at 6:20 PM
Updated January 20, 2025 at 3:46 PM
Resolved January 20, 2025 at 3:46 PM