API tools faq
paste
Advertisement
NMamaev

Untitled

NMamaev
Apr 13th, 2023
38
0
Never
Add comment
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
Bash 28.43 KB | None | 0 0
raw download clone embed print report
  1. [root@8119baa194e0 log]# grep 1d0b9f3c1f36399281a0ccf461865eda *.log*
  2. network_configure.log:2023-04-13 09:35:56.058 [pid=14595] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] DEBUG Starting new HTTP connection (1): consul:8500
  3. network_configure.log:2023-04-13 09:35:56.060 [pid=14595] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] DEBUG http://consul:8500 "PUT /v1/session/create HTTP/1.1" 200 77
  4. network_configure.log:2023-04-13 09:35:56.061 [pid=14595] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] DEBUG [ConsulSession#df8ffdc9-8521-cc6f-1acd-90dc16ba3eda]: session is created
  5. network_configure.log:2023-04-13 09:35:56.063 [pid=14595] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] DEBUG http://consul:8500 "PUT /v1/session/renew/df8ffdc9-8521-cc6f-1acd-90dc16ba3eda HTTP/1.1" 200 213
  6. network_configure.log:2023-04-13 09:35:56.080 [pid=14595] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] INFO Start network configure for domain 50_ube_hessonite
  7. network_configure.log:2023-04-13 09:35:56.081 [pid=14595] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] DEBUG With params: {"cluster": {"id": 21}, "datacenter_type": "common", "ha_enabled": false, "host": {"dns_servers": [], "domain": "ube-hessonite.switching.com", "ga_enabled": true, "id": "50", "interfaces": [{"cluster_interface": 0, "is_main_network": true, "is_vxlan": false, "mac": "52:54:00:7F:84:50", "model": "virtio", "network_switch": "vmbr0"}], "internal_name": "50_ube_hessonite", "ip_automation": "debian_based", "network": [{"host_interface": "ens3", "host_interface_mac": "52:54:00:7F:84:50", "ipv4": [{"gateway": "192.168.15.1", "id": 48, "ip": "192.168.15.7", "netmask": "255.255.255.0"}, {"gateway": "192.168.15.1", "id": 49, "ip": "192.168.15.8", "netmask": "255.255.255.255"}], "ipv6_secondaries": [], "network_switch": "vmbr0", "node_interface_name": "vmbr0"}], "new_ip_addrs": ["192.168.15.8"], "new_ip_ids": [49], "os_group": "ubuntu", "proxy_port": 22, "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:7F:84:50", "ipv4": [{"gateway": "192.168.15.1", "id": 48, "ip": "192.168.15.7", "netmask": "255.255.255.0"}, {"gateway": "192.168.15.1", "id": 49, "ip": "192.168.15.8", "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}}, "last_notify": 6563437, "metadata": "{\"account\":{\"email\":\"n.mamaev@ispsystem.com\",\"id\":4},\"base_resources\":{\"cpu_number\":1,\"ram_mib\":512},\"cluster\":{\"datacenter_type\":\"common\",\"id\":21,\"interface_count\":1,\"virtualization_type\":\"kvm\"},\"disks\":[{\"boot_order\":1,\"expand_part\":\"/dev/sda2\",\"id\":56,\"name\":\"ube_hessonite\",\"pool\":{\"id\":629,\"name\":\"File_vm\"},\"size_mib\":10240,\"storage\":{\"id\":508}}],\"domain\":\"ube-hessonite.switching.com\",\"id\":50,\"interfaces\":[{\"cluster_interface\":1,\"id\":48,\"is_vxlan\":false,\"mac_address\":\"52:54:00:7F:84:50\",\"model\":\"virtio\",\"name\":\"ens3\",\"node_interface\":636,\"node_interface_name\":\"vmbr0\",\"vxlan_id\":0}],\"internal_name\":\"50_ube_hessonite\",\"ipv4\":[{\"domain\":\"ube-hessonite.switching.com\",\"gateway\":\"192.168.15.1\",\"interface_id\":48,\"ip_addr\":\"192.168.15.7\",\"ippool_id\":1,\"local_id\":48,\"net_prefix\":24,\"network_id\":1,\"remote_id\":20574,\"state\":\"active\"},{\"domain\":\"ube-hessonite.switching.com\",\"gateway\":\"192.168.15.1\",\"interface_id\":48,\"ip_addr\":\"192.168.15.8\",\"ippool_id\":1,\"local_id\":49,\"net_prefix\":24,\"network_id\":1,\"remote_id\":20575,\"state\":\"prepare to allocate\"}],\"ipv6\":[],\"metadata_version\":\"1.0.1\",\"name\":\"ube_hessonite\",\"node\":{\"id\":631,\"ip_addr\":\"172.31.36.51\",\"os_version\":\"AstraLinux 1.7.3\",\"port\":22,\"virt_type\":\"kvm\"},\"os\":{\"group\":\"ubuntu\",\"id\":13,\"name\":\"Ubuntu 20.04\",\"tags\":[\"ubuntu2004\",\"ubuntu\",\"linux\"]},\"preset\":7,\"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": {"os_version": "AstraLinux 1.7.3"}, "node_ip": "172.31.36.51", "node_port": 22}
  8. vm_1_reader.log:2023-04-13 09:35:58.706 [pid=221] [#f18a1c09d7f5a6540806b6736322c4b8/10.60.4.173/@n.mamaev@ispsystem.com] Response body '{"last_notify":6563471,"task":{"account":{"email":"n.mamaev@ispsystem.com","id":4,"ip":"10.60.4.173"},"date_create":"2023-04-13 09:35:55.000000","date_end":"2023-04-13 09:35:56.000000","date_start":"2023-04-13 09:35:55.000000","message_params":{"ip_addr":"192.168.15.7","name":"ube_hessonite"},"name":"ip_allocate","output":"Unhandled exception: Action failed with error: Traceback (most recent call last):\n  File \"/opt/ispsystem/vm/scripts/kvm/host_network_configure.py\", line 145, in <module>\n    main()\n  File \"/opt/ispsystem/vm/scripts/kvm/host_network_configure.py\", line 38, in main\n    vm_firewall_params = h_firewall.make_vm_firewall_params( # pylint: disable=no-member\nAttributeError: module 'vm_firewall.vm_firewall_factory' has no attribute 'make_vm_firewall_params'","param":["--action","ip_allocate","--virt-type","kvm","--params","{\"cluster\":{\"id\":21},\"datacenter_type\":\"common\",\"ha_enabled\":false,\"host\":{\"dns_servers\":[],\"domain\":\"ube-hessonite.switching.com\",\"ga_enabled\":true,\"id\":\"50\",\"internal_name\":\"50_ube_hessonite\",\"ip_automation\":\"debian_based\",\"new_ip_addrs\":[\"192.168.15.8\"],\"new_ip_ids\":[49],\"os_group\":\"ubuntu\",\"proxy_port\":22,\"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\":{\"os_version\":\"AstraLinux 1.7.3\"},\"node_ip\":\"172.31.36.51\",\"node_port\":22}"],"request_id":"1d0b9f3c1f36399281a0ccf461865eda","status":"failed"}}'
  9. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] request method: POST url: /host/50/ip version: HTTP/1.0
  10. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Handler 'host/{host_id}/ip' choosen
  11. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [accept]application/json, text/plain, */*
  12. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [accept-encoding]gzip, deflate, br
  13. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [accept-language]ru
  14. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [connection]close
  15. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [content-length]92
  16. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [content-type]application/json
  17. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [cookie]token=172.31.48.152:5902; io=e5d91b119bb34f22be780f5f86ece64b; lang6=ru; ses6=342-5217bfdd-e4bf-44af-bf90-53cee6761615
  18. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [host]instance-1
  19. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [instance-id]1
  20. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [internal-auth]eyJsYW5nIjoicnUiLCJvd25lcl9lbWFpbCI6Im4ubWFtYWV2QGlzcHN5c3RlbS5jb20iLCJvd25lcl9pZCI6NCwicm9sZXMiOlsiQGFkbWluIl0sInNlc3Npb24iOiIzNDItNTIxN2JmZGQtZTRiZi00NGFmLWJmOTAtNTNjZWU2NzYxNjE1IiwidHJ1c3RlZV9pZCI6NCwieHNyZl90b2tlbiI6IjM0Mi01MjE3YmZkZC1lNGJmLTQ0YWYtYmY5MC01M2NlZTY3NjE2MTUifQ==
  21. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [origin]https://172.31.36.15
  22. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [referer]https://172.31.36.15/vm/host/item/50/ip?filter=~&sort=id:desc;
  23. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [user-agent]Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.3 Safari/605.1.15
  24. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [x-forwarded-for]10.60.4.173, 127.0.0.1
  25. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [x-remote-ip]10.60.4.173, 127.0.0.1
  26. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [x-request-id]1d0b9f3c1f36399281a0ccf461865eda
  27. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173] Got header: [x-xsrf-token]342-5217bfdd-e4bf-44af-bf90-53cee6761615
  28. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] RequestBody: {"interfaces":[{"cluster_interface":0,"host_interface":48,"ipv4_number":1,"ipv4_pool":[1]}]}
  29. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] End of POST request
  30. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Invoke POST request callback
  31. vm_1_writer.log:2023-04-13 09:35:55.685 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Executing event for hanlder host/{host_id}/ip
  32. vm_1_writer.log:2023-04-13 09:35:55.686 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='SELECT is_protected,net_is_synced,vm5_data,ha_sync_error,ha_maintenance,ha_restore_priority,ha_restore_on_fail,ip_automation,network_device,firewall_rules,process_number,tcp_connections_out,tcp_connections_in,anti_spoofing_settings,anti_spoofing,io_write_iops,io_read_iops,io_write_mbitps,io_read_mbitps,io_weight,nesting,cpu_weight,cpu_custom_model,cpu_mode,net_weight,net_out_mbitps,net_in_mbitps,iso,rescue_mode,start_date,disabled,mon_install_date,comment,domain,preset,account,reserved_node,node,vnc_port,proxy_port,net_bandwidth_mbitps_changed,net_bandwidth_mbitps_new,net_bandwidth_mbitps,cpu_number_new,cpu_number,ram_mib_new,ram_mib,spice_password,spice_port,spice_enabled,is_migrating,vnc_password,autostart_enabled,xml_version,state_update_date,guest_agent,state,os,internal_name,name,id FROM vm_host WHERE id='50'' duration=430
  33. vm_1_writer.log:2023-04-13 09:35:55.686 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Executing event for hanlder host/{host_id}/ip
  34. vm_1_writer.log:2023-04-13 09:35:55.688 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 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_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='631'' duration=319
  35. vm_1_writer.log:2023-04-13 09:35:55.688 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 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='21'' duration=244
  36. vm_1_writer.log:2023-04-13 09:35:55.691 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='UPDATE vm_host SET ha_maintenance='1' WHERE id=50' duration=2059
  37. vm_1_writer.log:2023-04-13 09:35:55.691 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='SELECT tag,ippool,account,comment,name,id FROM vm_vxlan WHERE ippool='1'' duration=147
  38. vm_1_writer.log:2023-04-13 09:35:55.691 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='SELECT ipp2cl.ippool FROM vm_ippool2cluster ipp2cl WHERE ipp2cl.cluster = '21' AND ipp2cl.interface = '0' GROUP BY ipp2cl.ippool' duration=177
  39. vm_1_writer.log:2023-04-13 09:35:55.691 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] InternalCall service: ip path: ippool/1/ip
  40. vm_1_writer.log:2023-04-13 09:35:55.696 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] InternalRead service: ip path: ip/20575
  41. vm_1_writer.log:2023-04-13 09:35:55.703 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 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='192.168.15.8'' duration=320
  42. vm_1_writer.log:2023-04-13 09:35:55.703 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] InternalRead service: ip path: ipnet/1
  43. vm_1_writer.log:2023-04-13 09:35:55.707 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='SELECT model,vxlan,mac_address,host,node_bridge,name,id FROM vm_host_interfaces WHERE id='48'' duration=380
  44. vm_1_writer.log:2023-04-13 09:35:55.710 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 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(49,'192.168.15.8','192.168.15.1','255.255.255.0',24,'ube-hessonite.switching.com',2,'prepare to allocate',4,1000000000000000000000000000003232239368,50,48,20575,1,1)' duration=2919
  45. vm_1_writer.log:2023-04-13 09:35:55.710 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Create notify 'instance/1/notify/create' with content '{"notifies":["host/50/vm_ip/49","vm_ip/49"]}'
  46. vm_1_writer.log:2023-04-13 09:35:55.710 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Create notify 'instance/1/notify/update' with content '{"notifies":["host/50"]}'
  47. vm_1_writer.log:2023-04-13 09:35:55.711 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 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='13'' duration=197
  48. vm_1_writer.log:2023-04-13 09:35:55.711 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='SELECT group_key,name,id FROM vm_os_group WHERE id='1'' duration=186
  49. vm_1_writer.log:2023-04-13 09:35:55.711 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='SELECT ip_addr FROM vm_ip WHERE host='50' ORDER BY id LIMIT 1' duration=194
  50. vm_1_writer.log:2023-04-13 09:35:55.712 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='SELECT value,name,id FROM vm_settings WHERE name='task_timeout'' duration=367
  51. vm_1_writer.log:2023-04-13 09:35:55.712 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='SELECT value,name,id FROM vm_settings WHERE name='consul_task_ttl_in_sec'' duration=147
  52. vm_1_writer.log:2023-04-13 09:35:55.717 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 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='30039' AND name='ip_allocate'' duration=231
  53. vm_1_writer.log:2023-04-13 09:35:55.718 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='INSERT INTO vm_task_log (id,consul_id,name,param,message_params,status,main_table,main_table_id,node,request_info) VALUES(135032,30039,'ip_allocate','[\"--action\",\"ip_allocate\",\"--virt-type\",\"kvm\",\"--params\",\"{\\\"cluster\\\":{\\\"id\\\":21},\\\"datacenter_type\\\":\\\"common\\\",\\\"ha_enabled\\\":false,\\\"host\\\":{\\\"dns_servers\\\":[],\\\"domain\\\":\\\"ube-hessonite.switching.com\\\",\\\"ga_enabled\\\":true,\\\"id\\\":\\\"50\\\",\\\"internal_name\\\":\\\"50_ube_hessonite\\\",\\\"ip_automation\\\":\\\"debian_based\\\",\\\"new_ip_addrs\\\":[\\\"192.168.15.8\\\"],\\\"new_ip_ids\\\":[49],\\\"os_group\\\":\\\"ubuntu\\\",\\\"proxy_port\\\":22,\\\"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\\\":{\\\"os_version\\\":\\\"AstraLinux 1.7.3\\\"},\\\"node_ip\\\":\\\"172.31.36.51\\\",\\\"node_port\\\":22}\"]','{\"ip_addr\":\"192.168.15.7\",\"name\":\"ube_hessonite\"}','created','vm_host',50,631,'{\"callback_counter\":42,\"first_start\":2088475549168403,\"need_log\":true,\"request\":{\"extra_tags\":[],\"id\":\"1d0b9f3c1f36399281a0ccf461865eda\",\"ip\":\"10.60.4.173\",\"user\":{\"id\":4,\"name\":\"n.mamaev@ispsystem.com\"}},\"runtime\":24162024}')' duration=289
  54. vm_1_writer.log:2023-04-13 09:35:55.724 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] db: id=0x7faaa401ef50 query='INSERT INTO vm_host_log (id,name,host,task,params,request_trustee,request_owner) VALUES(14708,'ip_allocate',50,135032,'{\"ip\":[\"192.168.15.8\"]}',4,4)' duration=5303
  55. vm_1_writer.log:2023-04-13 09:35:55.724 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Create notify 'instance/1/notify/create' with content '{"notifies":["host_history/14708","host/50/host_history/14708"]}'
  56. vm_1_writer.log:2023-04-13 09:35:55.724 [pid=7920] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Response body '{"free_on_failure":true,"id":[49],"task":30039}'
  57. vmctl.log:2023-04-13 09:35:55.769 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Got action ip_allocate with params
  58. vmctl.log:2023-04-13 09:35:55.769 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Using VmctlMode::VMCTL virt-type kvm
  59. vmctl.log:2023-04-13 09:35:55.770 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Stdin params: {"before_execute":{"host":{"interfaces":[{"cluster_interface":0,"is_main_network":true,"is_vxlan":false,"mac":"52:54:00:7F:84:50","model":"virtio","network_switch":"vmbr0"}],"network":[{"host_interface":"ens3","host_interface_mac":"52:54:00:7F:84:50","ipv4":[{"gateway":"192.168.15.1","id":48,"ip":"192.168.15.7","netmask":"255.255.255.0"},{"gateway":"192.168.15.1","id":49,"ip":"192.168.15.8","netmask":"255.255.255.255"}],"ipv6_secondaries":[],"network_switch":"vmbr0","node_interface_name":"vmbr0"}],"tuned_resources":{"network":[{"host_interface":"ens3","host_interface_mac":"52:54:00:7F:84:50","ipv4":[{"gateway":"192.168.15.1","id":48,"ip":"192.168.15.7","netmask":"255.255.255.0"},{"gateway":"192.168.15.1","id":49,"ip":"192.168.15.8","netmask":"255.255.255.255"}],"ipv6_secondaries":[],"network_switch":"vmbr0","node_interface_name":"vmbr0"}]}},"last_notify":6563437,"metadata":"{\"account\":{\"email\":\"n.mamaev@ispsystem.com\",\"id\":4},\"base_resources\":{\"cpu_number\":1,\"ram_mib\":512},\"cluster\":{\"datacenter_type\":\"common\",\"id\":21,\"interface_count\":1,\"virtualization_type\":\"kvm\"},\"disks\":[{\"boot_order\":1,\"expand_part\":\"/dev/sda2\",\"id\":56,\"name\":\"ube_hessonite\",\"pool\":{\"id\":629,\"name\":\"File_vm\"},\"size_mib\":10240,\"storage\":{\"id\":508}}],\"domain\":\"ube-hessonite.switching.com\",\"id\":50,\"interfaces\":[{\"cluster_interface\":1,\"id\":48,\"is_vxlan\":false,\"mac_address\":\"52:54:00:7F:84:50\",\"model\":\"virtio\",\"name\":\"ens3\",\"node_interface\":636,\"node_interface_name\":\"vmbr0\",\"vxlan_id\":0}],\"internal_name\":\"50_ube_hessonite\",\"ipv4\":[{\"domain\":\"ube-hessonite.switching.com\",\"gateway\":\"192.168.15.1\",\"interface_id\":48,\"ip_addr\":\"192.168.15.7\",\"ippool_id\":1,\"local_id\":48,\"net_prefix\":24,\"network_id\":1,\"remote_id\":20574,\"state\":\"active\"},{\"domain\":\"ube-hessonite.switching.com\",\"gateway\":\"192.168.15.1\",\"interface_id\":48,\"ip_addr\":\"192.168.15.8\",\"ippool_id\":1,\"local_id\":49,\"net_prefix\":24,\"network_id\":1,\"remote_id\":20575,\"state\":\"prepare to allocate\"}],\"ipv6\":[],\"metadata_version\":\"1.0.1\",\"name\":\"ube_hessonite\",\"node\":{\"id\":631,\"ip_addr\":\"172.31.36.51\",\"os_version\":\"AstraLinux 1.7.3\",\"port\":22,\"virt_type\":\"kvm\"},\"os\":{\"group\":\"ubuntu\",\"id\":13,\"name\":\"Ubuntu 20.04\",\"tags\":[\"ubuntu2004\",\"ubuntu\",\"linux\"]},\"preset\":7,\"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}}"},"stdin":{}}
  60. vmctl.log:2023-04-13 09:35:55.771 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Executing action ip_allocate with params
  61. vmctl.log:2023-04-13 09:35:55.771 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] IP settings params: {"cluster":{"id":21},"datacenter_type":"common","ha_enabled":false,"host":{"dns_servers":[],"domain":"ube-hessonite.switching.com","ga_enabled":true,"id":"50","interfaces":[{"cluster_interface":0,"is_main_network":true,"is_vxlan":false,"mac":"52:54:00:7F:84:50","model":"virtio","network_switch":"vmbr0"}],"internal_name":"50_ube_hessonite","ip_automation":"debian_based","network":[{"host_interface":"ens3","host_interface_mac":"52:54:00:7F:84:50","ipv4":[{"gateway":"192.168.15.1","id":48,"ip":"192.168.15.7","netmask":"255.255.255.0"},{"gateway":"192.168.15.1","id":49,"ip":"192.168.15.8","netmask":"255.255.255.255"}],"ipv6_secondaries":[],"network_switch":"vmbr0","node_interface_name":"vmbr0"}],"new_ip_addrs":["192.168.15.8"],"new_ip_ids":[49],"os_group":"ubuntu","proxy_port":22,"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:7F:84:50","ipv4":[{"gateway":"192.168.15.1","id":48,"ip":"192.168.15.7","netmask":"255.255.255.0"},{"gateway":"192.168.15.1","id":49,"ip":"192.168.15.8","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}},"last_notify":6563437,"metadata":"{\"account\":{\"email\":\"n.mamaev@ispsystem.com\",\"id\":4},\"base_resources\":{\"cpu_number\":1,\"ram_mib\":512},\"cluster\":{\"datacenter_type\":\"common\",\"id\":21,\"interface_count\":1,\"virtualization_type\":\"kvm\"},\"disks\":[{\"boot_order\":1,\"expand_part\":\"/dev/sda2\",\"id\":56,\"name\":\"ube_hessonite\",\"pool\":{\"id\":629,\"name\":\"File_vm\"},\"size_mib\":10240,\"storage\":{\"id\":508}}],\"domain\":\"ube-hessonite.switching.com\",\"id\":50,\"interfaces\":[{\"cluster_interface\":1,\"id\":48,\"is_vxlan\":false,\"mac_address\":\"52:54:00:7F:84:50\",\"model\":\"virtio\",\"name\":\"ens3\",\"node_interface\":636,\"node_interface_name\":\"vmbr0\",\"vxlan_id\":0}],\"internal_name\":\"50_ube_hessonite\",\"ipv4\":[{\"domain\":\"ube-hessonite.switching.com\",\"gateway\":\"192.168.15.1\",\"interface_id\":48,\"ip_addr\":\"192.168.15.7\",\"ippool_id\":1,\"local_id\":48,\"net_prefix\":24,\"network_id\":1,\"remote_id\":20574,\"state\":\"active\"},{\"domain\":\"ube-hessonite.switching.com\",\"gateway\":\"192.168.15.1\",\"interface_id\":48,\"ip_addr\":\"192.168.15.8\",\"ippool_id\":1,\"local_id\":49,\"net_prefix\":24,\"network_id\":1,\"remote_id\":20575,\"state\":\"prepare to allocate\"}],\"ipv6\":[],\"metadata_version\":\"1.0.1\",\"name\":\"ube_hessonite\",\"node\":{\"id\":631,\"ip_addr\":\"172.31.36.51\",\"os_version\":\"AstraLinux 1.7.3\",\"port\":22,\"virt_type\":\"kvm\"},\"os\":{\"group\":\"ubuntu\",\"id\":13,\"name\":\"Ubuntu 20.04\",\"tags\":[\"ubuntu2004\",\"ubuntu\",\"linux\"]},\"preset\":7,\"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":{"os_version":"AstraLinux 1.7.3"},"node_ip":"172.31.36.51","node_port":22}
  62. vmctl.log:2023-04-13 09:35:55.771 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Fork. New Process PID: 14595
  63. vmctl.log:2023-04-13 09:35:55.771 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] PID: 14595. Execute command: 'scripts/kvm/host_network_configure.py --node_addr 172.31.36.51 --node_port 22 --internal_name 50_ube_hessonite --private-key /opt/ispsystem/vm/etc/.ssh/vmmgr.1'
  64. vmctl.log:2023-04-13 09:35:56.131 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] PID: 14595. Failed with status 256
  65. vmctl.log:2023-04-13 09:35:56.131 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] PID: 14595. Output:
  66. vmctl.log:2023-04-13 09:35:56.131 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] PID: 14595. Error: Traceback (most recent call last):
  67. vmctl.log:2023-04-13 09:35:56.133 [pid=14593] [#1d0b9f3c1f36399281a0ccf461865eda/10.60.4.173/@n.mamaev@ispsystem.com] Unhandled exception: Action failed with error: Traceback (most recent call last):
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!