API tools faq
paste
Advertisement
NMamaev

Untitled

NMamaev
Jun 26th, 2023
482
0
Never
Add comment
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
Bash 44.37 KB | None | 0 0
raw download clone embed print report
  1. [root@c216e8033f0b log]# grep 3dcb485b6039f297aefec27f559d871a *.log*
  2. connect_storages.log:2023-06-26 14:59:32.511 [pid=12455] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] INFO Try connect to http://input:1500/vm/v3/node/4 with headers {'Host': 'instance-1', 'internal-auth': 'on'}
  3. connect_storages.log:2023-06-26 14:59:32.512 [pid=12455] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG Starting new HTTP connection (1): input:1500
  4. connect_storages.log:2023-06-26 14:59:32.514 [pid=12455] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG http://input:1500 "GET /vm/v3/node/4 HTTP/1.1" 200 1573
  5. node_network.log:2023-06-26 14:59:30.865 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] INFO node network configure
  6. node_network.log:2023-06-26 14:59:30.867 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG Starting new HTTP connection (1): input:1500
  7. node_network.log:2023-06-26 14:59:30.870 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG http://input:1500 "GET /vm/v3/ssh_address?id_type=node&id=4 HTTP/1.1" 200 1974
  8. node_network.log:2023-06-26 14:59:30.871 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG ssh params: {'is_dummy': False, 'last_notify': 47502, 'node_id': 4, 'ssh_address': '172.31.36.36', 'ssh_port': 22, 'ssh_user': 'root'}
  9. node_network.log:2023-06-26 14:59:30.911 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG Connecting to root@172.31.36.36:22
  10. node_network.log:2023-06-26 14:59:31.187 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] INFO Change default network forward mode
  11. node_network.log:2023-06-26 14:59:31.188 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG run EDITOR='sed -i "s/nat/open/g"' virsh net-edit default
  12. node_network.log:2023-06-26 14:59:31.321 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG run virsh net-start default
  13. node_network.log:2023-06-26 14:59:31.454 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] ERROR virsh net-start default failed with code 1 stderr "error: Failed to start network default
  14. node_network.log:2023-06-26 14:59:31.454 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG checking if vmbr0 is on ens10
  15. node_network.log:2023-06-26 14:59:31.454 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG run ip link show ens10
  16. node_network.log:2023-06-26 14:59:31.578 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG run ls -1 --color=never /etc/sysconfig/network-scripts/
  17. node_network.log:2023-06-26 14:59:31.704 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG run cat /etc/sysconfig/network-scripts/ifcfg-ens3
  18. node_network.log:2023-06-26 14:59:31.829 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG run cat /etc/sysconfig/network-scripts/ifcfg-eth0
  19. node_network.log:2023-06-26 14:59:31.953 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG run cat /etc/sysconfig/network-scripts/ifcfg-eth1
  20. node_network.log:2023-06-26 14:59:32.080 [pid=12449] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG run cat /etc/sysconfig/network-scripts/ifcfg-vmbr0
  21. node_nwfilter.log:2023-06-26 14:59:29.501 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] INFO node nwfilter configure
  22. node_nwfilter.log:2023-06-26 14:59:29.695 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter inout-drop-ports
  23. node_nwfilter.log:2023-06-26 14:59:29.721 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter inout-drop-ports
  24. node_nwfilter.log:2023-06-26 14:59:29.748 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter allow-incoming-ipv6
  25. node_nwfilter.log:2023-06-26 14:59:29.774 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter allow-incoming-ipv6
  26. node_nwfilter.log:2023-06-26 14:59:29.801 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter clean-traffic
  27. node_nwfilter.log:2023-06-26 14:59:29.826 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter clean-traffic
  28. node_nwfilter.log:2023-06-26 14:59:29.853 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter clean-traffic-v6-only
  29. node_nwfilter.log:2023-06-26 14:59:29.879 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter clean-traffic-v6-only
  30. node_nwfilter.log:2023-06-26 14:59:29.905 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter clean-traffic-with-v6
  31. node_nwfilter.log:2023-06-26 14:59:29.931 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter clean-traffic-with-v6
  32. node_nwfilter.log:2023-06-26 14:59:29.958 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter no-ipv6-spoofing
  33. node_nwfilter.log:2023-06-26 14:59:29.984 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter no-ipv6-spoofing
  34. node_nwfilter.log:2023-06-26 14:59:30.011 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-in-limit
  35. node_nwfilter.log:2023-06-26 14:59:30.037 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-in-limit
  36. node_nwfilter.log:2023-06-26 14:59:30.063 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-out-limit
  37. node_nwfilter.log:2023-06-26 14:59:30.089 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-out-limit
  38. node_nwfilter.log:2023-06-26 14:59:30.115 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-inout-limit
  39. node_nwfilter.log:2023-06-26 14:59:30.141 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-inout-limit
  40. node_nwfilter.log:2023-06-26 14:59:30.168 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-in-limit-clean-traffic
  41. node_nwfilter.log:2023-06-26 14:59:30.194 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-in-limit-clean-traffic
  42. node_nwfilter.log:2023-06-26 14:59:30.221 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-in-limit-clean-traffic-v6-only
  43. node_nwfilter.log:2023-06-26 14:59:30.247 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-in-limit-clean-traffic-v6-only
  44. node_nwfilter.log:2023-06-26 14:59:30.273 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-in-limit-clean-traffic-with-v6
  45. node_nwfilter.log:2023-06-26 14:59:30.299 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-in-limit-clean-traffic-with-v6
  46. node_nwfilter.log:2023-06-26 14:59:30.326 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-out-limit-clean-traffic
  47. node_nwfilter.log:2023-06-26 14:59:30.351 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-out-limit-clean-traffic
  48. node_nwfilter.log:2023-06-26 14:59:30.378 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-out-limit-clean-traffic-v6-only
  49. node_nwfilter.log:2023-06-26 14:59:30.404 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-out-limit-clean-traffic-v6-only
  50. node_nwfilter.log:2023-06-26 14:59:30.430 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-out-limit-clean-traffic-with-v6
  51. node_nwfilter.log:2023-06-26 14:59:30.456 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-out-limit-clean-traffic-with-v6
  52. node_nwfilter.log:2023-06-26 14:59:30.483 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-inout-limit-clean-traffic
  53. node_nwfilter.log:2023-06-26 14:59:30.508 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-inout-limit-clean-traffic
  54. node_nwfilter.log:2023-06-26 14:59:30.535 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-inout-limit-clean-traffic-v6-only
  55. node_nwfilter.log:2023-06-26 14:59:30.560 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-inout-limit-clean-traffic-v6-only
  56. node_nwfilter.log:2023-06-26 14:59:30.587 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG processing filter tcp-inout-limit-clean-traffic-with-v6
  57. node_nwfilter.log:2023-06-26 14:59:30.613 [pid=12448] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] DEBUG define filter tcp-inout-limit-clean-traffic-with-v6
  58. vm_1_reader.log:2023-06-27 02:34:04.760 [pid=309] [#699e9f323ebaa6fa2001483aaf5fe359/10.60.4.173/@admin@example.com] Response body '{"last_notify":205205,"task":{"account":{"email":"admin@example.com","id":3,"ip":"172.18.0.26"},"date_create":"2023-06-26 14:57:35.000000","date_end":"2023-06-26 14:59:32.000000","date_start":"2023-06-26 14:57:35.000000","message_params":{"ip_addr":"172.31.36.36","name":"2ifnode"},"name":"node_create","output":"Unhandled exception: Action failed with error: Traceback (most recent call last):\n  File \"/opt/ispsystem/vm/scripts/kvm/node_network_almalinux_8.py\", line 25, in <module>\n    main()\n  File \"/opt/ispsystem/vm/scripts/kvm/node_network_almalinux_8.py\", line 21, in main\n    centos_8.configure_network(args, params)\n  File \"/usr/local/lib/python3.9/site-packages/isp_node_network/centos_8.py\", line 294, in configure_network\n    setting = CommonDatacenter(conn, iface=iface[\"name\"], bridge=iface[\"network_switch\"])\n  File \"/usr/local/lib/python3.9/site-packages/isp_node_network/centos_8.py\", line 32, in __init__\n    self.iface_filename = self._find_iface_config()\n  File \"/usr/local/lib/python3.9/site-packages/isp_node_network/centos_8.py\", line 69, in _find_iface_config\n    raise Exception(f'Can not find iface {self.iface} config')\nException: Can not find iface ens10 config","param":["--action","node_create","--virt-type","kvm","--log-path","/var/log/node_create/node_4.log","--params","{\"autorun_scripts\":[],\"cluster_id\":2,\"datacenter_type\":\"common\",\"id\":4,\"image_storage_path\":\"/image\",\"interfaces\":[{\"name\":\"ens10\",\"network_switch\":\"vmbr0\"},{\"name\":\"eth0\",\"network_switch\":\"vmbr1\"}],\"ip\":\"172.31.36.36\",\"network_autosetup_disabled\":false,\"node_addr_v6\":null,\"node_interface_name\":\"vmbr0\",\"os_major_version\":\"8\",\"os_name\":\"almalinux\",\"os_storage_path\":\"/share\",\"os_version\":\"AlmaLinux 8.8\",\"proxy_enabled\":false,\"spice_enabled\":true,\"ssh_port\":22,\"ssh_user\":\"root\",\"timezone\":\"UTC\"}"],"request_id":"3dcb485b6039f297aefec27f559d871a","status":"failed"}}'
  59. vm_1_reader.log.1:2023-06-27 02:09:02.722 [pid=309] [#6b51a458a25b69319bedf0281320cf87/10.60.4.173/@admin@example.com] Response body '{"last_notify":199485,"task":{"account":{"email":"admin@example.com","id":3,"ip":"172.18.0.26"},"date_create":"2023-06-26 14:57:35.000000","date_end":"2023-06-26 14:59:32.000000","date_start":"2023-06-26 14:57:35.000000","message_params":{"ip_addr":"172.31.36.36","name":"2ifnode"},"name":"node_create","output":"Unhandled exception: Action failed with error: Traceback (most recent call last):\n  File \"/opt/ispsystem/vm/scripts/kvm/node_network_almalinux_8.py\", line 25, in <module>\n    main()\n  File \"/opt/ispsystem/vm/scripts/kvm/node_network_almalinux_8.py\", line 21, in main\n    centos_8.configure_network(args, params)\n  File \"/usr/local/lib/python3.9/site-packages/isp_node_network/centos_8.py\", line 294, in configure_network\n    setting = CommonDatacenter(conn, iface=iface[\"name\"], bridge=iface[\"network_switch\"])\n  File \"/usr/local/lib/python3.9/site-packages/isp_node_network/centos_8.py\", line 32, in __init__\n    self.iface_filename = self._find_iface_config()\n  File \"/usr/local/lib/python3.9/site-packages/isp_node_network/centos_8.py\", line 69, in _find_iface_config\n    raise Exception(f'Can not find iface {self.iface} config')\nException: Can not find iface ens10 config","param":["--action","node_create","--virt-type","kvm","--log-path","/var/log/node_create/node_4.log","--params","{\"autorun_scripts\":[],\"cluster_id\":2,\"datacenter_type\":\"common\",\"id\":4,\"image_storage_path\":\"/image\",\"interfaces\":[{\"name\":\"ens10\",\"network_switch\":\"vmbr0\"},{\"name\":\"eth0\",\"network_switch\":\"vmbr1\"}],\"ip\":\"172.31.36.36\",\"network_autosetup_disabled\":false,\"node_addr_v6\":null,\"node_interface_name\":\"vmbr0\",\"os_major_version\":\"8\",\"os_name\":\"almalinux\",\"os_storage_path\":\"/share\",\"os_version\":\"AlmaLinux 8.8\",\"proxy_enabled\":false,\"spice_enabled\":true,\"ssh_port\":22,\"ssh_user\":\"root\",\"timezone\":\"UTC\"}"],"request_id":"3dcb485b6039f297aefec27f559d871a","status":"failed"}}'
  60. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] request method: POST url: /node version: HTTP/1.0
  61. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Handler 'node' choosen
  62. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [connection]close
  63. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [content-length]371
  64. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [es-extra-tags]batch.64ce5a45-c774-f349-8c7d-cffc70561f20
  65. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [host]instance-1
  66. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [instance-id]1
  67. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [internal-auth]eyJlbWFpbF9jb25maXJtZWQiOnRydWUsImV4cGlyZXNfYXQiOiIyMDIzLTA3LTA2IDExOjM4OjQ2IiwiaW5zdGFuY2Vfb3duZXIiOnRydWUsImxhbmciOiJydSIsImxhc3Rfbm90aWZ5Ijo0NzAxNywib3duZXJfZW1haWwiOiJhZG1pbkBleGFtcGxlLmNvbSIsIm93bmVyX2lkIjozLCJyb2xlcyI6WyJAYWRtaW4iXSwic2VzX2lkIjoxLCJzZXNzaW9uIjoiRTJEOTQyREZCQTk1OTg4QTM5ODlCRUEzIiwic3VfaW5zdGFuY2UiOmZhbHNlLCJ0cnVzdGVlX2VtYWlsIjoiYWRtaW5AZXhhbXBsZS5jb20iLCJ0cnVzdGVlX2lkIjozLCJ4c3JmX3Rva2VuIjoiRTJEOTQyREZCQTk1OTg4QTM5ODlCRUEzIn0=
  68. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [x-forwarded-for]172.18.0.26
  69. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [x-remote-ip]172.18.0.26
  70. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [x-request-id]3dcb485b6039f297aefec27f559d871a
  71. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26] Got header: [x-xsrf-token]E2D942DFBA95988A3989BEA3
  72. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] RequestBody: {"cluster":2,"comment":"","host_filter":[],"host_limit":-1,"host_max":null,"interfaces":[{"cluster_interface":0,"node_interface":"ens10"},{"cluster_interface":1,"node_interface":"eth0"}],"ip":"172.31.36.36","lvm_vg_rename":false,"name":"2ifnode","network_autosetup_disabled":false,"overselling":1,"password":"*","ssh_port":22,"ssh_user":"root","vcpu_limit":-1}
  73. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] End of POST request
  74. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Invoke POST request callback
  75. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] WriterAsyncProcess
  76. vm_1_writer.log:2023-06-26 14:57:32.595 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT value,name,id FROM vm_bill_options WHERE name='license'' duration=181
  77. vm_1_writer.log:2023-06-26 14:57:32.596 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 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='2'' duration=208
  78. vm_1_writer.log:2023-06-26 14:57:32.596 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT vm_storage2cluster.id AS id FROM vm_storage2cluster WHERE (vm_storage2cluster.cluster='2')' duration=110
  79. vm_1_writer.log:2023-06-26 14:57:32.596 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Fork. New Process PID: 11312
  80. vm_1_writer.log:2023-06-26 14:57:32.597 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11312. Execute command: 'ssh-keygen -R 172.31.36.36'
  81. vm_1_writer.log:2023-06-26 14:57:32.599 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11312. Finished successefully with status 0
  82. vm_1_writer.log:2023-06-26 14:57:32.599 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11312. Output:
  83. vm_1_writer.log:2023-06-26 14:57:32.599 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11312. Error:
  84. vm_1_writer.log:2023-06-26 14:57:32.599 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Fork. New Process PID: 11313
  85. vm_1_writer.log:2023-06-26 14:57:32.599 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11313. Execute command: '/usr/bin/sshpass -e -- ssh-copy-id -p 22 -o StrictHostKeyChecking=no -o ConnectTimeout=15 -i /opt/ispsystem/vm/etc/.ssh/vmmgr.1.pub root@172.31.36.36'
  86. vm_1_writer.log:2023-06-26 14:57:33.412 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11313. Finished successefully with status 0
  87. vm_1_writer.log:2023-06-26 14:57:33.412 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11313. Output:
  88. vm_1_writer.log:2023-06-26 14:57:33.412 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11313. Error:
  89. vm_1_writer.log:2023-06-26 14:57:33.412 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Fork. New Process PID: 11358
  90. vm_1_writer.log:2023-06-26 14:57:33.412 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11358. Execute command: 'scripts/kvm/node_info.py --private-key /opt/ispsystem/vm/etc/.ssh/vmmgr.1 --host 172.31.36.36 --port 22 --user root'
  91. vm_1_writer.log:2023-06-26 14:57:35.057 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11358. Finished successefully with status 0
  92. vm_1_writer.log:2023-06-26 14:57:35.057 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11358. Output: {"os": {"version": "AlmaLinux 8.8", "name": "almalinux", "major_version": "8"}, "kvm_support": true, "kvm_enabled": true, "cpu_core_count": 4, "mem_mib": 3665, "hostname": "nmamaev.lvm.node.2.vm6-de-dev.com", "iface": "vmbr0"}
  93. vm_1_writer.log:2023-06-26 14:57:35.057 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] PID: 11358. Error:
  94. vm_1_writer.log:2023-06-26 14:57:35.057 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Node Info: 0
  95. vm_1_writer.log:2023-06-26 14:57:35.057 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Node Info: {"cpu_core_count":4,"hostname":"nmamaev.lvm.node.2.vm6-de-dev.com","iface":"vmbr0","kvm_enabled":true,"kvm_support":true,"mem_mib":3665,"os":{"major_version":"8","name":"almalinux","version":"AlmaLinux 8.8"}}
  96. vm_1_writer.log:2023-06-26 14:57:35.058 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT name FROM vm_node WHERE hostname='nmamaev.lvm.node.2.vm6-de-dev.com' AND cluster='2' LIMIT 1' duration=411
  97. vm_1_writer.log:2023-06-26 14:57:35.058 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] CheckLicense
  98. vm_1_writer.log:2023-06-26 14:57:35.059 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT id, cpu_number, additional_data FROM vm_node' duration=141
  99. vm_1_writer.log:2023-06-26 14:57:35.059 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT COUNT(id) FROM vm_node WHERE cluster = '2'' duration=144
  100. vm_1_writer.log:2023-06-26 14:57:35.059 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT id FROM vm_node WHERE name = '2ifnode' LIMIT 1' duration=128
  101. vm_1_writer.log:2023-06-26 14:57:35.060 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT id FROM vm_node WHERE ip_addr = '172.31.36.36' LIMIT 1' duration=104
  102. vm_1_writer.log:2023-06-26 14:57:35.063 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_node (id,name,comment,cluster,ram_mib,max_vcpu_number,cpu_number,ip_addr,vnc_addr,ssh_port,state,mon_install_date,os_version,overselling,hostname,host_filter) VALUES(4,'2ifnode','',2,3665,4,4,'172.31.36.36','172.31.36.36',22,'prepare_node','2023-06-26 14:57:35','AlmaLinux 8.8',1.000000,'nmamaev.lvm.node.2.vm6-de-dev.com','[]')' duration=3014
  103. vm_1_writer.log:2023-06-26 14:57:35.063 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT MAX(create_time) FROM vm_node_history WHERE event_type='field:state' AND ref='4'' duration=132
  104. vm_1_writer.log:2023-06-26 14:57:35.063 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_node_history (id,event_type,event_info,request_user,request_owner,request_ip,request_id,ref) VALUES (10,'field:state','{\"new_value\":\"prepare_node\",\"old_value\":null}','admin@example.com','---','172.18.0.26','3dcb485b6039f297aefec27f559d871a',4)' duration=115
  105. vm_1_writer.log:2023-06-26 14:57:35.063 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_node_interfaces (id,name,node,state) VALUES(7,'ens10',4,'vm6_created')' duration=114
  106. vm_1_writer.log:2023-06-26 14:57:35.063 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT nm_ruled,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 vm_node_bridge.is_default AND vm_node_bridge.is_main_network='1' AND vm_node_bridge.node='4'' duration=181
  107. vm_1_writer.log:2023-06-26 14:57:35.064 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_node_bridge (id,name,node,state,is_default,take_slave_ip) VALUES(6,'vmbr0',4,'vm6_created','1','1')' duration=110
  108. vm_1_writer.log:2023-06-26 14:57:35.064 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT COUNT(*) FROM vm_iface2bond2bridge JOIN vm_node_bridge ON vm_node_bridge.vlan IS NULL AND vm_node_bridge.id = vm_iface2bond2bridge.bridge WHERE (vm_iface2bond2bridge.iface = '7')' duration=145
  109. vm_1_writer.log:2023-06-26 14:57:35.064 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_iface2bond2bridge (id,iface,bridge) VALUES(6,7,6)' duration=97
  110. vm_1_writer.log:2023-06-26 14:57:35.064 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_node_interfaces (id,name,node,state) VALUES(8,'eth0',4,'vm6_created')' duration=236
  111. vm_1_writer.log:2023-06-26 14:57:35.064 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT nm_ruled,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 vm_node_bridge.is_default AND vm_node_bridge.is_main_network='0' AND vm_node_bridge.node='4'' duration=157
  112. vm_1_writer.log:2023-06-26 14:57:35.065 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_node_bridge (id,name,node,state,is_default,is_main_network,take_slave_ip) VALUES(7,'vmbr1',4,'vm6_created','1','0','1')' duration=943
  113. vm_1_writer.log:2023-06-26 14:57:35.066 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT COUNT(*) FROM vm_iface2bond2bridge JOIN vm_node_bridge ON vm_node_bridge.vlan IS NULL AND vm_node_bridge.id = vm_iface2bond2bridge.bridge WHERE (vm_iface2bond2bridge.iface = '8')' duration=216
  114. vm_1_writer.log:2023-06-26 14:57:35.066 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_iface2bond2bridge (id,iface,bridge) VALUES(7,8,7)' duration=397
  115. vm_1_writer.log:2023-06-26 14:57:35.066 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT vm_node_interfaces.name AS name, vm_node_bridge.name AS network_switch  FROM vm_node_interfaces INNER JOIN vm_iface2bond2bridge ON vm_iface2bond2bridge.iface=vm_node_interfaces.id INNER JOIN vm_node_bridge ON vm_node_bridge.id=vm_iface2bond2bridge.bridge WHERE vm_node_interfaces.node='4' AND vm_node_bridge.name IS NOT NULL' duration=231
  116. vm_1_writer.log:2023-06-26 14:57:35.066 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT s.name, s.script, s.type, s.priority FROM vm_node_script s LEFT JOIN vm_node_script2cluster n_s2c ON n_s2c.script=s.id WHERE n_s2c.cluster='2'' duration=176
  117. vm_1_writer.log:2023-06-26 14:57:35.068 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT value,name,id FROM vm_settings WHERE name='task_timeout'' duration=122
  118. vm_1_writer.log:2023-06-26 14:57:35.068 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT value,name,id FROM vm_settings WHERE name='consul_task_ttl_in_sec'' duration=103
  119. vm_1_writer.log:2023-06-26 14:57:35.071 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 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='34' AND name='node_create'' duration=174
  120. vm_1_writer.log:2023-06-26 14:57:35.071 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_task_log (id,consul_id,name,param,message_params,status,main_table,main_table_id,node,request_info) VALUES(12,34,'node_create','[\"--action\",\"node_create\",\"--virt-type\",\"kvm\",\"--log-path\",\"/var/log/node_create/node_4.log\",\"--params\",\"{\\\"autorun_scripts\\\":[],\\\"cluster_id\\\":2,\\\"datacenter_type\\\":\\\"common\\\",\\\"id\\\":4,\\\"image_storage_path\\\":\\\"/image\\\",\\\"interfaces\\\":[{\\\"name\\\":\\\"ens10\\\",\\\"network_switch\\\":\\\"vmbr0\\\"},{\\\"name\\\":\\\"eth0\\\",\\\"network_switch\\\":\\\"vmbr1\\\"}],\\\"ip\\\":\\\"172.31.36.36\\\",\\\"network_autosetup_disabled\\\":false,\\\"node_addr_v6\\\":null,\\\"node_interface_name\\\":\\\"vmbr0\\\",\\\"os_major_version\\\":\\\"8\\\",\\\"os_name\\\":\\\"almalinux\\\",\\\"os_storage_path\\\":\\\"/share\\\",\\\"os_version\\\":\\\"AlmaLinux 8.8\\\",\\\"proxy_enabled\\\":false,\\\"spice_enabled\\\":true,\\\"ssh_port\\\":22,\\\"ssh_user\\\":\\\"root\\\",\\\"timezone\\\":\\\"UTC\\\"}\"]','{\"ip_addr\":\"172.31.36.36\",\"name\":\"2ifnode\"}','created','vm_node',4,4,'{\"callback_counter\":13,\"first_start\":13293746209946,\"need_log\":true,\"request\":{\"extra_tags\":[\"batch.64ce5a45-c774-f349-8c7d-cffc70561f20\"],\"id\":\"3dcb485b6039f297aefec27f559d871a\",\"ip\":\"172.18.0.26\",\"user\":{\"id\":3,\"name\":\"admin@example.com\"}},\"runtime\":2475971546}')' duration=193
  121. vm_1_writer.log:2023-06-26 14:57:35.073 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT vm_storage2cluster.storage AS storage FROM vm_storage2cluster WHERE (vm_storage2cluster.cluster='2')' duration=154
  122. vm_1_writer.log:2023-06-26 14:57:35.073 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT imported_from,vm5_data,is_network,storage_params,state,type,comment,name,id FROM vm_storage WHERE id='2'' duration=119
  123. vm_1_writer.log:2023-06-26 14:57:35.073 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT hdd_overselling,ha_params,params,pool_name,enabled,is_main,cluster,storage,id FROM vm_storage2cluster WHERE storage='2' AND cluster='2'' duration=134
  124. vm_1_writer.log:2023-06-26 14:57:35.073 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_storage2node (id,storage,node,state,hdd_overselling) VALUES(4,2,4,'creating',1.000000)' duration=563
  125. vm_1_writer.log:2023-06-26 14:57:35.074 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Create notify 'instance/1/notify/create' with content '{"notifies":["storage/2/node/4"]}'
  126. vm_1_writer.log:2023-06-26 14:57:35.074 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT value,name,id FROM vm_settings WHERE name='task_timeout'' duration=192
  127. vm_1_writer.log:2023-06-26 14:57:35.074 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='SELECT value,name,id FROM vm_settings WHERE name='consul_task_ttl_in_sec'' duration=104
  128. vm_1_writer.log:2023-06-26 14:57:35.078 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 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='35' AND name='connect_storages'' duration=178
  129. vm_1_writer.log:2023-06-26 14:57:35.078 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_task_log (id,consul_id,name,param,message_params,status,main_table,main_table_id,request_info) VALUES(13,35,'connect_storages','[\"--action\",\"connect_storages\",\"--virt-type\",\"kvm\",\"--params\",\"{\\\"cluster_id\\\":2,\\\"node_id\\\":4,\\\"node_ip\\\":\\\"172.31.36.36\\\",\\\"node_ssh_port\\\":22,\\\"storages\\\":[{\\\"id\\\":2,\\\"type\\\":\\\"file\\\"}]}\"]','{\"name\":\"2ifnode\"}','created','vm_node',4,'{\"callback_counter\":23,\"first_start\":13293746209946,\"need_log\":true,\"request\":{\"extra_tags\":[\"batch.64ce5a45-c774-f349-8c7d-cffc70561f20\"],\"id\":\"3dcb485b6039f297aefec27f559d871a\",\"ip\":\"172.18.0.26\",\"user\":{\"id\":3,\"name\":\"admin@example.com\"}},\"runtime\":2476971344}')' duration=153
  130. vm_1_writer.log:2023-06-26 14:57:35.080 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc00e4a0 query='INSERT INTO vm_node_log (id,name,node,task,request_trustee,request_owner) VALUES(5,'node_create',4,12,3,3)' duration=1042
  131. vm_1_writer.log:2023-06-26 14:57:35.080 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Create notify 'instance/1/notify/create' with content '{"notifies":["node_history/5","node/4/node_history/5"]}'
  132. vm_1_writer.log:2023-06-26 14:57:35.080 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Create notify 'instance/1/notify/update' with content '{"notifies":["cluster/2"]}'
  133. vm_1_writer.log:2023-06-26 14:57:35.080 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Create notify 'instance/1/notify/create' with content '{"notifies":["node/4"]}'
  134. vm_1_writer.log:2023-06-26 14:57:35.080 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Response body '{"id":4,"storages_task":35,"task":34}'
  135. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] request method: POST url: /node/4 version: HTTP/1.0
  136. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Handler 'node/{node_id}' choosen
  137. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [connection]close
  138. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [content-length]43
  139. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [global-attributes]{"callback_counter":6,"first_start":13297968876234,"request":{"id":"3dcb485b6039f297aefec27f559d871a","ip":"172.18.0.26","user":{"name":"admin@example.com"}},"runtime":1717655928}
  140. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [host]instance-1
  141. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [instance-id]1
  142. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [internal-auth]eyJyb2xlcyI6WyJAaW50ZXJuYWwiXX0=
  143. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [x-forwarded-for]172.18.0.26
  144. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [x-remote-ip]172.18.0.26
  145. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [x-request-id]77ec8456c39d2a260b0ee2e56be33ff5
  146. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] RequestBody: {"values":{"state":"setup_virtualization"}}
  147. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] End of POST request
  148. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Invoke POST request callback
  149. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] WriterAsyncProcess
  150. vm_1_writer.log:2023-06-26 14:58:59.338 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] LimitAssert
  151. vm_1_writer.log:2023-06-26 14:58:59.339 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fe4033c40 query='SELECT nm_ruled,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='4'' duration=379
  152. vm_1_writer.log:2023-06-26 14:58:59.339 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fe4033c40 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='2'' duration=196
  153. vm_1_writer.log:2023-06-26 14:58:59.341 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fe4033c40 query='UPDATE vm_node SET state='setup_virtualization' WHERE id=4' duration=1443
  154. vm_1_writer.log:2023-06-26 14:58:59.341 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fe4033c40 query='SELECT MAX(create_time) FROM vm_node_history WHERE event_type='field:state' AND ref='4'' duration=147
  155. vm_1_writer.log:2023-06-26 14:58:59.341 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fe4033c40 query='INSERT INTO vm_node_history (id,prev_time,event_type,event_info,request_user,request_owner,request_ip,request_id,ref) VALUES (11,'2023-06-26 14:57:35','field:state','{\"new_value\":\"setup_virtualization\",\"old_value\":\"setup_virtualization\"}','admin@example.com','---','172.18.0.26','3dcb485b6039f297aefec27f559d871a',4)' duration=147
  156. vm_1_writer.log:2023-06-26 14:58:59.342 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Create notify 'instance/1/notify/update' with content '{"notifies":["node/4"]}'
  157. vm_1_writer.log:2023-06-26 14:58:59.342 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Response body '{"id":4}'
  158. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] request method: POST url: /node/4 version: HTTP/1.0
  159. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Handler 'node/{node_id}' choosen
  160. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [connection]close
  161. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [content-length]30
  162. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [global-attributes]{"callback_counter":12,"first_start":13297968876234,"request":{"id":"3dcb485b6039f297aefec27f559d871a","ip":"172.18.0.26","user":{"name":"admin@example.com"}},"runtime":84243116203}
  163. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [host]instance-1
  164. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [instance-id]1
  165. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [internal-auth]eyJyb2xlcyI6WyJAaW50ZXJuYWwiXX0=
  166. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [x-forwarded-for]172.18.0.26
  167. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [x-remote-ip]172.18.0.26
  168. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got header: [x-request-id]24cb410acd0cc77a0f96700349bab59e
  169. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] RequestBody: {"values":{"state":"crashed"}}
  170. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] End of POST request
  171. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Invoke POST request callback
  172. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] WriterAsyncProcess
  173. vm_1_writer.log:2023-06-26 14:59:32.234 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] LimitAssert
  174. vm_1_writer.log:2023-06-26 14:59:32.235 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc056f00 query='SELECT nm_ruled,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='4'' duration=370
  175. vm_1_writer.log:2023-06-26 14:59:32.235 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc056f00 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='2'' duration=195
  176. vm_1_writer.log:2023-06-26 14:59:32.236 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc056f00 query='UPDATE vm_node SET state='crashed' WHERE id=4' duration=1409
  177. vm_1_writer.log:2023-06-26 14:59:32.237 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc056f00 query='SELECT MAX(create_time) FROM vm_node_history WHERE event_type='field:state' AND ref='4'' duration=132
  178. vm_1_writer.log:2023-06-26 14:59:32.237 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] db: id=0x7f4fdc056f00 query='INSERT INTO vm_node_history (id,prev_time,event_type,event_info,request_user,request_owner,request_ip,request_id,ref) VALUES (12,'2023-06-26 14:58:59','field:state','{\"new_value\":\"crashed\",\"old_value\":\"crashed\"}','admin@example.com','---','172.18.0.26','3dcb485b6039f297aefec27f559d871a',4)' duration=116
  179. vm_1_writer.log:2023-06-26 14:59:32.240 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Create notify 'instance/1/notify/update' with content '{"notifies":["node/4"]}'
  180. vm_1_writer.log:2023-06-26 14:59:32.240 [pid=5096] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Response body '{"id":4}'
  181. vmctl.log:2023-06-26 14:59:32.315 [pid=12453] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Got action connect_storages with params
  182. vmctl.log:2023-06-26 14:59:32.315 [pid=12453] [#3dcb485b6039f297aefec27f559d871a/172.18.0.26/@admin@example.com] Using VmctlMode::VMCTL virt-type kvm
Advertisement
Add Comment
Please, Sign In to add comment
Advertisement
Public Pastes
Advertisement
We use cookies for various purposes including analytics. By continuing to use Pastebin, you agree to our use of cookies as described in the Cookies Policy.  OK, I Understand
Not a member of Pastebin yet?
Sign Up, it unlocks many cool features!