search

glpi-project / glpi-agent

GLPI Agent
GNU General Public License v2.0
251 stars 62 forks source link

Agent fails to communicate with GLPI server using glpi proxy agent #438

Closed Blank-Vcf closed 1 year ago

Blank-Vcf commented 1 year ago

Bug reporting acknowledgment

Yes, I read it

Professional support

None

Describe the bug

Agent 1.5 installer on windows machine contact glpi agent installed on windows server as proxy. When agent send inventory, everything work but computer is not imported/assigned to entity. If the same agent is configured to use glpi directly, rules match and computer is imported in the right entity.

To reproduce

proxy have proxy-server-plugin.local with:

disabled = no
glpi_protocol = yes
local_store = D:\inventory
log on proxy
[Mon Jul  3 15:33:41 2023][debug] [http server] POST request /proxy/glpi from client 10.xxx.xxx.xxx
[Mon Jul  3 15:33:41 2023][debug2] [proxy server plugin] application/x-compress-zlib type request from 10.xxx.xxx.xxx
[Mon Jul  3 15:33:41 2023][debug] [proxy server plugin] Got legacy PROLOG request from 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx
[Mon Jul  3 15:33:41 2023][debug] [proxy server plugin] Answering to 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx client to immediatly use GLPI protocol
[Mon Jul  3 15:33:41 2023][debug] [http server] response status 202
[Mon Jul  3 15:33:41 2023][debug] [http server] POST request /proxy/glpi from client 10.xxx.xxx.xxx
[Mon Jul  3 15:33:41 2023][debug2] [proxy server plugin] 99D466F3: application/x-compress-zlib type request from 10.xxx.xxx.xxx
[Mon Jul  3 15:33:41 2023][debug] [proxy server plugin] 99D466F3: contact proxy request from 10.xxx.xxx.xxx, agentid is 2e116056-73c3-1014-bfe6-8d4a66fbebbe
[Mon Jul  3 15:33:41 2023][debug2] [http client] Using Compress::Zlib for compression
[Mon Jul  3 15:33:41 2023][debug] [proxy server plugin] 99D466F3: Submitting contact from 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx to http:/glpi-srv/glpi/marketplace/glpiinventory
[Mon Jul  3 15:33:41 2023][debug2] [http client] 7532D2C8: sending message:
{
   "action": "contact",
   "deviceid": "pc-xxxx-2023-04-27-09-54-13",
   "enabled-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "httpd-plugins": {},
   "httpd-port": "62354",
   "installed-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "name": "GLPI-Agent",
   "tag": "GLPI_Agents_TAG",
   "version": "1.5"
}
[Mon Jul  3 15:33:41 2023][debug2] format: Zlib
[Mon Jul  3 15:33:41 2023][debug2] [http client] 7532D2C8: received message:
{"message":"remoteinventory task not supported","disabled":["remoteinventory"],"expiration":"24","status":"ok","tasks":{"collect":{"version":"1.2.1","server":"glpiinventory"},"deploy":{"version":"1.2.1","server":"glpiinventory"},"inventory":{"server":"glpi","version":"10.0.8-dev"}}}
[Mon Jul  3 15:33:41 2023][debug] [proxy server plugin] 99D466F3: Setting prolog_freq to 86400
[Mon Jul  3 15:33:41 2023][info] [proxy server plugin] 99D466F3: 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx contact submitted to http://glpi-srv/glpi/marketplace/glpiinventory
[Mon Jul  3 15:33:41 2023][debug] [http server] response status 200

agent stay in root entity in glpi

agent is using server http://glpi-srv:62354/proxy/glpi en registry

if switching to http://myglpisrv/glpi/marketplace/glpiinventory/ everything is ok

Expected behavior

entities have correct tag rules is: image

Operating system

Linux

GLPI Agent version

Nightly build (git version in additional context below)

GLPI version

development release (See additional context below)

GLPIInventory plugin or FusionInventory for GLPI plugin version

GLPI Inventory v1.1.0

Additional context

No response

g-bougard commented 1 year ago

Hi @Blank-Vcf can you download the inventory from GLPI after it has been uploaded in each context and check the "tag" property ? Was it kept with the same value in the 2 contexts ? If not, are you sure you configured the agent with the same tag when use proxy and when using proxy ?

Blank-Vcf commented 1 year ago

when agent is configured with glpi i found the json in files/_inventories/computer/0 with correct tag with proxy: file is not found on server never on proxy (should be in local with local_store = D:\inventory ? there the proxy one in it) agent is created in glpi. On agent log i have:

[Tue Jul  4 08:06:02 2023][debug] Got GLPI CONTACT pending answer
[Tue Jul  4 08:06:02 2023][info] server0 answer shows it supports GLPI Agent protocol
[Tue Jul  4 08:06:02 2023][info] target server0: server http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 08:06:02 2023][debug2] [http client] Using Compress::Zlib for compression
[Tue Jul  4 08:06:02 2023][info] sending contact request to server0
[Tue Jul  4 08:06:02 2023][debug2] [http client] 59770F40: sending message:
{
   "action": "contact",
   "deviceid": "mypc.mydomain-2023-04-27-09-54-13",
   "enabled-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "httpd-plugins": {},
   "httpd-port": "62354",
   "installed-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "name": "GLPI-Agent",
   "tag": "GLPI_Agents_TAG",
   "version": "1.5"
}
[Tue Jul  4 08:06:02 2023][debug2] [http client] 59770F40: received message:
{
   "expiration": "10s",
   "status": "pending"
}
[Tue Jul  4 08:06:12 2023][debug2] [http client] 59770F40: retry request after pending status
[Tue Jul  4 08:06:12 2023][error] [http client] communication error: 404 Unknown status
[Tue Jul  4 08:06:12 2023][debug2] [http client] received message:
Unknown status
[Tue Jul  4 08:06:12 2023][error] [http client] unexpected content, starting with: Unknown status
[Tue Jul  4 08:06:12 2023][error] No supported answer from server at http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 08:06:12 2023][info] target server0: next run: Tue Jul  4 08:08:12 2023 - http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 08:06:12 2023][debug] Agent memory usage before freeing memory: WSS=37838848 PFU=113442816
[Tue Jul  4 08:06:12 2023][info] GLPI Agent memory usage: WSS=3260416 PFU=113442816

on proxy log:

[Tue Jul  4 08:15:55 2023][debug] [http server] POST request /proxy/glpi from client 10.xxx.xxx.xxx
[Tue Jul  4 08:15:55 2023][debug2] [proxy server plugin] application/x-compress-zlib type request from 10.xxx.xxx.xxx
[Tue Jul  4 08:15:55 2023][debug] [proxy server plugin] Got legacy PROLOG request from 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx
[Tue Jul  4 08:15:55 2023][debug] [proxy server plugin] Answering to 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx client to immediatly use GLPI protocol
[Tue Jul  4 08:15:55 2023][debug] [http server] response status 202
[Tue Jul  4 08:15:55 2023][debug] [http server] POST request /proxy/glpi from client 10.xxx.xxx.xxx
[Tue Jul  4 08:15:55 2023][debug2] [proxy server plugin] BDCA9D26: application/x-compress-zlib type request from 10.xxx.xxx.xxx
[Tue Jul  4 08:15:55 2023][debug] [proxy server plugin] BDCA9D26: contact proxy request from 10.xxx.xxx.xxx, agentid is 2e116056-73c3-1014-bfe6-8d4a66fbebbe
[Tue Jul  4 08:15:55 2023][debug2] [http client] Using Compress::Zlib for compression
[Tue Jul  4 08:15:55 2023][debug] [proxy server plugin] BDCA9D26: Submitting contact from 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx to http://glpi_srvglpi/marketplace/glpiinventory
[Tue Jul  4 08:15:55 2023][debug2] [http client] 61ACB4EA: sending message:
{
   "action": "contact",
   "deviceid": "mypc.mydomain-2023-04-27-09-54-13",
   "enabled-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "httpd-plugins": {},
   "httpd-port": "62354",
   "installed-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "name": "GLPI-Agent",
   "tag": "GLPI_Agents_TAG",
   "version": "1.5"
}
[Tue Jul  4 08:15:56 2023][debug2] format: Zlib
[Tue Jul  4 08:15:56 2023][debug2] [http client] 61ACB4EA: received message:
{"message":"remoteinventory task not supported","disabled":["remoteinventory"],"expiration":"24","status":"ok","tasks":{"collect":{"version":"1.2.1","server":"glpiinventory"},"deploy":{"version":"1.2.1","server":"glpiinventory"},"inventory":{"server":"glpi","version":"10.0.8-dev"}}}
[Tue Jul  4 08:15:56 2023][debug] [proxy server plugin] BDCA9D26: Setting prolog_freq to 86400
[Tue Jul  4 08:15:56 2023][info] [proxy server plugin] BDCA9D26: 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx contact submitted to http://glpi_srv/glpi/marketplace/glpiinventory
[Tue Jul  4 08:15:56 2023][debug] [http server] response status 200
[Tue Jul  4 08:16:06 2023][debug] [http server] GET request /proxy/glpi from client 10.xxx.xxx.xxx
[Tue Jul  4 08:16:06 2023][debug2] [proxy server plugin] BDCA9D26: application/x-compress-zlib type request from 10.xxx.xxx.xxx
[Tue Jul  4 08:16:06 2023][debug] [proxy server plugin] BDCA9D26: Asked for BDCA9D26 request status from 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx
[Tue Jul  4 08:16:06 2023][info] [proxy server plugin] BDCA9D26: Unknown BDCA9D26 request status for 2e116056-73c3-1014-bfe6-8d4a66fbebbe@10.xxx.xxx.xxx
[Tue Jul  4 08:16:06 2023][debug] [http server] response status 404
g-bougard commented 1 year ago

Hi @Blank-Vcf

thank you for that logs.

Indeed they are showing the problem is elsewhere as the contact is sent to the server through the proxy but the proxy seems to fail to submit the answer and so it even doesn't make the inventory. Anyway, regarding your problem, do you mean the computer is moved the root entity after it tried to send the contact request ?

So here, the problem seems to be a proxy issue. By now, I don't understand why it fails to send back the server answer. But first, it seems you didn't share the same log timeslot: you shows different timestamp from proxy & client and REQUESTIDs are differents (59770F40 on the client & BDCA9D26 on the proxy). Of course, I can imagine you will have the same lines logs, but can you validate that ? The best is to take the REQUESTID from the client, and find all the lines related to in the proxy log. This REQUESTID is exactly here for this purpose: trace the request from the client to the server in logs. Indeed I must be sure the REQUESTID didn't change anywhere as it seems the proxy can't find the one the client is looking for.

Blank-Vcf commented 1 year ago

all agent stay in root (filter on my pc) image assets are not created contact ip is my proxy ip

for time stamp, i fall on a logrotage on proxy, log agent are from same agent with a second inventory edit: i'll clean everything and send back full logs

Blank-Vcf commented 1 year ago

proxy log 

[Tue Jul  4 09:53:11 2023][debug] Logger backend File initialized
[Tue Jul  4 09:53:11 2023][debug] GLPI Agent (1.5)
[Tue Jul  4 09:53:11 2023][debug] Configuration directory: D:/GLPI-Agent/etc
[Tue Jul  4 09:53:11 2023][debug] Data directory: D:/GLPI-Agent/share
[Tue Jul  4 09:53:11 2023][debug] Storage directory: D:\GLPI-Agent\var
[Tue Jul  4 09:53:11 2023][debug] Lib directory: D:/GLPI-Agent/perl/agent
[Tue Jul  4 09:53:11 2023][debug] [target local0] Next tasks run planned for Tue Jul  4 10:22:49 2023
[Tue Jul  4 09:53:11 2023][debug] [target server0] Next server contact planned for Wed Jul  5 02:17:33 2023
[Tue Jul  4 09:53:11 2023][debug2] getAvailableTasks() : add of task Collect version 2.9
[Tue Jul  4 09:53:11 2023][debug2] getAvailableTasks() : add of task Deploy version 3.0
[Tue Jul  4 09:53:11 2023][debug2] getAvailableTasks() : add of task ESX version 2.8
[Tue Jul  4 09:53:11 2023][debug2] getAvailableTasks() : add of task Inventory version 1.13
[Tue Jul  4 09:53:11 2023][debug2] getAvailableTasks() : add of task RemoteInventory version 1.2
[Tue Jul  4 09:53:11 2023][debug] Available tasks:
[Tue Jul  4 09:53:11 2023][debug] - Collect: 2.9
[Tue Jul  4 09:53:11 2023][debug] - Deploy: 3.0
[Tue Jul  4 09:53:11 2023][debug] - ESX: 2.8
[Tue Jul  4 09:53:11 2023][debug] - Inventory: 1.13
[Tue Jul  4 09:53:11 2023][debug] - RemoteInventory: 1.2
[Tue Jul  4 09:53:11 2023][debug] target local0: local D:\inventory\
[Tue Jul  4 09:53:11 2023][debug] Planned tasks for local0: Inventory,RemoteInventory
[Tue Jul  4 09:53:11 2023][debug] target server0: server http://glpi_srv/glpi/marketplace/glpiinventory
[Tue Jul  4 09:53:11 2023][debug] Planned tasks for server0: Inventory,ESX,RemoteInventory,Deploy,Collect
[Tue Jul  4 09:53:11 2023][debug] Provided by Teclib Edition
[Tue Jul  4 09:53:11 2023][debug] Installer built on Wed Jun 21 14:27:07 2023 UTC
[Tue Jul  4 09:53:11 2023][debug] Built with Strawberry Perl 5.36.0
[Tue Jul  4 09:53:11 2023][debug] Built on github actions windows image for glpi-project/glpi-agent repository
[Tue Jul  4 09:53:11 2023][info] GLPI Agent service starting
[Tue Jul  4 09:53:11 2023][debug] Trusted target ip: glpi_srv/32, ::ffff:ae5:2af/128
[Tue Jul  4 09:53:11 2023][debug] Trusted client ip/range: 127.0.0.1/32, ::ffff:7f00:1/128, ::1/128
[Tue Jul  4 09:53:11 2023][debug] [http server] Trying to load BasicAuthentication Server plugin
[Tue Jul  4 09:53:11 2023][debug] [basic authentication server plugin] Initializing BasicAuthentication v1.0 Server plugin...
[Tue Jul  4 09:53:11 2023][debug] [basic authentication server plugin] Loading BasicAuthentication Server plugin configuration from D:/GLPI-Agent/etc/basic-authentication-server-plugin.cfg
[Tue Jul  4 09:53:11 2023][debug] [http server] HTTPD BasicAuthentication Server plugin loaded but disabled
[Tue Jul  4 09:53:11 2023][debug] [http server] Trying to load Inventory Server plugin
[Tue Jul  4 09:53:11 2023][debug] [inventory server plugin] Initializing Inventory v1.1 Server plugin...
[Tue Jul  4 09:53:11 2023][debug] [inventory server plugin] Loading Inventory Server plugin configuration from D:/GLPI-Agent/etc/inventory-server-plugin.cfg
[Tue Jul  4 09:53:11 2023][debug] [http server] HTTPD Inventory Server plugin loaded but disabled
[Tue Jul  4 09:53:11 2023][debug] [http server] Trying to load Proxy Server plugin
[Tue Jul  4 09:53:11 2023][debug] [proxy server plugin] Initializing Proxy v2.2 Server plugin...
[Tue Jul  4 09:53:11 2023][debug] [proxy server plugin] Loading Proxy Server plugin configuration from D:/GLPI-Agent/etc/proxy-server-plugin.cfg
[Tue Jul  4 09:53:11 2023][info] [http server] HTTPD Proxy Server plugin loaded
[Tue Jul  4 09:53:11 2023][debug] [http server] Trying to load SecondaryProxy Server plugin
[Tue Jul  4 09:53:11 2023][debug] [proxy2 server plugin] Initializing SecondaryProxy v1.1 Server plugin...
[Tue Jul  4 09:53:11 2023][debug] [proxy2 server plugin] Loading SecondaryProxy Server plugin configuration from D:/GLPI-Agent/etc/proxy2-server-plugin.cfg
[Tue Jul  4 09:53:11 2023][debug] [http server] HTTPD SecondaryProxy Server plugin loaded but disabled
[Tue Jul  4 09:53:11 2023][debug] [http server] Trying to load SSL Server plugin
[Tue Jul  4 09:53:11 2023][debug] [ssl server plugin] Initializing SSL v1.1 Server plugin...
[Tue Jul  4 09:53:11 2023][debug] [ssl server plugin] Loading SSL Server plugin configuration from D:/GLPI-Agent/etc/ssl-server-plugin.cfg
[Tue Jul  4 09:53:11 2023][debug] [http server] HTTPD SSL Server plugin loaded but disabled
[Tue Jul  4 09:53:11 2023][debug] [http server] Trying to load Test Server plugin
[Tue Jul  4 09:53:11 2023][debug] [server test plugin] Initializing Test v1.5 Server plugin...
[Tue Jul  4 09:53:11 2023][debug] [server test plugin] Loading Test Server plugin configuration from D:/GLPI-Agent/etc/server-test-plugin.cfg
[Tue Jul  4 09:53:11 2023][debug] [http server] HTTPD Test Server plugin loaded but disabled
[Tue Jul  4 09:53:11 2023][debug] [http server] Trying to load ToolBox Server plugin
[Tue Jul  4 09:53:11 2023][debug] [toolbox plugin] Initializing ToolBox v1.1 Server plugin...
[Tue Jul  4 09:53:11 2023][debug] [toolbox plugin] Loading ToolBox Server plugin configuration from D:/GLPI-Agent/etc/toolbox-plugin.cfg
[Tue Jul  4 09:53:11 2023][debug] [http server] HTTPD ToolBox Server plugin loaded but disabled
[Tue Jul  4 09:53:11 2023][info] [http server] HTTPD service started on port 62354
[Tue Jul  4 09:53:12 2023][debug2] Looking for Win32_Processor class WMI objects
[Tue Jul  4 09:53:13 2023][debug] Agent memory usage before freeing memory: WSS=117460992 PFU=107278336
[Tue Jul  4 09:53:13 2023][info] GLPI Agent memory usage: WSS=3166208 PFU=107278336
[Tue Jul  4 09:53:13 2023][debug] Running in background mode
[Tue Jul  4 09:53:13 2023][info] target local0: next run: Tue Jul  4 10:22:49 2023 - D:\inventory\
[Tue Jul  4 09:53:13 2023][info] target server0: next run: Wed Jul  5 02:17:33 2023 - http://glpi_srv/glpi/marketplace/glpiinventory
[Tue Jul  4 09:53:23 2023][debug] target local0: init event for Inventory task
[Tue Jul  4 09:53:24 2023][debug] target server0: init event for Inventory task
[Tue Jul  4 09:53:25 2023][debug] target local0: init event for RemoteInventory task
[Tue Jul  4 09:53:26 2023][debug] target server0: init event for ESX task
[Tue Jul  4 09:53:28 2023][debug] target server0: init event for RemoteInventory task
[Tue Jul  4 09:53:30 2023][debug] target server0: init event for Deploy task
[Tue Jul  4 09:53:30 2023][debug] [target server0] New storage maintenance event on deploy task
[Tue Jul  4 09:53:30 2023][debug2] [target server0] Event scheduled in 120 seconds
[Tue Jul  4 09:53:32 2023][debug] target server0: init event for Collect task
[Tue Jul  4 09:53:36 2023][debug] [http server] POST request /proxy/glpi from client ip.agent.x.x
[Tue Jul  4 09:53:36 2023][debug2] [proxy server plugin] application/x-compress-zlib type request from ip.agent.x.x
[Tue Jul  4 09:53:36 2023][debug] [proxy server plugin] Got legacy PROLOG request from 2e116056-73c3-1014-bfe6-8d4a66fbebbe@ip.agent.x.x
[Tue Jul  4 09:53:36 2023][debug] [proxy server plugin] Answering to 2e116056-73c3-1014-bfe6-8d4a66fbebbe@ip.agent.x.x client to immediatly use GLPI protocol
[Tue Jul  4 09:53:36 2023][debug] [http server] response status 202
[Tue Jul  4 09:53:36 2023][debug] [http server] POST request /proxy/glpi from client ip.agent.x.x
[Tue Jul  4 09:53:36 2023][debug2] [proxy server plugin] 5BF6D529: application/x-compress-zlib type request from ip.agent.x.x
[Tue Jul  4 09:53:36 2023][debug] [proxy server plugin] 5BF6D529: contact proxy request from ip.agent.x.x, agentid is 2e116056-73c3-1014-bfe6-8d4a66fbebbe
[Tue Jul  4 09:53:36 2023][debug2] [http client] Using Compress::Zlib for compression
[Tue Jul  4 09:53:36 2023][debug] [proxy server plugin] 5BF6D529: Submitting contact from 2e116056-73c3-1014-bfe6-8d4a66fbebbe@ip.agent.x.x to http://glpi_srv/glpi/marketplace/glpiinventory
[Tue Jul  4 09:53:36 2023][debug2] [http client] 88401312: sending message:
{
   "action": "contact",
   "deviceid": "mypc.mydomain-2023-04-27-09-54-13",
   "enabled-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "httpd-plugins": {},
   "httpd-port": "62354",
   "installed-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "name": "GLPI-Agent",
   "tag": "GLPI_Agents_TAG",
   "version": "1.5"
}
[Tue Jul  4 09:53:36 2023][debug2] format: Zlib
[Tue Jul  4 09:53:36 2023][debug2] [http client] 88401312: received message:
{"message":"remoteinventory task not supported","disabled":["remoteinventory"],"expiration":"24","status":"ok","tasks":{"collect":{"version":"1.2.1","server":"glpiinventory"},"deploy":{"version":"1.2.1","server":"glpiinventory"},"inventory":{"server":"glpi","version":"10.0.8-dev"}}}
[Tue Jul  4 09:53:36 2023][debug] [proxy server plugin] 5BF6D529: Setting prolog_freq to 86400
[Tue Jul  4 09:53:36 2023][info] [proxy server plugin] 5BF6D529: 2e116056-73c3-1014-bfe6-8d4a66fbebbe@ip.agent.x.x contact submitted to http://glpi_srv/glpi/marketplace/glpiinventory
[Tue Jul  4 09:53:36 2023][debug] [http server] response status 200
[Tue Jul  4 09:53:46 2023][debug] [http server] GET request /proxy/glpi from client ip.agent.x.x
[Tue Jul  4 09:53:46 2023][debug2] [proxy server plugin] 5BF6D529: application/x-compress-zlib type request from ip.agent.x.x
[Tue Jul  4 09:53:46 2023][debug] [proxy server plugin] 5BF6D529: Asked for 5BF6D529 request status from 2e116056-73c3-1014-bfe6-8d4a66fbebbe@ip.agent.x.x
[Tue Jul  4 09:53:46 2023][info] [proxy server plugin] 5BF6D529: Unknown 5BF6D529 request status for 2e116056-73c3-1014-bfe6-8d4a66fbebbe@ip.agent.x.x
[Tue Jul  4 09:53:46 2023][debug] [http server] response status 404

agent log

[Tue Jul  4 09:53:27 2023][debug] Logger backend File initialized
[Tue Jul  4 09:53:27 2023][debug] GLPI Agent (1.5)
[Tue Jul  4 09:53:27 2023][debug] Configuration directory: C:/Program Files/GLPI-Agent/etc
[Tue Jul  4 09:53:27 2023][debug] Data directory: C:/Program Files/GLPI-Agent/share
[Tue Jul  4 09:53:27 2023][debug] Storage directory: C:\Program Files\GLPI-Agent\var
[Tue Jul  4 09:53:27 2023][debug] Lib directory: C:/Program Files/GLPI-Agent/perl/agent
[Tue Jul  4 09:53:27 2023][debug] [target server0] Next server contact planned for Tue Jul  4 09:54:04 2023
[Tue Jul  4 09:53:27 2023][debug2] getAvailableTasks() : add of task Collect version 2.9
[Tue Jul  4 09:53:27 2023][debug2] getAvailableTasks() : add of task Deploy version 3.0
[Tue Jul  4 09:53:27 2023][debug2] getAvailableTasks() : add of task Inventory version 1.13
[Tue Jul  4 09:53:27 2023][debug2] getAvailableTasks() : add of task RemoteInventory version 1.2
[Tue Jul  4 09:53:27 2023][debug] Available tasks:
[Tue Jul  4 09:53:27 2023][debug] - Collect: 2.9
[Tue Jul  4 09:53:27 2023][debug] - Deploy: 3.0
[Tue Jul  4 09:53:27 2023][debug] - Inventory: 1.13
[Tue Jul  4 09:53:27 2023][debug] - RemoteInventory: 1.2
[Tue Jul  4 09:53:27 2023][debug] target server0: server http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 09:53:27 2023][debug] Planned tasks for server0: RemoteInventory,Inventory,Deploy,Collect
[Tue Jul  4 09:53:27 2023][debug] Provided by Teclib Edition
[Tue Jul  4 09:53:28 2023][debug] Installer built on Wed Jun 21 14:27:07 2023 UTC
[Tue Jul  4 09:53:28 2023][debug] Built with Strawberry Perl 5.36.0
[Tue Jul  4 09:53:28 2023][debug] Built on github actions windows image for glpi-project/glpi-agent repository
[Tue Jul  4 09:53:28 2023][info] GLPI Agent service starting
[Tue Jul  4 09:53:28 2023][debug] Trusted target ip: glpi_proxy/32, ::ffff:ae5:13/128
[Tue Jul  4 09:53:28 2023][debug] Trusted client ip/range: 127.0.0.1/32, ::ffff:7f00:1/128, ::1/128
[Tue Jul  4 09:53:28 2023][debug] Trusted client ip/range: 10.x.x.x/32, ::ffff:ae5:219/128
[Tue Jul  4 09:53:28 2023][debug] [http server] Trying to load BasicAuthentication Server plugin
[Tue Jul  4 09:53:28 2023][debug] [basic authentication server plugin] Initializing BasicAuthentication v1.0 Server plugin...
[Tue Jul  4 09:53:28 2023][debug] [basic authentication server plugin] Loading BasicAuthentication Server plugin configuration from C:/Program Files/GLPI-Agent/etc/basic-authentication-server-plugin.cfg
[Tue Jul  4 09:53:28 2023][debug] [http server] HTTPD BasicAuthentication Server plugin loaded but disabled
[Tue Jul  4 09:53:28 2023][debug] [http server] Trying to load Inventory Server plugin
[Tue Jul  4 09:53:28 2023][debug] [inventory server plugin] Initializing Inventory v1.1 Server plugin...
[Tue Jul  4 09:53:28 2023][debug] [inventory server plugin] Loading Inventory Server plugin configuration from C:/Program Files/GLPI-Agent/etc/inventory-server-plugin.cfg
[Tue Jul  4 09:53:28 2023][debug] [http server] HTTPD Inventory Server plugin loaded but disabled
[Tue Jul  4 09:53:28 2023][debug] [http server] Trying to load Proxy Server plugin
[Tue Jul  4 09:53:28 2023][debug] [proxy server plugin] Initializing Proxy v2.2 Server plugin...
[Tue Jul  4 09:53:28 2023][debug] [proxy server plugin] Loading Proxy Server plugin configuration from C:/Program Files/GLPI-Agent/etc/proxy-server-plugin.cfg
[Tue Jul  4 09:53:28 2023][debug] [http server] HTTPD Proxy Server plugin loaded but disabled
[Tue Jul  4 09:53:28 2023][debug] [http server] Trying to load SecondaryProxy Server plugin
[Tue Jul  4 09:53:28 2023][debug] [proxy2 server plugin] Initializing SecondaryProxy v1.1 Server plugin...
[Tue Jul  4 09:53:28 2023][debug] [proxy2 server plugin] Loading SecondaryProxy Server plugin configuration from C:/Program Files/GLPI-Agent/etc/proxy2-server-plugin.cfg
[Tue Jul  4 09:53:28 2023][debug] [http server] HTTPD SecondaryProxy Server plugin loaded but disabled
[Tue Jul  4 09:53:28 2023][debug] [http server] Trying to load SSL Server plugin
[Tue Jul  4 09:53:28 2023][debug] [ssl server plugin] Initializing SSL v1.1 Server plugin...
[Tue Jul  4 09:53:28 2023][debug] [ssl server plugin] Loading SSL Server plugin configuration from C:/Program Files/GLPI-Agent/etc/ssl-server-plugin.cfg
[Tue Jul  4 09:53:28 2023][debug] [http server] HTTPD SSL Server plugin loaded but disabled
[Tue Jul  4 09:53:28 2023][debug] [http server] Trying to load Test Server plugin
[Tue Jul  4 09:53:28 2023][debug] [server test plugin] Initializing Test v1.5 Server plugin...
[Tue Jul  4 09:53:28 2023][debug] [server test plugin] Loading Test Server plugin configuration from C:/Program Files/GLPI-Agent/etc/server-test-plugin.cfg
[Tue Jul  4 09:53:28 2023][debug] [http server] HTTPD Test Server plugin loaded but disabled
[Tue Jul  4 09:53:28 2023][debug] [http server] Trying to load ToolBox Server plugin
[Tue Jul  4 09:53:28 2023][debug] [toolbox plugin] Initializing ToolBox v1.1 Server plugin...
[Tue Jul  4 09:53:28 2023][debug] [toolbox plugin] Loading ToolBox Server plugin configuration from C:/Program Files/GLPI-Agent/etc/toolbox-plugin.cfg
[Tue Jul  4 09:53:28 2023][debug] [http server] HTTPD ToolBox Server plugin loaded but disabled
[Tue Jul  4 09:53:28 2023][info] [http server] HTTPD service started on port 62354
[Tue Jul  4 09:53:28 2023][debug2] Looking for Win32_Processor class WMI objects
[Tue Jul  4 09:53:29 2023][debug] Agent memory usage before freeing memory: WSS=118218752 PFU=108359680
[Tue Jul  4 09:53:29 2023][info] GLPI Agent memory usage: WSS=3162112 PFU=108359680
[Tue Jul  4 09:53:29 2023][debug] Running in background mode
[Tue Jul  4 09:53:29 2023][info] target server0: next run: Tue Jul  4 09:54:04 2023 - http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 09:53:33 2023][debug] [http server] GET request / from client 127.0.0.1
[Tue Jul  4 09:53:33 2023][debug] [target listener] Next tasks run planned now
[Tue Jul  4 09:53:33 2023][debug] [http server] response status 200
[Tue Jul  4 09:53:34 2023][debug] [http server] GET request /now from client 127.0.0.1
[Tue Jul  4 09:53:34 2023][debug] [http server] rescheduling next contact for all targets right now
[Tue Jul  4 09:53:34 2023][debug] [http server] response status 200
[Tue Jul  4 09:53:35 2023][info] target server0: server http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 09:53:35 2023][debug2] [http client] Using Compress::Zlib for compression
[Tue Jul  4 09:53:35 2023][info] sending prolog request to server0
[Tue Jul  4 09:53:35 2023][debug2] [http client] sending message:
<?xml version="1.0" encoding="UTF-8"?>
<REQUEST>
  <DEVICEID>mypc.mydomain-2023-04-27-09-54-13</DEVICEID>
  <QUERY>PROLOG</QUERY>
  <TOKEN>12345678</TOKEN>
</REQUEST>
[Tue Jul  4 09:53:36 2023][debug2] [http client] receiving message:
{
   "expiration": 0,
   "status": "pending"
}
[Tue Jul  4 09:53:36 2023][debug] Got GLPI CONTACT pending answer
[Tue Jul  4 09:53:36 2023][info] server0 answer shows it supports GLPI Agent protocol
[Tue Jul  4 09:53:36 2023][info] target server0: server http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 09:53:36 2023][debug2] [http client] Using Compress::Zlib for compression
[Tue Jul  4 09:53:36 2023][info] sending contact request to server0
[Tue Jul  4 09:53:36 2023][debug2] [http client] 5BF6D529: sending message:
{
   "action": "contact",
   "deviceid": "mypc.mydomain-2023-04-27-09-54-13",
   "enabled-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "httpd-plugins": {},
   "httpd-port": "62354",
   "installed-tasks": [
      "collect",
      "deploy",
      "inventory",
      "remoteinventory"
   ],
   "name": "GLPI-Agent",
   "tag": "GLPI_Agents_TAG",
   "version": "1.5"
}
[Tue Jul  4 09:53:36 2023][debug2] [http client] 5BF6D529: received message:
{
   "expiration": "10s",
   "status": "pending"
}
[Tue Jul  4 09:53:46 2023][debug2] [http client] 5BF6D529: retry request after pending status
[Tue Jul  4 09:53:46 2023][error] [http client] communication error: 404 Unknown status
[Tue Jul  4 09:53:46 2023][debug2] [http client] received message:
Unknown status
[Tue Jul  4 09:53:46 2023][error] [http client] unexpected content, starting with: Unknown status
[Tue Jul  4 09:53:46 2023][error] No supported answer from server at http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 09:53:46 2023][info] target server0: next run: Tue Jul  4 09:54:46 2023 - http://glpi_proxy:62354/proxy/glpi
[Tue Jul  4 09:53:46 2023][debug] target server0: init event for RemoteInventory task
[Tue Jul  4 09:53:46 2023][debug] target server0: init event for Inventory task
[Tue Jul  4 09:53:46 2023][debug] target server0: init event for Deploy task
[Tue Jul  4 09:53:47 2023][debug] [target server0] New storage maintenance event on deploy task
[Tue Jul  4 09:53:47 2023][debug2] [target server0] Event scheduled in 120 seconds
[Tue Jul  4 09:53:47 2023][debug] target server0: init event for Collect task
g-bougard commented 1 year ago

Just to clarify a point, you're talking about agents not in the right entity. The fact is a new agent entity is root by default and it will be moved to the expected entity only after the asset is finally imported (rules are only applied on assets and we included a patch to update the agent at that time). So actually, your "problem" seems normal as the asset is not imported when using the proxy. Indeed this is just a symptom.

So now, we must better understand why the inventory is not started.

Blank-Vcf commented 1 year ago

inventory is initiated by the proxy or agent itself ? tcp flow is one way agent > proxy > glpi ?

g-bougard commented 1 year ago

Inventory is initiated by agent itself, but only if the contact from the server is confirmed, which seems not the case here. I guess the agent is attempting to contact the server through the proxy again and again, and very often without success. This is normal an server contact failure.

I see your proxy agent is on windows, maybe it has an issue in that context. Do you think you can configure a proxy agent on linux ?

As I said, I need to make some tests myself, and I think now you gave all needed information.

Blank-Vcf commented 1 year ago

i have a test box somewhere, i'll give it a try this afternoon

Blank-Vcf commented 1 year ago

it's ok with agent as proxy on a linux, tell me if you want logs. Don't have look logs, but agent inventory xml file is created with correct tag in it.

g-bougard commented 1 year ago

Hi @Blank-Vcf

I finally understood the problem as I was able to reproduce and I found I missed a thing on win32. You can try now with next nightly build to see if proxy works now as expected for you on windows.

Thank you for your reporting.

Blank-Vcf commented 1 year ago

hi, i have agent with GLPI-Agent-1.6-gitf8c3877f-x64.msi build, agent 1.5 can comunicate with proxy with the same problem. Updated agent with nightly on my pc, get error 500:

agent log:

[Wed Jul  5 08:34:09 2023][debug] [http server] GET request / from client 127.0.0.1
[Wed Jul  5 08:34:09 2023][debug] Trusted target ip: 10xxxxxxx/32, ::ffff:ae5:13/128
[Wed Jul  5 08:34:09 2023][debug] Trusted client ip/range: 127.0.0.1/32, ::ffff:7f00:1/128, ::1/128
[Wed Jul  5 08:34:09 2023][debug] Trusted client ip/range: 10.xxxxxxx/32, ::ffff:ae5:219/128
[Wed Jul  5 08:34:09 2023][debug] [http server] response status 200
[Wed Jul  5 08:34:10 2023][debug] [http server] GET request /now from client 127.0.0.1
[Wed Jul  5 08:34:10 2023][debug] [http server] rescheduling next contact for all targets right now
[Wed Jul  5 08:34:10 2023][debug] [http server] response status 200
[Wed Jul  5 08:34:11 2023][info] target server0: server http://glpi_proxy:62354/proxy/glpi
[Wed Jul  5 08:34:11 2023][debug2] [http client] Using Compress::Zlib for compression
[Wed Jul  5 08:34:11 2023][info] sending prolog request to server0
[Wed Jul  5 08:34:11 2023][debug2] [http client] sending message:
<?xml version="1.0" encoding="UTF-8"?>
<REQUEST>
  <DEVICEID>Cmypc.mydomain-2023-04-27-09-54-13</DEVICEID>
  <QUERY>PROLOG</QUERY>
  <TOKEN>12345678</TOKEN>
</REQUEST>
[Wed Jul  5 08:34:13 2023][error] [http client] internal response: 500 Status read failed: Une connexion existante a dû être fermée par l’hôte distant.
[Wed Jul  5 08:34:13 2023][error] No supported answer from server at http://glpi_proxy:62354/proxy/glpi
[Wed Jul  5 08:34:13 2023][info] target server0: next run: Wed Jul  5 09:06:13 2023 - http://glpi_proxy:62354/proxy/glpi
[Wed Jul  5 08:34:13 2023][debug] Agent memory usage before freeing memory: WSS=23093248 PFU=119595008
[Wed Jul  5 08:34:13 2023][info] GLPI Agent memory usage: WSS=3215360 PFU=119595008

proxy log:

[Wed Jul  5 08:34:11 2023][debug] [http server] POST request /proxy/glpi from client 10.xx.x.xx
[Wed Jul  5 08:34:11 2023][debug] forking process -5840 to handle Proxy request
[Wed Jul  5 08:34:11 2023][debug2] Proxy[-5840]: forked
[Wed Jul  5 08:34:11 2023][debug2] [proxy server plugin] application/x-compress-zlib type request from 10.xx.x.xx
g-bougard commented 1 year ago

Hi @Blank-Vcf

humpf, maybe a problem with XML support. Anyway the error is not exactly the same than before.

Did you enable glpi_protocol = yes in the proxy configuration ?

Blank-Vcf commented 1 year ago

yes it's enabled: proxy-server-plugin.local

disabled = no
glpi_protocol = yes
port = 62354
local_store = D:/inventory

on debug2 on other agent:

[Wed Jul  5 09:03:17 2023][error] [http client] internal response: 500 Can't connect to 10.xx.xxx.xx:62354 (Aucune connexion n’a pu 괲e 鴡blie car l’ordinateur cible l’a express魥nt refus饮)
[Wed Jul  5 09:03:17 2023][debug2] [http client] received message:
Can't connect to .xx.xxx.xx:62354 (Aucune connexion n’a pu 괲e 鴡blie car l’ordinateur cible l’a express魥nt refus饮)

Aucune connexion n’a pu 괲e 鴡blie car l’ordinateur cible l’a express魥nt refus饮 at C:\Program Files\GLPI-Agent\perl\vendor\lib/LWP/Protocol/http.pm line 50.
g-bougard commented 1 year ago

Hi @Blank-Vcf

did you enable the firewall rule installation during installing the proxy glpi-agent ? You can check it by sharing the output of:

netsh advfirewall firewall show rule name="GLPI Agent"
Blank-Vcf commented 1 year ago

rules are here: netsh advfirewall firewall show rule name="GLPI Agent"

Nom de la règle : GLPI Agent

Activé : Oui Direction : Sortie Profiles : Domaine,Privé,Public Groupement : LocalIP : Tout RemoteIP : Tout Protocole : Tout Traversée latérale : Non Action : Autoriser

Nom de la règle : GLPI Agent

Activé : Oui Direction : Actif Profiles : Domaine,Privé,Public Groupement : LocalIP : Tout RemoteIP : Tout Protocole : TCP LocalPort : 62354 RemotePort : Tout Traversée latérale : Non Action : Autoriser Ok.

firewall is not enable and agent 1.5 stil communicate with proxy.

Blank-Vcf commented 1 year ago

@g-bougard i have roll back to 1.5 agent on proxy and everything is working.

g-bougard commented 1 year ago

?

What do you mean ? GLPI-Agent proxy feature on windows works with 1.5 version ? If yes, did you change anything ?

Can you share client & proxy logs ?

Blank-Vcf commented 1 year ago

i even know wtf is going on .... made a error on installed path agent on proxy and reinstall from scratch by just keeping proxy cfg and all my already sync agent in glpi are syncing correctly and match rules... :tired_face:

Blank-Vcf commented 1 year ago

agent log:

[Thu Jul  6 10:11:14 2023][debug] Logger backend File initialized
[Thu Jul  6 10:11:14 2023][debug] GLPI Agent (1.6-gitf8c3877f)
[Thu Jul  6 10:11:14 2023][debug] Configuration directory: C:/Program Files/GLPI-Agent/etc
[Thu Jul  6 10:11:14 2023][debug] Data directory: C:/Program Files/GLPI-Agent/share
[Thu Jul  6 10:11:14 2023][debug] Storage directory: C:\Program Files\GLPI-Agent\var
[Thu Jul  6 10:11:14 2023][debug] Lib directory: C:/Program Files/GLPI-Agent/perl/agent
[Thu Jul  6 10:11:14 2023][debug] [target server0] Next server contact planned for Fri Jul  7 09:46:24 2023
[Thu Jul  6 10:11:14 2023][debug2] getAvailableTasks() : add of task Collect version 2.9
[Thu Jul  6 10:11:14 2023][debug2] getAvailableTasks() : add of task Deploy version 3.0
[Thu Jul  6 10:11:14 2023][debug2] getAvailableTasks() : add of task Inventory version 1.13
[Thu Jul  6 10:11:14 2023][debug2] getAvailableTasks() : add of task RemoteInventory version 1.2
[Thu Jul  6 10:11:14 2023][debug] Available tasks:
[Thu Jul  6 10:11:14 2023][debug] - Collect: 2.9
[Thu Jul  6 10:11:14 2023][debug] - Deploy: 3.0
[Thu Jul  6 10:11:14 2023][debug] - Inventory: 1.13
[Thu Jul  6 10:11:14 2023][debug] - RemoteInventory: 1.2
[Thu Jul  6 10:11:14 2023][debug] target server0: server http://10.proxy.ip:62354/proxy/glpi
[Thu Jul  6 10:11:14 2023][debug] Planned tasks for server0: RemoteInventory,Inventory,Collect,Deploy
[Thu Jul  6 10:11:14 2023][debug] Provided by Teclib Edition
[Thu Jul  6 10:11:14 2023][debug] Installer built on Wed Jul  5 02:45:27 2023 UTC
[Thu Jul  6 10:11:14 2023][debug] Built with Strawberry Perl 5.36.0
[Thu Jul  6 10:11:14 2023][debug] Built on github actions windows image for glpi-project/glpi-agent repository
[Thu Jul  6 10:11:14 2023][info] GLPI Agent service starting
[Thu Jul  6 10:11:14 2023][debug] Trusted target ip: 10.proxy.ip/32, ::ffff:ae5:13/128
[Thu Jul  6 10:11:14 2023][debug] Trusted client ip/range: 127.0.0.1/32, ::ffff:7f00:1/128, ::1/128
[Thu Jul  6 10:11:14 2023][debug] Trusted client ip/range: 10.xxxxxxx/32, ::ffff:ae5:219/128
[Thu Jul  6 10:11:14 2023][debug] [http server] Trying to load BasicAuthentication Server plugin
[Thu Jul  6 10:11:14 2023][debug] [basic authentication server plugin] Initializing BasicAuthentication v1.0 Server plugin...
[Thu Jul  6 10:11:14 2023][debug] [basic authentication server plugin] Loading BasicAuthentication Server plugin configuration from C:/Program Files/GLPI-Agent/etc/basic-authentication-server-plugin.cfg
[Thu Jul  6 10:11:14 2023][debug] [http server] HTTPD BasicAuthentication Server plugin loaded but disabled
[Thu Jul  6 10:11:14 2023][debug] [http server] Trying to load Inventory Server plugin
[Thu Jul  6 10:11:14 2023][debug] [inventory server plugin] Initializing Inventory v1.1 Server plugin...
[Thu Jul  6 10:11:14 2023][debug] [inventory server plugin] Loading Inventory Server plugin configuration from C:/Program Files/GLPI-Agent/etc/inventory-server-plugin.cfg
[Thu Jul  6 10:11:14 2023][debug] [http server] HTTPD Inventory Server plugin loaded but disabled
[Thu Jul  6 10:11:14 2023][debug] [http server] Trying to load Proxy Server plugin
[Thu Jul  6 10:11:14 2023][debug] [proxy server plugin] Initializing Proxy v2.2 Server plugin...
[Thu Jul  6 10:11:14 2023][debug] [proxy server plugin] Loading Proxy Server plugin configuration from C:/Program Files/GLPI-Agent/etc/proxy-server-plugin.cfg
[Thu Jul  6 10:11:14 2023][debug] [http server] HTTPD Proxy Server plugin loaded but disabled
[Thu Jul  6 10:11:14 2023][debug] [http server] Trying to load SecondaryProxy Server plugin
[Thu Jul  6 10:11:14 2023][debug] [proxy2 server plugin] Initializing SecondaryProxy v1.1 Server plugin...
[Thu Jul  6 10:11:14 2023][debug] [proxy2 server plugin] Loading SecondaryProxy Server plugin configuration from C:/Program Files/GLPI-Agent/etc/proxy2-server-plugin.cfg
[Thu Jul  6 10:11:14 2023][debug] [http server] HTTPD SecondaryProxy Server plugin loaded but disabled
[Thu Jul  6 10:11:14 2023][debug] [http server] Trying to load SSL Server plugin
[Thu Jul  6 10:11:14 2023][debug] [ssl server plugin] Initializing SSL v1.1 Server plugin...
[Thu Jul  6 10:11:14 2023][debug] [ssl server plugin] Loading SSL Server plugin configuration from C:/Program Files/GLPI-Agent/etc/ssl-server-plugin.cfg
[Thu Jul  6 10:11:14 2023][debug] [http server] HTTPD SSL Server plugin loaded but disabled
[Thu Jul  6 10:11:14 2023][debug] [http server] Trying to load Test Server plugin
[Thu Jul  6 10:11:14 2023][debug] [server test plugin] Initializing Test v1.6-gitf8c3877f Server plugin...
[Thu Jul  6 10:11:14 2023][debug] [server test plugin] Loading Test Server plugin configuration from C:/Program Files/GLPI-Agent/etc/server-test-plugin.cfg
[Thu Jul  6 10:11:14 2023][debug] [http server] HTTPD Test Server plugin loaded but disabled
[Thu Jul  6 10:11:14 2023][debug] [http server] Trying to load ToolBox Server plugin
[Thu Jul  6 10:11:14 2023][debug] [toolbox plugin] Initializing ToolBox v1.1 Server plugin...
[Thu Jul  6 10:11:14 2023][debug] [toolbox plugin] Loading ToolBox Server plugin configuration from C:/Program Files/GLPI-Agent/etc/toolbox-plugin.cfg
[Thu Jul  6 10:11:14 2023][debug] [http server] HTTPD ToolBox Server plugin loaded but disabled
[Thu Jul  6 10:11:14 2023][info] [http server] HTTPD service started on port 62354
[Thu Jul  6 10:11:14 2023][debug2] Looking for Win32_Processor class WMI objects
[Thu Jul  6 10:11:15 2023][debug] Agent memory usage before freeing memory: WSS=118566912 PFU=108605440
[Thu Jul  6 10:11:15 2023][info] GLPI Agent memory usage: WSS=3035136 PFU=108605440
[Thu Jul  6 10:11:15 2023][debug] Running in background mode
[Thu Jul  6 10:11:15 2023][info] target server0: next run: Fri Jul  7 09:46:24 2023 - http://10.proxy.ip:62354/proxy/glpi
[Thu Jul  6 10:11:21 2023][debug] [http server] GET request /now from client 127.0.0.1
[Thu Jul  6 10:11:21 2023][debug] [http server] rescheduling next contact for all targets right now
[Thu Jul  6 10:11:21 2023][debug] [http server] response status 200
[Thu Jul  6 10:11:22 2023][debug] [http server] GET request /favicon.ico from client 127.0.0.1
[Thu Jul  6 10:11:22 2023][debug] [http server] response status 200
[Thu Jul  6 10:11:22 2023][info] target server0: server http://10.proxy.ip:62354/proxy/glpi
[Thu Jul  6 10:11:22 2023][debug2] [http client] Using Compress::Zlib for compression
[Thu Jul  6 10:11:22 2023][info] sending prolog request to server0
[Thu Jul  6 10:11:22 2023][debug2] [http client] sending message:
<?xml version="1.0" encoding="UTF-8"?>
<REQUEST>
  <DEVICEID>mypc.mydomain-2023-04-27-09-54-13</DEVICEID>
  <QUERY>PROLOG</QUERY>
  <TOKEN>12345678</TOKEN>
</REQUEST>
[Thu Jul  6 10:11:22 2023][debug2] [http client] receiving message:
<?xml version="1.0" encoding="UTF-8"?>
<REPLY>
  <PROLOG_FREQ>24</PROLOG_FREQ>
  <RESPONSE>SEND</RESPONSE>
</REPLY>
[Thu Jul  6 10:11:22 2023][debug] new thread 3 to handle task RemoteInventory
[Thu Jul  6 10:11:22 2023][debug] Remote inventory task execution disabled: no remote setup
[Thu Jul  6 10:11:22 2023][debug] new thread 4 to handle task Inventory
[Thu Jul  6 10:11:22 2023][info] running task Inventory
[Thu Jul  6 10:11:22 2023][info] New inventory from mypc.mydomain-2023-04-27-09-54-13 for server0 (tag=GLPI_Agents_CAM)
[Thu Jul  6 10:11:22 2023][debug2] module GLPI::Agent::Task::Inventory::AIX disabled
[Thu Jul  6 10:11:22 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Bios disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:22 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Controllers disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Drives disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Hardware disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::LVM disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Memory disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Modems disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Networks disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::OS disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Slots disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Softwares disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Sounds disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Storages disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::AIX::Videos disabled: implicit dependency GLPI::Agent::Task::Inventory::AIX not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::BSD disabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::Alpha disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::Drives disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::MIPS disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::Memory disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::Networks disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::OS disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::SPARC disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::Softwares disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::Storages disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::Storages::Megaraid disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD::Storages not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::Uptime disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::BSD::i386 disabled: implicit dependency GLPI::Agent::Task::Inventory::BSD not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Arch disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Batteries::Acpiconf disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Batteries::SysClass disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Batteries::Upower disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Databases disabled: 'database' category disabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Databases::DB2 disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Databases not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Databases::MSSQL disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Databases not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Databases::MongoDB disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Databases not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Databases::MySQL disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Databases not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Databases::Oracle disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Databases not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Databases::PostgreSQL disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Databases not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Domains disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Drives::ASM disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Environment disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Firewall::Systemd disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Firewall::Ufw disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Hostname disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Ipmi disabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Ipmi::Fru disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Ipmi not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Ipmi::Fru::Controllers disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Ipmi::Fru not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Ipmi::Fru::Memory disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Ipmi::Fru not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Ipmi::Fru::Psu disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Ipmi::Fru not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::Ipmi::Lan disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::Ipmi not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Networks::iLO disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::PCI disabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::PCI::Controllers disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::PCI not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::PCI::Modems disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::PCI not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::PCI::Sounds disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::PCI not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::PCI::Videos disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::PCI not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Generic::PCI::Videos::Nvidia disabled: implicit dependency GLPI::Agent::Task::Inventory::Generic::PCI::Videos not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Printers disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Processes disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Remote_Mgmt::AnyDesk disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Remote_Mgmt::LiteManager disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Remote_Mgmt::MeshCentral disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Remote_Mgmt::RustDesk disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Remote_Mgmt::SupRemo disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Rudder disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Softwares::Deb disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Softwares::Flatpak disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Softwares::Gentoo disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Softwares::Nix disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Softwares::Pacman disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Softwares::RPM disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Softwares::Slackware disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Softwares::Snap disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Storages::3ware disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Storages::HP disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Storages::HpWithSmartctl disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::USB disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Generic::Users disabled: 'user' category disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::HPUX disabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Bios disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Controllers disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Drives disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Hardware disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::MP disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Memory disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Networks disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::OS disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Slots disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Softwares disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Storages disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::HPUX::Uptime disabled: implicit dependency GLPI::Agent::Task::Inventory::HPUX not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Linux disabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::ARM disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::ARM::Board disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::ARM not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::ARM::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::ARM not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Alpha disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Alpha::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Alpha not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Bios disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Distro disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Distro::NonLSB disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Distro not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Distro::OSRelease disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Distro not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Drives disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Hardware disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Inputs disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::LVM disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::MIPS disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::MIPS::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::MIPS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Memory disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Networks disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Networks::DockerMacvlan disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Networks not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Networks::FibreChannel disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Networks not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::OS disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::PowerPC disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::PowerPC::Bios disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::PowerPC not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::PowerPC::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::PowerPC not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::SPARC disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::SPARC::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::SPARC not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Storages disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Storages::Adaptec disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Storages not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Storages::Lsilogic disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Storages not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Storages::Megacli disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Storages not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Storages::MegacliWithSmartctl disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Storages not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Storages::Megaraid disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Storages not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Storages::ServeRaid disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::Storages not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Uptime disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::Videos disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::i386 disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::i386::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::i386 not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::m68k disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Linux::m68k::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::Linux::m68k not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::MacOS disabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::AntiVirus disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Batteries disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Bios disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Drives disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Firewall disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Hardware disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Hostname disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::License disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Memory disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Networks disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::OS disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Printers disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Psu disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Softwares disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Sound disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Storages disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::USB disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Uptime disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::MacOS::Videos disabled: implicit dependency GLPI::Agent::Task::Inventory::MacOS not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Solaris disabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Bios disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::CPU disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Controllers disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Drives disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Hardware disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Memory disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Networks disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::OS disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Slots disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Softwares disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2]   GLPI::Agent::Task::Inventory::Solaris::Storages disabled: implicit dependency GLPI::Agent::Task::Inventory::Solaris not enabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Docker disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Hpvm disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Jails disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Libvirt disabled
[Thu Jul  6 10:11:23 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Lxc disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Lxd disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Parallels disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Qemu disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::SolarisZones disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::SystemdNspawn disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::VirtualBox disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Virtuozzo disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::VmWareDesktop disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::VmWareESX disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Vserver disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::Xen disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Virtualization::XenCitrixServer disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Win32::Registry disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Win32::Storages::HP disabled
[Thu Jul  6 10:11:24 2023][debug2] module GLPI::Agent::Task::Inventory::Win32::Users disabled: 'user' category disabled
[Thu Jul  6 10:11:24 2023][debug] module GLPI::Agent::Task::Inventory::Win32::Bios disabled because of GLPI::Agent::Task::Inventory::Generic::Dmidecode::Bios
[Thu Jul  6 10:11:24 2023][debug] module GLPI::Agent::Task::Inventory::Win32::Memory disabled because of GLPI::Agent::Task::Inventory::Generic::Dmidecode
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::AccessLog
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::Generic
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Batteries
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Dmidecode
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Dmidecode::Battery
[Thu Jul  6 10:11:24 2023][debug2] executing dmidecode
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Dmidecode::Bios
[Thu Jul  6 10:11:24 2023][debug2] executing dmidecode
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Dmidecode::Hardware
[Thu Jul  6 10:11:24 2023][debug2] executing dmidecode
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::Win32
[Thu Jul  6 10:11:24 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Hardware
[Thu Jul  6 10:11:24 2023][debug2] Looking for Win32_OperatingSystem class WMI objects
[Thu Jul  6 10:11:24 2023][debug2] Looking for Win32_ComputerSystem class WMI objects
[Thu Jul  6 10:11:25 2023][debug2] Looking for Win32_ComputerSystemProduct class WMI objects
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Vmsystem
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Dmidecode::Memory
[Thu Jul  6 10:11:25 2023][debug2] executing dmidecode
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Dmidecode::Ports
[Thu Jul  6 10:11:25 2023][debug2] executing dmidecode
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Dmidecode::Psu
[Thu Jul  6 10:11:25 2023][debug2] executing dmidecode
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Dmidecode::Slots
[Thu Jul  6 10:11:25 2023][debug2] executing dmidecode
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Drives
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Firewall
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Networks
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::OS
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Remote_Mgmt
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Remote_Mgmt::TeamViewer
[Thu Jul  6 10:11:25 2023][debug] Found TeamViewerID : 806188480
[Thu Jul  6 10:11:25 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::SSH
[Thu Jul  6 10:11:25 2023][debug2] executing ssh-keyscan -T 1 127.0.0.1
[Thu Jul  6 10:11:27 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Screen
[Thu Jul  6 10:11:27 2023][debug2] Looking for WMIMonitorConnectionParams class WMI objects
[Thu Jul  6 10:11:27 2023][debug2] Looking for Win32_DesktopMonitor class WMI objects
[Thu Jul  6 10:11:27 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Softwares
[Thu Jul  6 10:11:27 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Storages
[Thu Jul  6 10:11:27 2023][debug] Running GLPI::Agent::Task::Inventory::Generic::Timezone
[Thu Jul  6 10:11:27 2023][debug] Using DateTime::TimeZone to get the timezone name
[Thu Jul  6 10:11:27 2023][debug] Running GLPI::Agent::Task::Inventory::Provider
[Thu Jul  6 10:11:27 2023][debug] Running GLPI::Agent::Task::Inventory::Virtualization
[Thu Jul  6 10:11:27 2023][debug] Running GLPI::Agent::Task::Inventory::Virtualization::HyperV
[Thu Jul  6 10:11:27 2023][debug] Win32::OLE ERROR: Invalid namespace
[Thu Jul  6 10:11:27 2023][debug] Win32::OLE ERROR: Invalid namespace
[Thu Jul  6 10:11:27 2023][debug] Win32::OLE ERROR: Invalid namespace
[Thu Jul  6 10:11:27 2023][debug] Win32::OLE ERROR: Invalid namespace
[Thu Jul  6 10:11:27 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::CPU
[Thu Jul  6 10:11:27 2023][debug2] Looking for Win32_Processor class WMI objects
[Thu Jul  6 10:11:28 2023][debug] Running GLPI::Agent::Task::Inventory::Virtualization::Wsl
[Thu Jul  6 10:11:28 2023][debug2] Looking for Win32_OperatingSystem class WMI objects
[Thu Jul  6 10:11:29 2023][debug2] Doing SELECT * FROM Win32_UserProfile WHERE LocalPath IS NOT NULL AND Special=FALSE WMI query
[Thu Jul  6 10:11:29 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::AntiVirus
[Thu Jul  6 10:11:29 2023][debug2] Looking for AntiVirusProduct class WMI objects
[Thu Jul  6 10:11:29 2023][debug2] Looking for AntiVirusProduct class WMI objects
[Thu Jul  6 10:11:29 2023][debug] Found Cortex XDR™ Advanced Endpoint Protection (state=0x41000)
[Thu Jul  6 10:11:29 2023][debug2] Added Cortex XDR™ Advanced Endpoint Protection v8.0.1.33809
[Thu Jul  6 10:11:29 2023][debug] Found Windows Defender (state=0x60100)
[Thu Jul  6 10:11:29 2023][debug2] Added Windows Defender
[Thu Jul  6 10:11:29 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Batteries
[Thu Jul  6 10:11:29 2023][debug2] executing powercfg /batteryreport /xml /output "C:\Program Files\GLPI-Agent\share\batteries.xml"
[Thu Jul  6 10:11:31 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Chassis
[Thu Jul  6 10:11:31 2023][debug2] Looking for Win32_SystemEnclosure class WMI objects
[Thu Jul  6 10:11:31 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Controllers
[Thu Jul  6 10:11:31 2023][debug2] Looking for Win32_FloppyController class WMI objects
[Thu Jul  6 10:11:31 2023][debug2] Looking for Win32_IDEController class WMI objects
[Thu Jul  6 10:11:32 2023][debug2] Looking for Win32_SCSIController class WMI objects
[Thu Jul  6 10:11:32 2023][debug2] Looking for Win32_VideoController class WMI objects
[Thu Jul  6 10:11:32 2023][debug2] Looking for Win32_InfraredDevice class WMI objects
[Thu Jul  6 10:11:32 2023][debug2] Looking for Win32_USBController class WMI objects
[Thu Jul  6 10:11:32 2023][debug2] Looking for Win32_1394Controller class WMI objects
[Thu Jul  6 10:11:32 2023][debug2] Looking for Win32_PCMCIAController class WMI objects
[Thu Jul  6 10:11:32 2023][debug2] Looking for CIM_LogicalDevice class WMI objects
[Thu Jul  6 10:11:33 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Drives
[Thu Jul  6 10:11:33 2023][debug2] Looking for Win32_OperatingSystem class WMI objects
[Thu Jul  6 10:11:33 2023][debug2] Looking for Win32_LogicalDisk class WMI objects
[Thu Jul  6 10:11:33 2023][debug2] Looking for Win32_Volume class WMI objects
[Thu Jul  6 10:11:33 2023][debug2] Looking for Win32_EncryptableVolume class WMI objects
[Thu Jul  6 10:11:33 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Environment
[Thu Jul  6 10:11:33 2023][debug2] Looking for Win32_Environment class WMI objects
[Thu Jul  6 10:11:33 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Firewall
[Thu Jul  6 10:11:33 2023][debug2] Looking for Win32_NetworkAdapterConfiguration class WMI objects
[Thu Jul  6 10:11:33 2023][debug2] Looking for MSFT_NetAdapter class WMI objects
[Thu Jul  6 10:11:34 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Inputs
[Thu Jul  6 10:11:34 2023][debug2] Looking for Win32_Keyboard class WMI objects
[Thu Jul  6 10:11:34 2023][debug2] Looking for Win32_PointingDevice class WMI objects
[Thu Jul  6 10:11:34 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::License
[Thu Jul  6 10:11:34 2023][debug2] Looking for SoftwareLicensingProduct class WMI objects
[Thu Jul  6 10:12:11 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Modems
[Thu Jul  6 10:12:11 2023][debug2] Looking for Win32_POTSModem class WMI objects
[Thu Jul  6 10:12:11 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Networks
[Thu Jul  6 10:12:11 2023][debug2] Looking for Win32_NetworkAdapterConfiguration class WMI objects
[Thu Jul  6 10:12:11 2023][debug2] Looking for MSFT_NetAdapter class WMI objects
[Thu Jul  6 10:12:11 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::OS
[Thu Jul  6 10:12:11 2023][debug2] Looking for Win32_OperatingSystem class WMI objects
[Thu Jul  6 10:12:11 2023][debug2] Looking for Win32_ComputerSystem class WMI objects
[Thu Jul  6 10:12:11 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Ports
[Thu Jul  6 10:12:11 2023][debug2] Looking for Win32_SerialPort class WMI objects
[Thu Jul  6 10:12:11 2023][debug2] Looking for Win32_ParallelPort class WMI objects
[Thu Jul  6 10:12:11 2023][debug2] Looking for Win32_PortConnector class WMI objects
[Thu Jul  6 10:12:11 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Printers
[Thu Jul  6 10:12:11 2023][debug2] Looking for Win32_Printer class WMI objects
[Thu Jul  6 10:12:12 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Slots
[Thu Jul  6 10:12:12 2023][debug2] Looking for Win32_SystemSlot class WMI objects
[Thu Jul  6 10:12:12 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Softwares
[Thu Jul  6 10:12:12 2023][debug] 'scan-profiles' configuration parameter disabled, ignoring software in user profiles
[Thu Jul  6 10:12:12 2023][debug2] Looking for Win32_QuickFixEngineering class WMI objects
[Thu Jul  6 10:12:13 2023][debug2] Looking for Win32_OperatingSystem class WMI objects
[Thu Jul  6 10:12:13 2023][debug2] executing powershell -NonInteractive -ExecutionPolicy Unrestricted -File get-appxpackage-dLhZ_h.ps1
[Thu Jul  6 10:12:19 2023][debug2] Found 98 uwp packages
[Thu Jul  6 10:12:19 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Sounds
[Thu Jul  6 10:12:19 2023][debug2] Looking for Win32_SoundDevice class WMI objects
[Thu Jul  6 10:12:19 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Storages
[Thu Jul  6 10:12:19 2023][debug2] Looking for MSFT_PhysicalDisk class WMI objects
[Thu Jul  6 10:12:20 2023][debug2] executing hdparm -I /dev/hdc
[Thu Jul  6 10:12:20 2023][debug] invalid value RAID for field INTERFACE for section STORAGES
[Thu Jul  6 10:12:20 2023][debug2] executing hdparm -I /dev/hda
[Thu Jul  6 10:12:20 2023][debug] invalid value RAID for field INTERFACE for section STORAGES
[Thu Jul  6 10:12:20 2023][debug2] executing hdparm -I /dev/hdd
[Thu Jul  6 10:12:20 2023][debug2] executing hdparm -I /dev/hdb
[Thu Jul  6 10:12:20 2023][debug] invalid value RAID for field INTERFACE for section STORAGES
[Thu Jul  6 10:12:20 2023][debug2] Looking for Win32_CDROMDrive class WMI objects
[Thu Jul  6 10:12:20 2023][debug2] Looking for Win32_TapeDrive class WMI objects
[Thu Jul  6 10:12:20 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::USB
[Thu Jul  6 10:12:20 2023][debug2] Looking for CIM_LogicalDevice class WMI objects
[Thu Jul  6 10:12:22 2023][debug] Running GLPI::Agent::Task::Inventory::Win32::Videos
[Thu Jul  6 10:12:22 2023][debug2] Looking for Win32_VideoController class WMI objects
[Thu Jul  6 10:12:22 2023][debug] Section DRIVES has changed since last inventory
[Thu Jul  6 10:12:22 2023][debug] Section FIREWALL has changed since last inventory
[Thu Jul  6 10:12:22 2023][debug2] [http client] Using Compress::Zlib for compression
[Thu Jul  6 10:12:22 2023][debug2] [http client] sending message:
<?xml version="1.0" encoding="UTF-8"?>
<REQUEST>
  <CONTENT>
  ****my pc inventory****
  </CONTENT>
  <DEVICEID>mypc.mydomain-2023-04-27-09-54-13</DEVICEID>
  <QUERY>INVENTORY</QUERY>
</REQUEST>
[Thu Jul  6 10:12:23 2023][debug2] [http client] receiving message:
<?xml version='1.0' encoding='UTF-8'?>
<REPLY></REPLY>
[Thu Jul  6 10:12:25 2023][debug] new thread 5 to handle task Collect
[Thu Jul  6 10:12:25 2023][info] running task Collect
[Thu Jul  6 10:12:25 2023][debug2] [http client] Not using compression
[Thu Jul  6 10:12:25 2023][debug2] http://10.proxy.ip:62354/proxy/glpi?action=getConfig&machineid=mypc.mydomain-2023-04-27-09-54-13&task[Collect]=2.9
[Thu Jul  6 10:12:25 2023][info] No job schedule returned by server0
[Thu Jul  6 10:12:27 2023][debug] new thread 6 to handle task Deploy
[Thu Jul  6 10:12:27 2023][info] running task Deploy
[Thu Jul  6 10:12:27 2023][debug2] [http client] Not using compression
[Thu Jul  6 10:12:27 2023][debug2] http://10.proxy.ip:62354/proxy/glpi?action=getConfig&machineid=mypc.mydomain-2023-04-27-09-54-13&task[Deploy]=3.0
[Thu Jul  6 10:12:27 2023][info] No job schedule returned by server0
[Thu Jul  6 10:12:29 2023][info] target server0: next run: Fri Jul  7 09:44:44 2023 - http://10.proxy.ip:62354/proxy/glpi
[Thu Jul  6 10:12:29 2023][debug] Agent memory usage before freeing memory: WSS=108691456 PFU=126115840
[Thu Jul  6 10:12:29 2023][info] GLPI Agent memory usage: WSS=3207168 PFU=126115840
[Thu Jul  6 10:12:30 2023][debug] target server0: init event for RemoteInventory task
[Thu Jul  6 10:12:31 2023][debug] target server0: init event for Inventory task
[Thu Jul  6 10:12:32 2023][debug] target server0: init event for Collect task
[Thu Jul  6 10:12:33 2023][debug] target server0: init event for Deploy task
[Thu Jul  6 10:12:33 2023][debug] [target server0] New storage maintenance event on deploy task
[Thu Jul  6 10:12:33 2023][debug2] [target server0] Event scheduled in 120 seconds

proxy log (there some cross over data from from other agent)

[Thu Jul  6 10:11:07 2023][debug] Logger backend File initialized
[Thu Jul  6 10:11:07 2023][debug] GLPI Agent (1.5)
[Thu Jul  6 10:11:07 2023][debug] Configuration directory: D:/GLPI-Agent/etc
[Thu Jul  6 10:11:07 2023][debug] Data directory: D:/GLPI-Agent/share
[Thu Jul  6 10:11:07 2023][debug] Storage directory: D:\GLPI-Agent\var
[Thu Jul  6 10:11:07 2023][debug] Lib directory: D:/GLPI-Agent/perl/agent
[Thu Jul  6 10:11:07 2023][debug] [target local0] Next tasks run planned for Thu Jul  6 10:42:30 2023
[Thu Jul  6 10:11:07 2023][debug] [target server0] Next server contact planned for Thu Jul  6 10:32:54 2023
[Thu Jul  6 10:11:07 2023][debug2] getAvailableTasks() : add of task Collect version 2.9
[Thu Jul  6 10:11:07 2023][debug2] getAvailableTasks() : add of task Deploy version 3.0
[Thu Jul  6 10:11:07 2023][debug2] getAvailableTasks() : add of task Inventory version 1.13
[Thu Jul  6 10:11:07 2023][debug2] getAvailableTasks() : add of task RemoteInventory version 1.2
[Thu Jul  6 10:11:07 2023][debug] Available tasks:
[Thu Jul  6 10:11:07 2023][debug] - Collect: 2.9
[Thu Jul  6 10:11:07 2023][debug] - Deploy: 3.0
[Thu Jul  6 10:11:07 2023][debug] - Inventory: 1.13
[Thu Jul  6 10:11:07 2023][debug] - RemoteInventory: 1.2
[Thu Jul  6 10:11:07 2023][debug] target local0: local D:\inventory\
[Thu Jul  6 10:11:07 2023][debug] Planned tasks for local0: Inventory,RemoteInventory
[Thu Jul  6 10:11:07 2023][debug] target server0: server http://10.gli.srv.ip/glpi/marketplace/glpiinventory
[Thu Jul  6 10:11:07 2023][debug] Planned tasks for server0: Inventory,Deploy,RemoteInventory,Collect
[Thu Jul  6 10:11:07 2023][debug] Provided by Teclib Edition
[Thu Jul  6 10:11:07 2023][debug] Installer built on Wed Jun 21 14:27:07 2023 UTC
[Thu Jul  6 10:11:07 2023][debug] Built with Strawberry Perl 5.36.0
[Thu Jul  6 10:11:07 2023][debug] Built on github actions windows image for glpi-project/glpi-agent repository
[Thu Jul  6 10:11:07 2023][info] GLPI Agent service starting
[Thu Jul  6 10:11:07 2023][debug] Trusted target ip: 10.gli.srv.ip/32, ::ffff:ae5:2af/128
[Thu Jul  6 10:11:07 2023][debug] Trusted client ip/range: 127.0.0.1/32, ::ffff:7f00:1/128, ::1/128
[Thu Jul  6 10:11:07 2023][debug] [http server] Trying to load BasicAuthentication Server plugin
[Thu Jul  6 10:11:07 2023][debug] [basic authentication server plugin] Initializing BasicAuthentication v1.0 Server plugin...
[Thu Jul  6 10:11:07 2023][debug] [basic authentication server plugin] Loading BasicAuthentication Server plugin configuration from D:/GLPI-Agent/etc/basic-authentication-server-plugin.cfg
[Thu Jul  6 10:11:07 2023][debug] [http server] HTTPD BasicAuthentication Server plugin loaded but disabled
[Thu Jul  6 10:11:07 2023][debug] [http server] Trying to load Inventory Server plugin
[Thu Jul  6 10:11:07 2023][debug] [inventory server plugin] Initializing Inventory v1.1 Server plugin...
[Thu Jul  6 10:11:07 2023][debug] [inventory server plugin] Loading Inventory Server plugin configuration from D:/GLPI-Agent/etc/inventory-server-plugin.cfg
[Thu Jul  6 10:11:07 2023][debug] [http server] HTTPD Inventory Server plugin loaded but disabled
[Thu Jul  6 10:11:07 2023][debug] [http server] Trying to load Proxy Server plugin
[Thu Jul  6 10:11:07 2023][debug] [proxy server plugin] Initializing Proxy v2.2 Server plugin...
[Thu Jul  6 10:11:07 2023][debug] [proxy server plugin] Loading Proxy Server plugin configuration from D:/GLPI-Agent/etc/proxy-server-plugin.cfg
[Thu Jul  6 10:11:07 2023][info] [http server] HTTPD Proxy Server plugin loaded
[Thu Jul  6 10:11:07 2023][debug] [http server] Trying to load SecondaryProxy Server plugin
[Thu Jul  6 10:11:07 2023][debug] [proxy2 server plugin] Initializing SecondaryProxy v1.1 Server plugin...
[Thu Jul  6 10:11:07 2023][debug] [proxy2 server plugin] Loading SecondaryProxy Server plugin configuration from D:/GLPI-Agent/etc/proxy2-server-plugin.cfg
[Thu Jul  6 10:11:07 2023][debug] [http server] HTTPD SecondaryProxy Server plugin loaded but disabled
[Thu Jul  6 10:11:07 2023][debug] [http server] Trying to load SSL Server plugin
[Thu Jul  6 10:11:07 2023][debug] [ssl server plugin] Initializing SSL v1.1 Server plugin...
[Thu Jul  6 10:11:07 2023][debug] [ssl server plugin] Loading SSL Server plugin configuration from D:/GLPI-Agent/etc/ssl-server-plugin.cfg
[Thu Jul  6 10:11:07 2023][debug] [http server] HTTPD SSL Server plugin loaded but disabled
[Thu Jul  6 10:11:07 2023][debug] [http server] Trying to load Test Server plugin
[Thu Jul  6 10:11:07 2023][debug] [server test plugin] Initializing Test v1.5 Server plugin...
[Thu Jul  6 10:11:07 2023][debug] [server test plugin] Loading Test Server plugin configuration from D:/GLPI-Agent/etc/server-test-plugin.cfg
[Thu Jul  6 10:11:07 2023][debug] [http server] HTTPD Test Server plugin loaded but disabled
[Thu Jul  6 10:11:07 2023][debug] [http server] Trying to load ToolBox Server plugin
[Thu Jul  6 10:11:07 2023][debug] [toolbox plugin] Initializing ToolBox v1.1 Server plugin...
[Thu Jul  6 10:11:07 2023][debug] [toolbox plugin] Loading ToolBox Server plugin configuration from D:/GLPI-Agent/etc/toolbox-plugin.cfg
[Thu Jul  6 10:11:07 2023][debug] [http server] HTTPD ToolBox Server plugin loaded but disabled
[Thu Jul  6 10:11:07 2023][info] [http server] HTTPD service started on port 62354
[Thu Jul  6 10:11:07 2023][info] [http server] HTTPD Proxy Server plugin also used on main port 62354
[Thu Jul  6 10:11:08 2023][debug2] Looking for Win32_Processor class WMI objects
[Thu Jul  6 10:11:09 2023][debug] Agent memory usage before freeing memory: WSS=119296000 PFU=112410624
[Thu Jul  6 10:11:09 2023][info] GLPI Agent memory usage: WSS=3371008 PFU=112410624
[Thu Jul  6 10:11:09 2023][debug] Running in background mode
[Thu Jul  6 10:11:09 2023][info] target local0: next run: Thu Jul  6 10:42:30 2023 - D:\inventory\
[Thu Jul  6 10:11:09 2023][info] target server0: next run: Thu Jul  6 10:32:54 2023 - http://10.gli.srv.ip/glpi/marketplace/glpiinventory
[Thu Jul  6 10:11:19 2023][debug] target local0: init event for Inventory task
[Thu Jul  6 10:11:20 2023][debug] target server0: init event for Inventory task
[Thu Jul  6 10:11:21 2023][debug] target local0: init event for RemoteInventory task
[Thu Jul  6 10:11:22 2023][debug] target server0: init event for Deploy task
[Thu Jul  6 10:11:22 2023][debug] [target server0] New storage maintenance event on deploy task
[Thu Jul  6 10:11:22 2023][debug2] [target server0] Event scheduled in 120 seconds
[Thu Jul  6 10:11:22 2023][debug] [http server] POST request /proxy/glpi from client 10.my.pc.ip
[Thu Jul  6 10:11:22 2023][debug2] [proxy server plugin] application/x-compress-zlib type request from 10.my.pc.ip
[Thu Jul  6 10:11:22 2023][info] [proxy server plugin] PROLOG query from mypc.mydomain-2023-04-27-09-54-13@10.my.pc.ip
[Thu Jul  6 10:11:22 2023][debug2] [proxy server plugin] PROLOG request from mypc.mydomain-2023-04-27-09-54-13@10.my.pc.ip
[Thu Jul  6 10:11:22 2023][debug] [http server] response status 200
[Thu Jul  6 10:11:23 2023][debug] target server0: init event for RemoteInventory task
[Thu Jul  6 10:11:23 2023][debug] target server0: init event for Collect task
[Thu Jul  6 10:11:45 2023][debug] [http server] POST request /proxy/glpi from client 10.not.my.ip
[Thu Jul  6 10:11:45 2023][debug2] [proxy server plugin] application/x-compress-zlib type request from 10.not.my.ip
[Thu Jul  6 10:11:45 2023][info] [proxy server plugin] PROLOG query from notmypc.mydomain-2023-05-05-07-28-18@10.not.my.ip
[Thu Jul  6 10:11:45 2023][debug2] [proxy server plugin] PROLOG request from notmypc.mydomain-2023-05-05-07-28-18@10.not.my.ip
[Thu Jul  6 10:11:45 2023][debug] [http server] response status 200
[Thu Jul  6 10:11:46 2023][debug] [http server] GET request /proxy/glpi from client 10.not.my.ip
[Thu Jul  6 10:11:46 2023][debug2] [proxy server plugin] application/json type request from 10.not.my.ip
[Thu Jul  6 10:11:46 2023][debug] [proxy server plugin] action=getConfig&task%5BCollect%5D=2.9&machineid=notmypc.mydomain-2023-05-05-07-28-18 request from 10.not.my.ip, sending nothing to do
[Thu Jul  6 10:11:46 2023][debug] [http server] response status 200
[Thu Jul  6 10:11:50 2023][debug] [http server] GET request /proxy/glpi from client 10.not.my.ip
[Thu Jul  6 10:11:50 2023][debug2] [proxy server plugin] application/json type request from 10.not.my.ip
[Thu Jul  6 10:11:50 2023][debug] [proxy server plugin] action=getConfig&task%5BDeploy%5D=3.0&machineid=notmypc.mydomain-2023-05-05-07-28-18 request from 10.not.my.ip, sending nothing to do
[Thu Jul  6 10:11:50 2023][debug] [http server] response status 200
[Thu Jul  6 10:12:22 2023][debug] [http server] POST request /proxy/glpi from client 10.my.pc.ip
[Thu Jul  6 10:12:22 2023][debug2] [proxy server plugin] application/x-compress-zlib type request from 10.my.pc.ip
[Thu Jul  6 10:12:22 2023][info] [proxy server plugin] INVENTORY query from mypc.mydomain-2023-04-27-09-54-13@10.my.pc.ip
[Thu Jul  6 10:12:22 2023][debug] [proxy server plugin] proxy request for mypc.mydomain-2023-04-27-09-54-13@10.my.pc.ip
[Thu Jul  6 10:12:22 2023][debug] [proxy server plugin] Saving inventory in D:/inventory/mypc.mydomain-2023-04-27-09-54-13.xml
[Thu Jul  6 10:12:22 2023][debug2] [http client] Using Compress::Zlib for compression
[Thu Jul  6 10:12:22 2023][debug] [proxy server plugin] Submitting inventory from mypc.mydomain-2023-04-27-09-54-13@10.my.pc.ip to http://10.gli.srv.ip/glpi/marketplace/glpiinventory
[Thu Jul  6 10:12:22 2023][debug2] [http client] sending message:
<?xml version="1.0" encoding="UTF-8"?>
<REQUEST>
  <CONTENT>
 ***** not my pc inventoy*****
  <DEVICEID>notmypc.mydomain-2023-05-05-07-28-18</DEVICEID>
  <QUERY>INVENTORY</QUERY>
</REQUEST>
[Thu Jul  6 10:12:27 2023][debug2] format: Zlib
[Thu Jul  6 10:12:27 2023][debug2] [http client] receiving message:
<?xml version="1.0"?>
<REPLY><RESPONSE>SEND</RESPONSE></REPLY>
[Thu Jul  6 10:12:27 2023][info] [proxy server plugin] Inventory from notmypc.mydomain-2023-05-05-07-28-18@10.not.my.ip submitted to http://10.gli.srv.ip/glpi/marketplace/glpiinventory
[Thu Jul  6 10:12:27 2023][debug] [http server] response status 200
[Thu Jul  6 10:12:28 2023][debug] [http server] GET request /proxy/glpi from client 10.my.pc.ip
[Thu Jul  6 10:12:28 2023][debug2] [proxy server plugin] application/json type request from 10.my.pc.ip
[Thu Jul  6 10:12:28 2023][debug] [proxy server plugin] action=getConfig&machineid=mypc.mydomain-2023-04-27-09-54-13&task%5BDeploy%5D=3.0 request from 10.my.pc.ip, sending nothing to do
[Thu Jul  6 10:12:28 2023][debug] [http server] response status 200
Blank-Vcf commented 1 year ago

there is one thig to take care also, i have updated glpi to last stable release 1.0.8 and plugin to 1.2.2

Blank-Vcf commented 1 year ago

Ok weirdo things continue, while firsts pcs inventory works it has stop during the morning. I reproduce it this afternoon, to confirm that:

image i can give you full log by mail, too much info to clean in it

g-bougard commented 1 year ago

By now, I don't need your log file. I still observed weird things with my own tests and only on windows. I know there's a problem on windows related to multi-threading and this is hard to debug. So just wait I fix it and I should re-open this ticket.

g-bougard commented 1 year ago

Hi @Blank-Vcf

I found a fix related to XML::LibXML loading on win32, next nightly build should definitively fix that issue.

Blank-Vcf commented 1 year ago

ok thanks i'll try it tomorrow.

Blank-Vcf commented 1 year ago

that look good after upgrading proxy agent, all clients are falling in the right entity after inventory send. I'll keep an eye on it for others agents and tell if you if i'll get some other errors. 👍