I forgot to add the pfconnector-server.log is full of connections and
re-connections to many switches and other servers ports, but they don't
look as errors...
A snippet of the log is in attachment.
Regards,
Massimiliano Ballerini
On 27/07/2023 12:11, Massimiliano Ballerini wrote:
Hello,
I have a cluster of 3 server with packetfence 12.2.
We noticed the pfconnector service keep increasing ram usage over time
costantly on all 3 servers. I have standard load balancing of services
in the cluster, so web interface on the first one, radius etc on the
others. If I restart all pf services the ram usage is reset almost to
zero for the service pfconnector, and then it starts again to increase.
I've been searching online for this pfconnector service and ram usage,
but found nothing. Is anyone familiar with this behavior?
Here's the top of the 3 servers:
SERVER1:
PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND
4002511 root 20 0 6101832 3.8g 7700 S 3.0 24.1 1994:47
/usr/local/pf/sbin/pfconnector server --host 100.64.0.1,127.0.0.1
--port 22226 --reverse
uptime 11:56:49 up 78 days, 21:00
(pf restarted 24 days ago)
SERVER 2:
PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND
2928 root 20 0 15.6g 11.3g 7080 S 2.9 72.4 11412:50
/usr/local/pf/sbin/pfconnector server --host 100.64.0.1,127.0.0.1
--port 22226 --reverse
uptime 11:03:38 up 78 days
SERVER 3:
PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND
2727 root 20 0 15.4g 10.7g 5680 S 0.7 68.7 11476:19
/usr/local/pf/sbin/pfconnector server --host 100.64.0.1,127.0.0.1
--port 22226 --reverse
uptime 10:09:26 up 78 days
Regards,
Massimiliano
--
Massimiliano Ballerini
Laboratori Guglielmo Marconi
Via Porrettana, 123 - 40037 Pontecchio Marconi (BO)
e-mail: massimiliano.baller...@labs.it
web: http://www.labs.it
mob: +39 349 2600513
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/login"; pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/login"; pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/login"; pid=1
Jul 27 11:53:54 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:54+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:53:56 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:56+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:53:58 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:53:58+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:53:58 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:53:58 server: session#1: tun: proxy#R:41669=>X.X.5.5:161/udp: Listening
Jul 27 11:53:59 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:53:59 server: session#1: tun: proxy#R:35651=>X.X.46.11:161/udp: Closing due to inactivity timeout
Jul 27 11:53:59 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:53:59 server: session#1: tun: proxy#R:34993=>X.X.26.8:161/udp: Cleared entry from active dynamic reverses
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:53:49.671795691 +0200 CEST m=+1984907.688633027" pid=1
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:53:49.671795691 +0200 CEST m=+1984907.688633027" pid=1
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=dbug msg="Item local_connector has been detected as expired in pfconfig. Reloading." pid=1
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=dbug msg="Adding object local_connector" pid=1
Jul 27 11:54:01 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:01+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:02 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:02 server: session#1: tun: proxy#R:46697=>X.X.55.6:161/udp: Closing due to inactivity timeout
Jul 27 11:54:02 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:02+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:02 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:02 server: session#1: tun: proxy#R:34219=>X.X.55.6:161/udp: Listening
Jul 27 11:54:04 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:04 server: session#1: tun: proxy#R:39769=>X.X.14.7:161/udp: Closing due to inactivity timeout
Jul 27 11:54:05 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:05+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:01.550443229 +0200 CEST m=+1984919.567279305" pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:01.550443229 +0200 CEST m=+1984919.567279305" pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=dbug msg="Item local_connector has been detected as expired in pfconfig. Reloading." pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=dbug msg="Adding object local_connector" pid=1
Jul 27 11:54:08 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:08+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Handling GET /api/v1/pfconnector/all-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 0001-01-01 00:00:00 +0000 UTC" pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 0001-01-01 00:00:00 +0000 UTC" pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/login"; pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/login"; pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/login"; pid=1
Jul 27 11:54:09 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:09+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:11 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:11+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:14 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:14 server: session#1: tun: proxy#R:46805=>X.X.3.229:161/udp: Cleared entry from active dynamic reverses
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:08.910468034 +0200 CEST m=+1984926.927304108" pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:08.910468034 +0200 CEST m=+1984926.927304108" pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=dbug msg="Item local_connector has been detected as expired in pfconfig. Reloading." pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=dbug msg="Adding object local_connector" pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:15+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:15 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:15 server: session#1: tun: proxy#R:43925=>X.X.8.8:161/udp: Listening
Jul 27 11:54:19 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:19 server: session#1: tun: proxy#R:39173=>X.X.8.9:161/udp: Closing due to inactivity timeout
Jul 27 11:54:20 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:20 server: session#1: tun: proxy#R:34277=>X.X.52.5:161/udp: Listening
Jul 27 11:54:20 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:20+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:20 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:20 server: session#1: tun: proxy#R:45769=>X.X.17.6:161/udp: Cleared entry from active dynamic reverses
Jul 27 11:54:20 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:20 server: session#1: tun: proxy#R:45817=>X.X.54.6:161/udp: Cleared entry from active dynamic reverses
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:15.952636956 +0200 CEST m=+1984933.969473029" pid=1
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:15.952636956 +0200 CEST m=+1984933.969473029" pid=1
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=dbug msg="Item local_connector has been detected as expired in pfconfig. Reloading." pid=1
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=dbug msg="Adding object local_connector" pid=1
Jul 27 11:54:22 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:22+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:23 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:23+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Handling GET /api/v1/pfconnector/all-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 0001-01-01 00:00:00 +0000 UTC" pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 0001-01-01 00:00:00 +0000 UTC" pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/login"; pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/login"; pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/login"; pid=1
Jul 27 11:54:24 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:24+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:26 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:26+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:26 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:26 server: session#1: tun: proxy#R:34617=>X.X.3.230:161/udp: Cleared entry from active dynamic reverses
Jul 27 11:54:27 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:27 server: session#1: tun: proxy#R:34813=>X.X.15.6:161/udp: Closing due to inactivity timeout
Jul 27 11:54:29 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:29 server: session#1: tun: proxy#R:41963=>X.X.25.11:161/udp: Cleared entry from active dynamic reverses
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:22.240265821 +0200 CEST m=+1984940.257101895" pid=1
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:22.240265821 +0200 CEST m=+1984940.257101895" pid=1
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=dbug msg="Item local_connector has been detected as expired in pfconfig. Reloading." pid=1
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=dbug msg="Adding object local_connector" pid=1
Jul 27 11:54:31 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:31+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:34 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:34 server: session#1: tun: proxy#R:36339=>X.X.10.8:161/udp: Closing due to inactivity timeout
Jul 27 11:54:35 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:35+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:35 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:35+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:35 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:35 server: session#1: tun: proxy#R:41701=>X.X.63.5:161/udp: Listening
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:31.542298967 +0200 CEST m=+1984949.559135040" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:31.542298967 +0200 CEST m=+1984949.559135040" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Item local_connector has been detected as expired in pfconfig. Reloading." pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Adding object local_connector" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:39 server: session#1: tun: proxy#R:44617=>X.X.3.231:161/udp: Cleared entry from active dynamic reverses
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Handling GET /api/v1/pfconnector/all-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 0001-01-01 00:00:00 +0000 UTC" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 0001-01-01 00:00:00 +0000 UTC" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/login"; pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.3:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/login"; pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.1.8:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Request isn't authorized, performing login against the Unified API" pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/login"; pid=1
Jul 27 11:54:39 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:39+0200 lvl=info msg="Calling Unified API on uri: https://X.X.255.108:9999/api/v1/pfconnector/local-fingerbank-collector-endpoints"; pid=1
Jul 27 11:54:41 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:41+0200 lvl=info msg="Handling GET /api/v1/pfconnector/local-fingerbank-collector-endpoints" pid=1
Jul 27 11:54:44 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:44 server: session#1: tun: proxy#R:33427=>X.X.62.5:161/udp: Closing due to inactivity timeout
Jul 27 11:54:45 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:45 server: session#1: tun: proxy#R:33325=>X.X.8.8:161/udp: Closing due to inactivity timeout
Jul 27 11:54:48 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:48 server: session#1: tun: proxy#R:33757=>X.X.64.5:161/udp: Closing due to inactivity timeout
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:39.052326377 +0200 CEST m=+1984957.069162451" pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=dbug msg="Memory configuration is more than 5 seconds old. Considering config::Connector() as invalid do reload it." pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=dbug msg="Resource is not valid anymore. Was loaded at 2023-07-27 11:54:39.052326377 +0200 CEST m=+1984957.069162451" pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=dbug msg="Item local_connector has been detected as expired in pfconfig. Reloading." pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=dbug msg="Adding object local_connector" pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:49+0200 lvl=dbug msg="Memory configuration was never loaded. Considering config::Connector() as invalid do the initial load." pid=1
Jul 27 11:54:49 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:49 server: session#1: tun: proxy#R:43143=>X.X.27.11:161/udp: Listening
Jul 27 11:54:50 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:50 server: session#1: tun: proxy#R:43283=>X.X.52.5:161/udp: Closing due to inactivity timeout
Jul 27 11:54:51 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:51+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
Jul 27 11:54:51 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: 2023/07/27 11:54:51 server: session#1: tun: proxy#R:39073=>X.X.67.5:161/udp: Listening
Jul 27 11:54:52 smw-lgm-nac pfconnector-server-docker-wrapper[4002399]: t=2023-07-27T11:54:52+0200 lvl=info msg="Handling POST /api/v1/pfconnector/dynreverse" pid=1
_______________________________________________
PacketFence-users mailing list
PacketFence-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/packetfence-users
