Skip to content

Instantly share code, notes, and snippets.

@PeterS-gd

PeterS-gd/kvm-agent-groovy.log Secret

Last active October 7, 2021 13:04
Show Gist options
  • Save PeterS-gd/2d930b3317ea7b25ddf950e0e1cb167c to your computer and use it in GitHub Desktop.
Save PeterS-gd/2d930b3317ea7b25ddf950e0e1cb167c to your computer and use it in GitHub Desktop.
Download ZIP
Raw
kvm-agent-groovy.log
2021-10-07 08:52:44,660 INFO [kvm.resource.LibvirtConnection] (agentRequest-Handler-2:null) (logid:e381c0f1) No existing libvirtd connection found. Opening a new one
2021-10-07 08:52:44,662 WARN [kvm.resource.LibvirtConnection] (agentRequest-Handler-2:null) (logid:e381c0f1) Can not find a connection for Instance s-1535-VM. Assuming the default connection.
2021-10-07 08:52:44,832 WARN [kvm.resource.LibvirtKvmAgentHook] (agentRequest-Handler-2:null) (logid:e381c0f1) Groovy script '/etc/cloudstack/agent/hooks/libvirt-vm-state-change.groovy' is not available. Transformations will not be applied.
2021-10-07 08:52:44,832 WARN [kvm.resource.LibvirtKvmAgentHook] (agentRequest-Handler-2:null) (logid:e381c0f1) Groovy scripting engine is not initialized. Data transformation skipped.
2021-10-07 08:52:50,444 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) Attempting to create storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 (NetworkFilesystem) in libvirt
2021-10-07 08:52:50,464 WARN [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) Storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 was not found running in libvirt. Need to create it.
2021-10-07 08:52:50,464 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) Didn't find an existing storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 by UUID, checking for pools with duplicate paths
2021-10-07 08:53:14,829 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-4:null) (logid:240ed1f1) Trying to fetch storage pool 6db2511f-6992-3120-b49e-fafdfa8ec257 from libvirt
2021-10-07 08:53:14,852 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-4:null) (logid:240ed1f1) Asking libvirt to refresh storage pool 6db2511f-6992-3120-b49e-fafdfa8ec257
2021-10-07 08:54:56,906 ERROR [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) org.libvirt.LibvirtException: internal error: Child process (/bin/mount 192.168.204.62:/cloudstack/template/tmpl/1/3 /mnt/ee90a381-7f4b-398d-b91b-cb4c3ddac152 -o nodev,nosuid,noexec) unexpected exit status 32: mount.nfs: Connection timed out
2021-10-07 08:54:56,906 ERROR [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) Failed to create netfs mount: 192.168.204.62:/cloudstack/template/tmpl/1/3
org.libvirt.LibvirtException: internal error: Child process (/bin/mount 192.168.204.62:/cloudstack/template/tmpl/1/3 /mnt/ee90a381-7f4b-398d-b91b-cb4c3ddac152 -o nodev,nosuid,noexec) unexpected exit status 32: mount.nfs: Connection timed out
at org.libvirt.ErrorHandler.processError(Unknown Source)
at org.libvirt.ErrorHandler.processError(Unknown Source)
at org.libvirt.Connect.storagePoolCreateXML(Unknown Source)
at com.cloud.hypervisor.kvm.storage.LibvirtStorageAdaptor.createNetfsStoragePool(LibvirtStorageAdaptor.java:255)
at com.cloud.hypervisor.kvm.storage.LibvirtStorageAdaptor.createStoragePool(LibvirtStorageAdaptor.java:621)
at com.cloud.hypervisor.kvm.storage.KVMStoragePoolManager.createStoragePool(KVMStoragePoolManager.java:329)
at com.cloud.hypervisor.kvm.storage.KVMStoragePoolManager.getStoragePoolByURI(KVMStoragePoolManager.java:284)
at com.cloud.hypervisor.kvm.storage.KVMStorageProcessor.copyTemplateToPrimaryStorage(KVMStorageProcessor.java:215)
at com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:95)
at com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:59)
at com.cloud.hypervisor.kvm.resource.wrapper.LibvirtStorageSubSystemCommandWrapper.execute(LibvirtStorageSubSystemCommandWrapper.java:36)
at com.cloud.hypervisor.kvm.resource.wrapper.LibvirtStorageSubSystemCommandWrapper.execute(LibvirtStorageSubSystemCommandWrapper.java:30)
at com.cloud.hypervisor.kvm.resource.wrapper.LibvirtRequestWrapper.execute(LibvirtRequestWrapper.java:78)
at com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1648)
at com.cloud.agent.Agent.processRequest(Agent.java:661)
at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:1079)
at com.cloud.utils.nio.Task.call(Task.java:83)
at com.cloud.utils.nio.Task.call(Task.java:29)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:829)
2021-10-07 08:54:56,906 ERROR [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) [Ljava.lang.StackTraceElement;@4f90e723
2021-10-07 08:55:00,468 INFO [kvm.resource.LibvirtConnection] (agentRequest-Handler-2:null) (logid:bcef1bbe) No existing libvirtd connection found. Opening a new one
2021-10-07 08:55:00,470 WARN [kvm.resource.LibvirtConnection] (agentRequest-Handler-2:null) (logid:bcef1bbe) Can not find a connection for Instance v-1536-VM. Assuming the default connection.
2021-10-07 08:55:00,654 WARN [kvm.resource.LibvirtKvmAgentHook] (agentRequest-Handler-2:null) (logid:bcef1bbe) Groovy script '/etc/cloudstack/agent/hooks/libvirt-vm-state-change.groovy' is not available. Transformations will not be applied.
2021-10-07 08:55:00,654 WARN [kvm.resource.LibvirtKvmAgentHook] (agentRequest-Handler-2:null) (logid:bcef1bbe) Groovy scripting engine is not initialized. Data transformation skipped.
2021-10-07 08:55:15,445 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-4:null) (logid:c3457856) Trying to fetch storage pool 6db2511f-6992-3120-b49e-fafdfa8ec257 from libvirt
2021-10-07 08:55:15,467 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-4:null) (logid:c3457856) Asking libvirt to refresh storage pool 6db2511f-6992-3120-b49e-fafdfa8ec257
2021-10-07 08:59:36,516 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-1:null) (logid:bcef1bbe) Attempting to create storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 (NetworkFilesystem) in libvirt
2021-10-07 08:59:36,536 WARN [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-1:null) (logid:bcef1bbe) Storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 was not found running in libvirt. Need to create it.
2021-10-07 08:59:36,536 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-1:null) (logid:bcef1bbe) Didn't find an existing storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 by UUID, checking for pools with duplicate paths
2021-10-07 08:59:37,556 INFO [kvm.resource.LibvirtConnection] (agentRequest-Handler-4:null) (logid:e381c0f1) No existing libvirtd connection found. Opening a new one
2021-10-07 08:59:37,558 WARN [kvm.resource.LibvirtConnection] (agentRequest-Handler-4:null) (logid:e381c0f1) Can not find a connection for Instance s-1539-VM. Assuming the default connection.
2021-10-07 08:59:37,727 WARN [kvm.resource.LibvirtKvmAgentHook] (agentRequest-Handler-4:null) (logid:e381c0f1) Groovy script '/etc/cloudstack/agent/hooks/libvirt-vm-state-change.groovy' is not available. Transformations will not be applied.
2021-10-07 08:59:37,727 WARN [kvm.resource.LibvirtKvmAgentHook] (agentRequest-Handler-4:null) (logid:e381c0f1) Groovy scripting engine is not initialized. Data transformation skipped.
2021-10-07 09:00:17,025 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:8c74a8b9) Trying to fetch storage pool 6db2511f-6992-3120-b49e-fafdfa8ec257 from libvirt
2021-10-07 09:00:17,048 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:8c74a8b9) Asking libvirt to refresh storage pool 6db2511f-6992-3120-b49e-fafdfa8ec257
2021-10-07 09:01:43,030 ERROR [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-1:null) (logid:bcef1bbe) org.libvirt.LibvirtException: internal error: Child process (/bin/mount 192.168.204.62:/cloudstack/template/tmpl/1/3 /mnt/ee90a381-7f4b-398d-b91b-cb4c3ddac152 -o nodev,nosuid,noexec) unexpected exit status 32: mount.nfs: Connection timed out
2021-10-07 09:01:43,030 ERROR [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-1:null) (logid:bcef1bbe) Failed to create netfs mount: 192.168.204.62:/cloudstack/template/tmpl/1/3
org.libvirt.LibvirtException: internal error: Child process (/bin/mount 192.168.204.62:/cloudstack/template/tmpl/1/3 /mnt/ee90a381-7f4b-398d-b91b-cb4c3ddac152 -o nodev,nosuid,noexec) unexpected exit status 32: mount.nfs: Connection timed out
at org.libvirt.ErrorHandler.processError(Unknown Source)
at org.libvirt.ErrorHandler.processError(Unknown Source)
at org.libvirt.Connect.storagePoolCreateXML(Unknown Source)
at com.cloud.hypervisor.kvm.storage.LibvirtStorageAdaptor.createNetfsStoragePool(LibvirtStorageAdaptor.java:255)
at com.cloud.hypervisor.kvm.storage.LibvirtStorageAdaptor.createStoragePool(LibvirtStorageAdaptor.java:621)
at com.cloud.hypervisor.kvm.storage.KVMStoragePoolManager.createStoragePool(KVMStoragePoolManager.java:329)
at com.cloud.hypervisor.kvm.storage.KVMStoragePoolManager.getStoragePoolByURI(KVMStoragePoolManager.java:284)
at com.cloud.hypervisor.kvm.storage.KVMStorageProcessor.copyTemplateToPrimaryStorage(KVMStorageProcessor.java:215)
at com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:95)
at com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:59)
at com.cloud.hypervisor.kvm.resource.wrapper.LibvirtStorageSubSystemCommandWrapper.execute(LibvirtStorageSubSystemCommandWrapper.java:36)
at com.cloud.hypervisor.kvm.resource.wrapper.LibvirtStorageSubSystemCommandWrapper.execute(LibvirtStorageSubSystemCommandWrapper.java:30)
at com.cloud.hypervisor.kvm.resource.wrapper.LibvirtRequestWrapper.execute(LibvirtRequestWrapper.java:78)
at com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1648)
at com.cloud.agent.Agent.processRequest(Agent.java:661)
at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:1079)
at com.cloud.utils.nio.Task.call(Task.java:83)
at com.cloud.utils.nio.Task.call(Task.java:29)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:829)
2021-10-07 09:01:43,031 ERROR [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-1:null) (logid:bcef1bbe) [Ljava.lang.StackTraceElement;@2d1c7824
2021-10-07 09:01:46,420 INFO [kvm.resource.LibvirtConnection] (agentRequest-Handler-3:null) (logid:bcef1bbe) No existing libvirtd connection found. Opening a new one
2021-10-07 09:01:46,422 WARN [kvm.resource.LibvirtConnection] (agentRequest-Handler-3:null) (logid:bcef1bbe) Can not find a connection for Instance v-1538-VM. Assuming the default connection.
2021-10-07 09:01:46,593 WARN [kvm.resource.LibvirtKvmAgentHook] (agentRequest-Handler-3:null) (logid:bcef1bbe) Groovy script '/etc/cloudstack/agent/hooks/libvirt-vm-state-change.groovy' is not available. Transformations will not be applied.
2021-10-07 09:01:46,593 WARN [kvm.resource.LibvirtKvmAgentHook] (agentRequest-Handler-3:null) (logid:bcef1bbe) Groovy scripting engine is not initialized. Data transformation skipped.
2021-10-07 09:01:54,699 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) Attempting to create storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 (NetworkFilesystem) in libvirt
2021-10-07 09:01:54,721 WARN [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) Storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 was not found running in libvirt. Need to create it.
2021-10-07 09:01:54,721 INFO [kvm.storage.LibvirtStorageAdaptor] (agentRequest-Handler-5:null) (logid:bcef1bbe) Didn't find an existing storage pool ee90a381-7f4b-398d-b91b-cb4c3ddac152 by UUID, checking for pools with duplicate paths
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment