Docker Swarm hiccups on 1.8.4.1

304 views

Skip to first unread message

Chidi Ugonna

unread,

Jul 26, 2022, 12:49:57 PM7/26/22

to xnat_discussion

Hi all,

We are in the early developments stages of setting up an XNAT system (version 1.8.4.1 build 7) and I am stumped on why the container service (3.1.0) is not working with Docker swarm. When I switch docker swarm off it works perfectly. The other plugins installed are (batch-plugin 0.5.0, ohif-viewer 3.1.0 and ldap auth 1.1.0)

I am using a custom container we have developed which is mostly based on the NrgXnat dcm2bids-session container.

I am wondering if I have a fundamental misconception of how docker swarm should be configured? Do I have to make changes to the way I have created containers that seem to work in non-swarm mode?

We have a 4 node cluster. On 1 node (call it n1) , we are running XNAT in an Ubuntu 20.04 VM running, I believe in XenServer (I can double-check version and setup if this is important). On the other three compute nodes (all ubuntu 20.04) we are running docker 20.10.12. and have set up a swarm with all three nodes as shown below:

ID HOSTNAME STATUS AVAILABILITY MANAGER STATUS ENGINE VERSION
j7tolthzjvwd3m2 * n2.addr.org Ready Active Leader 20.10.12
sr4ffb3qth7xgu n3.addr.org Ready Active 20.10.12
iunsw64l9s0dknq0 n4.addr.org Ready Active 20.10.12

The master compute node n2 is receiving docker requests on port 2376. Also I am using a very basic self-signed SSL certificate on the VM so that we access it using https on port 443.

All nodes have access to /data/xnat/archive and /data/xnat/build which have been set up as NFS mounts. The xnat user has access to all nodes (n1,n2,n3,n4) with sudo privileges (and also added to the docker group)

In swarm mode I can see that the build directory is successfully created under the xnat user and the xnat user has write prvileges. But then almost immediately after creating the build directory it stops. This is what I see in XNAT:

Workflow Details
ID XNAT_E00001
ExternalID PhantomMRI
Datatype xnat:mrSessionData
Pipeline qcsession-xnat-0.1
Status Failed (Dismissed)
Launch time 2022-07-26 08:39:16.432
Percentage complete
Job Id
Created by user
Current step launch time
Current step id
Next step id
Step Description
Comments
Details Could not create service: Request error: POST http://n2.d.d.d:2376/services/create: 500
Justification Container launch
Description
Src
Type PROCESS
Category DATA

Related Items

Execution parameters

and this is what is in container.logs:

2022-07-26 08:39:16,742 [DefaultMessageListenerContainer-6] ERROR org.nrg.containers.api.DockerControlApi - Request error: POST http://n2.d.d.d:2376/services/create: 500
2022-07-26 08:39:16,762 [DefaultMessageListenerContainer-6] ERROR org.nrg.containers.services.impl.ContainerServiceImpl - Container launch failed for wfid 105.
org.nrg.containers.exceptions.DockerServerException: Could not create service: Request error: POST http:// n2.d.d.d:2376 :2376/services/create: 500
at org.nrg.containers.api.DockerControlApi.createService(DockerControlApi.java:884)
at org.nrg.containers.api.DockerControlApi.createContainerOrSwarmService(DockerControlApi.java:366)
at org.nrg.containers.services.impl.ContainerServiceImpl.launchResolvedDockerCommand(ContainerServiceImpl.java:600)
at org.nrg.containers.services.impl.ContainerServiceImpl.launchResolvedCommand(ContainerServiceImpl.java:572)
at org.nrg.containers.services.impl.ContainerServiceImpl.launchResolvedCommand(ContainerServiceImpl.java:560)
at org.nrg.containers.services.impl.ContainerServiceImpl.consumeResolveCommandAndLaunchContainer(ContainerServiceImpl.java:535)
at org.nrg.containers.jms.listeners.ContainerStagingRequestListener.onRequest(ContainerStagingRequestListener.java:49)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.springframework.messaging.handler.invocation.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:180)
at org.springframework.messaging.handler.invocation.InvocableHandlerMethod.invoke(InvocableHandlerMethod.java:112)
at org.springframework.jms.listener.adapter.MessagingMessageListenerAdapter.invokeHandler(MessagingMessageListenerAdapter.java:104)
at org.springframework.jms.listener.adapter.MessagingMessageListenerAdapter.onMessage(MessagingMessageListenerAdapter.java:69)
at org.springframework.jms.listener.AbstractMessageListenerContainer.doInvokeListener(AbstractMessageListenerContainer.java:719)
at org.springframework.jms.listener.AbstractMessageListenerContainer.invokeListener(AbstractMessageListenerContainer.java:679)
at org.springframework.jms.listener.AbstractMessageListenerContainer.doExecuteListener(AbstractMessageListenerContainer.java:649)
at org.springframework.jms.listener.AbstractPollingMessageListenerContainer.doReceiveAndExecute(AbstractPollingMessageListenerContainer.java:317)
at org.springframework.jms.listener.AbstractPollingMessageListenerContainer.receiveAndExecute(AbstractPollingMessageListenerContainer.java:255)
at org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.invokeListener(DefaultMessageListenerContainer.java:1167)
at org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.executeOngoingLoop(DefaultMessageListenerContainer.java:1159)
at org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.run(DefaultMessageListenerContainer.java:1056)
at java.lang.Thread.run(Thread.java:748)
Caused by: org.mandas.docker.client.exceptions.DockerRequestException: Request error: POST http://n2.d.d.d:2376/services/create: 500
at org.mandas.docker.client.DefaultDockerClient.propagate(DefaultDockerClient.java:2590)
at org.mandas.docker.client.DefaultDockerClient.request(DefaultDockerClient.java:2479)
at org.mandas.docker.client.DefaultDockerClient.createService(DefaultDockerClient.java:1652)
at org.mandas.docker.client.DefaultDockerClient.createService(DefaultDockerClient.java:1641)
at org.nrg.containers.api.DockerControlApi.createService(DockerControlApi.java:872)
... 23 common frames omitted
Caused by: javax.ws.rs.InternalServerErrorException: HTTP 500 Internal Server Error
at org.glassfish.jersey.client.JerseyInvocation.convertToException(JerseyInvocation.java:914)
at org.glassfish.jersey.client.JerseyInvocation.translate(JerseyInvocation.java:712)
at org.glassfish.jersey.client.JerseyInvocation.lambda$invoke$1(JerseyInvocation.java:632)
at org.glassfish.jersey.client.JerseyInvocation.call(JerseyInvocation.java:654)
at org.glassfish.jersey.client.JerseyInvocation.lambda$runInScope$3(JerseyInvocation.java:648)
at org.glassfish.jersey.internal.Errors.process(Errors.java:292)
at org.glassfish.jersey.internal.Errors.process(Errors.java:274)
at org.glassfish.jersey.internal.Errors.process(Errors.java:205)
at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:390)
at org.glassfish.jersey.client.JerseyInvocation.runInScope(JerseyInvocation.java:648)
at org.glassfish.jersey.client.JerseyInvocation.invoke(JerseyInvocation.java:631)
at org.glassfish.jersey.client.JerseyInvocation$Builder.method(JerseyInvocation.java:434)
at org.mandas.docker.client.DefaultDockerClient.request(DefaultDockerClient.java:2477)
... 26 common frames omitted

Any ideas/suggestions would be gratefully appreciated!

Thank you

Chidi

John Flavin

unread,

Jul 26, 2022, 4:44:35 PM7/26/22

to xnat_di...@googlegroups.com

Hi Chidi,

Thanks for all the information you've provided! I can't tell exactly what is going wrong, but I was able to figure out some parts of it and can give you recommendations of what to try next.

First we'll take a look at the error message:

Request error: POST http://n2.d.d.d:2376/services/create: 500

What I can tell for sure is that this error message isn't generated by any of the code within the container service itself. That error means the container service sent a request off to your remote swarm master node to start a swarm service, but the swarm node responded with an HTTP 500 response indicating it had an internal problem processing the request.

We can't necessarily isolate the cause just based on that fact alone; for instance, we could see that response if something about the swarm itself is not configured correctly, but also if the container service settings are not configured correctly to talk to the swarm, or for other reasons as well. We'll have to keep digging. But now we have a direction to go.

Another piece that would be helpful is to get more detail on the communication between the container service and the swarm node. Either the request that the container service is making to create the swarm service, or the full error message that the swarm node sends back. Unfortunately, the container service itself isn't logging those kinds of communications (at least not at the level of detail I would want for debugging) so we can't look there.

Would it be possible for you to check the docker logs on your swarm master node? See these instructions for where to find them: https://docs.docker.com/config/daemon/#read-the-logs. Just watch the logs, try to launch another job from the container service, and see what comes up. It may also help to start docker with debug mode turned on; you can find those instructions at the same link, just below the section on logs.

Another thing you could explore is whether you can talk to the swarm master node from your xnat node but independently of the container service by making requests to the docker remote API directly. Open a command line on the xnat node and use curl (or your http client of choice) to do... well anything at all at this point. Some basic things you could try, just to verify connectivity:

curl http://n2.d.d.d:2376/_ping

curl http://n2.d.d.d:2376/version

Once you can do that, you could try to create a service by POSTing to /services/create. That would require a bit more work to construct the proper JSON for the request which may not be worth the time. But if you can't get the docker logs, it could potentially be a helpful exercise.

One final observation I can make is that it looks odd to use port 2376 with http; port 2375 is conventionally used for non-encrypted http communication and 2376 for https. I would be surprised if this were the cause of the issues you're seeing, but without more information about the particular error you're getting I can't rule it out.

John Flavin

Backend Team Lead

johnf...@flywheel.io

He/Him

flywheel.io

--
You received this message because you are subscribed to the Google Groups "xnat_discussion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to xnat_discussi...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/xnat_discussion/392011d9-d766-4639-a6dd-ff082d5ec8b5n%40googlegroups.com.

Chidi Ugonna

unread,

Jul 26, 2022, 8:33:15 PM7/26/22

to xnat_discussion

Hi John,

Thank you so much for your quick response and for all these invaluable ideas. The 2 curl commands you provided to test connectivity worked from all nodes. I went ahead and restarted the docker service (with debug flag on) using port 2375 and as you suspected the error was the same but I appreciate the tip on best practice and I will use this port going forward. I have attached the docker log with debug on starting from when I restarted the docker service to use port 2375 so it is quite hefty but I presumed it would help to have as much information as possible. I attempt to launch the container at the 16:21:42 mark whixh I have tried to highlight below. I hope this is not too overwhelming - I have tried anonymize the logs by changing ip addresses and have pasted below (hopefully not a terrible idea) and have also attached as a text file. Let me know if you need more information or want me to try anything else. Thanks again, Chidi

Jul 26 16:20:17 n2.addr.org dockerd[332974]: time="2022-07-26T16:20:17.667466649-07:00" level=debug msg="Clean shutdown succeeded"
Jul 26 16:20:17 n2.addr.org dockerd[332974]: time="2022-07-26T16:20:17.667480826-07:00" level=info msg="Daemon shutdown complete"
Jul 26 16:20:17 n2.addr.org dockerd[332974]: time="2022-07-26T16:20:17.667515241-07:00" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Jul 26 16:20:17 n2.addr.org systemd[1]: docker.service: Succeeded.
-- Subject: Unit succeeded
-- Defined-By: systemd
-- Support: http://www.ubuntu.com/support
--
-- The unit docker.service has successfully entered the 'dead' state.
Jul 26 16:20:17 n2.addr.org systemd[1]: Stopped Docker Application Container Engine.
-- Subject: A stop job for unit docker.service has finished
-- Defined-By: systemd
-- Support: http://www.ubuntu.com/support
--
-- A stop job for unit docker.service has finished.
--
-- The job identifier is 14944 and the job result is done.
Jul 26 16:20:17 n2.addr.org systemd[1]: Starting Docker Application Container Engine...
-- Subject: A start job for unit docker.service has begun execution
-- Defined-By: systemd
-- Support: http://www.ubuntu.com/support
--
-- A start job for unit docker.service has begun execution.
--
-- The job identifier is 14944.
Jul 26 16:20:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:17.715014397-07:00" level=info msg="Starting up"
Jul 26 16:20:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:17.715420310-07:00" level=debug msg="Listener created for HTTP on fd ()"
Jul 26 16:20:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:17.715517643-07:00" level=debug msg="Listener created for HTTP on unix (/var/run/docker.sock)"
Jul 26 16:20:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:17.715537691-07:00" level=warning msg="Binding to IP address without --tlsverify is insecure and gives root access on this machine to everyone who has access to your network." host="tcp://0.0.0.0:2375"
Jul 26 16:20:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:17.715550615-07:00" level=warning msg="Binding to an IP address, even on localhost, can also give access to scripts run in a browser. Be safe out there!" host="tcp://0.0.0.0:2375"
Jul 26 16:20:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:18.715603261-07:00" level=warning msg="Binding to an IP address without --tlsverify is deprecated. Startup is intentionally being slowed down to show this message" host="tcp://0.0.0.0:2375"
Jul 26 16:20:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:18.715657393-07:00" level=warning msg="Please consider generating tls certificates with client validation to prevent exposing unauthenticated root access to your network" host="tcp://0.0.0.0:2375"
Jul 26 16:20:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:18.715673884-07:00" level=warning msg="You can override this by explicitly specifying '--tls=false' or '--tlsverify=false'" host="tcp://0.0.0.0:2375"
Jul 26 16:20:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:18.715695254-07:00" level=warning msg="Support for listening on TCP without authentication or explicit intent to run without authentication will be removed in the next release" host="tcp://0.0.0.0:2375"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.722147472-07:00" level=debug msg="Listener created for HTTP on tcp (0.0.0.0:2375)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.722618438-07:00" level=info msg="detected 127.0.0.53 nameserver, assuming systemd-resolved, so using resolv.conf: /run/systemd/resolve/resolv.conf"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.723020294-07:00" level=debug msg="Golang's threads limit set to 3710880"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.723472003-07:00" level=info msg="parsed scheme: \"unix\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.723487071-07:00" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.723506067-07:00" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.723514573-07:00" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.723580066-07:00" level=debug msg="metrics API listening on /var/run/docker/metrics.sock"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.724504925-07:00" level=info msg="parsed scheme: \"unix\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.724519422-07:00" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.724539770-07:00" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.724550190-07:00" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.725254675-07:00" level=debug msg="Using default logging driver json-file"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.725320508-07:00" level=debug msg="processing event stream" module=libcontainerd namespace=plugins.moby
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.725345485-07:00" level=debug msg="[graphdriver] priority list: [btrfs zfs overlay2 fuse-overlayfs aufs overlay devicemapper vfs]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.728223878-07:00" level=debug msg="backingFs=extfs, projectQuotaSupported=false, indexOff=\"index=off,\", userxattr=\"\"" storage-driver=overlay2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.728244156-07:00" level=info msg="[graphdriver] using prior storage driver: overlay2"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.728254375-07:00" level=debug msg="Initialized graph driver overlay2"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.733840339-07:00" level=debug msg="No quota support for local volumes in /var/lib/docker/volumes: Filesystem does not support, or has not enabled quotas"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734615546-07:00" level=warning msg="Your kernel does not support swap memory limit"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734626998-07:00" level=warning msg="Your kernel does not support CPU realtime scheduler"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734631827-07:00" level=warning msg="Your kernel does not support cgroup blkio weight"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734635915-07:00" level=warning msg="Your kernel does not support cgroup blkio weight_device"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734735031-07:00" level=debug msg="Max Concurrent Downloads: 3"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734744970-07:00" level=debug msg="Max Concurrent Uploads: 5"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734748747-07:00" level=debug msg="Max Download Attempts: 5"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734767402-07:00" level=info msg="Loading containers: start."
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734799843-07:00" level=debug msg="Option Experimental: false"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734805764-07:00" level=debug msg="Option DefaultDriver: bridge"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734809761-07:00" level=debug msg="Option DefaultNetwork: bridge"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734814130-07:00" level=debug msg="Network Control Plane MTU: 1500"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.734874293-07:00" level=debug msg="processing event stream" module=libcontainerd namespace=moby
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.740778786-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -j DOCKER-ISOLATION]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.742340412-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -D PREROUTING -m addrtype --dst-type LOCAL -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.743984042-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -D OUTPUT -m addrtype --dst-type LOCAL ! --dst 127.0.0.0/8 -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.745459256-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -D OUTPUT -m addrtype --dst-type LOCAL -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.746379527-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -D PREROUTING]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.747227972-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -D OUTPUT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.747953086-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -F DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.749127664-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -X DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.750146581-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -F DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.751656580-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -X DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.752988775-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -F DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.754550021-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -X DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.755928072-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -F DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.757501530-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -X DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.759186619-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -F DOCKER-ISOLATION]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.760302106-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -X DOCKER-ISOLATION]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.761294022-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -n -L DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.761922103-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -N DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.762756812-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -n -L DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.763961758-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -n -L DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.764918928-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -n -L DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.766324471-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -N DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.767750012-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-1 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.769059735-07:00" level=debug msg="/usr/sbin/iptables, [--wait -A DOCKER-ISOLATION-STAGE-1 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.770803994-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-2 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.772066879-07:00" level=debug msg="/usr/sbin/iptables, [--wait -A DOCKER-ISOLATION-STAGE-2 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.776717534-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C POSTROUTING -s 172.18.0.0/16 ! -o docker_gwbridge -j MASQUERADE]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.777738243-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C DOCKER -i docker_gwbridge -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.778436176-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -I DOCKER -i docker_gwbridge -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.779414866-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -i docker_gwbridge -o docker_gwbridge -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.780765426-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -i docker_gwbridge -o docker_gwbridge -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.781862508-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -i docker_gwbridge ! -o docker_gwbridge -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.782687620-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C PREROUTING -m addrtype --dst-type LOCAL -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.783795914-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -A PREROUTING -m addrtype --dst-type LOCAL -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.785229078-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C OUTPUT -m addrtype --dst-type LOCAL -j DOCKER ! --dst 127.0.0.0/8]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.786064429-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -A OUTPUT -m addrtype --dst-type LOCAL -j DOCKER ! --dst 127.0.0.0/8]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.786989168-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker_gwbridge -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.788035916-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker_gwbridge -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.789231945-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker_gwbridge -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.790541267-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker_gwbridge -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.791921573-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.793205648-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.794749701-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.796564192-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-1 -i docker_gwbridge ! -o docker_gwbridge -j DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.797995253-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -I DOCKER-ISOLATION-STAGE-1 -i docker_gwbridge ! -o docker_gwbridge -j DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.799512136-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-2 -o docker_gwbridge -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.800787624-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -I DOCKER-ISOLATION-STAGE-2 -o docker_gwbridge -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.802759152-07:00" level=debug msg="Network (a1b258d) restored"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.803067221-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C POSTROUTING -s 172.17.0.0/16 ! -o docker0 -j MASQUERADE]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.803957355-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C DOCKER -i docker0 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.804878206-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -I DOCKER -i docker0 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.806141001-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -i docker0 -o docker0 -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.807088542-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -i docker0 -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.808068665-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -i docker0 ! -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.809236280-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C PREROUTING -m addrtype --dst-type LOCAL -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.810149207-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C PREROUTING -m addrtype --dst-type LOCAL -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.810829767-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C OUTPUT -m addrtype --dst-type LOCAL -j DOCKER ! --dst 127.0.0.0/8]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.811634019-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C OUTPUT -m addrtype --dst-type LOCAL -j DOCKER ! --dst 127.0.0.0/8]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.812807326-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.813921741-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.814728919-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.816084157-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.817165080-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.818302218-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.819608996-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.821260832-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.822413299-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -I DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.823885136-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.825149483-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -I DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.826931915-07:00" level=debug msg="Network (d482e25) restored"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.827950390-07:00" level=debug msg="Allocating IPv4 pools for network docker_gwbridge (a1b258df4d9f4ce72e14296010b61afae6bf45e25c02868c695a745f61541df3)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.827965228-07:00" level=debug msg="RequestPool(LocalDefault, 172.18.0.0/16, , map[], false)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.827983693-07:00" level=debug msg="RequestAddress(LocalDefault/172.18.0.0/16, 172.18.0.1, map[RequestAddressType:com.docker.network.gateway])"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.827998030-07:00" level=debug msg="Request address PoolID:172.18.0.0/16 App: ipam/default/data, ID: LocalDefault/172.18.0.0/16, DBIndex: 0x0, Bits: 65536, Unselected: 65534, Sequence: (0x80000000, 1)->(0x0, 2046)->(0x1, 1)->end Curr:0 Serial:false PrefAddress:172.18.0.1 "
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.828048855-07:00" level=debug msg="Allocating IPv4 pools for network bridge (d482e254ca5df2ee1bd96e1f6d7b871dda5e29c6903566a7399735cb41e0efb8)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.828057452-07:00" level=debug msg="RequestPool(LocalDefault, 172.17.0.0/16, , map[], false)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.828067150-07:00" level=debug msg="RequestAddress(LocalDefault/172.17.0.0/16, 172.17.0.1, map[RequestAddressType:com.docker.network.gateway])"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.828075546-07:00" level=debug msg="Request address PoolID:172.17.0.0/16 App: ipam/default/data, ID: LocalDefault/172.17.0.0/16, DBIndex: 0x0, Bits: 65536, Unselected: 65534, Sequence: (0x80000000, 1)->(0x0, 2046)->(0x1, 1)->end Curr:0 Serial:false PrefAddress:172.17.0.1 "
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.829506276-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C POSTROUTING -s 172.17.0.0/16 ! -o docker0 -j MASQUERADE]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.831874069-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -D POSTROUTING -s 172.17.0.0/16 ! -o docker0 -j MASQUERADE]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.832793107-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C DOCKER -i docker0 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.833608660-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -D DOCKER -i docker0 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.834576580-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -i docker0 -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.835481101-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -i docker0 -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.837393356-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -i docker0 ! -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.838532659-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -i docker0 ! -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.840180567-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.841189976-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.842407896-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -o docker0 -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.843812808-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.845476085-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.846633501-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.848636808-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.850058231-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -D DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.851602885-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.852855491-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -D DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.854993642-07:00" level=debug msg="releasing IPv4 pools from network bridge (d482e254ca5df2ee1bd96e1f6d7b871dda5e29c6903566a7399735cb41e0efb8)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.855017827-07:00" level=debug msg="ReleaseAddress(LocalDefault/172.17.0.0/16, 172.17.0.1)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.855052532-07:00" level=debug msg="Released address PoolID:LocalDefault/172.17.0.0/16, Address:172.17.0.1 Sequence:App: ipam/default/data, ID: LocalDefault/172.17.0.0/16, DBIndex: 0x0, Bits: 65536, Unselected: 65533, Sequence: (0xc0000000, 1)->(0x0, 2046)->(0x1, 1)->end Curr:0"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.855068993-07:00" level=debug msg="ReleasePool(LocalDefault/172.17.0.0/16)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.855585374-07:00" level=debug msg="cleanupServiceDiscovery for network:d482e254ca5df2ee1bd96e1f6d7b871dda5e29c6903566a7399735cb41e0efb8"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.855604370-07:00" level=debug msg="cleanupServiceBindings for d482e254ca5df2ee1bd96e1f6d7b871dda5e29c6903566a7399735cb41e0efb8"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.856268850-07:00" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.856291813-07:00" level=debug msg="Allocating IPv4 pools for network bridge (53c585e97e8935f9083fe74670ab36d0a8d98872774e27c22b0227f19450ef60)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.856301731-07:00" level=debug msg="RequestPool(LocalDefault, 172.17.0.0/16, , map[], false)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.856316659-07:00" level=debug msg="RequestAddress(LocalDefault/172.17.0.0/16, 172.17.0.1, map[RequestAddressType:com.docker.network.gateway])"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.856328321-07:00" level=debug msg="Request address PoolID:172.17.0.0/16 App: ipam/default/data, ID: LocalDefault/172.17.0.0/16, DBIndex: 0x0, Bits: 65536, Unselected: 65534, Sequence: (0x80000000, 1)->(0x0, 2046)->(0x1, 1)->end Curr:0 Serial:false PrefAddress:172.17.0.1 "
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.856528808-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C POSTROUTING -s 172.17.0.0/16 ! -o docker0 -j MASQUERADE]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.857489294-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -I POSTROUTING -s 172.17.0.0/16 ! -o docker0 -j MASQUERADE]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.858744705-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C DOCKER -i docker0 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.859397973-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -I DOCKER -i docker0 -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.860398364-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -i docker0 -o docker0 -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.861465971-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -i docker0 -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.862450954-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -i docker0 -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.863701365-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -i docker0 ! -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.865024834-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -i docker0 ! -o docker0 -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.866467436-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C PREROUTING -m addrtype --dst-type LOCAL -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.867259356-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C PREROUTING -m addrtype --dst-type LOCAL -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.868112590-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C OUTPUT -m addrtype --dst-type LOCAL -j DOCKER ! --dst 127.0.0.0/8]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.869267872-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t nat -C OUTPUT -m addrtype --dst-type LOCAL -j DOCKER ! --dst 127.0.0.0/8]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.869982115-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.871098825-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -o docker0 -j DOCKER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.872672414-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.874200006-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -o docker0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.875967249-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.877249921-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.878811728-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -j DOCKER-ISOLATION-STAGE-1]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.880834051-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.882109029-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -I DOCKER-ISOLATION-STAGE-1 -i docker0 ! -o docker0 -j DOCKER-ISOLATION-STAGE-2]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.883599852-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.884732732-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -I DOCKER-ISOLATION-STAGE-2 -o docker0 -j DROP]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.887072071-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -n -L DOCKER-USER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.888312994-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-USER -j RETURN]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.889454921-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -j DOCKER-USER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.890419515-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -j DOCKER-USER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.891990088-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -j DOCKER-USER]"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.893886765-07:00" level=info msg="Loading containers: done."
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.906023456-07:00" level=info msg="Docker daemon" commit="20.10.12-0ubuntu2~20.04.1" graphdriver(s)=overlay2 version=20.10.12
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.913900408-07:00" level=debug msg="loaded node credentials" module=node/tls node.id=qp1bbekd8qj7tolthzjvwd3m2 node.role=swarm-manager
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.914140559-07:00" level=debug msg="(*Agent).run" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.914301752-07:00" level=info msg="parsed scheme: \"\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.914313715-07:00" level=info msg="scheme \"\" not registered, fallback to default scheme" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.914328032-07:00" level=info msg="ccResolverWrapper: sending update to cc: {[{/var/run/docker/swarm/control.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.914334965-07:00" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.914371253-07:00" level=debug msg="next certificate renewal scheduled for 1519h35m26.08564112s from now" fields.time="2022-09-27 23:56:00.00000024 -0700 MST m=+5470542.308422644" module=node/tls node.id=qp1bbekd8qj7tolthzjvwd3m2 node.role=swarm-manager
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.916312143-07:00" level=info msg="Listening for connections" addr="[::]:2377" module=node node.id=qp1bbekd8qj7tolthzjvwd3m2 proto=tcp
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.916335497-07:00" level=info msg="Listening for local connections" addr=/var/run/docker/swarm/control.sock module=node node.id=qp1bbekd8qj7tolthzjvwd3m2 proto=unix
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.917640250-07:00" level=info msg="76fc5d22c4ba2e09 became follower at term 10" module=raft node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.917662211-07:00" level=info msg="newRaft 76fc5d22c4ba2e09 [peers: [], term: 10, commit: 120, applied: 0, lastindex: 120, lastterm: 10]" module=raft node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.922493746-07:00" level=info msg="parsed scheme: \"\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.922509436-07:00" level=info msg="scheme \"\" not registered, fallback to default scheme" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.922657134-07:00" level=info msg="ccResolverWrapper: sending update to cc: {[{n2.d.d.d:2377 <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.922667714-07:00" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.922692460-07:00" level=info msg="manager selected by agent for new session: {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.922754226-07:00" level=info msg="waiting 0s before registering session" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.922783231-07:00" level=debug msg="(*session).start" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927296587-07:00" level=info msg="76fc5d22c4ba2e09 is starting a new election at term 10" module=raft node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927368883-07:00" level=info msg="76fc5d22c4ba2e09 became candidate at term 11" module=raft node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927380856-07:00" level=info msg="76fc5d22c4ba2e09 received MsgVoteResp from 76fc5d22c4ba2e09 at term 11" module=raft node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927390684-07:00" level=info msg="76fc5d22c4ba2e09 became leader at term 11" module=raft node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927397657-07:00" level=info msg="raft.node: 76fc5d22c4ba2e09 elected leader 76fc5d22c4ba2e09 at term 11" module=raft node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927437222-07:00" level=debug msg="error handling streaming rpc" error="rpc error: code = Aborted desc = dispatcher is stopped" rpc=/docker.swarmkit.v1.Dispatcher/Session
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927535176-07:00" level=error msg="error creating cluster object" error="name conflicts with an existing object" module=node node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927557618-07:00" level=error msg="agent: session failed" backoff=100ms error="rpc error: code = Aborted desc = dispatcher is stopped" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927604366-07:00" level=debug msg="agent: rebuild session" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927588025-07:00" level=info msg="leadership changed from not yet part of a raft cluster to qp1bbekd8qj7tolthzjvwd3m2" module=node node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927631938-07:00" level=info msg="parsed scheme: \"\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927672464-07:00" level=info msg="scheme \"\" not registered, fallback to default scheme" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927649200-07:00" level=info msg="dispatcher starting" module=dispatcher node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927836793-07:00" level=info msg="ccResolverWrapper: sending update to cc: {[{n2.d.d.d:2377 <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927848635-07:00" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927871418-07:00" level=info msg="manager selected by agent for new session: {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927908408-07:00" level=info msg="waiting 32.731696ms before registering session" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.927940087-07:00" level=debug msg="Root CA set successfully" cluster.id=yc5bdt7otol64gcld03xwwdat method="(*Server).UpdateRootCA" module=ca node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932007877-07:00" level=debug msg="RequestPool(GlobalDefault, 10.0.0.0/24, , map[], false)"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932047912-07:00" level=debug msg="RequestAddress(GlobalDefault/10.0.0.0/24, 10.0.0.1, map[RequestAddressType:com.docker.network.gateway com.docker.network.ipam.serial:true])"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932070785-07:00" level=debug msg="Request address PoolID:10.0.0.0/24 App: ipam/default/data, ID: GlobalDefault/10.0.0.0/24, DBIndex: 0x0, Bits: 256, Unselected: 254, Sequence: (0x80000000, 1)->(0x0, 6)->(0x1, 1)->end Curr:0 Serial:true PrefAddress:10.0.0.1 "
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932105590-07:00" level=debug msg="overlay network option: 4096"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932468312-07:00" level=debug msg="RequestAddress(GlobalDefault/10.0.0.0/24, 10.0.0.3, map[com.docker.network.ipam.serial:true])"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932485875-07:00" level=debug msg="Request address PoolID:10.0.0.0/24 App: ipam/default/data, ID: GlobalDefault/10.0.0.0/24, DBIndex: 0x0, Bits: 256, Unselected: 253, Sequence: (0xc0000000, 1)->(0x0, 6)->(0x1, 1)->end Curr:0 Serial:true PrefAddress:10.0.0.3 "
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932502597-07:00" level=debug msg="RequestAddress(GlobalDefault/10.0.0.0/24, 10.0.0.4, map[com.docker.network.ipam.serial:true])"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932511634-07:00" level=debug msg="Request address PoolID:10.0.0.0/24 App: ipam/default/data, ID: GlobalDefault/10.0.0.0/24, DBIndex: 0x0, Bits: 256, Unselected: 252, Sequence: (0xd0000000, 1)->(0x0, 6)->(0x1, 1)->end Curr:0 Serial:true PrefAddress:10.0.0.4 "
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932525530-07:00" level=debug msg="RequestAddress(GlobalDefault/10.0.0.0/24, 10.0.0.2, map[com.docker.network.ipam.serial:true])"
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.932534477-07:00" level=debug msg="Request address PoolID:10.0.0.0/24 App: ipam/default/data, ID: GlobalDefault/10.0.0.0/24, DBIndex: 0x0, Bits: 256, Unselected: 251, Sequence: (0xd8000000, 1)->(0x0, 6)->(0x1, 1)->end Curr:0 Serial:true PrefAddress:10.0.0.2 "
Jul 26 16:20:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:33.960692985-07:00" level=debug msg="(*session).start" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.028659688-07:00" level=debug msg="node status updated" method="(*Dispatcher).processUpdates" module=dispatcher node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.028893998-07:00" level=info msg="worker qp1bbekd8qj7tolthzjvwd3m2 was successfully registered" method="(*Dispatcher).register"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029322183-07:00" level=debug method="(*session).logSubscriptions" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029330800-07:00" level=debug method="(*session).watch" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029345547-07:00" level=debug msg="(*session).listen" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029350186-07:00" level=debug msg="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029466525-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029613732-07:00" level=debug method="(*Dispatcher).Assignments" node.id=qp1bbekd8qj7tolthzjvwd3m2 node.session=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029669847-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.072674208s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029616116-07:00" level=debug msg="node registered" method="(*LogBroker).ListenSubscriptions" node=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029757722-07:00" level=debug msg="agent: registered" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029798038-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.072674208s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029807175-07:00" level=info msg="initialized VXLAN UDP port to 4789 "
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029836501-07:00" level=debug msg="(*worker).Assign" len(assignments)=0 module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029872298-07:00" level=debug msg="(*worker).reconcileSecrets" len(removedSecrets)=0 len(updatedSecrets)=0 module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029885693-07:00" level=debug msg="(*worker).reconcileConfigs" len(removedConfigs)=0 len(updatedConfigs)=0 module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.029893889-07:00" level=debug msg="(*worker).reconcileTaskState" len(removedTasks)=0 len(updatedTasks)=0 module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.417968222-07:00" level=info msg="Initializing Libnetwork Agent Listen-Addr=0.0.0.0 Local-addr=n2.d.d.d Adv-addr=n2.d.d.d Data-addr= Remote-addr-list=[] MTU=1500"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.418040908-07:00" level=debug msg="Control plane MTU: 1500 will initialize NetworkDB with: 1400"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.417987969-07:00" level=info msg="Daemon has completed initialization"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.418094780-07:00" level=info msg="New memberlist node - Node:n2.addr.org will use memberlist nodeID:d1d86763daee with config:&{NodeID:d1d86763daee Hostname:n2.addr.org BindAddr:0.0.0.0 AdvertiseAddr:n2.d.d.d BindPort:0 Keys:[[12 135 133 102 131 49 106 120 126 174 144 42 130 141 139 12] [170 95 76 46 26 175 78 157 13 230 31 180 11 12 153 108] [49 9 7 86 59 238 107 245 190 65 63 186 34 151 231 94]] PacketBufferSize:1400 reapEntryInterval:1800000000000 reapNetworkInterval:1825000000000 StatsPrintPeriod:5m0s HealthPrintPeriod:1m0s}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.418190159-07:00" level=debug msg="Encryption key 1: 0c878"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.418199517-07:00" level=debug msg="Encryption key 2: aa5f4"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.418207171-07:00" level=debug msg="Encryption key 3: 31090"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.418737789-07:00" level=info msg="Node d1d86763daee/n2.d.d.d, joined gossip cluster"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.418836254-07:00" level=info msg="Node d1d86763daee/n2.d.d.d, added to nodes list"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.419054775-07:00" level=debug msg="Initial encryption keys: [(key: 827d3, tag: 0x755b) (key: 04923, tag: 0x7559) (key: c255f, tag: 0x755d)]"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.419318010-07:00" level=debug msg="Initial encryption keys: [(key: 827d3, tag: 0x755b) (key: 04923, tag: 0x7559) (key: c255f, tag: 0x755d)]"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.419524839-07:00" level=debug msg="Allocating IPv4 pools for network ingress (8hyprs12unlyysaz2pzu7f477)"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.419539126-07:00" level=debug msg="RequestPool(LocalDefault, 10.0.0.0/24, , map[], false)"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.419559504-07:00" level=debug msg="RequestAddress(LocalDefault/10.0.0.0/24, 10.0.0.1, map[RequestAddressType:com.docker.network.gateway])"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.419576897-07:00" level=debug msg="Request address PoolID:10.0.0.0/24 App: ipam/default/data, ID: LocalDefault/10.0.0.0/24, DBIndex: 0x0, Bits: 256, Unselected: 254, Sequence: (0x80000000, 1)->(0x0, 6)->(0x1, 1)->end Curr:0 Serial:false PrefAddress:10.0.0.1 "
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.419636288-07:00" level=debug msg="overlay: Received vxlan IDs: 4096"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.419650225-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t mangle -C OUTPUT -p udp --dport 4789 -m u32 --u32 0>>22&0x3C@12&0xFFFFFF00=1048576 -j MARK --set-mark 13681891]"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.421757016-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C INPUT -m policy --dir in --pol ipsec -p udp --dport 4789 -m u32 --u32 0>>22&0x3C@12&0xFFFFFF00=1048576 -j ACCEPT]"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.424658813-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C INPUT -p udp --dport 4789 -m u32 --u32 0>>22&0x3C@12&0xFFFFFF00=1048576 -j DROP]"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.426815849-07:00" level=debug msg="n2.addr.org(d1d86763daee): joined network 8hyprs12unlyysaz2pzu7f477"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427079695-07:00" level=debug msg="Registering routers"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427103710-07:00" level=debug msg="Registering GET, /containers/{name:.*}/checkpoints"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427197196-07:00" level=debug msg="Registering POST, /containers/{name:.*}/checkpoints"
Jul 26 16:20:34 n2.addr.org systemd[1]: Started Docker Application Container Engine.
-- Subject: A start job for unit docker.service has finished successfully
-- Defined-By: systemd
-- Support: http://www.ubuntu.com/support
--
-- A start job for unit docker.service has finished successfully.
--
-- The job identifier is 14944.
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427286884-07:00" level=debug msg="Registering DELETE, /containers/{name}/checkpoints/{checkpoint}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427387614-07:00" level=debug msg="Registering HEAD, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427455411-07:00" level=debug msg="Registering GET, /containers/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427519321-07:00" level=debug msg="Registering GET, /containers/{name:.*}/export"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427562903-07:00" level=debug msg="Registering GET, /containers/{name:.*}/changes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427617406-07:00" level=debug msg="Registering GET, /containers/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427666558-07:00" level=debug msg="Registering GET, /containers/{name:.*}/top"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427715751-07:00" level=debug msg="Registering GET, /containers/{name:.*}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427757319-07:00" level=debug msg="Registering GET, /containers/{name:.*}/stats"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427800199-07:00" level=debug msg="Registering GET, /containers/{name:.*}/attach/ws"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427856305-07:00" level=debug msg="Registering GET, /exec/{id:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427913182-07:00" level=debug msg="Registering GET, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427961463-07:00" level=debug msg="Registering POST, /containers/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.427998592-07:00" level=debug msg="Registering POST, /containers/{name:.*}/kill"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428056030-07:00" level=debug msg="Registering POST, /containers/{name:.*}/pause"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428093982-07:00" level=debug msg="Registering POST, /containers/{name:.*}/unpause"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428143685-07:00" level=debug msg="Registering POST, /containers/{name:.*}/restart"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428179142-07:00" level=debug msg="Registering POST, /containers/{name:.*}/start"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428222513-07:00" level=debug msg="Registering POST, /containers/{name:.*}/stop"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428279841-07:00" level=debug msg="Registering POST, /containers/{name:.*}/wait"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428324716-07:00" level=debug msg="Registering POST, /containers/{name:.*}/resize"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428384508-07:00" level=debug msg="Registering POST, /containers/{name:.*}/attach"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428423331-07:00" level=debug msg="Registering POST, /containers/{name:.*}/copy"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428468205-07:00" level=debug msg="Registering POST, /containers/{name:.*}/exec"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428507149-07:00" level=debug msg="Registering POST, /exec/{name:.*}/start"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428545481-07:00" level=debug msg="Registering POST, /exec/{name:.*}/resize"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428579825-07:00" level=debug msg="Registering POST, /containers/{name:.*}/rename"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428623237-07:00" level=debug msg="Registering POST, /containers/{name:.*}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428670977-07:00" level=debug msg="Registering POST, /containers/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428703097-07:00" level=debug msg="Registering POST, /commit"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428724958-07:00" level=debug msg="Registering PUT, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428793838-07:00" level=debug msg="Registering DELETE, /containers/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428835646-07:00" level=debug msg="Registering GET, /images/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428874008-07:00" level=debug msg="Registering GET, /images/search"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428904496-07:00" level=debug msg="Registering GET, /images/get"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428927880-07:00" level=debug msg="Registering GET, /images/{name:.*}/get"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.428969478-07:00" level=debug msg="Registering GET, /images/{name:.*}/history"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429012659-07:00" level=debug msg="Registering GET, /images/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429066350-07:00" level=debug msg="Registering POST, /images/load"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429114821-07:00" level=debug msg="Registering POST, /images/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429139377-07:00" level=debug msg="Registering POST, /images/{name:.*}/push"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429179433-07:00" level=debug msg="Registering POST, /images/{name:.*}/tag"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429223445-07:00" level=debug msg="Registering POST, /images/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429251488-07:00" level=debug msg="Registering DELETE, /images/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429298657-07:00" level=debug msg="Registering OPTIONS, /{anyroute:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429528639-07:00" level=debug msg="Registering GET, /_ping"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429550210-07:00" level=debug msg="Registering HEAD, /_ping"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429578904-07:00" level=debug msg="Registering GET, /events"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429602638-07:00" level=debug msg="Registering GET, /info"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429623367-07:00" level=debug msg="Registering GET, /version"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429656169-07:00" level=debug msg="Registering GET, /system/df"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429680024-07:00" level=debug msg="Registering POST, /auth"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429701524-07:00" level=debug msg="Registering GET, /volumes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429729046-07:00" level=debug msg="Registering GET, /volumes/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429764984-07:00" level=debug msg="Registering POST, /volumes/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429788999-07:00" level=debug msg="Registering POST, /volumes/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429814948-07:00" level=debug msg="Registering DELETE, /volumes/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429853851-07:00" level=debug msg="Registering POST, /build"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429882505-07:00" level=debug msg="Registering POST, /build/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429910588-07:00" level=debug msg="Registering POST, /build/cancel"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429936957-07:00" level=debug msg="Registering POST, /session"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429955933-07:00" level=debug msg="Registering POST, /swarm/init"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.429980309-07:00" level=debug msg="Registering POST, /swarm/join"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430005045-07:00" level=debug msg="Registering POST, /swarm/leave"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430028589-07:00" level=debug msg="Registering GET, /swarm"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430048828-07:00" level=debug msg="Registering GET, /swarm/unlockkey"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430076730-07:00" level=debug msg="Registering POST, /swarm/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430108299-07:00" level=debug msg="Registering POST, /swarm/unlock"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430141772-07:00" level=debug msg="Registering GET, /services"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430165407-07:00" level=debug msg="Registering GET, /services/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430198579-07:00" level=debug msg="Registering POST, /services/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430225590-07:00" level=debug msg="Registering POST, /services/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430263551-07:00" level=debug msg="Registering DELETE, /services/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430301703-07:00" level=debug msg="Registering GET, /services/{id}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430340095-07:00" level=debug msg="Registering GET, /nodes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430360494-07:00" level=debug msg="Registering GET, /nodes/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430393806-07:00" level=debug msg="Registering DELETE, /nodes/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430422941-07:00" level=debug msg="Registering POST, /nodes/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430459961-07:00" level=debug msg="Registering GET, /tasks"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430489446-07:00" level=debug msg="Registering GET, /tasks/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430518801-07:00" level=debug msg="Registering GET, /tasks/{id}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430555891-07:00" level=debug msg="Registering GET, /secrets"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430582581-07:00" level=debug msg="Registering POST, /secrets/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430607238-07:00" level=debug msg="Registering DELETE, /secrets/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430639709-07:00" level=debug msg="Registering GET, /secrets/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430671368-07:00" level=debug msg="Registering POST, /secrets/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430715601-07:00" level=debug msg="Registering GET, /configs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430739126-07:00" level=debug msg="Registering POST, /configs/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430764373-07:00" level=debug msg="Registering DELETE, /configs/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430796403-07:00" level=debug msg="Registering GET, /configs/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430828013-07:00" level=debug msg="Registering POST, /configs/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430863550-07:00" level=debug msg="Registering GET, /plugins"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430893306-07:00" level=debug msg="Registering GET, /plugins/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430932129-07:00" level=debug msg="Registering GET, /plugins/privileges"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430959470-07:00" level=debug msg="Registering DELETE, /plugins/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.430993794-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/enable"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.431031105-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/disable"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.431068335-07:00" level=debug msg="Registering POST, /plugins/pull"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.431088733-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/push"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.432120834-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/upgrade"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.432313927-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/set"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.432409026-07:00" level=debug msg="Registering POST, /plugins/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.432483426-07:00" level=debug msg="Registering GET, /distribution/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.434425207-07:00" level=debug msg="Registering POST, /grpc"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.434718398-07:00" level=debug msg="Registering GET, /networks"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.434812155-07:00" level=debug msg="Registering GET, /networks/"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.434908456-07:00" level=debug msg="Registering GET, /networks/{id:.+}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.434990871-07:00" level=debug msg="Registering POST, /networks/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.435053408-07:00" level=debug msg="Registering POST, /networks/{id:.*}/connect"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.435126576-07:00" level=debug msg="Registering POST, /networks/{id:.*}/disconnect"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.435336040-07:00" level=debug msg="Registering POST, /networks/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.435620735-07:00" level=debug msg="Registering DELETE, /networks/{id:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.436193693-07:00" level=debug msg="Registering routers"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.436252042-07:00" level=debug msg="Registering GET, /containers/{name:.*}/checkpoints"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.436558519-07:00" level=debug msg="Registering POST, /containers/{name:.*}/checkpoints"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.436587543-07:00" level=info msg="API listen on /run/docker.sock"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.437165821-07:00" level=debug msg="Registering DELETE, /containers/{name}/checkpoints/{checkpoint}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438223630-07:00" level=debug msg="Registering HEAD, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438300003-07:00" level=debug msg="Registering GET, /containers/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438336352-07:00" level=debug msg="Registering GET, /containers/{name:.*}/export"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438376197-07:00" level=debug msg="Registering GET, /containers/{name:.*}/changes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438440868-07:00" level=debug msg="Registering GET, /containers/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438485963-07:00" level=debug msg="Registering GET, /containers/{name:.*}/top"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438530036-07:00" level=debug msg="Registering GET, /containers/{name:.*}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438569520-07:00" level=debug msg="Registering GET, /containers/{name:.*}/stats"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438611169-07:00" level=debug msg="Registering GET, /containers/{name:.*}/attach/ws"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438650773-07:00" level=debug msg="Registering GET, /exec/{id:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438686991-07:00" level=debug msg="Registering GET, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438732667-07:00" level=debug msg="Registering POST, /containers/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438763936-07:00" level=debug msg="Registering POST, /containers/{name:.*}/kill"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438803460-07:00" level=debug msg="Registering POST, /containers/{name:.*}/pause"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438842964-07:00" level=debug msg="Registering POST, /containers/{name:.*}/unpause"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438888129-07:00" level=debug msg="Registering POST, /containers/{name:.*}/restart"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438928135-07:00" level=debug msg="Registering POST, /containers/{name:.*}/start"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.438967248-07:00" level=debug msg="Registering POST, /containers/{name:.*}/stop"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439005761-07:00" level=debug msg="Registering POST, /containers/{name:.*}/wait"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439045495-07:00" level=debug msg="Registering POST, /containers/{name:.*}/resize"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439087083-07:00" level=debug msg="Registering POST, /containers/{name:.*}/attach"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439128672-07:00" level=debug msg="Registering POST, /containers/{name:.*}/copy"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439169759-07:00" level=debug msg="Registering POST, /containers/{name:.*}/exec"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439207430-07:00" level=debug msg="Registering POST, /exec/{name:.*}/start"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439240432-07:00" level=debug msg="Registering POST, /exec/{name:.*}/resize"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439280477-07:00" level=debug msg="Registering POST, /containers/{name:.*}/rename"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439317276-07:00" level=debug msg="Registering POST, /containers/{name:.*}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439355358-07:00" level=debug msg="Registering POST, /containers/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439387478-07:00" level=debug msg="Registering POST, /commit"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439412596-07:00" level=debug msg="Registering PUT, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439457610-07:00" level=debug msg="Registering DELETE, /containers/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439499419-07:00" level=debug msg="Registering GET, /images/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439525768-07:00" level=debug msg="Registering GET, /images/search"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439550204-07:00" level=debug msg="Registering GET, /images/get"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439581072-07:00" level=debug msg="Registering GET, /images/{name:.*}/get"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439618463-07:00" level=debug msg="Registering GET, /images/{name:.*}/history"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439653138-07:00" level=debug msg="Registering GET, /images/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439690628-07:00" level=debug msg="Registering POST, /images/load"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439715154-07:00" level=debug msg="Registering POST, /images/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439738308-07:00" level=debug msg="Registering POST, /images/{name:.*}/push"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439771941-07:00" level=debug msg="Registering POST, /images/{name:.*}/tag"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439807178-07:00" level=debug msg="Registering POST, /images/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439834289-07:00" level=debug msg="Registering DELETE, /images/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439866699-07:00" level=debug msg="Registering OPTIONS, /{anyroute:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439900493-07:00" level=debug msg="Registering GET, /_ping"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439923075-07:00" level=debug msg="Registering HEAD, /_ping"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439945568-07:00" level=debug msg="Registering GET, /events"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439970495-07:00" level=debug msg="Registering GET, /info"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.439993668-07:00" level=debug msg="Registering GET, /version"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440018525-07:00" level=debug msg="Registering GET, /system/df"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440043682-07:00" level=debug msg="Registering POST, /auth"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440067968-07:00" level=debug msg="Registering GET, /volumes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440091111-07:00" level=debug msg="Registering GET, /volumes/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440130536-07:00" level=debug msg="Registering POST, /volumes/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440155783-07:00" level=debug msg="Registering POST, /volumes/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440181141-07:00" level=debug msg="Registering DELETE, /volumes/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440218301-07:00" level=debug msg="Registering POST, /build"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440243498-07:00" level=debug msg="Registering POST, /build/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440266080-07:00" level=debug msg="Registering POST, /build/cancel"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440289895-07:00" level=debug msg="Registering POST, /session"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440313319-07:00" level=debug msg="Registering POST, /swarm/init"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440338667-07:00" level=debug msg="Registering POST, /swarm/join"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440361320-07:00" level=debug msg="Registering POST, /swarm/leave"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440384924-07:00" level=debug msg="Registering GET, /swarm"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440404952-07:00" level=debug msg="Registering GET, /swarm/unlockkey"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440430991-07:00" level=debug msg="Registering POST, /swarm/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440456629-07:00" level=debug msg="Registering POST, /swarm/unlock"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440479612-07:00" level=debug msg="Registering GET, /services"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440503747-07:00" level=debug msg="Registering GET, /services/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440547369-07:00" level=debug msg="Registering POST, /services/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440571765-07:00" level=debug msg="Registering POST, /services/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440609767-07:00" level=debug msg="Registering DELETE, /services/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440645614-07:00" level=debug msg="Registering GET, /services/{id}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440686681-07:00" level=debug msg="Registering GET, /nodes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440709094-07:00" level=debug msg="Registering GET, /nodes/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440745512-07:00" level=debug msg="Registering DELETE, /nodes/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440786329-07:00" level=debug msg="Registering POST, /nodes/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440824721-07:00" level=debug msg="Registering GET, /tasks"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440848275-07:00" level=debug msg="Registering GET, /tasks/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440884483-07:00" level=debug msg="Registering GET, /tasks/{id}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440922164-07:00" level=debug msg="Registering GET, /secrets"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440947462-07:00" level=debug msg="Registering POST, /secrets/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.440972399-07:00" level=debug msg="Registering DELETE, /secrets/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441012073-07:00" level=debug msg="Registering GET, /secrets/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441050636-07:00" level=debug msg="Registering POST, /secrets/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441089850-07:00" level=debug msg="Registering GET, /configs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441112702-07:00" level=debug msg="Registering POST, /configs/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441140244-07:00" level=debug msg="Registering DELETE, /configs/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441178867-07:00" level=debug msg="Registering GET, /configs/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441215586-07:00" level=debug msg="Registering POST, /configs/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441254699-07:00" level=debug msg="Registering GET, /plugins"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441278715-07:00" level=debug msg="Registering GET, /plugins/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441316025-07:00" level=debug msg="Registering GET, /plugins/privileges"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441347203-07:00" level=debug msg="Registering DELETE, /plugins/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441381177-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/enable"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441418898-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/disable"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441456799-07:00" level=debug msg="Registering POST, /plugins/pull"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441489140-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/push"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441524807-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/upgrade"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441570623-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/set"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441605429-07:00" level=debug msg="Registering POST, /plugins/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441638641-07:00" level=debug msg="Registering GET, /distribution/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441681843-07:00" level=debug msg="Registering POST, /grpc"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441703243-07:00" level=debug msg="Registering GET, /networks"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441725204-07:00" level=debug msg="Registering GET, /networks/"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441752295-07:00" level=debug msg="Registering GET, /networks/{id:.+}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441792380-07:00" level=debug msg="Registering POST, /networks/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441817868-07:00" level=debug msg="Registering POST, /networks/{id:.*}/connect"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441857683-07:00" level=debug msg="Registering POST, /networks/{id:.*}/disconnect"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441894783-07:00" level=debug msg="Registering POST, /networks/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441926483-07:00" level=debug msg="Registering DELETE, /networks/{id:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441967460-07:00" level=debug msg="Registering GET, /vars"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.441990152-07:00" level=debug msg="Registering GET, /pprof/"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442010681-07:00" level=debug msg="Registering GET, /pprof/cmdline"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442033594-07:00" level=debug msg="Registering GET, /pprof/profile"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442058711-07:00" level=debug msg="Registering GET, /pprof/symbol"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442087575-07:00" level=debug msg="Registering GET, /pprof/trace"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442112112-07:00" level=debug msg="Registering GET, /pprof/{name}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442227148-07:00" level=debug msg="Registering routers"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442234031-07:00" level=debug msg="Registering GET, /containers/{name:.*}/checkpoints"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442275849-07:00" level=debug msg="Registering POST, /containers/{name:.*}/checkpoints"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442310354-07:00" level=info msg="API listen on /var/run/docker.sock"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442311917-07:00" level=debug msg="Registering DELETE, /containers/{name}/checkpoints/{checkpoint}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442459885-07:00" level=debug msg="Registering HEAD, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442519107-07:00" level=debug msg="Registering GET, /containers/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442557679-07:00" level=debug msg="Registering GET, /containers/{name:.*}/export"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442593096-07:00" level=debug msg="Registering GET, /containers/{name:.*}/changes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442634263-07:00" level=debug msg="Registering GET, /containers/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442676042-07:00" level=debug msg="Registering GET, /containers/{name:.*}/top"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442719183-07:00" level=debug msg="Registering GET, /containers/{name:.*}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442758407-07:00" level=debug msg="Registering GET, /containers/{name:.*}/stats"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442800466-07:00" level=debug msg="Registering GET, /containers/{name:.*}/attach/ws"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442843657-07:00" level=debug msg="Registering GET, /exec/{id:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442877992-07:00" level=debug msg="Registering GET, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442920151-07:00" level=debug msg="Registering POST, /containers/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442945549-07:00" level=debug msg="Registering POST, /containers/{name:.*}/kill"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.442989511-07:00" level=debug msg="Registering POST, /containers/{name:.*}/pause"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443031721-07:00" level=debug msg="Registering POST, /containers/{name:.*}/unpause"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443066887-07:00" level=debug msg="Registering POST, /containers/{name:.*}/restart"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443107934-07:00" level=debug msg="Registering POST, /containers/{name:.*}/start"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443144523-07:00" level=debug msg="Registering POST, /containers/{name:.*}/stop"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443188225-07:00" level=debug msg="Registering POST, /containers/{name:.*}/wait"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443226327-07:00" level=debug msg="Registering POST, /containers/{name:.*}/resize"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443268546-07:00" level=debug msg="Registering POST, /containers/{name:.*}/attach"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443309152-07:00" level=debug msg="Registering POST, /containers/{name:.*}/copy"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443355029-07:00" level=debug msg="Registering POST, /containers/{name:.*}/exec"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443407958-07:00" level=debug msg="Registering POST, /exec/{name:.*}/start"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443445008-07:00" level=debug msg="Registering POST, /exec/{name:.*}/resize"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443485454-07:00" level=debug msg="Registering POST, /containers/{name:.*}/rename"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443521502-07:00" level=debug msg="Registering POST, /containers/{name:.*}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443557639-07:00" level=debug msg="Registering POST, /containers/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443584931-07:00" level=debug msg="Registering POST, /commit"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443607764-07:00" level=debug msg="Registering PUT, /containers/{name:.*}/archive"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443647118-07:00" level=debug msg="Registering DELETE, /containers/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443681873-07:00" level=debug msg="Registering GET, /images/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443705918-07:00" level=debug msg="Registering GET, /images/search"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443730094-07:00" level=debug msg="Registering GET, /images/get"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443752045-07:00" level=debug msg="Registering GET, /images/{name:.*}/get"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443801478-07:00" level=debug msg="Registering GET, /images/{name:.*}/history"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443842074-07:00" level=debug msg="Registering GET, /images/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443876249-07:00" level=debug msg="Registering POST, /images/load"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443900324-07:00" level=debug msg="Registering POST, /images/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443921574-07:00" level=debug msg="Registering POST, /images/{name:.*}/push"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443956059-07:00" level=debug msg="Registering POST, /images/{name:.*}/tag"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.443989361-07:00" level=debug msg="Registering POST, /images/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444013116-07:00" level=debug msg="Registering DELETE, /images/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444046679-07:00" level=debug msg="Registering OPTIONS, /{anyroute:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444074682-07:00" level=debug msg="Registering GET, /_ping"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444099458-07:00" level=debug msg="Registering HEAD, /_ping"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444118394-07:00" level=debug msg="Registering GET, /events"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444140065-07:00" level=debug msg="Registering GET, /info"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444160453-07:00" level=debug msg="Registering GET, /version"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444183406-07:00" level=debug msg="Registering GET, /system/df"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444206119-07:00" level=debug msg="Registering POST, /auth"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444226758-07:00" level=debug msg="Registering GET, /volumes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444253999-07:00" level=debug msg="Registering GET, /volumes/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444287191-07:00" level=debug msg="Registering POST, /volumes/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444314272-07:00" level=debug msg="Registering POST, /volumes/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444339219-07:00" level=debug msg="Registering DELETE, /volumes/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444373073-07:00" level=debug msg="Registering POST, /build"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444395184-07:00" level=debug msg="Registering POST, /build/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444419530-07:00" level=debug msg="Registering POST, /build/cancel"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444442132-07:00" level=debug msg="Registering POST, /session"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444461389-07:00" level=debug msg="Registering POST, /swarm/init"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444483751-07:00" level=debug msg="Registering POST, /swarm/join"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444510351-07:00" level=debug msg="Registering POST, /swarm/leave"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444533514-07:00" level=debug msg="Registering GET, /swarm"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444553792-07:00" level=debug msg="Registering GET, /swarm/unlockkey"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444578799-07:00" level=debug msg="Registering POST, /swarm/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444602664-07:00" level=debug msg="Registering POST, /swarm/unlock"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444629595-07:00" level=debug msg="Registering GET, /services"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444650344-07:00" level=debug msg="Registering GET, /services/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444689678-07:00" level=debug msg="Registering POST, /services/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444715827-07:00" level=debug msg="Registering POST, /services/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444750923-07:00" level=debug msg="Registering DELETE, /services/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444783384-07:00" level=debug msg="Registering GET, /services/{id}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444818410-07:00" level=debug msg="Registering GET, /nodes"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444838979-07:00" level=debug msg="Registering GET, /nodes/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444870398-07:00" level=debug msg="Registering DELETE, /nodes/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444899422-07:00" level=debug msg="Registering POST, /nodes/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444935530-07:00" level=debug msg="Registering GET, /tasks"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444954646-07:00" level=debug msg="Registering GET, /tasks/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.444985785-07:00" level=debug msg="Registering GET, /tasks/{id}/logs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445025730-07:00" level=debug msg="Registering GET, /secrets"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445061186-07:00" level=debug msg="Registering POST, /secrets/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445085402-07:00" level=debug msg="Registering DELETE, /secrets/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445116240-07:00" level=debug msg="Registering GET, /secrets/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445152188-07:00" level=debug msg="Registering POST, /secrets/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445187885-07:00" level=debug msg="Registering GET, /configs"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445208704-07:00" level=debug msg="Registering POST, /configs/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445235915-07:00" level=debug msg="Registering DELETE, /configs/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445268346-07:00" level=debug msg="Registering GET, /configs/{id}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445300006-07:00" level=debug msg="Registering POST, /configs/{id}/update"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445333569-07:00" level=debug msg="Registering GET, /plugins"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445352715-07:00" level=debug msg="Registering GET, /plugins/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445389494-07:00" level=debug msg="Registering GET, /plugins/privileges"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445438396-07:00" level=debug msg="Registering DELETE, /plugins/{name:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445477820-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/enable"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445508247-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/disable"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445558021-07:00" level=debug msg="Registering POST, /plugins/pull"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445582577-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/push"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445616350-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/upgrade"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445654823-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/set"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445685250-07:00" level=debug msg="Registering POST, /plugins/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445708113-07:00" level=debug msg="Registering GET, /distribution/{name:.*}/json"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445759279-07:00" level=debug msg="Registering POST, /grpc"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445789546-07:00" level=debug msg="Registering GET, /networks"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445822027-07:00" level=debug msg="Registering GET, /networks/"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445848497-07:00" level=debug msg="Registering GET, /networks/{id:.+}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445891358-07:00" level=debug msg="Registering POST, /networks/create"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445915443-07:00" level=debug msg="Registering POST, /networks/{id:.*}/connect"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445954085-07:00" level=debug msg="Registering POST, /networks/{id:.*}/disconnect"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.445992408-07:00" level=debug msg="Registering POST, /networks/prune"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446018076-07:00" level=debug msg="Registering DELETE, /networks/{id:.*}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446059554-07:00" level=debug msg="Registering GET, /vars"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446082086-07:00" level=debug msg="Registering GET, /pprof/"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446105029-07:00" level=debug msg="Registering GET, /pprof/cmdline"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446132761-07:00" level=debug msg="Registering GET, /pprof/profile"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446160474-07:00" level=debug msg="Registering GET, /pprof/symbol"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446182675-07:00" level=debug msg="Registering GET, /pprof/trace"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446204246-07:00" level=debug msg="Registering GET, /pprof/{name}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446239422-07:00" level=debug msg="Registering GET, /vars"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446260482-07:00" level=debug msg="Registering GET, /pprof/"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446284186-07:00" level=debug msg="Registering GET, /pprof/cmdline"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446309253-07:00" level=debug msg="Registering GET, /pprof/profile"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446333208-07:00" level=debug msg="Registering GET, /pprof/symbol"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446356853-07:00" level=debug msg="Registering GET, /pprof/trace"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446378934-07:00" level=debug msg="Registering GET, /pprof/{name}"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.446500052-07:00" level=info msg="API listen on [::]:2375"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.497487948-07:00" level=error msg="error reading the kernel parameter net.ipv4.vs.conn_reuse_mode" error="open /proc/sys/net/ipv4/vs/conn_reuse_mode: no such file or directory"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.497533975-07:00" level=error msg="error reading the kernel parameter net.ipv4.vs.expire_nodest_conn" error="open /proc/sys/net/ipv4/vs/expire_nodest_conn: no such file or directory"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.497548993-07:00" level=error msg="error reading the kernel parameter net.ipv4.vs.expire_quiescent_template" error="open /proc/sys/net/ipv4/vs/expire_quiescent_template: no such file or directory"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.497992517-07:00" level=debug msg="Assigning addresses for endpoint ingress-endpoint's interface on network ingress"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.498016272-07:00" level=debug msg="RequestAddress(LocalDefault/10.0.0.0/24, 10.0.0.2, map[])"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.498036199-07:00" level=debug msg="Request address PoolID:10.0.0.0/24 App: ipam/default/data, ID: LocalDefault/10.0.0.0/24, DBIndex: 0x0, Bits: 256, Unselected: 253, Sequence: (0xc0000000, 1)->(0x0, 6)->(0x1, 1)->end Curr:0 Serial:false PrefAddress:10.0.0.2 "
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.498377401-07:00" level=debug msg="Assigning addresses for endpoint ingress-endpoint's interface on network ingress"
Jul 26 16:20:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:34.842842171-07:00" level=debug msg="checkEncryption(8hyprs1, <nil>, 4096, true)"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.038060773-07:00" level=debug msg="Assigning addresses for endpoint gateway_ingress-sbox's interface on network docker_gwbridge"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.038104956-07:00" level=debug msg="RequestAddress(LocalDefault/172.18.0.0/16, <nil>, map[])"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.038123511-07:00" level=debug msg="Request address PoolID:172.18.0.0/16 App: ipam/default/data, ID: LocalDefault/172.18.0.0/16, DBIndex: 0x0, Bits: 65536, Unselected: 65533, Sequence: (0xc0000000, 1)->(0x0, 2046)->(0x1, 1)->end Curr:0 Serial:false PrefAddress:<nil> "
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.040597654-07:00" level=debug msg="Assigning addresses for endpoint gateway_ingress-sbox's interface on network docker_gwbridge"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.143176590-07:00" level=debug msg="Programming external connectivity on endpoint gateway_ingress-sbox (995c1dc135ae392aea95fa8b60d7e6b521809f5145c3023c9a3549985108f35a)"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.143381746-07:00" level=debug msg="EnableService ingress-sbox START"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.143397736-07:00" level=debug msg="addServiceInfoToCluster START for c1e695844a1e136c44dca60d541abea4638a05b8bb79695bf2f3924eeda01670"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.143471284-07:00" level=debug msg="addContainerNameResolution c1e695844a1e136c44dca60d541abea4638a05b8bb79695bf2f3924eeda01670 ingress-endpoint"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.143498455-07:00" level=debug msg="addServiceInfoToCluster END for c1e695844a1e136c44dca60d541abea4638a05b8bb79695bf2f3924eeda01670"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.143507723-07:00" level=debug msg="EnableService ingress-sbox DONE"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.143517050-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -nL DOCKER-INGRESS]"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.145068347-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -n -L DOCKER-USER]"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.146432643-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C DOCKER-USER -j RETURN]"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.148080221-07:00" level=debug msg="/usr/sbin/iptables, [--wait -t filter -C FORWARD -j DOCKER-USER]"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.149907006-07:00" level=debug msg="/usr/sbin/iptables, [--wait -D FORWARD -j DOCKER-USER]"
Jul 26 16:20:35 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:35.151916173-07:00" level=debug msg="/usr/sbin/iptables, [--wait -I FORWARD -j DOCKER-USER]"
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.698570245-07:00" level=debug msg="Calling GET /version"
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.707767751-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.754850293-07:00" level=debug msg="Calling GET /version"
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.763296415-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.842663284-07:00" level=debug msg="node status updated" method="(*Dispatcher).processUpdates" module=dispatcher node.id=khuop19miiunsw64l9s0dknq0
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.843529863-07:00" level=info msg="worker khuop19miiunsw64l9s0dknq0 was successfully registered" method="(*Dispatcher).register"
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.844256640-07:00" level=debug msg="node registered" method="(*LogBroker).ListenSubscriptions" node=khuop19miiunsw64l9s0dknq0
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.844269885-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.882423295s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:37.844289251-07:00" level=debug method="(*Dispatcher).Assignments" node.id=khuop19miiunsw64l9s0dknq0 node.session=60t1jll63qvo1sq352sdve35g
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.226286556-07:00" level=debug msg="Calling GET /version"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.235201961-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.300970519-07:00" level=debug msg="memberlist: Stream connection from=n3.d.d.d:54614"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.301298406-07:00" level=info msg="Node 37d990438d5e/n4.d.d.d, joined gossip cluster"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.301339833-07:00" level=info msg="Node 37d990438d5e/n4.d.d.d, added to nodes list"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.301361474-07:00" level=info msg="Node 2db9c99f94a7/n3.d.d.d, joined gossip cluster"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.301376913-07:00" level=info msg="Node 2db9c99f94a7/n3.d.d.d, added to nodes list"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.847684813-07:00" level=debug msg="node status updated" method="(*Dispatcher).processUpdates" module=dispatcher node.id=irmicohs5k1sr4ffb3qth7xgu
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.848115483-07:00" level=info msg="worker irmicohs5k1sr4ffb3qth7xgu was successfully registered" method="(*Dispatcher).register"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.848756989-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.613483274s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.848775223-07:00" level=debug msg="node registered" method="(*LogBroker).ListenSubscriptions" node=irmicohs5k1sr4ffb3qth7xgu
Jul 26 16:20:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:38.848869411-07:00" level=debug method="(*Dispatcher).Assignments" node.id=irmicohs5k1sr4ffb3qth7xgu node.session=f8dxghpcbn2aikj6zy48aiadq
Jul 26 16:20:39 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:39.103439556-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:39 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:39.103739349-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.092685742s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:39 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:39.103917645-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.092685742s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:41 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:41.462153210-07:00" level=debug msg="memberlist: Stream connection from=n3.d.d.d:54616"
Jul 26 16:20:42 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:42.727840332-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.331682653s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:43.463345522-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.444187876s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:44 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:44.197125521-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:44 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:44.197412500-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.615589591s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:44 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:44.197520123-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.615589591s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:48.060333395-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.577166968s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:48.259337906-07:00" level=debug msg="Calling GET /version"
Jul 26 16:20:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:48.268644105-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:20:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:48.813668491-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:48.813971712-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.333102854s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:48.814180795-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.333102854s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:48.908744080-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.650918416s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:52 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:52.639087853-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.41253572s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:53 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:53.560846036-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.043081292s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:54 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:54.148357752-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:54 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:54.148651094-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.147398104s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:54 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:54.148826804-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.147398104s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:58 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:58.052717818-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.787688229s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:58 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:58.283263268-07:00" level=debug msg="Calling GET /version"
Jul 26 16:20:58 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:58.292420117-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:20:58 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:58.605446264-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.498620423s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:59 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:59.297185438-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:20:59 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:59.297608784-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.833050908s" method="(*Dispatcher).Heartbeat"
Jul 26 16:20:59 n2.addr.org dockerd[348258]: time="2022-07-26T16:20:59.297803881-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.833050908s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:02 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:02.842064672-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.63028748s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.105486186-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.260654803s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.131839160-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.132017736-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.166832873s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.132201672-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.166832873s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.419116904-07:00" level=debug msg="n2.addr.org(d1d86763daee): Initiating bulk sync with node 37d990438d5e"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.419146811-07:00" level=debug msg="n2.addr.org(d1d86763daee): Initiating unsolicited bulk sync for networks [8hyprs12unlyysaz2pzu7f477] with node 37d990438d5e"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420193819-07:00" level=debug msg="memberlist: Stream connection from=n4.d.d.d:41806"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420379569-07:00" level=debug msg="n2.addr.org(d1d86763daee): Bulk sync to node 37d990438d5e took 876.589µs"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420402852-07:00" level=debug msg="handleEpTableEvent ADD 1fffc2c2f381c9e06d54e0417348038fbd7ebeb8f0c028131795f07d1247ff51 R:{ingress-endpoint <nil> 10.0.0.3 [] [] [] false}"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420509713-07:00" level=debug msg="checkEncryption(8hyprs1, n3.d.d.d, 4096, false)"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420613218-07:00" level=debug msg="addContainerNameResolution 1fffc2c2f381c9e06d54e0417348038fbd7ebeb8f0c028131795f07d1247ff51 ingress-endpoint"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420632845-07:00" level=debug msg="handleEpTableEvent ADD c16c86273efae1973b7072706275a54741c5b96163125abc7f3d3caf0151b659 R:{ingress-endpoint <nil> 10.0.0.4 [] [] [] false}"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420699540-07:00" level=debug msg="addContainerNameResolution c16c86273efae1973b7072706275a54741c5b96163125abc7f3d3caf0151b659 ingress-endpoint"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420880030-07:00" level=debug msg="Neighbor entry added for IP:10.0.0.3, mac:02:42:0a:00:00:03 on ifc:vx-001000-8hypr"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420979306-07:00" level=debug msg="Neighbor entry added for IP:n3.d.d.d, mac:02:42:0a:00:00:03 on ifc:vx-001000-8hypr"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.420999174-07:00" level=debug msg="checkEncryption(8hyprs1, n4.d.d.d, 4096, false)"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.421085326-07:00" level=debug msg="Neighbor entry added for IP:10.0.0.4, mac:02:42:0a:00:00:04 on ifc:vx-001000-8hypr"
Jul 26 16:21:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:04.421176157-07:00" level=debug msg="Neighbor entry added for IP:n4.d.d.d, mac:02:42:0a:00:00:04 on ifc:vx-001000-8hypr"
Jul 26 16:21:07 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:07.473978719-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.146851317s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:07 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:07.859837111-07:00" level=debug msg="memberlist: Stream connection from=n4.d.d.d:41810"
Jul 26 16:21:08 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:08.307703182-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:08 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:08.316811179-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:21:09 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:09.299427348-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:09 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:09.299780823-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.901800871s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:09 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:09.299940123-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.901800871s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:09 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:09.367646907-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.809488888s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:12 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:12.091992490-07:00" level=debug msg="memberlist: Initiating push/pull sync with: n4.d.d.d:7946"
Jul 26 16:21:12 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:12.621995358-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.384764148s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:14 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:14.178478879-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.084393109s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:14 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:14.201855736-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:14 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:14.202179415-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.937751637s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:14 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:14.202411541-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.937751637s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:18.008313168-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.618728732s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:18.331440777-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:18.340995193-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:21:19 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:19.140445423-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:19 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:19.140886863-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.584537029s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:19 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:19.141093020-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.584537029s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:19 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:19.263850028-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.528122603s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:22 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:22.628097361-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.138032058s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:23 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:23.726266702-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:23 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:23.726635365-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.368883325s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:23 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:23.726810344-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.368883325s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:23 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:23.793246187-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.632999899s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:27 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:27.767603299-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.12682685s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:28 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:28.355238543-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:28 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:28.364579488-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:21:28 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:28.426988682-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.336921549s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:29 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:29.096222567-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:29 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:29.096554712-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.582272188s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:29 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:29.096750670-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.582272188s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:30 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:30.012531204-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:30 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:30.021635664-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:21:32 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:32.895155180-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.906431301s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:33.680118156-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:33.680487631-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.642778949s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:33.680639677-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.642778949s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:33 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:33.764562813-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.213952101s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:34.419793745-07:00" level=debug msg="n2.addr.org(d1d86763daee): Initiating bulk sync with node 37d990438d5e"
Jul 26 16:21:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:34.419823280-07:00" level=debug msg="n2.addr.org(d1d86763daee): Initiating unsolicited bulk sync for networks [8hyprs12unlyysaz2pzu7f477] with node 37d990438d5e"
Jul 26 16:21:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:34.420646338-07:00" level=debug msg="memberlist: Stream connection from=n4.d.d.d:41814"
Jul 26 16:21:34 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:34.420799857-07:00" level=debug msg="n2.addr.org(d1d86763daee): Bulk sync to node 37d990438d5e took 598.987µs"
Jul 26 16:21:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:37.300356090-07:00" level=debug msg="memberlist: Stream connection from=n3.d.d.d:54626"
Jul 26 16:21:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:37.300536940-07:00" level=debug msg="n2.addr.org(d1d86763daee): Initiating bulk sync for networks [8hyprs12unlyysaz2pzu7f477] with node 2db9c99f94a7"
Jul 26 16:21:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:37.802767659-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.516707976s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:37 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:37.860743614-07:00" level=debug msg="memberlist: Stream connection from=n4.d.d.d:41816"
Jul 26 16:21:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:38.323697955-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:38.324165494-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.754909934s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:38.324360430-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.754909934s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:38.389036014-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:38.398220285-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:21:38 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:38.980139486-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.90470598s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:41 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:41.464288104-07:00" level=debug msg="memberlist: Stream connection from=n3.d.d.d:54628"
Jul 26 16:21:42 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:42.092793083-07:00" level=debug msg="memberlist: Initiating push/pull sync with: n3.d.d.d:7946"
Jul 26 16:21:42 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:42.320883068-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.261976236s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:42 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:42.715739994-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:42 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:42.724968757-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.077692246-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.080297335-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.080508993-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.58892533s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.080652773-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.58892533s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.087829488-07:00" level=debug msg="Calling POST /services/create"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.088026608-07:00" level=debug msg="form data: {\"EndpointSpec\":{\"Ports\":[]},\"Labels\":{},\"Mode\":{\"Replicated\":{\"Replicas\":0}},\"Name\":\"7228d680-17d5-43f3-ad99-1dff87e9f87f\",\"TaskTemplate\":{\"ContainerSpec\":{\"Command\":[\"/bin/sh\",\"-c\",\"python /src/qcsession-xnat.py --session XNAT_E00002 --overwrite True --host $XNAT_HOST --user $XNAT_USER --pass $XNAT_PASS --upload-by-ref False --cleanup True --proc_steps 'initialisation:isphantom:,phantomqc' --dicomdir /dicom --niftidir /nifti\"],\"Env\":[\"XNAT_USER=c01c47cc-fb01-43f0-90dd-570a4a775a80\",\"XNAT_EVENT_ID=108\",\"XNAT_WORKFLOW_ID=108\",\"XNAT_HOST=https://n1.d.d.d\",\"XNAT_PASS=ib1CtbnZay6e1XAMPARosmPziHmEaYUlrtOwM4PcbUSlsFBpTyXsEvNQG3Ios1q5\"],\"Image\":\"qcsession-xnat:0.1\",\"Labels\":{},\"Mounts\":[{\"ReadOnly\":false,\"Source\":\"/data/xnat/build/905c4799-dc8f-4a8e-89fe-d3654aba966a\",\"Target\":\"/nifti\"},{\"ReadOnly\":false,\"Source\":\"/var/run/docker.sock\",\"Target\":\"/var/run/docker.sock\"}],\"Sysctls\":{},\"User\":\"\"},\"Placement\":{\"Constraints\":[\"==\"]},\"Resources\":{\"Limits\":{\"MemoryBytes\":0,\"NanoCPUs\":0},\"Reservations\":{\"MemoryBytes\":0}},\"RestartPolicy\":{\"Condition\":\"none\"}}}"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.088832434-07:00" level=warning msg="invalid authconfig: invalid character '\\u009e' looking for beginning of value"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089104505-07:00" level=debug msg="error handling rpc" error="key '' is invalid" rpc=/docker.swarmkit.v1.Control/CreateService
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089219672-07:00" level=error msg="Error creating service 7228d680-17d5-43f3-ad99-1dff87e9f87f: rpc error: code = Unknown desc = key '' is invalid"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089253966-07:00" level=debug msg="FIXME: Got an API for which error does not match any expected type!!!: rpc error: code = Unknown desc = key '' is invalid" error_type="*status.statusError" module=api
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089269876-07:00" level=error msg="Handler for POST /services/create returned error: rpc error: code = Unknown desc = key '' is invalid"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089280937-07:00" level=debug msg="FIXME: Got an API for which error does not match any expected type!!!: rpc error: code = Unknown desc = key '' is invalid" error_type="*status.statusError" module=api
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.885662275-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.82798545s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:47 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:47.584507186-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.65846951s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:47 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:47.670593680-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:47 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:47.671310327-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.042654107s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:47 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:47.671619559-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.042654107s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:48.411977817-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:48.421121540-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:21:48 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:48.714339758-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.075135964s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:52 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:52.243692464-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.451402226s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:52 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:52.714857610-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:52 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:52.715194894-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.623605084s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:52 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:52.715397435-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.623605084s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:53 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:53.790208216-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.964559504s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:57 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:57.339443897-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:57 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:57.339819914-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 4.84340556s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:57 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:57.340013888-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 4.84340556s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:21:57 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:57.695997765-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.972124807s" method="(*Dispatcher).Heartbeat"
Jul 26 16:21:58 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:58.445204903-07:00" level=debug msg="Calling GET /version"
Jul 26 16:21:58 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:58.455323550-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:21:58 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:58.755991576-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.129841037s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:02 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:02.183987847-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:22:02 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:02.184434677-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.122080439s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:02 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:02.184705847-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.122080439s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:22:02 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:02.669748976-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.757420087s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:03 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:03.886494783-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.819614281s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:04.419487623-07:00" level=debug msg="n2.addr.org(d1d86763daee): Initiating bulk sync with node 37d990438d5e"
Jul 26 16:22:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:04.419569887-07:00" level=debug msg="n2.addr.org(d1d86763daee): Initiating unsolicited bulk sync for networks [8hyprs12unlyysaz2pzu7f477] with node 37d990438d5e"
Jul 26 16:22:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:04.420726031-07:00" level=debug msg="memberlist: Stream connection from=n4.d.d.d:41820"
Jul 26 16:22:04 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:04.420883848-07:00" level=debug msg="n2.addr.org(d1d86763daee): Bulk sync to node 37d990438d5e took 736.374µs"
Jul 26 16:22:07 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:07.307395341-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:22:07 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:07.308043499-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.364116577s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:07 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:07.308261059-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.364116577s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:22:07 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:07.428288917-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.662256039s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:08 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:08.469642949-07:00" level=debug msg="Calling GET /version"
Jul 26 16:22:08 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:08.479849171-07:00" level=debug msg="Calling GET /swarm"
Jul 26 16:22:08 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:08.706887557-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.007790145s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:11 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:11.465971076-07:00" level=debug msg="memberlist: Stream connection from=n3.d.d.d:54634"
Jul 26 16:22:12 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:12.091980665-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 5.12363716s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:12 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:12.093617813-07:00" level=debug msg="memberlist: Initiating push/pull sync with: n3.d.d.d:7946"
Jul 26 16:22:12 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:12.673105564-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:22:12 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:12.673652352-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.058188208s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:12 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:12.673916108-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.058188208s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:22:13 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:13.715288009-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 4.760970922s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:17.217091306-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat khuop19miiunsw64l9s0dknq0 <nil> n4.d.d.d:42596}, expect next heartbeat in 4.979321021s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:17.732460450-07:00" level=debug msg="sending heartbeat to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377} with timeout 5s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:22:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:17.732981811-07:00" level=debug msg="received heartbeat from worker {[swarm-manager] yc5bdt7otol64gcld03xwwdat qp1bbekd8qj7tolthzjvwd3m2 <nil> n2.d.d.d:33322}, expect next heartbeat in 5.01860891s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:17 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:17.733190233-07:00" level=debug msg="heartbeat successful to manager {qp1bbekd8qj7tolthzjvwd3m2 n2.d.d.d:2377}, next heartbeat period: 5.01860891s" method="(*session).heartbeat" module=node/agent node.id=qp1bbekd8qj7tolthzjvwd3m2 session.id=267e55dkdiweuu9d8ppflukrq sessionID=267e55dkdiweuu9d8ppflukrq
Jul 26 16:22:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:18.476912585-07:00" level=debug msg="received heartbeat from worker {[swarm-worker] yc5bdt7otol64gcld03xwwdat irmicohs5k1sr4ffb3qth7xgu <nil> n3.d.d.d:59650}, expect next heartbeat in 5.305230212s" method="(*Dispatcher).Heartbeat"
Jul 26 16:22:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:18.492804348-07:00" level=debug msg="Calling GET /version"
Jul 26 16:22:18 n2.addr.org dockerd[348258]: time="2022-07-26T16:22:18.503074550-07:00" level=debug msg="Calling GET /swarm"

swarm_logs.txt

John Flavin

unread,

Jul 27, 2022, 10:54:48 AM7/27/22

to xnat_di...@googlegroups.com

TL;DR

My hypothesis is that in your server settings, someone clicked the "Add constraint" button but never filled it out. If that is correct you can fix it by editing your container host settings (Administer > Plugin Settings > Container Host); scroll down to the Swarm Node Constraints and click the X to remove the empty constraint.

https://wiki.xnat.org/display/CSDEV/Configuring+a+Container+Host

DETAILS

Thanks for the detailed logs. I was able to look through them and find the two things I needed: the message sent by the container service and the error message that it caused docker to generate. Let's go through the relevant part of the logs.

These are the messages logged when docker received the container service's attempt at creating the swarm service. I'll leave them here to reference for later.

Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.087829488-07:00" level=debug msg="Calling POST /services/create"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.088026608-07:00" level=debug msg="form data: {\"EndpointSpec\":{\"Ports\":[]},\"Labels\":{},\"Mode\":{\"Replicated\":{\"Replicas\":0}},\"Name\":\"7228d680-17d5-43f3-ad99-1dff87e9f87f\",\"TaskTemplate\":{\"ContainerSpec\":{\"Command\":[\"/bin/sh\",\"-c\",\"python /src/qcsession-xnat.py --session XNAT_E00002 --overwrite True --host $XNAT_HOST --user $XNAT_USER --pass $XNAT_PASS --upload-by-ref False --cleanup True --proc_steps 'initialisation:isphantom:,phantomqc' --dicomdir /dicom --niftidir /nifti\"],\"Env\":[\"XNAT_USER=c01c47cc-fb01-43f0-90dd-570a4a775a80\",\"XNAT_EVENT_ID=108\",\"XNAT_WORKFLOW_ID=108\",\"XNAT_HOST=https://n1.d.d.d\",\"XNAT_PASS=ib1CtbnZay6e1XAMPARosmPziHmEaYUlrtOwM4PcbUSlsFBpTyXsEvNQG3Ios1q5\"],\"Image\":\"qcsession-xnat:0.1\",\"Labels\":{},\"Mounts\":[{\"ReadOnly\":false,\"Source\":\"/data/xnat/build/905c4799-dc8f-4a8e-89fe-d3654aba966a\",\"Target\":\"/nifti\"},{\"ReadOnly\":false,\"Source\":\"/var/run/docker.sock\",\"Target\":\"/var/run/docker.sock\"}],\"Sysctls\":{},\"User\":\"\"},\"Placement\":{\"Constraints\":[\"==\"]},\"Resources\":{\"Limits\":{\"MemoryBytes\":0,\"NanoCPUs\":0},\"Reservations\":{\"MemoryBytes\":0}},\"RestartPolicy\":{\"Condition\":\"none\"}}}"

Next is this:

Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.088832434-07:00" level=warning msg="invalid authconfig: invalid character '\\u009e' looking for beginning of value"

This is a warning about an invalid character. But I can't find that character anywhere in the JSON that the CS sent and it isn't an error so I guess we will just ignore it.

This is the actual error. It gets logged a few times as it gets passed around various internal parts of docker.

Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089104505-07:00" level=debug msg="error handling rpc" error="key '' is invalid" rpc=/docker.swarmkit.v1.Control/CreateService
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089219672-07:00" level=error msg="Error creating service 7228d680-17d5-43f3-ad99-1dff87e9f87f: rpc error: code = Unknown desc = key '' is invalid"

These are kind of funny to me. It looks like the error message that was generated somewhere deep within docker's internals isn't a standard format and someone working on a different part of docker's internals left a note about that with a "FIXME" message as they passed the error around.

Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089253966-07:00" level=debug msg="FIXME: Got an API for which error does not match any expected type!!!: rpc error: code = Unknown desc = key '' is invalid" error_type="*status.statusError" module=api
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089269876-07:00" level=error msg="Handler for POST /services/create returned error: rpc error: code = Unknown desc = key '' is invalid"
Jul 26 16:21:43 n2.addr.org dockerd[348258]: time="2022-07-26T16:21:43.089280937-07:00" level=debug msg="FIXME: Got an API for which error does not match any expected type!!!: rpc error: code = Unknown desc = key '' is invalid" error_type="*status.statusError" module=api

Ok, that's all the relevant logs. What can we learn from the error? First is the "msg":

error handling rpc

This doesn't tell us anything we didn't know. RPC means "remote procedure call"; this is just saying "I received a message from outside and handling it caused an error". Next is the "error":

key '' is invalid

This part is new information to us. Docker is reading the JSON message we sent, trying to parse it into various internal data structures. Somewhere in that JSON docker is trying to turn something into a key, but whatever it's looking at is empty. Now let's look back at the JSON and figure out what could cause that error.

Everything in the JSON looks pretty ordinary to me except for one thing:

\"Placement\":{\"Constraints\":[\"==\"]}

This is setting a node placement constraint. The constraint value here is just "=="; usually the placement constraints are in the form "{key}{comparator}{value}", but there isn't any key or value here, only the comparator "==". That is consistent with the error message, as docker is trying to parse a key from the string "==" but it only finds a comparator.

Assuming that this is all correct leads me to the hypothesis I gave above: your container host settings in container service have a constraint with no details. You should be able to fix it by removing that constraint from your settings. And on our end, I'll make a ticket to add some validation / checks for these kinds of "empty" constraints.

John Flavin

Backend Team Lead

johnf...@flywheel.io

He/Him

flywheel.io

To view this discussion on the web visit https://groups.google.com/d/msgid/xnat_discussion/ef405b2c-b35d-4f33-b6d9-8a42c162bda4n%40googlegroups.com.

Chidi Ugonna

unread,

Jul 27, 2022, 11:38:40 AM7/27/22

to xnat_discussion

John, thank you! That was exactly the problem! Indeed someone (who shall remain nameless i.e. me!) clicked the add add constraint button but then left it blank as shown below. Just needed to click on the "x" as you suggested to fix the problem.

Thanks so much for the detailed and clear explanations - I really appreciate it and learned a lot.

Best,

Chidi

Reply all

Reply to author

Forward

0 new messages