Advertisement
NMamaev

Untitled

May 27th, 2023
106
0
Never
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
Bash 130.29 KB | None | 0 0
  1. [root@af495e8db047 log]# grep f396c7c72d6f6e0195d52c681712eaef *
  2. host_configure_spice.log:2023-05-26 22:53:22.650 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): consul:8500
  3. host_configure_spice.log:2023-05-26 22:53:22.652 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/session/create HTTP/1.1" 200 77
  4. host_configure_spice.log:2023-05-26 22:53:22.653 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG [ConsulSession#314c1f86-edca-a72c-67ac-e3a11f328ec0]: session is created
  5. host_configure_spice.log:2023-05-26 22:53:22.655 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/session/renew/314c1f86-edca-a72c-67ac-e3a11f328ec0 HTTP/1.1" 200 212
  6. host_configure_spice.log:2023-05-26 22:53:22.656 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): input:1500
  7. host_configure_spice.log:2023-05-26 22:53:22.659 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://input:1500 "GET /vm/v3/ssh_address?id_type=node&id=2 HTTP/1.1" 200 1984
  8. host_configure_spice.log:2023-05-26 22:53:22.660 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG ssh params: {'is_dummy': False, 'last_notify': 403109, 'node_id': 2, 'ssh_address': '172.31.48.153', 'ssh_port': 22, 'ssh_user': 'astra-node-2'}
  9. host_configure_spice.log:2023-05-26 22:53:22.725 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Connecting to astra-node-2@172.31.48.153:22
  10. host_configure_spice.log:2023-05-26 22:53:22.755 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Stop domain 7_active_imaged_n2
  11. host_configure_spice.log:2023-05-26 22:53:22.756 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): consul:8500
  12. host_configure_spice.log:2023-05-26 22:53:22.757 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/kv/task_manager/progress/866?acquire=314c1f86-edca-a72c-67ac-e3a11f328ec0 HTTP/1.1" 200 29
  13. host_configure_spice.log:2023-05-26 22:53:22.760 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 1
  14. host_configure_spice.log:2023-05-26 22:53:25.766 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 2
  15. host_configure_spice.log:2023-05-26 22:53:28.769 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 3
  16. host_configure_spice.log:2023-05-26 22:53:31.774 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 4
  17. host_configure_spice.log:2023-05-26 22:53:34.779 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 5
  18. host_configure_spice.log:2023-05-26 22:53:37.785 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 6
  19. host_configure_spice.log:2023-05-26 22:53:40.789 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 7
  20. host_configure_spice.log:2023-05-26 22:53:43.851 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 8
  21. host_configure_spice.log:2023-05-26 22:53:46.857 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 9
  22. host_configure_spice.log:2023-05-26 22:53:49.862 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 10
  23. host_configure_spice.log:2023-05-26 22:53:52.667 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/session/renew/314c1f86-edca-a72c-67ac-e3a11f328ec0 HTTP/1.1" 200 212
  24. host_configure_spice.log:2023-05-26 22:53:52.869 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 11
  25. host_configure_spice.log:2023-05-26 22:53:55.874 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 12
  26. host_configure_spice.log:2023-05-26 22:53:58.880 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 13
  27. host_configure_spice.log:2023-05-26 22:54:01.886 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 14
  28. host_configure_spice.log:2023-05-26 22:54:04.891 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 15
  29. host_configure_spice.log:2023-05-26 22:54:07.898 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 16
  30. host_configure_spice.log:2023-05-26 22:54:10.904 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Shutdown... try 17
  31. host_configure_spice.log:2023-05-26 22:54:13.910 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Settings Autostart to false for 7_active_imaged_n2
  32. host_configure_spice.log:2023-05-26 22:54:13.913 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/kv/task_manager/progress/866?acquire=314c1f86-edca-a72c-67ac-e3a11f328ec0 HTTP/1.1" 200 29
  33. host_configure_spice.log:2023-05-26 22:54:13.915 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO Create HostSpice configurator on 172.31.48.153
  34. host_configure_spice.log:2023-05-26 22:54:13.916 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO found virtio-serial controller: ControllerParams(type='virtio-serial', id=0, model=None, address=Address(type='pci', bus='0x00', port=None))
  35. host_configure_spice.log:2023-05-26 22:54:13.916 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Updated xml:
  36. host_configure_spice.log:2023-05-26 22:54:13.926 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Start domain 7_active_imaged_n2
  37. host_configure_spice.log:2023-05-26 22:54:13.929 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/kv/task_manager/progress/866?acquire=314c1f86-edca-a72c-67ac-e3a11f328ec0 HTTP/1.1" 200 29
  38. host_configure_spice.log:2023-05-26 22:54:14.323 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO [Internal Post] Set VNC-port
  39. host_configure_spice.log:2023-05-26 22:54:14.323 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Get VNC-port for domain: 7_active_imaged_n2
  40. host_configure_spice.log:2023-05-26 22:54:14.343 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO VNC-port: 5900
  41. host_configure_spice.log:2023-05-26 22:54:14.343 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO Try connect to http://input:1500/vm/v3/host/7_active_imaged_n2 with headers {'Host': 'instance-1', 'internal-auth': 'on'}
  42. host_configure_spice.log:2023-05-26 22:54:14.344 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): input:1500
  43. host_configure_spice.log:2023-05-26 22:54:14.350 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://input:1500 "POST /vm/v3/host/7_active_imaged_n2 HTTP/1.1" 200 8
  44. host_configure_spice.log:2023-05-26 22:54:14.351 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO [Internal Post] Set SPICE-port
  45. host_configure_spice.log:2023-05-26 22:54:14.351 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Get SPICE-port for domain: 7_active_imaged_n2
  46. host_configure_spice.log:2023-05-26 22:54:14.354 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO SPICE-port: 5901
  47. host_configure_spice.log:2023-05-26 22:54:14.354 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO Try connect to http://input:1500/vm/v3/host/7_active_imaged_n2 with headers {'Host': 'instance-1', 'internal-auth': 'on'}
  48. host_configure_spice.log:2023-05-26 22:54:14.355 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): input:1500
  49. host_configure_spice.log:2023-05-26 22:54:14.368 [pid=8827] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://input:1500 "POST /vm/v3/host/7_active_imaged_n2 HTTP/1.1" 200 8
  50. host.log:2023-05-26 22:52:12.304 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): consul:8500
  51. host.log:2023-05-26 22:52:12.305 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/session/create HTTP/1.1" 200 77
  52. host.log:2023-05-26 22:52:12.306 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG [ConsulSession#0ed2e4bb-402e-2511-e936-79f3729c294e]: session is created
  53. host.log:2023-05-26 22:52:12.307 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Check task abort job
  54. host.log:2023-05-26 22:52:12.307 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Host creation is started with params: {'cluster': {'id': 1}, 'datacenter_type': 'ip_fabric', 'efi_boot': False, 'ha_enabled': False, 'host': {'additional_disks': [], 'bridge': 'vmbr0', 'disk': {'boot_order': 1, 'expand_part': '/dev/sda2', 'file_format': 'qcow2', 'id': 7, 'internal_name': '7_active_imaged_n2', 'name': 'active_imaged_n2', 'pool_name': 'File_vm', 'size_mib': 10240, 'storage_id': 1, 'storage_params': {'pool': {'vm_storage_path': '/vm'}}, 'storage_type': 'file', 'target_bus': 'virtio', 'target_dev': 'vda'}, 'dns_servers': [], 'domain': 'active-imaged-n2.ipfabric.com', 'interfaces': [{'cluster_interface': 0, 'is_main_network': True, 'is_vxlan': False, 'mac': '52:54:00:5C:38:57', 'model': 'virtio', 'network_switch': 'vmbr0'}], 'internal_name': '7_active_imaged_n2', 'mem': '512', 'name': 'active_imaged_n2', 'network': [{'host_interface': 'ens3', 'host_interface_mac': '52:54:00:5C:38:57', 'ipv4': [{'gateway': '10.0.0.75', 'id': 7, 'ip': '172.31.50.206', 'netmask': '255.255.255.255'}], 'ipv6_secondaries': [], 'network_switch': 'vmbr0', 'node_interface_name': 'vmbr0'}], 'password': 'qwe123qwe123', 'source': {'expand_part': '/dev/sda2', 'id': 1, 'image_name': '1_1_preset_image.raw', 'ip_automation': 'debian_based', 'location': {'connection_params': {'ip': '172.31.48.153', 'login': 'astra-node-2', 'path': '/image', 'port': 22}, 'id': 2, 'type': None}, 'os_group': 'ubuntu', 'path': '/image/1_1_preset_image.raw', 'type': 'image'}, 'spice': {'password': 'C352F91DB6865C9A47FCBB06'}, 'ssh_address': '172.31.50.206', 'ssh_key': [], 'ssh_port': 22, 'timezone': 'UTC', 'tuned_resources': {'anti_spoofing': True, 'anti_spoofing_settings': {'vlan': False}, 'cpu_custom_model': None, 'cpu_mode': 'default', 'cpu_weight': 1024, 'firewall_rules': None, 'io_read_iops': 0, 'io_read_mbitps': 0, 'io_weight': 500, 'io_write_iops': 0, 'io_write_mbitps': 0, 'nesting': False, 'net_in_mbitps': 0, 'net_out_mbitps': 0, 'net_weight': 5, 'network': [{'host_interface': 'ens3', 'host_interface_mac': '52:54:00:5C:38:57', 'ipv4': [{'gateway': '10.0.0.75', 'id': 7, 'ip': '172.31.50.206', 'netmask': '255.255.255.255'}], 'ipv6_secondaries': [], 'network_switch': 'vmbr0', 'node_interface_name': 'vmbr0'}], 'process_number': -1, 'tcp_connections_in': 0, 'tcp_connections_out': 0}, 'vcpu': '1', 'vnc_address': '172.31.48.153', 'vnc_password': 'E0BAB525'}, 'id': '7', 'install_mode': 'create_from_image', 'kms_address': '', 'last_notify': 402790, 'metadata': '{"account":{"email":"nikitamamaev1912@gmail.com","id":100005},"base_resources":{"cpu_number":1,"ram_mib":512},"cluster":{"datacenter_type":"ip_fabric","id":1,"interface_count":1,"ip_fabric":{"bgp_routing_type":"frr","gateway":"10.0.0.75","mac":"02:00:00:00:00:01"},"virtualization_type":"kvm"},"disks":[{"boot_order":1,"expand_part":"/dev/sda2","id":7,"name":"active_imaged_n2","pool":{"id":2,"name":"File_vm"},"size_mib":10240,"storage":{"id":1}}],"domain":"active-imaged-n2.ipfabric.com","id":7,"interfaces":[{"cluster_interface":0,"id":7,"is_vxlan":false,"mac_address":"52:54:00:5C:38:57","model":"virtio","name":"ens3","node_interface":2,"node_interface_name":"vmbr0","vxlan_id":0}],"internal_name":"7_active_imaged_n2","ipv4":[{"domain":"active-imaged-n2.ipfabric.com","gateway":"10.0.0.75","interface_id":7,"ip_addr":"172.31.50.206","ippool_id":1,"local_id":7,"net_prefix":32,"network_id":1,"remote_id":12,"state":"prepare to allocate"}],"ipv6":[],"metadata_version":"1.0.1","name":"active_imaged_n2","node":{"id":2,"ip_addr":"172.31.48.153","os_version":"AstraLinux 1.7.3","port":22,"virt_type":"kvm"},"os":{"group":"ubuntu","id":14,"name":"Ubuntu 22.04","tags":["ubuntu2204","ubuntu","linux"]},"state":{"disabled":false,"rescue_mode":false},"tuned_resources":{"anti_spoofing":true,"anti_spoofing_settings":{"vlan":false},"cpu_custom_model":null,"cpu_mode":"default","cpu_weight":1024,"firewall_rules":null,"io_read_iops":0,"io_read_mbitps":0,"io_weight":500,"io_write_iops":0,"io_write_mbitps":0,"nesting":false,"net_in_mbitps":0,"net_out_mbitps":0,"net_weight":5,"process_number":-1,"tcp_connections_in":0,"tcp_connections_out":0}}', 'node': {'id': 2, 'ip_addr': '172.31.48.153', 'os_version': 'AstraLinux 1.7.3', 'ssh_port': '22'}, 'product_key': '', 'ssh_port': 22, 'timeout_seconds': 7200}
  55. host.log:2023-05-26 22:52:12.308 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG creating ServerNode for node id: 2
  56. host.log:2023-05-26 22:52:12.308 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): input:1500
  57. host.log:2023-05-26 22:52:12.307 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/session/renew/0ed2e4bb-402e-2511-e936-79f3729c294e HTTP/1.1" 200 213
  58. host.log:2023-05-26 22:52:12.311 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://input:1500 "GET /vm/v3/ssh_address?id_type=node&id=2 HTTP/1.1" 200 1984
  59. host.log:2023-05-26 22:52:12.311 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG ssh params: {'is_dummy': False, 'last_notify': 402790, 'node_id': 2, 'ssh_address': '172.31.48.153', 'ssh_port': 22, 'ssh_user': 'astra-node-2'}
  60. host.log:2023-05-26 22:52:12.353 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Connecting to astra-node-2@172.31.48.153:22
  61. host.log:2023-05-26 22:52:12.376 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG creating host. Node host: 172.31.48.153, node port: 22
  62. host.log:2023-05-26 22:52:12.419 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Connecting to astra-node-2@172.31.48.153:22
  63. host.log:2023-05-26 22:52:12.438 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): consul:8500
  64. host.log:2023-05-26 22:52:12.440 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/kv/task_manager/progress/865?acquire=0ed2e4bb-402e-2511-e936-79f3729c294e HTTP/1.1" 200 29
  65. host.log:2023-05-26 22:52:12.705 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run test -e /image/1_1_preset_image.raw
  66. host.log:2023-05-26 22:52:12.721 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO DomainInterfaces [{'cluster_interface': 0, 'is_main_network': True, 'is_vxlan': False, 'mac': '52:54:00:5C:38:57', 'model': 'virtio', 'network_switch': 'vmbr0'}]
  67. host.log:2023-05-26 22:52:12.833 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Set link params: target_bus virtio target_dev vda boot_order 1
  68. host.log:2023-05-26 22:52:12.841 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Append disk in xml
  69. host.log:2023-05-26 22:52:12.850 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Set tuned resources: {'anti_spoofing': True, 'anti_spoofing_settings': {'vlan': False}, 'cpu_custom_model': None, 'cpu_mode': 'default', 'cpu_weight': 1024, 'firewall_rules': None, 'io_read_iops': 0, 'io_read_mbitps': 0, 'io_weight': 500, 'io_write_iops': 0, 'io_write_mbitps': 0, 'nesting': False, 'net_in_mbitps': 0, 'net_out_mbitps': 0, 'net_weight': 5, 'network': [{'host_interface': 'ens3', 'host_interface_mac': '52:54:00:5C:38:57', 'ipv4': [{'gateway': '10.0.0.75', 'id': 7, 'ip': '172.31.50.206', 'netmask': '255.255.255.255'}], 'ipv6_secondaries': [], 'network_switch': 'vmbr0', 'node_interface_name': 'vmbr0'}], 'process_number': -1, 'tcp_connections_in': 0, 'tcp_connections_out': 0}
  70. host.log:2023-05-26 22:52:12.851 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting CPU tuning
  71. host.log:2023-05-26 22:52:12.852 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Tuning CPU weight
  72. host.log:2023-05-26 22:52:12.852 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Old cpu node found, removing
  73. host.log:2023-05-26 22:52:12.852 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Setting CPU topology
  74. host.log:2023-05-26 22:52:12.858 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG firewall_type is FirewallType.NFTABLES
  75. host.log:2023-05-26 22:52:12.881 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  76. host.log:2023-05-26 22:52:12.894 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] ERROR nft 'list tables' | grep 'ip nat' failed with code 1 stderr ""
  77. host.log:2023-05-26 22:52:12.894 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add table ip nat'
  78. host.log:2023-05-26 22:52:12.949 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  79. host.log:2023-05-26 22:52:12.958 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add chain ip nat PREROUTING { type nat hook prerouting priority dstnat ; policy accept; }'
  80. host.log:2023-05-26 22:52:12.992 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  81. host.log:2023-05-26 22:52:13.045 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  82. host.log:2023-05-26 22:52:13.055 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add chain ip nat POSTROUTING { type nat hook postrouting priority srcnat ; policy accept; }'
  83. host.log:2023-05-26 22:52:13.068 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  84. host.log:2023-05-26 22:52:13.123 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  85. host.log:2023-05-26 22:52:13.133 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  86. host.log:2023-05-26 22:52:13.146 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  87. host.log:2023-05-26 22:52:13.158 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  88. host.log:2023-05-26 22:52:13.208 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  89. host.log:2023-05-26 22:52:13.218 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  90. host.log:2023-05-26 22:52:13.227 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  91. host.log:2023-05-26 22:52:13.236 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  92. host.log:2023-05-26 22:52:13.245 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  93. host.log:2023-05-26 22:52:13.253 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  94. host.log:2023-05-26 22:52:13.261 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  95. host.log:2023-05-26 22:52:13.269 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  96. host.log:2023-05-26 22:52:13.277 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  97. host.log:2023-05-26 22:52:13.285 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  98. host.log:2023-05-26 22:52:13.340 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  99. host.log:2023-05-26 22:52:13.349 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  100. host.log:2023-05-26 22:52:13.358 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  101. host.log:2023-05-26 22:52:13.414 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  102. host.log:2023-05-26 22:52:13.427 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  103. host.log:2023-05-26 22:52:13.438 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add chain ip nat libvirt-I-vm7_net0'
  104. host.log:2023-05-26 22:52:13.492 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  105. host.log:2023-05-26 22:52:13.500 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  106. host.log:2023-05-26 22:52:13.509 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat PREROUTING iifname "vm7_net0" counter jump libvirt-I-vm7_net0'
  107. host.log:2023-05-26 22:52:13.518 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  108. host.log:2023-05-26 22:52:13.568 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  109. host.log:2023-05-26 22:52:13.576 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add chain ip nat I-vm7_net0-mac'
  110. host.log:2023-05-26 22:52:13.585 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  111. host.log:2023-05-26 22:52:13.594 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  112. host.log:2023-05-26 22:52:13.603 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat libvirt-I-vm7_net0 counter jump I-vm7_net0-mac'
  113. host.log:2023-05-26 22:52:13.659 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  114. host.log:2023-05-26 22:52:13.670 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  115. host.log:2023-05-26 22:52:13.679 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat I-vm7_net0-mac ether saddr 52:54:00:5C:38:57 counter return'
  116. host.log:2023-05-26 22:52:13.733 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  117. host.log:2023-05-26 22:52:13.742 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  118. host.log:2023-05-26 22:52:13.754 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat I-vm7_net0-mac counter drop'
  119. host.log:2023-05-26 22:52:13.810 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  120. host.log:2023-05-26 22:52:13.822 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  121. host.log:2023-05-26 22:52:13.832 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add chain ip nat I-vm7_net0-ip'
  122. host.log:2023-05-26 22:52:13.884 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  123. host.log:2023-05-26 22:52:13.893 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  124. host.log:2023-05-26 22:52:13.903 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat libvirt-I-vm7_net0 ether type ip counter jump I-vm7_net0-ip'
  125. host.log:2023-05-26 22:52:13.912 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  126. host.log:2023-05-26 22:52:13.923 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  127. host.log:2023-05-26 22:52:13.931 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat I-vm7_net0-ip ether type ip ip saddr { 172.31.50.206 } counter accept'
  128. host.log:2023-05-26 22:52:13.984 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  129. host.log:2023-05-26 22:52:13.993 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  130. host.log:2023-05-26 22:52:14.005 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat I-vm7_net0-ip counter drop'
  131. host.log:2023-05-26 22:52:14.014 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  132. host.log:2023-05-26 22:52:14.069 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  133. host.log:2023-05-26 22:52:14.078 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat libvirt-I-vm7_net0 ether type 0x0806 arp saddr ip { 172.31.50.206 } counter accept'
  134. host.log:2023-05-26 22:52:14.086 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  135. host.log:2023-05-26 22:52:14.140 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  136. host.log:2023-05-26 22:52:14.148 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat libvirt-I-vm7_net0 counter drop'
  137. host.log:2023-05-26 22:52:14.157 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  138. host.log:2023-05-26 22:52:14.165 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  139. host.log:2023-05-26 22:52:14.174 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  140. host.log:2023-05-26 22:52:14.225 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  141. host.log:2023-05-26 22:52:14.236 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add chain ip nat libvirt-O-vm7_net0'
  142. host.log:2023-05-26 22:52:14.244 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  143. host.log:2023-05-26 22:52:14.254 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  144. host.log:2023-05-26 22:52:14.263 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat POSTROUTING oifname "vm7_net0" counter jump libvirt-O-vm7_net0'
  145. host.log:2023-05-26 22:52:14.316 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  146. host.log:2023-05-26 22:52:14.325 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  147. host.log:2023-05-26 22:52:14.334 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat libvirt-O-vm7_net0 ether type ip counter accept'
  148. host.log:2023-05-26 22:52:14.342 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  149. host.log:2023-05-26 22:52:14.398 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  150. host.log:2023-05-26 22:52:14.409 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat libvirt-O-vm7_net0 ether type arp counter accept'
  151. host.log:2023-05-26 22:52:14.418 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  152. host.log:2023-05-26 22:52:14.474 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  153. host.log:2023-05-26 22:52:14.483 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat libvirt-O-vm7_net0 ether type 0x8035 counter accept'
  154. host.log:2023-05-26 22:52:14.492 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  155. host.log:2023-05-26 22:52:14.544 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  156. host.log:2023-05-26 22:52:14.553 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule ip nat libvirt-O-vm7_net0 counter drop'
  157. host.log:2023-05-26 22:52:14.562 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'ip nat'
  158. host.log:2023-05-26 22:52:14.570 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table ip nat'
  159. host.log:2023-05-26 22:52:14.624 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  160. host.log:2023-05-26 22:52:14.633 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  161. host.log:2023-05-26 22:52:14.642 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add set inet filter I-vm7-connlimit-blackhole { type ipv4_addr; size 65535; flags dynamic,timeout; }'
  162. host.log:2023-05-26 22:52:14.652 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  163. host.log:2023-05-26 22:52:14.705 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  164. host.log:2023-05-26 22:52:14.715 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  165. host.log:2023-05-26 22:52:14.724 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  166. host.log:2023-05-26 22:52:14.777 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  167. host.log:2023-05-26 22:52:14.787 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  168. host.log:2023-05-26 22:52:14.798 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  169. host.log:2023-05-26 22:52:14.849 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  170. host.log:2023-05-26 22:52:14.859 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  171. host.log:2023-05-26 22:52:14.870 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  172. host.log:2023-05-26 22:52:14.926 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  173. host.log:2023-05-26 22:52:14.937 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  174. host.log:2023-05-26 22:52:14.950 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  175. host.log:2023-05-26 22:52:15.005 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  176. host.log:2023-05-26 22:52:15.016 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  177. host.log:2023-05-26 22:52:15.027 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  178. host.log:2023-05-26 22:52:15.038 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  179. host.log:2023-05-26 22:52:15.090 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  180. host.log:2023-05-26 22:52:15.101 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  181. host.log:2023-05-26 22:52:15.112 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  182. host.log:2023-05-26 22:52:15.165 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  183. host.log:2023-05-26 22:52:15.176 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  184. host.log:2023-05-26 22:52:15.185 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule inet filter FORWARD oifname "vm7_net0" ip saddr @dc-ips counter comment "vm6_oif_vm7_net0_dc_counter"'
  185. host.log:2023-05-26 22:52:15.195 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  186. host.log:2023-05-26 22:52:15.249 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  187. host.log:2023-05-26 22:52:15.261 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  188. host.log:2023-05-26 22:52:15.271 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  189. host.log:2023-05-26 22:52:15.280 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule inet filter FORWARD oifname "vm7_net0" ip6 saddr @dc-ips6 counter comment "vm6_oif_vm7_net0_dc_counter"'
  190. host.log:2023-05-26 22:52:15.332 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  191. host.log:2023-05-26 22:52:15.342 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  192. host.log:2023-05-26 22:52:15.350 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  193. host.log:2023-05-26 22:52:15.359 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  194. host.log:2023-05-26 22:52:15.369 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule inet filter FORWARD iifname "vm7_net0" ip daddr @dc-ips counter comment "vm6_iif_vm7_net0_dc_counter"'
  195. host.log:2023-05-26 22:52:15.378 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  196. host.log:2023-05-26 22:52:15.429 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  197. host.log:2023-05-26 22:52:15.439 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  198. host.log:2023-05-26 22:52:15.449 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  199. host.log:2023-05-26 22:52:15.501 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'add rule inet filter FORWARD iifname "vm7_net0" ip6 daddr @dc-ips6 counter comment "vm6_iif_vm7_net0_dc_counter"'
  200. host.log:2023-05-26 22:52:15.511 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft 'list tables' | grep 'inet filter'
  201. host.log:2023-05-26 22:52:15.522 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run nft --handle 'list table inet filter'
  202. host.log:2023-05-26 22:52:15.720 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run grep --quiet --fixed-strings 'include "/etc/nftables/vm/7_active_imaged_n2.nft"' /etc/nftables/vm_list.nft
  203. host.log:2023-05-26 22:52:15.729 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] ERROR grep --quiet --fixed-strings 'include "/etc/nftables/vm/7_active_imaged_n2.nft"' /etc/nftables/vm_list.nft failed with code 1 stderr ""
  204. host.log:2023-05-26 22:52:16.016 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Check task abort job
  205. host.log:2023-05-26 22:52:16.017 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run /usr/bin/ssh-keygen -R 172.31.50.206
  206. host.log:2023-05-26 22:52:16.028 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run test -d /image
  207. host.log:2023-05-26 22:52:16.036 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run touch /image/vm.exkXs2aYjI
  208. host.log:2023-05-26 22:52:16.045 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG make_temp tmp: /image/vm.exkXs2aYjI make_temp data: None
  209. host.log:2023-05-26 22:52:16.045 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run cp -f /image/1_1_preset_image.raw /image/vm.exkXs2aYjI && virt-sysprep --format=raw --operations defaults,ca-certificates,kerberos-data,user-account --add /image/vm.exkXs2aYjI --root-password random
  210. host.log:2023-05-26 22:52:31.845 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run virt-customize --delete '/etc/network/interfaces' -a '/image/vm.exkXs2aYjI'
  211. host.log:2023-05-26 22:52:34.919 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/kv/task_manager/progress/865?acquire=0ed2e4bb-402e-2511-e936-79f3729c294e HTTP/1.1" 200 29
  212. host.log:2023-05-26 22:52:34.920 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO extract image to volume
  213. host.log:2023-05-26 22:52:34.921 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run LIBGUESTFS_BACKEND=direct /usr/bin/virt-resize --format 'raw' --output-format 'qcow2' --expand /dev/sda2 /image/vm.exkXs2aYjI /vm/7_active_imaged_n2
  214. host.log:2023-05-26 22:52:39.517 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] ERROR LIBGUESTFS_BACKEND=direct /usr/bin/virt-resize --format 'raw' --output-format 'qcow2' --expand /dev/sda2 /image/vm.exkXs2aYjI /vm/7_active_imaged_n2 failed with code 1 stderr "virt-resize: error: You cannot use --expand when there is no surplus space
  215. host.log:2023-05-26 22:52:39.518 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run LIBGUESTFS_BACKEND=direct /usr/bin/virt-resize --format 'raw' --output-format 'qcow2' --shrink /dev/sda2 /image/vm.exkXs2aYjI /vm/7_active_imaged_n2
  216. host.log:2023-05-26 22:52:42.336 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/session/renew/0ed2e4bb-402e-2511-e936-79f3729c294e HTTP/1.1" 200 213
  217. host.log:2023-05-26 22:53:07.119 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Check task abort job
  218. host.log:2023-05-26 22:53:07.122 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/kv/task_manager/progress/865?acquire=0ed2e4bb-402e-2511-e936-79f3729c294e HTTP/1.1" 200 29
  219. host.log:2023-05-26 22:53:07.123 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO configure timezone, pass, hostname
  220. host.log:2023-05-26 22:53:07.124 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run cat > /tmp/os_setting_7_active_imaged_n2.sh << EOF
  221. host.log:2023-05-26 22:53:07.140 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run /usr/bin/virt-customize --no-network --root-password password:qwe123qwe123 --domain 7_active_imaged_n2 --hostname active-imaged-n2.ipfabric.com --timezone UTC --run '/tmp/os_setting_7_active_imaged_n2.sh'
  222. host.log:2023-05-26 22:53:11.202 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO configure ssh keys
  223. host.log:2023-05-26 22:53:11.202 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run /usr/bin/virt-customize --no-network --domain '7_active_imaged_n2'
  224. host.log:2023-05-26 22:53:12.367 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/session/renew/0ed2e4bb-402e-2511-e936-79f3729c294e HTTP/1.1" 200 213
  225. host.log:2023-05-26 22:53:14.350 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO configure OS settings
  226. host.log:2023-05-26 22:53:14.350 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO configure network
  227. host.log:2023-05-26 22:53:14.350 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run cat /etc/resolv.conf
  228. host.log:2023-05-26 22:53:14.359 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG [make_dns] node_dns_servers: {'77.88.8.8', '1.1.1.1'}
  229. host.log:2023-05-26 22:53:14.526 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run LIBGUESTFS_MEMSIZE=512 LIBGUESTFS_BACKEND=direct /usr/bin/virt-customize --network -d '7_active_imaged_n2' --run '/tmp/network_7_active_imaged_n2.sh'
  230. host.log:2023-05-26 22:53:17.641 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run rm -rf /tmp/network_7_active_imaged_n2.sh
  231. host.log:2023-05-26 22:53:17.697 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG os_configure template found
  232. host.log:2023-05-26 22:53:17.697 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run cat > /tmp/os_configure_7_active_imaged_n2.sh << EOF
  233. host.log:2023-05-26 22:53:17.706 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run cat /etc/resolv.conf
  234. host.log:2023-05-26 22:53:17.714 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG [make_dns] node_dns_servers: {'77.88.8.8', '1.1.1.1'}
  235. host.log:2023-05-26 22:53:17.716 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG resolv template found
  236. host.log:2023-05-26 22:53:17.716 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run cat > /tmp/resolv_7_active_imaged_n2.sh << EOF
  237. host.log:2023-05-26 22:53:17.765 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run /usr/bin/virt-customize --no-network -d '7_active_imaged_n2' --selinux-relabel --run '/tmp/os_configure_7_active_imaged_n2.sh' --run '/tmp/resolv_7_active_imaged_n2.sh'
  238. host.log:2023-05-26 22:53:21.561 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run rm -f /tmp/*_'7_active_imaged_n2'.sh
  239. host.log:2023-05-26 22:53:21.569 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run rm -rf /image/vm.exkXs2aYjI
  240. host.log:2023-05-26 22:53:21.841 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Start domain 7_active_imaged_n2
  241. host.log:2023-05-26 22:53:21.843 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://consul:8500 "PUT /v1/kv/task_manager/progress/865?acquire=0ed2e4bb-402e-2511-e936-79f3729c294e HTTP/1.1" 200 29
  242. host.log:2023-05-26 22:53:22.247 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO [Internal Post] Set VNC-port
  243. host.log:2023-05-26 22:53:22.247 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Get VNC-port for domain: <libvirt.virDomain object at 0x7fd281790d90>
  244. host.log:2023-05-26 22:53:22.250 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO VNC-port: {port}
  245. host.log:2023-05-26 22:53:22.250 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO Try connect to http://input:1500/vm/v3/host/7_active_imaged_n2 with headers {'Host': 'instance-1', 'internal-auth': 'on'}
  246. host.log:2023-05-26 22:53:22.251 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): input:1500
  247. host.log:2023-05-26 22:53:22.262 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://input:1500 "POST /vm/v3/host/7_active_imaged_n2 HTTP/1.1" 200 8
  248. host.log:2023-05-26 22:53:22.263 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO [Internal Post] Set SPICE-port
  249. host.log:2023-05-26 22:53:22.263 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Get SPICE-port for domain: <libvirt.virDomain object at 0x7fd281790d90>
  250. host.log:2023-05-26 22:53:22.265 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] WARNING Get graphics "port" failed: device with type "spice" not found
  251. host.log:2023-05-26 22:53:22.265 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO SPICE-port: 0
  252. host.log:2023-05-26 22:53:22.265 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO Try connect to http://input:1500/vm/v3/host/7_active_imaged_n2 with headers {'Host': 'instance-1', 'internal-auth': 'on'}
  253. host.log:2023-05-26 22:53:22.266 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): input:1500
  254. host.log:2023-05-26 22:53:22.271 [pid=8739] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://input:1500 "POST /vm/v3/host/7_active_imaged_n2 HTTP/1.1" 200 8
  255. image_copy.log:2023-05-26 22:50:27.846 [pid=8652] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Connecting to astra-node-1@172.31.48.161:22
  256. image_copy.log:2023-05-26 22:50:27.865 [pid=8652] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run test -f /image/1_1_preset_image.raw
  257. image_copy.log:2023-05-26 22:50:27.968 [pid=8652] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Connecting to astra-node-1@172.31.48.161:22
  258. image_copy.log:2023-05-26 22:50:27.990 [pid=8652] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run set -o pipefail; tar -C /image -czpf - 1_1_preset_image.raw | ssh -o StrictHostKeyChecking=no -o ConnectTimeout=60 -o ServerAliveInterval=10 -p 22 astra-node-2@172.31.48.153 "sudo -nE bash -c 'tar -C /image -xzpf -'"
  259. grep: nginx: Is a directory
  260. node_frr_configure.log:2023-05-26 22:53:22.625 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO node vxlan configure
  261. node_frr_configure.log:2023-05-26 22:53:22.627 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): input:1500
  262. node_frr_configure.log:2023-05-26 22:53:22.630 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://input:1500 "GET /vm/v3/ssh_address?id_type=node&id=2 HTTP/1.1" 200 1984
  263. node_frr_configure.log:2023-05-26 22:53:22.631 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG ssh params: {'is_dummy': False, 'last_notify': 403109, 'node_id': 2, 'ssh_address': '172.31.48.153', 'ssh_port': 22, 'ssh_user': 'astra-node-2'}
  264. node_frr_configure.log:2023-05-26 22:53:22.674 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Connecting to astra-node-2@172.31.48.153:22
  265. node_frr_configure.log:2023-05-26 22:53:22.695 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run test -f /etc/frr/daemons
  266. node_frr_configure.log:2023-05-26 22:53:22.765 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run sed -i "s/^\(bgpd=\).*$/\1no/g" /etc/frr/daemons
  267. node_frr_configure.log:2023-05-26 22:53:22.817 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run sed -i "s/^\(bgpd_options*=\).*$/\1\"   -A 127.0.0.1\"/g" /etc/frr/daemons
  268. node_frr_configure.log:2023-05-26 22:53:22.826 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run test -f /etc/frr/bgpd.conf
  269. node_frr_configure.log:2023-05-26 22:53:22.970 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run systemctl stop frr
  270. node_frr_configure.log:2023-05-26 22:53:23.244 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run systemctl disable frr
  271. node_frr_configure.log:2023-05-26 22:53:23.727 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] INFO Try connect to http://input:1500/ip/v3/ipnet with headers {'Host': 'instance-1', 'internal-auth': 'on'}
  272. node_frr_configure.log:2023-05-26 22:53:23.728 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG Starting new HTTP connection (1): input:1500
  273. node_frr_configure.log:2023-05-26 22:53:23.731 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG http://input:1500 "GET /ip/v3/ipnet HTTP/1.1" 200 370
  274. node_frr_configure.log:2023-05-26 22:53:23.732 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run test -f /etc/frr/daemons
  275. node_frr_configure.log:2023-05-26 22:53:23.741 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run test -f /etc/frr/daemons
  276. node_frr_configure.log:2023-05-26 22:53:23.749 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run sed -i "s/^\(bgpd=\).*$/\1yes/g" /etc/frr/daemons
  277. node_frr_configure.log:2023-05-26 22:53:23.800 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run sed -i "s/^\(bgpd_options*=\).*$/\1\"   -A 127.0.0.1\"/g" /etc/frr/daemons
  278. node_frr_configure.log:2023-05-26 22:53:23.812 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run test -f /etc/frr/bgpd.conf
  279. node_frr_configure.log:2023-05-26 22:53:23.825 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run md5sum /etc/frr/bgpd.conf | awk '{print $1}'
  280. node_frr_configure.log:2023-05-26 22:53:23.877 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run echo "no service integrated-vtysh-config" > /etc/frr/vtysh.conf
  281. node_frr_configure.log:2023-05-26 22:53:23.885 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run rm -f /etc/frr/frr.conf
  282. node_frr_configure.log:2023-05-26 22:53:24.033 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run systemctl is-enabled frr -q
  283. node_frr_configure.log:2023-05-26 22:53:24.048 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] ERROR systemctl is-enabled frr -q failed with code 1 stderr ""
  284. node_frr_configure.log:2023-05-26 22:53:24.049 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run systemctl enable frr
  285. node_frr_configure.log:2023-05-26 22:53:24.510 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run md5sum /etc/frr/bgpd.conf | awk '{print $1}'
  286. node_frr_configure.log:2023-05-26 22:53:24.520 [pid=8826] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] DEBUG run systemctl restart frr
  287. vm_1_reader.log:2023-05-26 22:57:24.801 [pid=239] [#918fb5d93e2a3d88aad9b018f0d02fde/10.60.4.173/@nikitamamaev1912@gmail.com] Response body '{"last_notify":404172,"task":{"account":{"email":"nikitamamaev1912@gmail.com","id":"100005","ip":"172.18.0.24"},"date_create":"2023-05-26T22:50:27.558406","date_end":"2023-05-26T22:54:14","date_start":"2023-05-26T22:53:22","message_params":{"name":"active_imaged_n2","spice_enabled":"true"},"name":"host_spice_configure","output":"","param":["--action","host_spice_configure","--virt-type","kvm","--params","{\"disk\":{\"boot_order\":1,\"expand_part\":\"/dev/sda2\",\"file_format\":\"qcow2\",\"id\":7,\"internal_name\":\"7_active_imaged_n2\",\"name\":\"active_imaged_n2\",\"pool_name\":\"File_vm\",\"size_mib\":10240,\"storage_id\":1,\"storage_params\":{\"pool\":{\"vm_storage_path\":\"/vm\"}},\"storage_type\":\"file\",\"target_bus\":\"virtio\",\"target_dev\":\"vda\"},\"ha_enabled\":false,\"host\":{\"datacenter_type\":\"ip_fabric\",\"domain\":\"active-imaged-n2.ipfabric.com\",\"id\":7,\"internal_name\":\"7_active_imaged_n2\",\"os_group\":\"ubuntu\"},\"node\":{\"id\":2,\"image_storage_path\":\"/image\",\"ip_addr\":\"172.31.48.153\",\"os_version\":\"AstraLinux 1.7.3\",\"port\":22,\"virt_type\":\"kvm\"},\"spice_enabled\":true,\"spice_password\":\"*\"}"],"request_id":"f396c7c72d6f6e0195d52c681712eaef","status":"complete"}}'
  288. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] request method: POST url: /host version: HTTP/1.0
  289. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Handler 'host' choosen
  290. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [connection]close
  291. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [content-length]373
  292. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [host]instance-1
  293. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [instance-id]1
  294. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [internal-auth]eyJlbWFpbF9jb25maXJtZWQiOnRydWUsImV4cGlyZXNfYXQiOiIiLCJpbnN0YW5jZV9vd25lciI6ZmFsc2UsImxhbmciOiJydSIsImxhc3Rfbm90aWZ5Ijo0MDIyOTcsIm93bmVyX2VtYWlsIjoibmlraXRhbWFtYWV2MTkxMkBnbWFpbC5jb20iLCJvd25lcl9pZCI6MTAwMDA1LCJyb2xlcyI6WyJAYWRtaW4iXSwic2VzX2lkIjozNCwic2Vzc2lvbiI6IjEwMDAwMDI5LWU0MTJmYzdhLTdiMmMtNDdjOS05M2Y1LTIyOGQ0ODA3MGMxMSIsInN1X2luc3RhbmNlIjpmYWxzZSwidHJ1c3RlZV9lbWFpbCI6Im5pa2l0YW1hbWFldjE5MTJAZ21haWwuY29tIiwidHJ1c3RlZV9pZCI6MTAwMDA1LCJ4c3JmX3Rva2VuIjoiMTAwMDAwMjktZTQxMmZjN2EtN2IyYy00N2M5LTkzZjUtMjI4ZDQ4MDcwYzExIn0=
  295. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [x-forwarded-for]172.18.0.24
  296. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [x-remote-ip]172.18.0.24
  297. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [x-request-id]f396c7c72d6f6e0195d52c681712eaef
  298. vm_1_writer.log:2023-05-26 22:50:27.341 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24] Got header: [x-xsrf-token]10000029-e412fc7a-7b2c-47c9-93f5-228d48070c11
  299. vm_1_writer.log:2023-05-26 22:50:27.342 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] RequestBody: {"account":100005,"cluster":1,"cpu_number":1,"custom_interfaces":[{"bridge":"vmbr0","ip_count":1,"ippool":1,"mac":null}],"disks":[{"boot_order":1,"size_mib":10240,"storage":1,"tags":[]}],"domain":"active-imaged-n2.ipfabric.com","ignore_recipe_filters":false,"image":1,"name":"active_imaged_n2","node":2,"password":"*","ram_mib":512,"send_email_mode":"saas_only"}
  300. vm_1_writer.log:2023-05-26 22:50:27.342 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] End of POST request
  301. vm_1_writer.log:2023-05-26 22:50:27.342 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Invoke POST request callback
  302. vm_1_writer.log:2023-05-26 22:50:27.342 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "vm5_data","spice_enabled","node_os_family","vxlan_mode","node_network_gateway","node_network_timeout","ha_error","ha_cluster_id","ha_agent_version","ha_checking_host","ha_enabled","net_bandwidth_mbitps","dns_servers","host_per_node_limit","proxy_enabled","domain_change_allowed","manage_disk_enabled","iso_enabled","cpu_overselling","overselling","qemu_version","domain_template","image_storage_path","os_storage_path","interface_count","imported_from","host_filter","host_distribution_policy","datacenter_type","virtualization_type","time_zone","comment","name","id" FROM vm_cluster WHERE "id"='1'' duration=248
  303. vm_1_writer.log:2023-05-26 22:50:27.342 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "file_size_mib","comment","parent_host","account","for_all","size_mib","cpu_number","ram_mib","available_until","date_create","state","virtualization_type","ip_automation","network_device","expand_part","os","image_name","name","id" FROM vm_image WHERE "id"='1'' duration=177
  304. vm_1_writer.log:2023-05-26 22:50:27.343 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "vm5_data","efi_boot","kms_supported","is_lxd_image","is_dummy","state","image_size_mib","archive_size_mib","min_size_mib","ip_automation","network_device","expand_part","tags","adminonly","install_script_updated_at","install_script_checksum","install_script_name","updated_at","repository","checksum","image_name","file_name","os_group","name","id" FROM vm_os WHERE "id"='14'' duration=172
  305. vm_1_writer.log:2023-05-26 22:50:27.343 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "group_key","name","id" FROM vm_os_group WHERE "id"='1'' duration=130
  306. vm_1_writer.log:2023-05-26 22:50:27.343 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "hdd_overselling","ha_params","params","pool_name","enabled","is_main","cluster","storage","id" FROM vm_storage2cluster WHERE cluster='1' AND is_main=TRUE' duration=117
  307. vm_1_writer.log:2023-05-26 22:50:27.343 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "vm5_data","auth_source","state","roles","email","id" FROM vm_account WHERE "id"='100005'' duration=102
  308. vm_1_writer.log:2023-05-26 22:50:27.343 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] WriterAsyncProcess
  309. vm_1_writer.log:2023-05-26 22:50:27.343 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_bill_options WHERE "name"='license'' duration=109
  310. vm_1_writer.log:2023-05-26 22:50:27.344 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] {
  311. vm_1_writer.log:2023-05-26 22:50:27.347 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT vm_node.id AS id, vm_node.cluster AS cluster, vm_cluster.name AS cluster_name, vm_cluster.virtualization_type AS virtualization_type, vm_cluster.host_distribution_policy AS host_distribution_policy, vm_node.name AS name, vm_node.cpu_number AS cpu_number, vm_node.vcpu_limit AS vcpu_limit, vm_node.ram_mib AS ram_mib, vm_node.overselling AS overselling, vm_node.state AS state, vm_node.libvirt_error AS libvirt_error, vm_node.lxd_error AS lxd_error, vm_node.ha_state AS ha_state, vm_node.host_creation_blocked AS host_creation_blocked, vm_node.host_limit AS host_limit, vm_node.host_filter AS host_filter, vm_node.libvirt_version AS libvirt_version, COALESCE(hosts.vcpu, 0) + COALESCE(moving_hosts.vcpu, 0) AS cpu_number_allocated, COALESCE(hosts.ram, 0) + COALESCE(moving_hosts.ram, 0) AS ram_mib_allocated, COALESCE(hosts.number, 0) + COALESCE(moving_hosts.number, 0) AS host_count, node_ipv4.total_ipv4 AS ipv4_total, node_ipv4.used_ipv4 AS ipv4_allocated, COALESCE(JSONB_AGG(DISTINCT CASE WHEN storage2node.id IS NOT NULL THEN JSONB_BUILD_OBJECT('id', storage2node.id, 'name', storage2node.name, 'type', storage2node.type, 'state', storage2node.state, 'local_state', storage2node.local_state, 'is_main', COALESCE(TO_JSONB(storage2node.is_main), JSONB('false')), 'enabled', COALESCE(TO_JSONB(storage2node.enabled), JSONB('false')), 'size_mib', storage2node.size_mib, 'available_mib', storage2node.available_mib, 'hdd_overselling', storage2node.hdd_overselling, 'virt_pool', storage2node.virt_pool, 'tags', st2tags.tags, 'hdd_mib_allocated', storage2node.hdd_mib_allocated) END ) FILTER (WHERE storage2node.id IS NOT NULL), CAST('[]' AS JSONB)) AS storages, JSONB_AGG(vm_node_bridge.name) AS bridge_names FROM vm_node LEFT JOIN vm_cluster ON vm_node.cluster=vm_cluster.id LEFT JOIN (SELECT node, COUNT(*) as number, COALESCE(SUM(ram_mib), 1) AS ram, COALESCE(SUM(cpu_number), 1) AS vcpu FROM vm_host host GROUP BY node) AS hosts ON hosts.node=vm_node.id LEFT JOIN (SELECT reserved_node, COUNT(*) as number, COALESCE(SUM(ram_mib), 1) AS ram, COALESCE(SUM(cpu_number), 1) AS vcpu FROM vm_host host GROUP BY reserved_node) AS moving_hosts ON moving_hosts.reserved_node=vm_node.id LEFT JOIN (SELECT node, COALESCE(SUM(CASE WHEN state='active' THEN 1 ELSE 0 END), 0) AS used_ipv4, COALESCE(COUNT(state), 0) AS total_ipv4 FROM vm_hetzner_ip hetzner_ip WHERE family=2 GROUP BY node) AS node_ipv4 ON node_ipv4.node=vm_node.id LEFT JOIN (SELECT s2n.node AS node, s2n.size_mib AS size_mib, s2n.available_mib AS available_mib, s2n.hdd_overselling AS hdd_overselling, s.id AS id, s.name AS name, s.type AS type, s.state AS state, s2n.state AS local_state, s2c.enabled AS enabled, s2c.params AS virt_pool, s2c.is_main as is_main, COALESCE(disks.hdd_mib, 0) AS hdd_mib_allocated FROM vm_storage2node s2n INNER JOIN vm_storage s ON s.id=s2n.storage LEFT JOIN (SELECT storage2node, SUM(size_mib) AS hdd_mib FROM vm_disk GROUP by storage2node) AS disks ON disks.storage2node=s2n.id INNER JOIN vm_node n ON s2n.node=n.id INNER JOIN vm_storage2cluster s2c ON s2c.storage=s.id AND s2c.cluster=n.cluster) AS storage2node ON storage2node.node=vm_node.id LEFT JOIN (SELECT st.id AS storage, COALESCE(JSONB_AGG(DISTINCT storage2tag.tag) FILTER (WHERE storage2tag.tag IS NOT NULL), CAST('[]' AS JSONB)) AS tags FROM vm_storage st LEFT JOIN vm_storage2tag storage2tag ON st.id=storage2tag.storage GROUP BY st.id) AS st2tags ON st2tags.storage=storage2node.id INNER JOIN vm_node_bridge ON vm_node_bridge.node=vm_node.id WHERE (vm_node.id='2') GROUP BY vm_node.id, vm_cluster.id, hosts.vcpu, moving_hosts.vcpu, hosts.ram, moving_hosts.ram, hosts.number, moving_hosts.number, node_ipv4.total_ipv4, node_ipv4.used_ipv4' duration=2427
  312. vm_1_writer.log:2023-05-26 22:50:27.347 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "additional_data","vm5_data","update_dc_networks_failed","network_error","network_settings_lock","ha_error","ha_disable_failed","ha_state","host_filter","host_limit","selinux_enforcing","hostname","overselling","lxd_version","qemu_version","libvirt_version","uptime","kernel_version","os_version","metrics_timestamp","mon_install_date","mon_installed","host_creation_blocked","property","disk_params","gray_ips","problems","spice_error","bird_error","lxd_error","libvirt_error","frr_error","connection_error","state","ssh_user","ssh_port","vnc_addr","ip_addr_v6","ip_addr","socket_number","vcpu_limit","cpu_number","max_vcpu_number","ram_mib","cluster","comment","name","id" FROM vm_node WHERE "id"='2'' duration=499
  313. vm_1_writer.log:2023-05-26 22:50:27.348 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Constructing Storage from params '{"available_mib":19311,"enabled":true,"hdd_mib_allocated":0,"hdd_overselling":1,"id":1,"is_main":true,"local_state":"active","name":"Storage1","size_mib":59256,"state":"active","tags":[],"type":"file","virt_pool":{"vm_storage_path":"/vm"}}'
  314. vm_1_writer.log:2023-05-26 22:50:27.348 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Fork. New Process PID: 8637
  315. vm_1_writer.log:2023-05-26 22:50:27.348 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8637. Execute command: '/usr/local/bin/vssh 2  free -m | awk '/[0-9]/ {print $7}''
  316. vm_1_writer.log:2023-05-26 22:50:27.480 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8637. Finished successefully with status 0
  317. vm_1_writer.log:2023-05-26 22:50:27.480 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8637. Output: 3517
  318. vm_1_writer.log:2023-05-26 22:50:27.480 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8637. Error:
  319. vm_1_writer.log:2023-05-26 22:50:27.482 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT vm_node.id AS id, vm_node.cluster AS cluster, vm_cluster.name AS cluster_name, vm_cluster.virtualization_type AS virtualization_type, vm_cluster.host_distribution_policy AS host_distribution_policy, vm_node.name AS name, vm_node.cpu_number AS cpu_number, vm_node.vcpu_limit AS vcpu_limit, vm_node.ram_mib AS ram_mib, vm_node.overselling AS overselling, vm_node.state AS state, vm_node.libvirt_error AS libvirt_error, vm_node.lxd_error AS lxd_error, vm_node.ha_state AS ha_state, vm_node.host_creation_blocked AS host_creation_blocked, vm_node.host_limit AS host_limit, vm_node.host_filter AS host_filter, vm_node.libvirt_version AS libvirt_version, COALESCE(hosts.vcpu, 0) + COALESCE(moving_hosts.vcpu, 0) AS cpu_number_allocated, COALESCE(hosts.ram, 0) + COALESCE(moving_hosts.ram, 0) AS ram_mib_allocated, COALESCE(hosts.number, 0) + COALESCE(moving_hosts.number, 0) AS host_count, node_ipv4.total_ipv4 AS ipv4_total, node_ipv4.used_ipv4 AS ipv4_allocated, COALESCE(JSONB_AGG(DISTINCT CASE WHEN storage2node.id IS NOT NULL THEN JSONB_BUILD_OBJECT('id', storage2node.id, 'name', storage2node.name, 'type', storage2node.type, 'state', storage2node.state, 'local_state', storage2node.local_state, 'is_main', COALESCE(TO_JSONB(storage2node.is_main), JSONB('false')), 'enabled', COALESCE(TO_JSONB(storage2node.enabled), JSONB('false')), 'size_mib', storage2node.size_mib, 'available_mib', storage2node.available_mib, 'hdd_overselling', storage2node.hdd_overselling, 'virt_pool', storage2node.virt_pool, 'tags', st2tags.tags, 'hdd_mib_allocated', storage2node.hdd_mib_allocated) END ) FILTER (WHERE storage2node.id IS NOT NULL), CAST('[]' AS JSONB)) AS storages, JSONB_AGG(vm_node_bridge.name) AS bridge_names FROM vm_node LEFT JOIN vm_cluster ON vm_node.cluster=vm_cluster.id LEFT JOIN (SELECT node, COUNT(*) as number, COALESCE(SUM(ram_mib), 1) AS ram, COALESCE(SUM(cpu_number), 1) AS vcpu FROM vm_host host GROUP BY node) AS hosts ON hosts.node=vm_node.id LEFT JOIN (SELECT reserved_node, COUNT(*) as number, COALESCE(SUM(ram_mib), 1) AS ram, COALESCE(SUM(cpu_number), 1) AS vcpu FROM vm_host host GROUP BY reserved_node) AS moving_hosts ON moving_hosts.reserved_node=vm_node.id LEFT JOIN (SELECT node, COALESCE(SUM(CASE WHEN state='active' THEN 1 ELSE 0 END), 0) AS used_ipv4, COALESCE(COUNT(state), 0) AS total_ipv4 FROM vm_hetzner_ip hetzner_ip WHERE family=2 GROUP BY node) AS node_ipv4 ON node_ipv4.node=vm_node.id LEFT JOIN (SELECT s2n.node AS node, s2n.size_mib AS size_mib, s2n.available_mib AS available_mib, s2n.hdd_overselling AS hdd_overselling, s.id AS id, s.name AS name, s.type AS type, s.state AS state, s2n.state AS local_state, s2c.enabled AS enabled, s2c.params AS virt_pool, s2c.is_main as is_main, COALESCE(disks.hdd_mib, 0) AS hdd_mib_allocated FROM vm_storage2node s2n INNER JOIN vm_storage s ON s.id=s2n.storage LEFT JOIN (SELECT storage2node, SUM(size_mib) AS hdd_mib FROM vm_disk GROUP by storage2node) AS disks ON disks.storage2node=s2n.id INNER JOIN vm_node n ON s2n.node=n.id INNER JOIN vm_storage2cluster s2c ON s2c.storage=s.id AND s2c.cluster=n.cluster) AS storage2node ON storage2node.node=vm_node.id LEFT JOIN (SELECT st.id AS storage, COALESCE(JSONB_AGG(DISTINCT storage2tag.tag) FILTER (WHERE storage2tag.tag IS NOT NULL), CAST('[]' AS JSONB)) AS tags FROM vm_storage st LEFT JOIN vm_storage2tag storage2tag ON st.id=storage2tag.storage GROUP BY st.id) AS st2tags ON st2tags.storage=storage2node.id INNER JOIN vm_node_bridge ON vm_node_bridge.node=vm_node.id WHERE (vm_node.id='2') GROUP BY vm_node.id, vm_cluster.id, hosts.vcpu, moving_hosts.vcpu, hosts.ram, moving_hosts.ram, hosts.number, moving_hosts.number, node_ipv4.total_ipv4, node_ipv4.used_ipv4' duration=1951
  320. vm_1_writer.log:2023-05-26 22:50:27.482 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Constructing Storage from params '{"available_mib":19311,"enabled":true,"hdd_mib_allocated":0,"hdd_overselling":1,"id":1,"is_main":true,"local_state":"active","name":"Storage1","size_mib":59256,"state":"active","tags":[],"type":"file","virt_pool":{"vm_storage_path":"/vm"}}'
  321. vm_1_writer.log:2023-05-26 22:50:27.483 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "imported_from","vm5_data","is_network","storage_params","state","type","comment","name","id" FROM vm_storage WHERE "id"='1'' duration=127
  322. vm_1_writer.log:2023-05-26 22:50:27.487 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_host ("id","name","internal_name","os","state","xml_version","vnc_password","spice_enabled","spice_password","ram_mib","cpu_number","node","account","domain","start_date","anti_spoofing_settings","network_device","ip_automation","ha_maintenance") VALUES(7,'active_imaged_n2','7_active_imaged_n2',14,'creating',1,'vsX7DTGg/W+7s0iAC12AJJ18ESUsC/ENbQ1STP4GvryQlgsyBWH+OaAUYFLHE/tt2iFFf7oaGYMRryxzrFu5mPfteGmCTefbnoaxGDfGqeSo3RD+LC7Ex25QjQSipZYZ9x63u1Vu4MYG8lXJD0wodW75fOvkDtIgTwFv+nt2Y04sBBCrWj+OIjFR3C5BdmFtGzPFHrxmQJerk6reH1M/GLWwTUag9PSeGaOeABclJ0kyjnUdgMEWzMNDw6Aa1oW6anjPtCLUgpqbALeId7zo/4q608wr+1jMXe805WfLMEUT1iN/PiXz55qb+CwqfPoL473YOkUCXe2ZAEsXqrhgWw==','1','a1r0Paj4oOEuE4u7aT6eQvCmod1vPyjIUeygtK7elE9XL8BSsT0VlS1niJBdnsF8s5IIQvqDb1LIWX+D/NDE2q1c4CoHEdqsw6YCGQSSk1lI4tpFNI6ncmX5B7pZ/zcBpcV7KwAO57Vhyf60Bd7ot9nc93j8g1dulj4wfuzvgaW5TO+qjcTtqzNO7uBepkXiMR1F6zoxZapfok0WDX4V95dnsJSL6xjLpxhdgCmY/YlLDqTzKeXG4/GWhOAtLIgwNlYNI4N4uvOJ+we/N7YhL69qk/E1ocfqtsUFE/EFCyAWv5iSnTlWEDMB3DtQeu5lKAOpfGRmTVl6xCJq8iSjKg==',512,1,2,100005,'active-imaged-n2.ipfabric.com',1685141427,'{"vlan":false}','ens3','debian_based','1')' duration=4220
  323. vm_1_writer.log:2023-05-26 22:50:27.488 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT MAX(create_time) FROM vm_host_history WHERE event_type='field:state' AND ref='7'' duration=196
  324. vm_1_writer.log:2023-05-26 22:50:27.488 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_host_history (id,event_type,event_info,request_user,request_owner,request_ip,request_id,ref) VALUES (33,'field:state','{"new_value":"creating","old_value":null}','nikitamamaev1912@gmail.com','---','172.18.0.24','f396c7c72d6f6e0195d52c681712eaef',7)' duration=143
  325. vm_1_writer.log:2023-05-26 22:50:27.488 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "hdd_overselling","available_mib","size_mib","state","node","storage","id" FROM vm_storage2node WHERE "storage"='1' AND "node"='2'' duration=117
  326. vm_1_writer.log:2023-05-26 22:50:27.488 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT COALESCE(JSONB_AGG(target_dev), CAST('[]' AS JSONB)) FROM vm_disk WHERE (host = '7')' duration=137
  327. vm_1_writer.log:2023-05-26 22:50:27.492 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_disk ("id","name","internal_name","is_main","expand_part","size_mib","boot_order","target_dev","bus","storage2node","account","host","tags") VALUES(7,'active_imaged_n2','7_active_imaged_n2','1','/dev/sda2',10240,1,'vda','virtio',2,100005,7,'[]')' duration=4172
  328. vm_1_writer.log:2023-05-26 22:50:27.493 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT MAX(create_time) FROM vm_disk_history WHERE event_type='field:size_mib' AND ref='7'' duration=190
  329. vm_1_writer.log:2023-05-26 22:50:27.493 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_disk_history (id,event_type,event_info,request_user,request_owner,request_ip,request_id,ref) VALUES (7,'field:size_mib','{"new_value":"10240","old_value":null}','nikitamamaev1912@gmail.com','---','172.18.0.24','f396c7c72d6f6e0195d52c681712eaef',7)' duration=148
  330. vm_1_writer.log:2023-05-26 22:50:27.493 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "date_create","old_values","take_slave_ip","vlan","is_main_network","is_default","state","gateway_v6","gateway_v4","ipv6","ipv4","node","name","id" FROM vm_node_bridge WHERE "name"='vmbr0' AND "node"='2'' duration=148
  331. vm_1_writer.log:2023-05-26 22:50:27.493 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "model","vxlan","mac_address","host","node_bridge","name","id" FROM vm_host_interfaces WHERE "node_bridge"='2' AND "host"='7'' duration=98
  332. vm_1_writer.log:2023-05-26 22:50:27.493 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='qemu_reserve_mac_bytes'' duration=97
  333. vm_1_writer.log:2023-05-26 22:50:27.493 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='mgr_reserve_mac_bytes'' duration=83
  334. vm_1_writer.log:2023-05-26 22:50:27.494 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "model","vxlan","mac_address","host","node_bridge","name","id" FROM vm_host_interfaces WHERE "mac_address"='52:54:00:5C:38:57'' duration=98
  335. vm_1_writer.log:2023-05-26 22:50:27.497 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_host_interfaces ("id","name","node_bridge","host","mac_address") VALUES(7,'ens3',2,7,'52:54:00:5C:38:57')' duration=3718
  336. vm_1_writer.log:2023-05-26 22:50:27.498 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "tag","ippool","account","comment","name","id" FROM vm_vxlan WHERE "ippool"='1'' duration=126
  337. vm_1_writer.log:2023-05-26 22:50:27.498 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT ipp2cl.ippool FROM vm_ippool2cluster ipp2cl WHERE ipp2cl.cluster = '1' AND ipp2cl.interface = '0' GROUP BY ipp2cl.ippool' duration=134
  338. vm_1_writer.log:2023-05-26 22:50:27.498 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] InternalCall service: ip path: ippool/1/ip
  339. vm_1_writer.log:2023-05-26 22:50:27.503 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] InternalRead service: ip path: ip/12
  340. vm_1_writer.log:2023-05-26 22:50:27.506 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "ippool","network","remote_id","host_interface","host","bin","account","property","state","family","domain","net_prefix","first_addr","netmask","gateway","ip_addr","comment","id" FROM vm_ip WHERE ip_addr='172.31.50.206'' duration=187
  341. vm_1_writer.log:2023-05-26 22:50:27.506 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] InternalRead service: ip path: ipnet/1
  342. vm_1_writer.log:2023-05-26 22:50:27.508 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "cluster","bgp_community_v6","bgp_as_v6","bgp_community","bgp_as","mac","gateway","bgp_routing_type","id" FROM vm_ip_fabric_settings WHERE "cluster"='1'' duration=145
  343. vm_1_writer.log:2023-05-26 22:50:27.513 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_ip ("id","ip_addr","gateway","netmask","net_prefix","domain","family","state","account","bin","host","host_interface","remote_id","network","ippool") VALUES(7,'172.31.50.206','10.0.0.75','255.255.255.255',32,'active-imaged-n2.ipfabric.com',2,'prepare to allocate',100005,1000000000000000000000000000002887725774,7,7,12,1,1)' duration=5134
  344. vm_1_writer.log:2023-05-26 22:50:27.514 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='UPDATE vm_host SET "proxy_port"=22 WHERE "id"=7' duration=907
  345. vm_1_writer.log:2023-05-26 22:50:27.515 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/update' with content '{"notifies":["cluster/1","node/2"]}'
  346. vm_1_writer.log:2023-05-26 22:50:27.515 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT vm_host_interfaces.node_bridge AS node_bridge, vm_host_interfaces.mac_address AS mac_address, model, vm_host_interfaces.vxlan AS vxlan, vm_node_bridge.name AS name, vm_node_bridge.is_main_network AS is_main_network FROM vm_host_interfaces LEFT JOIN vm_node_bridge ON vm_host_interfaces.node_bridge=vm_node_bridge.id WHERE (vm_host_interfaces.host='7') ORDER BY vm_node_bridge.is_main_network DESC, vm_host_interfaces.id' duration=222
  347. vm_1_writer.log:2023-05-26 22:50:27.517 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT JSONB_BUILD_OBJECT('ip_ids', COALESCE(ip2iface.list, CAST('[]' AS JSONB)), 'mac_address', vm_host_interfaces.mac_address, 'name', vm_host_interfaces.name, 'network_switch', vm_node_bridge.name, 'node_interface_name', vm_node_bridge.name) AS json FROM vm_host_interfaces LEFT JOIN (SELECT vm_ip.host_interface AS host_interface, COALESCE(JSONB_AGG(vm_ip.id), CAST('[]' AS JSONB)) AS list FROM vm_ip WHERE (vm_ip.state NOT IN ('deleting','crashed') ) GROUP BY vm_ip.host_interface) ip2iface ON vm_host_interfaces.id=ip2iface.host_interface JOIN vm_node_bridge ON vm_node_bridge.id=vm_host_interfaces.node_bridge WHERE (vm_host_interfaces.host='7')' duration=311
  348. vm_1_writer.log:2023-05-26 22:50:27.517 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT ip_addr FROM vm_ip WHERE host='7' ORDER BY id LIMIT 1' duration=132
  349. vm_1_writer.log:2023-05-26 22:50:27.520 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] ssh keys from auth {"last_notify":402301,"list":[],"size":0}
  350. vm_1_writer.log:2023-05-26 22:50:27.520 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT vm_ssh_key.ssh_key FROM vm_ssh_key2cluster JOIN vm_ssh_key ON vm_ssh_key.id=vm_ssh_key2cluster.ssh_key WHERE vm_ssh_key2cluster.cluster='1'' duration=210
  351. vm_1_writer.log:2023-05-26 22:50:27.521 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='task_timeout'' duration=114
  352. vm_1_writer.log:2023-05-26 22:50:27.521 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","os","name","id" FROM vm_os_options WHERE "name"='product_key' AND "os"='14'' duration=146
  353. vm_1_writer.log:2023-05-26 22:50:27.521 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","os","name","id" FROM vm_os_options WHERE "name"='kms_ip' AND "os"='14'' duration=125
  354. vm_1_writer.log:2023-05-26 22:50:27.523 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] /v3/whoami/vm result {"email_confirmed":true,"expires_at":"","instance_owner":false,"lang":"ru","last_notify":402301,"owner_email":"nikitamamaev1912@gmail.com","owner_id":100005,"roles":["@admin"],"ses_id":34,"session":"10000029-e412fc7a-7b2c-47c9-93f5-228d48070c11","su_instance":false,"trustee_email":"nikitamamaev1912@gmail.com","trustee_id":100005,"xsrf_token":"10000029-e412fc7a-7b2c-47c9-93f5-228d48070c11"}
  355. vm_1_writer.log:2023-05-26 22:50:27.524 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] whoami result {"error":{"code":3007,"msg":"Session header was not set"}}
  356. vm_1_writer.log:2023-05-26 22:50:27.525 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT os.id AS id, os.name AS name, os.tags AS tags, os_group.group_key AS "group" FROM vm_os os LEFT JOIN vm_os_group os_group ON os.os_group=os_group.id WHERE os.id='14'' duration=294
  357. vm_1_writer.log:2023-05-26 22:50:27.525 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT disk.id AS id, disk.name AS name, disk.size_mib AS size_mib, disk.boot_order AS boot_order, disk.expand_part AS expand_part, vm_storage2node.id AS pool_id, vm_storage2cluster.pool_name AS pool_name, vm_storage2node.storage AS storage_id FROM vm_disk disk LEFT JOIN vm_storage2node ON vm_storage2node.id=disk.storage2node LEFT JOIN vm_node ON vm_node.id=vm_storage2node.node LEFT JOIN vm_storage2cluster ON vm_storage2cluster.storage=vm_storage2node.storage AND vm_storage2cluster.cluster=vm_node.cluster WHERE disk.host='7'' duration=356
  358. vm_1_writer.log:2023-05-26 22:50:27.526 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT i.id AS id, i.name AS name, i.mac_address AS mac_address, i.vxlan IS NOT NULL AS is_vxlan, i.model AS model, x.id AS vxlan_id, b.id AS node_bridge, b.name AS node_bridge_name, b.is_main_network AS is_main_network FROM vm_host_interfaces AS i LEFT JOIN vm_node_bridge b ON i.node_bridge = b.id LEFT JOIN vm_vxlan x ON x.id = i.vxlan WHERE (i.host = '7') ORDER BY i.id, b.is_main_network DESC' duration=240
  359. vm_1_writer.log:2023-05-26 22:50:27.526 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "date_create","old_values","take_slave_ip","vlan","is_main_network","is_default","state","gateway_v6","gateway_v4","ipv6","ipv4","node","name","id" FROM vm_node_bridge WHERE id = '2'' duration=104
  360. vm_1_writer.log:2023-05-26 22:50:27.526 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT id AS local_id, ip_addr, gateway, net_prefix, domain, host_interface AS interface_id, remote_id, network AS network_id, ippool AS ippool_id, state FROM vm_ip WHERE host='7' AND family='2'' duration=147
  361. vm_1_writer.log:2023-05-26 22:50:27.526 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT id AS local_id, ip_addr, gateway, net_prefix, domain, host_interface AS interface_id, remote_id, network AS network_id, ippool AS ippool_id, state FROM vm_ip WHERE host='7' AND family='10'' duration=185
  362. vm_1_writer.log:2023-05-26 22:50:27.527 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT ip_addr FROM vm_ip WHERE host='7' ORDER BY id LIMIT 1' duration=153
  363. vm_1_writer.log:2023-05-26 22:50:27.527 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "node","image","id" FROM vm_image2node WHERE "image"='1' AND "node"='2'' duration=192
  364. vm_1_writer.log:2023-05-26 22:50:27.527 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='task_timeout'' duration=151
  365. vm_1_writer.log:2023-05-26 22:50:27.527 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='consul_task_ttl_in_sec'' duration=119
  366. vm_1_writer.log:2023-05-26 22:50:27.533 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "ha_cluster_id","ha_id","password_hidden","defer_reason","request_info","node","main_table_id","main_table","output","date_end","date_start","date_create","status","message_params","param","name","consul_id","id" FROM vm_task_log WHERE "consul_id"='864' AND "name"='host_image_copy'' duration=229
  367. vm_1_writer.log:2023-05-26 22:50:27.533 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_task_log ("id","consul_id","name","param","message_params","status","main_table","main_table_id","request_info") VALUES(76,864,'host_image_copy', E'["--action","host_image_copy","--virt-type","kvm","--params","{\\"destination\\":{\\"connection_params\\":{\\"ip\\":\\"172.31.48.153\\",\\"login\\":\\"astra-node-2\\",\\"path\\":\\"/image\\",\\"port\\":22},\\"id\\":2,\\"type\\":null},\\"image_id\\":1,\\"image_name\\":\\"1_1_preset_image.raw\\"}"]','{"name":"active"}','created','vm_image',1,'{"callback_counter":53,"first_start":102482592569377,"need_log":true,"request":{"extra_tags":[],"id":"f396c7c72d6f6e0195d52c681712eaef","ip":"172.18.0.24","user":{"id":100005,"name":"nikitamamaev1912@gmail.com"}},"runtime":180225150}')' duration=241
  368. vm_1_writer.log:2023-05-26 22:50:27.534 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='gray_ips'' duration=155
  369. vm_1_writer.log:2023-05-26 22:50:27.534 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='task_timeout'' duration=91
  370. vm_1_writer.log:2023-05-26 22:50:27.541 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "ha_cluster_id","ha_id","password_hidden","defer_reason","request_info","node","main_table_id","main_table","output","date_end","date_start","date_create","status","message_params","param","name","consul_id","id" FROM vm_task_log WHERE "consul_id"='865' AND "name"='host_create'' duration=225
  371. vm_1_writer.log:2023-05-26 22:50:27.542 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_task_log ("id","consul_id","name","param","message_params","status","main_table","main_table_id","node","request_info") VALUES(77,865,'host_create', E'["--action","host_create","--virt-type","kvm","--params","{\\"cluster\\":{\\"id\\":1},\\"datacenter_type\\":\\"ip_fabric\\",\\"efi_boot\\":false,\\"ha_enabled\\":false,\\"host\\":{\\"additional_disks\\":[],\\"bridge\\":\\"vmbr0\\",\\"disk\\":{\\"boot_order\\":1,\\"expand_part\\":\\"/dev/sda2\\",\\"file_format\\":\\"qcow2\\",\\"id\\":7,\\"internal_name\\":\\"7_active_imaged_n2\\",\\"name\\":\\"active_imaged_n2\\",\\"pool_name\\":\\"File_vm\\",\\"size_mib\\":10240,\\"storage_id\\":1,\\"storage_params\\":{\\"pool\\":{\\"vm_storage_path\\":\\"/vm\\"}},\\"storage_type\\":\\"file\\",\\"target_bus\\":\\"virtio\\",\\"target_dev\\":\\"vda\\"},\\"dns_servers\\":[],\\"domain\\":\\"active-imaged-n2.ipfabric.com\\",\\"interfaces\\":[{\\"cluster_interface\\":0,\\"is_main_network\\":true,\\"is_vxlan\\":false,\\"mac\\":\\"52:54:00:5C:38:57\\",\\"model\\":\\"virtio\\",\\"network_switch\\":\\"vmbr0\\"}],\\"internal_name\\":\\"7_active_imaged_n2\\",\\"mem\\":\\"512\\",\\"name\\":\\"active_imaged_n2\\",\\"network\\":[{\\"host_interface\\":\\"ens3\\",\\"host_interface_mac\\":\\"52:54:00:5C:38:57\\",\\"ipv4\\":[{\\"gateway\\":\\"10.0.0.75\\",\\"id\\":7,\\"ip\\":\\"172.31.50.206\\",\\"netmask\\":\\"255.255.255.255\\"}],\\"ipv6_secondaries\\":[],\\"network_switch\\":\\"vmbr0\\",\\"node_interface_name\\":\\"vmbr0\\"}],\\"password\\":\\"*\\",\\"source\\":{\\"expand_part\\":\\"/dev/sda2\\",\\"id\\":1,\\"image_name\\":\\"1_1_preset_image.raw\\",\\"ip_automation\\":\\"debian_based\\",\\"location\\":{\\"connection_params\\":{\\"ip\\":\\"172.31.48.153\\",\\"login\\":\\"astra-node-2\\",\\"path\\":\\"/image\\",\\"port\\":22},\\"id\\":2,\\"type\\":null},\\"os_group\\":\\"ubuntu\\",\\"path\\":\\"/image/1_1_preset_image.raw\\",\\"type\\":\\"image\\"},\\"spice\\":{\\"password\\":\\"*\\"},\\"ssh_address\\":\\"172.31.50.206\\",\\"ssh_key\\":[],\\"ssh_port\\":22,\\"timezone\\":\\"UTC\\",\\"tuned_resources\\":{\\"anti_spoofing\\":true,\\"anti_spoofing_settings\\":{\\"vlan\\":false},\\"cpu_custom_model\\":null,\\"cpu_mode\\":\\"default\\",\\"cpu_weight\\":1024,\\"firewall_rules\\":null,\\"io_read_iops\\":0,\\"io_read_mbitps\\":0,\\"io_weight\\":500,\\"io_write_iops\\":0,\\"io_write_mbitps\\":0,\\"nesting\\":false,\\"net_in_mbitps\\":0,\\"net_out_mbitps\\":0,\\"net_weight\\":5,\\"network\\":[{\\"host_interface\\":\\"ens3\\",\\"host_interface_mac\\":\\"52:54:00:5C:38:57\\",\\"ipv4\\":[{\\"gateway\\":\\"10.0.0.75\\",\\"id\\":7,\\"ip\\":\\"172.31.50.206\\",\\"netmask\\":\\"255.255.255.255\\"}],\\"ipv6_secondaries\\":[],\\"network_switch\\":\\"vmbr0\\",\\"node_interface_name\\":\\"vmbr0\\"}],\\"process_number\\":-1,\\"tcp_connections_in\\":0,\\"tcp_connections_out\\":0},\\"vcpu\\":\\"1\\",\\"vnc_address\\":\\"172.31.48.153\\",\\"vnc_password\\":\\"*\\"},\\"id\\":\\"7\\",\\"install_mode\\":\\"create_from_image\\",\\"kms_address\\":\\"\\",\\"node\\":{\\"id\\":2,\\"ip_addr\\":\\"172.31.48.153\\",\\"os_version\\":\\"AstraLinux 1.7.3\\",\\"ssh_port\\":\\"22\\"},\\"product_key\\":\\"\\",\\"ssh_port\\":22,\\"timeout_seconds\\":7200}"]','{"ip_addr":"172.31.50.206","name":"active_imaged_n2"}','created','vm_host',7,2,'{"callback_counter":59,"first_start":102482592569377,"need_log":true,"request":{"extra_tags":[],"id":"f396c7c72d6f6e0195d52c681712eaef","ip":"172.18.0.24","user":{"id":100005,"name":"nikitamamaev1912@gmail.com"}},"runtime":188190464}')' duration=348
  372. vm_1_writer.log:2023-05-26 22:50:27.542 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/create' with content '{"notifies":["host/7/vm_ip/7","vm_ip/7"]}'
  373. vm_1_writer.log:2023-05-26 22:50:27.543 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_host_log ("id","name","host","task","rights","params","request_trustee","request_owner") VALUES(50,'host_create',7,77,'{"params":{"node":["@admin"]}}','{"cpu":1,"disk":10240,"ip":["172.31.50.206"],"node":{"addr":"172.31.48.153","id":2,"name":"node-2"},"os":"Ubuntu 22.04","ram":512}',100005,100005)' duration=344
  374. vm_1_writer.log:2023-05-26 22:50:27.543 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/create' with content '{"notifies":["host_history/50","host/7/host_history/50"]}'
  375. vm_1_writer.log:2023-05-26 22:50:27.543 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_node_log ("id","name","node","task","host","params","request_trustee","request_owner") VALUES(33,'host_create',2,77,7,'{"host_name":"active_imaged_n2"}',100005,100005)' duration=748
  376. vm_1_writer.log:2023-05-26 22:50:27.543 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/create' with content '{"notifies":["node_history/33","node/2/node_history/33"]}'
  377. vm_1_writer.log:2023-05-26 22:50:27.544 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT os.id AS id, os.name AS name, os.tags AS tags, os_group.group_key AS "group" FROM vm_os os LEFT JOIN vm_os_group os_group ON os.os_group=os_group.id WHERE os.id='14'' duration=244
  378. vm_1_writer.log:2023-05-26 22:50:27.544 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT disk.id AS id, disk.name AS name, disk.size_mib AS size_mib, disk.boot_order AS boot_order, disk.expand_part AS expand_part, vm_storage2node.id AS pool_id, vm_storage2cluster.pool_name AS pool_name, vm_storage2node.storage AS storage_id FROM vm_disk disk LEFT JOIN vm_storage2node ON vm_storage2node.id=disk.storage2node LEFT JOIN vm_node ON vm_node.id=vm_storage2node.node LEFT JOIN vm_storage2cluster ON vm_storage2cluster.storage=vm_storage2node.storage AND vm_storage2cluster.cluster=vm_node.cluster WHERE disk.host='7'' duration=339
  379. vm_1_writer.log:2023-05-26 22:50:27.545 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT i.id AS id, i.name AS name, i.mac_address AS mac_address, i.vxlan IS NOT NULL AS is_vxlan, i.model AS model, x.id AS vxlan_id, b.id AS node_bridge, b.name AS node_bridge_name, b.is_main_network AS is_main_network FROM vm_host_interfaces AS i LEFT JOIN vm_node_bridge b ON i.node_bridge = b.id LEFT JOIN vm_vxlan x ON x.id = i.vxlan WHERE (i.host = '7') ORDER BY i.id, b.is_main_network DESC' duration=280
  380. vm_1_writer.log:2023-05-26 22:50:27.545 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "date_create","old_values","take_slave_ip","vlan","is_main_network","is_default","state","gateway_v6","gateway_v4","ipv6","ipv4","node","name","id" FROM vm_node_bridge WHERE id = '2'' duration=134
  381. vm_1_writer.log:2023-05-26 22:50:27.545 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT id AS local_id, ip_addr, gateway, net_prefix, domain, host_interface AS interface_id, remote_id, network AS network_id, ippool AS ippool_id, state FROM vm_ip WHERE host='7' AND family='2'' duration=111
  382. vm_1_writer.log:2023-05-26 22:50:27.545 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT id AS local_id, ip_addr, gateway, net_prefix, domain, host_interface AS interface_id, remote_id, network AS network_id, ippool AS ippool_id, state FROM vm_ip WHERE host='7' AND family='10'' duration=93
  383. vm_1_writer.log:2023-05-26 22:50:27.546 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='task_timeout'' duration=114
  384. vm_1_writer.log:2023-05-26 22:50:27.547 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='consul_task_ttl_in_sec'' duration=366
  385. vm_1_writer.log:2023-05-26 22:50:27.559 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "ha_cluster_id","ha_id","password_hidden","defer_reason","request_info","node","main_table_id","main_table","output","date_end","date_start","date_create","status","message_params","param","name","consul_id","id" FROM vm_task_log WHERE "consul_id"='866' AND "name"='host_spice_configure'' duration=476
  386. vm_1_writer.log:2023-05-26 22:50:27.559 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_task_log ("id","consul_id","name","param","message_params","status","main_table","main_table_id","request_info") VALUES(78,866,'host_spice_configure', E'["--action","host_spice_configure","--virt-type","kvm","--params","{\\"disk\\":{\\"boot_order\\":1,\\"expand_part\\":\\"/dev/sda2\\",\\"file_format\\":\\"qcow2\\",\\"id\\":7,\\"internal_name\\":\\"7_active_imaged_n2\\",\\"name\\":\\"active_imaged_n2\\",\\"pool_name\\":\\"File_vm\\",\\"size_mib\\":10240,\\"storage_id\\":1,\\"storage_params\\":{\\"pool\\":{\\"vm_storage_path\\":\\"/vm\\"}},\\"storage_type\\":\\"file\\",\\"target_bus\\":\\"virtio\\",\\"target_dev\\":\\"vda\\"},\\"ha_enabled\\":false,\\"host\\":{\\"datacenter_type\\":\\"ip_fabric\\",\\"domain\\":\\"active-imaged-n2.ipfabric.com\\",\\"id\\":7,\\"internal_name\\":\\"7_active_imaged_n2\\",\\"os_group\\":\\"ubuntu\\"},\\"node\\":{\\"id\\":2,\\"image_storage_path\\":\\"/image\\",\\"ip_addr\\":\\"172.31.48.153\\",\\"os_version\\":\\"AstraLinux 1.7.3\\",\\"port\\":22,\\"virt_type\\":\\"kvm\\"},\\"spice_enabled\\":true,\\"spice_password\\":\\"*\\"}"]','{"name":"active_imaged_n2","spice_enabled":"true"}','created','vm_host',7,'{"callback_counter":77,"first_start":102482592569377,"need_log":true,"request":{"extra_tags":[],"id":"f396c7c72d6f6e0195d52c681712eaef","ip":"172.18.0.24","user":{"id":100005,"name":"nikitamamaev1912@gmail.com"}},"runtime":194575203}')' duration=382
  387. vm_1_writer.log:2023-05-26 22:50:27.561 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_host_log ("id","name","host","task","params","request_trustee","request_owner") VALUES(51,'host_spice_configure',7,78,'{"name":"active_imaged_n2","spice_enabled":true}',100005,100005)' duration=471
  388. vm_1_writer.log:2023-05-26 22:50:27.561 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/create' with content '{"notifies":["host_history/51","host/7/host_history/51"]}'
  389. vm_1_writer.log:2023-05-26 22:50:27.562 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT DISTINCT ip.network, ip.family FROM vm_host JOIN vm_ip ip ON ip.host=vm_host.id AND ip.ippool NOT IN ( SELECT DISTINCT vm_vxlan.ippool FROM vm_vxlan) WHERE vm_host.node = '2'' duration=471
  390. vm_1_writer.log:2023-05-26 22:50:27.562 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT DISTINCT ip.network, ip.family FROM vm_host JOIN vm_ip ip ON ip.host=vm_host.id AND ip.ippool NOT IN ( SELECT DISTINCT vm_vxlan.ippool FROM vm_vxlan) WHERE vm_host.node = '2'AND vm_host.id != 7' duration=245
  391. vm_1_writer.log:2023-05-26 22:50:27.562 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT vm_ip_fabric_settings.bgp_routing_type FROM vm_ip_fabric_settings WHERE vm_ip_fabric_settings.cluster='1'' duration=138
  392. vm_1_writer.log:2023-05-26 22:50:27.563 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT ip, bgp_as, comment FROM vm_bgp_session WHERE ip_fabric_settings='1' AND type='v4'' duration=291
  393. vm_1_writer.log:2023-05-26 22:50:27.563 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT ip, bgp_as, comment FROM vm_bgp_session WHERE ip_fabric_settings='1' AND type='v6'' duration=107
  394. vm_1_writer.log:2023-05-26 22:50:27.563 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT DISTINCT ip.network, ip.family FROM vm_host JOIN vm_ip ip ON ip.host=vm_host.id AND ip.ippool NOT IN ( SELECT DISTINCT vm_vxlan.ippool FROM vm_vxlan) WHERE vm_host.node = '2'' duration=205
  395. vm_1_writer.log:2023-05-26 22:50:27.563 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='task_timeout'' duration=265
  396. vm_1_writer.log:2023-05-26 22:50:27.564 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "value","name","id" FROM vm_settings WHERE "name"='consul_task_ttl_in_sec'' duration=129
  397. vm_1_writer.log:2023-05-26 22:50:27.569 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='SELECT "ha_cluster_id","ha_id","password_hidden","defer_reason","request_info","node","main_table_id","main_table","output","date_end","date_start","date_create","status","message_params","param","name","consul_id","id" FROM vm_task_log WHERE "consul_id"='867' AND "name"='node_update_frr'' duration=190
  398. vm_1_writer.log:2023-05-26 22:50:27.570 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a5804e1f0 query='INSERT INTO vm_task_log ("id","consul_id","name","param","message_params","status","main_table","main_table_id","node","request_info") VALUES(79,867,'node_update_frr', E'["--action","node_update_frr","--virt-type","kvm","--params","{\\"bgp_settings\\":{\\"bgp_as\\":62200,\\"bgp_as_v6\\":null,\\"bgp_community\\":\\"\\",\\"bgp_community_v6\\":null,\\"bgp_routing_type\\":\\"frr\\",\\"bgp_sessions\\":[{\\"bgp_as\\":\\"62200\\",\\"comment\\":\\"\\",\\"ip\\":\\"172.31.49.8\\"}],\\"bgp_sessions_v6\\":[]},\\"dc_type\\":\\"ip_fabric\\",\\"gateway\\":null,\\"id\\":2,\\"ip\\":\\"172.31.48.153\\",\\"networks\\":{\\"ipv4\\":[1],\\"ipv6\\":[]},\\"old_vxlan_mode\\":\\"disabled\\",\\"os_version\\":\\"AstraLinux 1.7.3\\",\\"ssh_port\\":22,\\"timeout\\":300,\\"vxlan_mode\\":\\"disabled\\"}"]','{"ip_addr":"172.31.48.153","name":"node-2"}','created','vm_node',2,2,'{"callback_counter":87,"first_start":102482592569377,"need_log":true,"request":{"extra_tags":[],"id":"f396c7c72d6f6e0195d52c681712eaef","ip":"172.18.0.24","user":{"id":100005,"name":"nikitamamaev1912@gmail.com"}},"runtime":196526904}')' duration=230
  399. vm_1_writer.log:2023-05-26 22:50:27.570 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/create' with content '{"notifies":["host/7"]}'
  400. vm_1_writer.log:2023-05-26 22:50:27.571 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Response body '{"id":7,"spice_task":866,"task":865}'
  401. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] request method: POST url: /image/1/change_state version: HTTP/1.0
  402. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Handler 'image/{image_id}/change_state' choosen
  403. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [connection]close
  404. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [content-length]18
  405. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [global-attributes]{"request":{"id":"f396c7c72d6f6e0195d52c681712eaef","ip":"172.18.0.24","user":{"name":"nikitamamaev1912@gmail.com"}}}
  406. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [host]instance-1
  407. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [instance-id]1
  408. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [internal-auth]eyJyb2xlcyI6WyJAaW50ZXJuYWwiXX0=
  409. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [x-forwarded-for]172.18.0.24
  410. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [x-remote-ip]172.18.0.24
  411. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [x-request-id]641700fc9f48eeb8a784f22b9e6aaf43
  412. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] RequestBody: {"state":"in_use"}
  413. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] End of POST request
  414. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Invoke POST request callback
  415. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] WriterAsyncProcess
  416. vm_1_writer.log:2023-05-26 22:52:12.055 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] LimitAssert
  417. vm_1_writer.log:2023-05-26 22:52:12.056 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a50004fb0 query='SELECT "file_size_mib","comment","parent_host","account","for_all","size_mib","cpu_number","ram_mib","available_until","date_create","state","virtualization_type","ip_automation","network_device","expand_part","os","image_name","name","id" FROM vm_image WHERE "id"='1'' duration=193
  418. vm_1_writer.log:2023-05-26 22:52:12.056 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a50004fb0 query='UPDATE vm_image SET "state"='in_use' WHERE "id"=1' duration=371
  419. vm_1_writer.log:2023-05-26 22:52:12.056 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/update' with content '{"notifies":["host/1/image/1"]}'
  420. vm_1_writer.log:2023-05-26 22:52:12.056 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/update' with content '{"notifies":["/1"]}'
  421. vm_1_writer.log:2023-05-26 22:52:12.056 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Response body '{"id":1}'
  422. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] request method: POST url: /image/1/change_state version: HTTP/1.0
  423. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Handler 'image/{image_id}/change_state' choosen
  424. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [connection]close
  425. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [content-length]18
  426. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [global-attributes]{"callback_counter":6,"first_start":102587308244603,"request":{"id":"f396c7c72d6f6e0195d52c681712eaef","ip":"172.18.0.24","user":{"name":"nikitamamaev1912@gmail.com"}},"runtime":16313849}
  427. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [host]instance-1
  428. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [instance-id]1
  429. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [internal-auth]eyJyb2xlcyI6WyJAaW50ZXJuYWwiXX0=
  430. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [x-forwarded-for]172.18.0.24
  431. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [x-remote-ip]172.18.0.24
  432. vm_1_writer.log:2023-05-26 22:53:22.320 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got header: [x-request-id]6088a74f3b04870eb036a1f658e42bce
  433. vm_1_writer.log:2023-05-26 22:53:22.321 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] RequestBody: {"state":"active"}
  434. vm_1_writer.log:2023-05-26 22:53:22.321 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] End of POST request
  435. vm_1_writer.log:2023-05-26 22:53:22.321 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Invoke POST request callback
  436. vm_1_writer.log:2023-05-26 22:53:22.321 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] WriterAsyncProcess
  437. vm_1_writer.log:2023-05-26 22:53:22.321 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] LimitAssert
  438. vm_1_writer.log:2023-05-26 22:53:22.321 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a580343c0 query='SELECT "file_size_mib","comment","parent_host","account","for_all","size_mib","cpu_number","ram_mib","available_until","date_create","state","virtualization_type","ip_automation","network_device","expand_part","os","image_name","name","id" FROM vm_image WHERE "id"='1'' duration=274
  439. vm_1_writer.log:2023-05-26 22:53:22.322 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] db: id=0x7c5a580343c0 query='UPDATE vm_image SET "state"='active' WHERE "id"=1' duration=593
  440. vm_1_writer.log:2023-05-26 22:53:22.322 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/update' with content '{"notifies":["host/1/image/1"]}'
  441. vm_1_writer.log:2023-05-26 22:53:22.322 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Create notify 'instance/1/notify/update' with content '{"notifies":["/1"]}'
  442. vm_1_writer.log:2023-05-26 22:53:22.322 [pid=7589] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Response body '{"id":1}'
  443. vmctl.log:2023-05-26 22:50:27.589 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got action host_image_copy with params
  444. vmctl.log:2023-05-26 22:50:27.589 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Using VmctlMode::VMCTL virt-type kvm
  445. vmctl.log:2023-05-26 22:50:27.590 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Stdin params: {"before_execute":{"last_notify":402301,"source_list":[{"connection_params":{"ip":"172.31.48.161","login":"astra-node-1","path":"/image","port":22},"id":1,"type":null}]},"stdin":{}}
  446. vmctl.log:2023-05-26 22:50:27.590 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Executing action host_image_copy with params
  447. vmctl.log:2023-05-26 22:50:27.590 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Fork. New Process PID: 8652
  448. vmctl.log:2023-05-26 22:50:27.590 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8652. Execute command: 'scripts/image_copy.py'
  449. vmctl.log:2023-05-26 22:52:11.996 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8652. Finished successefully with status 0
  450. vmctl.log:2023-05-26 22:52:11.996 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8652. Output: {}
  451. vmctl.log:2023-05-26 22:52:11.996 [pid=8649] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8652. Error: Identity added: /opt/ispsystem/vm/etc/.ssh/vmmgr.1 (root@auth_back)
  452. vmctl.log:2023-05-26 22:52:12.041 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got action host_create with params
  453. vmctl.log:2023-05-26 22:52:12.041 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Using VmctlMode::VMCTL virt-type kvm
  454. vmctl.log:2023-05-26 22:52:12.042 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Stdin params: {"before_execute":{"last_notify":402790},"stdin":{"metadata":{"account":{"email":"nikitamamaev1912@gmail.com","id":100005},"base_resources":{"cpu_number":1,"ram_mib":512},"cluster":{"datacenter_type":"ip_fabric","id":1,"interface_count":1,"ip_fabric":{"bgp_routing_type":"frr","gateway":"10.0.0.75","mac":"02:00:00:00:00:01"},"virtualization_type":"kvm"},"disks":[{"boot_order":1,"expand_part":"/dev/sda2","id":7,"name":"active_imaged_n2","pool":{"id":2,"name":"File_vm"},"size_mib":10240,"storage":{"id":1}}],"domain":"active-imaged-n2.ipfabric.com","id":7,"interfaces":[{"cluster_interface":0,"id":7,"is_vxlan":false,"mac_address":"52:54:00:5C:38:57","model":"virtio","name":"ens3","node_interface":2,"node_interface_name":"vmbr0","vxlan_id":0}],"internal_name":"7_active_imaged_n2","ipv4":[{"domain":"active-imaged-n2.ipfabric.com","gateway":"10.0.0.75","interface_id":7,"ip_addr":"172.31.50.206","ippool_id":1,"local_id":7,"net_prefix":32,"network_id":1,"remote_id":12,"state":"prepare to allocate"}],"ipv6":[],"metadata_version":"1.0.1","name":"active_imaged_n2","node":{"id":2,"ip_addr":"172.31.48.153","os_version":"AstraLinux 1.7.3","port":22,"virt_type":"kvm"},"os":{"group":"ubuntu","id":14,"name":"Ubuntu 22.04","tags":["ubuntu2204","ubuntu","linux"]},"state":{"disabled":false,"rescue_mode":false},"tuned_resources":{"anti_spoofing":true,"anti_spoofing_settings":{"vlan":false},"cpu_custom_model":null,"cpu_mode":"default","cpu_weight":1024,"firewall_rules":null,"io_read_iops":0,"io_read_mbitps":0,"io_weight":500,"io_write_iops":0,"io_write_mbitps":0,"nesting":false,"net_in_mbitps":0,"net_out_mbitps":0,"net_weight":5,"process_number":-1,"tcp_connections_in":0,"tcp_connections_out":0}}}}
  455. vmctl.log:2023-05-26 22:52:12.043 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Executing action host_create with params
  456. vmctl.log:2023-05-26 22:52:12.043 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] InternalCall service: vm path: image/1/change_state
  457. vmctl.log:2023-05-26 22:52:12.058 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] params: {"cluster":{"id":1},"datacenter_type":"ip_fabric","efi_boot":false,"ha_enabled":false,"host":{"additional_disks":[],"bridge":"vmbr0","disk":{"boot_order":1,"expand_part":"/dev/sda2","file_format":"qcow2","id":7,"internal_name":"7_active_imaged_n2","name":"active_imaged_n2","pool_name":"File_vm","size_mib":10240,"storage_id":1,"storage_params":{"pool":{"vm_storage_path":"/vm"}},"storage_type":"file","target_bus":"virtio","target_dev":"vda"},"dns_servers":[],"domain":"active-imaged-n2.ipfabric.com","interfaces":[{"cluster_interface":0,"is_main_network":true,"is_vxlan":false,"mac":"52:54:00:5C:38:57","model":"virtio","network_switch":"vmbr0"}],"internal_name":"7_active_imaged_n2","mem":"512","name":"active_imaged_n2","network":[{"host_interface":"ens3","host_interface_mac":"52:54:00:5C:38:57","ipv4":[{"gateway":"10.0.0.75","id":7,"ip":"172.31.50.206","netmask":"255.255.255.255"}],"ipv6_secondaries":[],"network_switch":"vmbr0","node_interface_name":"vmbr0"}],"password":"qwe123qwe123","source":{"expand_part":"/dev/sda2","id":1,"image_name":"1_1_preset_image.raw","ip_automation":"debian_based","location":{"connection_params":{"ip":"172.31.48.153","login":"astra-node-2","path":"/image","port":22},"id":2,"type":null},"os_group":"ubuntu","path":"/image/1_1_preset_image.raw","type":"image"},"spice":{"password":"C352F91DB6865C9A47FCBB06"},"ssh_address":"172.31.50.206","ssh_key":[],"ssh_port":22,"timezone":"UTC","tuned_resources":{"anti_spoofing":true,"anti_spoofing_settings":{"vlan":false},"cpu_custom_model":null,"cpu_mode":"default","cpu_weight":1024,"firewall_rules":null,"io_read_iops":0,"io_read_mbitps":0,"io_weight":500,"io_write_iops":0,"io_write_mbitps":0,"nesting":false,"net_in_mbitps":0,"net_out_mbitps":0,"net_weight":5,"network":[{"host_interface":"ens3","host_interface_mac":"52:54:00:5C:38:57","ipv4":[{"gateway":"10.0.0.75","id":7,"ip":"172.31.50.206","netmask":"255.255.255.255"}],"ipv6_secondaries":[],"network_switch":"vmbr0","node_interface_name":"vmbr0"}],"process_number":-1,"tcp_connections_in":0,"tcp_connections_out":0},"vcpu":"1","vnc_address":"172.31.48.153","vnc_password":"E0BAB525"},"id":"7","install_mode":"create_from_image","kms_address":"","last_notify":402790,"metadata":"{\"account\":{\"email\":\"nikitamamaev1912@gmail.com\",\"id\":100005},\"base_resources\":{\"cpu_number\":1,\"ram_mib\":512},\"cluster\":{\"datacenter_type\":\"ip_fabric\",\"id\":1,\"interface_count\":1,\"ip_fabric\":{\"bgp_routing_type\":\"frr\",\"gateway\":\"10.0.0.75\",\"mac\":\"02:00:00:00:00:01\"},\"virtualization_type\":\"kvm\"},\"disks\":[{\"boot_order\":1,\"expand_part\":\"/dev/sda2\",\"id\":7,\"name\":\"active_imaged_n2\",\"pool\":{\"id\":2,\"name\":\"File_vm\"},\"size_mib\":10240,\"storage\":{\"id\":1}}],\"domain\":\"active-imaged-n2.ipfabric.com\",\"id\":7,\"interfaces\":[{\"cluster_interface\":0,\"id\":7,\"is_vxlan\":false,\"mac_address\":\"52:54:00:5C:38:57\",\"model\":\"virtio\",\"name\":\"ens3\",\"node_interface\":2,\"node_interface_name\":\"vmbr0\",\"vxlan_id\":0}],\"internal_name\":\"7_active_imaged_n2\",\"ipv4\":[{\"domain\":\"active-imaged-n2.ipfabric.com\",\"gateway\":\"10.0.0.75\",\"interface_id\":7,\"ip_addr\":\"172.31.50.206\",\"ippool_id\":1,\"local_id\":7,\"net_prefix\":32,\"network_id\":1,\"remote_id\":12,\"state\":\"prepare to allocate\"}],\"ipv6\":[],\"metadata_version\":\"1.0.1\",\"name\":\"active_imaged_n2\",\"node\":{\"id\":2,\"ip_addr\":\"172.31.48.153\",\"os_version\":\"AstraLinux 1.7.3\",\"port\":22,\"virt_type\":\"kvm\"},\"os\":{\"group\":\"ubuntu\",\"id\":14,\"name\":\"Ubuntu 22.04\",\"tags\":[\"ubuntu2204\",\"ubuntu\",\"linux\"]},\"state\":{\"disabled\":false,\"rescue_mode\":false},\"tuned_resources\":{\"anti_spoofing\":true,\"anti_spoofing_settings\":{\"vlan\":false},\"cpu_custom_model\":null,\"cpu_mode\":\"default\",\"cpu_weight\":1024,\"firewall_rules\":null,\"io_read_iops\":0,\"io_read_mbitps\":0,\"io_weight\":500,\"io_write_iops\":0,\"io_write_mbitps\":0,\"nesting\":false,\"net_in_mbitps\":0,\"net_out_mbitps\":0,\"net_weight\":5,\"process_number\":-1,\"tcp_connections_in\":0,\"tcp_connections_out\":0}}","node":{"id":2,"ip_addr":"172.31.48.153","os_version":"AstraLinux 1.7.3","ssh_port":"22"},"product_key":"","ssh_port":22,"timeout_seconds":7200}
  458. vmctl.log:2023-05-26 22:52:12.058 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Fork. New Process PID: 8739
  459. vmctl.log:2023-05-26 22:52:12.058 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8739. Execute command: 'scripts/kvm/host_create.py'
  460. vmctl.log:2023-05-26 22:53:22.319 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8739. Finished successefully with status 0
  461. vmctl.log:2023-05-26 22:53:22.319 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8739. Output: {}
  462. vmctl.log:2023-05-26 22:53:22.319 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8739. Error: libvirt: QEMU Driver error : Домен не найден: нет домена с совпадающим именем «7_active_imaged_n2»
  463. vmctl.log:2023-05-26 22:53:22.319 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] InternalCall service: vm path: image/1/change_state
  464. vmctl.log:2023-05-26 22:53:22.323 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] ip: 172.31.50.206
  465. vmctl.log:2023-05-26 22:53:22.323 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Fork. New Process PID: 8821
  466. vmctl.log:2023-05-26 22:53:22.323 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8821. Execute command: 'ssh-keygen -R 172.31.50.206'
  467. vmctl.log:2023-05-26 22:53:22.326 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8821. Failed with status 65280
  468. vmctl.log:2023-05-26 22:53:22.326 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8821. Output:
  469. vmctl.log:2023-05-26 22:53:22.326 [pid=8735] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8821. Error:
  470. vmctl.log:2023-05-26 22:53:22.408 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got action host_spice_configure with params
  471. vmctl.log:2023-05-26 22:53:22.408 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Using VmctlMode::VMCTL virt-type kvm
  472. vmctl.log:2023-05-26 22:53:22.409 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Stdin params: {"before_execute":{"last_notify":403109},"stdin":{"metadata":{"account":{"email":"nikitamamaev1912@gmail.com","id":100005},"base_resources":{"cpu_number":1,"ram_mib":512},"cluster":{"datacenter_type":"ip_fabric","id":1,"interface_count":1,"ip_fabric":{"bgp_routing_type":"frr","gateway":"10.0.0.75","mac":"02:00:00:00:00:01"},"virtualization_type":"kvm"},"disks":[{"boot_order":1,"expand_part":"/dev/sda2","id":7,"name":"active_imaged_n2","pool":{"id":2,"name":"File_vm"},"size_mib":10240,"storage":{"id":1}}],"domain":"active-imaged-n2.ipfabric.com","id":7,"interfaces":[{"cluster_interface":0,"id":7,"is_vxlan":false,"mac_address":"52:54:00:5C:38:57","model":"virtio","name":"ens3","node_interface":2,"node_interface_name":"vmbr0","vxlan_id":0}],"internal_name":"7_active_imaged_n2","ipv4":[{"domain":"active-imaged-n2.ipfabric.com","gateway":"10.0.0.75","interface_id":7,"ip_addr":"172.31.50.206","ippool_id":1,"local_id":7,"net_prefix":32,"network_id":1,"remote_id":12,"state":"prepare to allocate"}],"ipv6":[],"metadata_version":"1.0.1","name":"active_imaged_n2","node":{"id":2,"ip_addr":"172.31.48.153","os_version":"AstraLinux 1.7.3","port":22,"virt_type":"kvm"},"os":{"group":"ubuntu","id":14,"name":"Ubuntu 22.04","tags":["ubuntu2204","ubuntu","linux"]},"state":{"disabled":false,"rescue_mode":false},"tuned_resources":{"anti_spoofing":true,"anti_spoofing_settings":{"vlan":false},"cpu_custom_model":null,"cpu_mode":"default","cpu_weight":1024,"firewall_rules":null,"io_read_iops":0,"io_read_mbitps":0,"io_weight":500,"io_write_iops":0,"io_write_mbitps":0,"nesting":false,"net_in_mbitps":0,"net_out_mbitps":0,"net_weight":5,"process_number":-1,"tcp_connections_in":0,"tcp_connections_out":0}}}}
  473. vmctl.log:2023-05-26 22:53:22.409 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Executing action host_spice_configure with params
  474. vmctl.log: {"disk":{"boot_order":1,"expand_part":"/dev/sda2","file_format":"qcow2","id":7,"internal_name":"7_active_imaged_n2","name":"active_imaged_n2","pool_name":"File_vm","size_mib":10240,"storage_id":1,"storage_params":{"pool":{"vm_storage_path":"/vm"}},"storage_type":"file","target_bus":"virtio","target_dev":"vda"},"ha_enabled":false,"host":{"datacenter_type":"ip_fabric","domain":"active-imaged-n2.ipfabric.com","id":7,"internal_name":"7_active_imaged_n2","os_group":"ubuntu"},"last_notify":403109,"metadata":"{\"account\":{\"email\":\"nikitamamaev1912@gmail.com\",\"id\":100005},\"base_resources\":{\"cpu_number\":1,\"ram_mib\":512},\"cluster\":{\"datacenter_type\":\"ip_fabric\",\"id\":1,\"interface_count\":1,\"ip_fabric\":{\"bgp_routing_type\":\"frr\",\"gateway\":\"10.0.0.75\",\"mac\":\"02:00:00:00:00:01\"},\"virtualization_type\":\"kvm\"},\"disks\":[{\"boot_order\":1,\"expand_part\":\"/dev/sda2\",\"id\":7,\"name\":\"active_imaged_n2\",\"pool\":{\"id\":2,\"name\":\"File_vm\"},\"size_mib\":10240,\"storage\":{\"id\":1}}],\"domain\":\"active-imaged-n2.ipfabric.com\",\"id\":7,\"interfaces\":[2023-05-26 22:53:22.408 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Got action node_update_frr with params
  475. vmctl.log:2023-05-26 22:53:22.408 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Using VmctlMode::VMCTL virt-type kvm
  476. vmctl.log:2023-05-26 22:53:22.409 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Stdin params: {"before_execute":{"last_notify":403109},"stdin":{}}
  477. vmctl.log:2023-05-26 22:53:22.409 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Executing action node_update_frr with params
  478. vmctl.log:2023-05-26 22:53:22.409 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Fork. New Process PID: 8826
  479. vmctl.log:2023-05-26 22:53:22.410 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8826. Execute command: 'scripts/node_frr.py --node-address 172.31.48.153 --node-port 22 --private-key /opt/ispsystem/vm/etc/.ssh/vmmgr.1'
  480. vmctl.log:2023-05-26 22:53:22.410 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] Fork. New Process PID: 8827
  481. vmctl.log:2023-05-26 22:53:22.410 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8827. Execute command: 'scripts/kvm/host_configure_spice.py --node-address 172.31.48.153 --domain-name 7_active_imaged_n2 --image-storage-path /image'
  482. vmctl.log:2023-05-26 22:53:24.754 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8826. Finished successefully with status 0
  483. vmctl.log:2023-05-26 22:53:24.754 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8826. Output: {}
  484. vmctl.log:2023-05-26 22:53:24.754 [pid=8822] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8826. Error:
  485. vmctl.log:2023-05-26 22:54:14.412 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8827. Finished successefully with status 0
  486. vmctl.log:2023-05-26 22:54:14.412 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8827. Output: {"spice_enabled": true, "exit_code": 0}
  487. vmctl.log:2023-05-26 22:54:14.412 [pid=8823] [#f396c7c72d6f6e0195d52c681712eaef/172.18.0.24/@nikitamamaev1912@gmail.com] PID: 8827. Error:
Advertisement
Add Comment
Please, Sign In to add comment
Advertisement