2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] request method: POST url: /host/42/guest_agent version: HTTP/1.0
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Handler 'host/{host_id}/guest_agent' choosen
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [accept]application/json, text/plain, */*
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [accept-encoding]gzip, deflate, br
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [accept-language]ru-RU,ru;q=0.9,en-US;q=0.8,en;q=0.7
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [connection]close
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [content-length]2
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [content-type]application/json
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [cookie]io=733439953f064f9584c7ec80744a5cbb; lang6=ru; ses6=93-645c6f97-c15a-46ab-b035-899c99bd2655
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [host]instance-1
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [instance-id]1
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [internal-auth]eyJsYW5nIjoicnUiLCJvd25lcl9lbWFpbCI6Im4ubWFtYWV2QGlzcHN5c3RlbS5jb20iLCJvd25lcl9pZCI6Mywicm9sZXMiOlsiQGFkbWluIl0sInNlc3Npb24iOiI5My02NDVjNmY5Ny1jMTVhLTQ2YWItYjAzNS04OTljOTliZDI2NTUiLCJ0cnVzdGVlX2lkIjozLCJ4c3JmX3Rva2VuIjoiOTMtNjQ1YzZmOTctYzE1YS00NmFiLWIwMzUtODk5Yzk5YmQyNjU1In0=
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [origin]https://172.31.225.9
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [referer]https://172.31.225.9/vm/host/list?filter=~&sort=id:desc;&page=1:25;
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [sec-ch-ua]" Not A;Brand";v="99", "Chromium";v="100", "Google Chrome";v="100"
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [sec-ch-ua-mobile]?0
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [sec-ch-ua-platform]"macOS"
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [sec-fetch-dest]empty
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [sec-fetch-mode]cors
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [sec-fetch-site]same-origin
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [user-agent]Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/100.0.4896.88 Safari/537.36
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [x-forwarded-for]10.70.2.173, 127.0.0.1
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [x-remote-ip]10.70.2.173, 127.0.0.1
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [x-request-id]128dcd7ebd6ec8e0450d1c6ca4c6b7aa
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173] Got header: [x-xsrf-token]93-645c6f97-c15a-46ab-b035-899c99bd2655
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] RequestBody: {}
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] End of POST request
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Invoke POST request callback
2022-04-18 19:33:51.266 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT value,name,id FROM vm_bill_options WHERE name='license'' duration=192
2022-04-18 19:33:51.267 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT IFNULL(SUM(n.cpu_number), 0) FROM vm_cluster c LEFT JOIN vm_node n ON n.cluster = c.id' duration=204
2022-04-18 19:33:51.268 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT 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,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,vnc_password,autostart_enabled,xml_version,state_update_date,guest_agent,state,os,internal_name,name,id FROM vm_host WHERE id='42'' duration=317
2022-04-18 19:33:51.269 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT 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,bird_error,lxd_error,libvirt_error,frr_error,connection_error,state,ssh_port,vnc_addr,ip_addr_v6,ip_addr,socket_number,cpu_number,max_vcpu_number,ram_mib,cluster,comment,name,id FROM vm_node WHERE id='18'' duration=342
2022-04-18 19:33:51.270 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 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,updated_at,repository,checksum,image_name,file_name,os_group,name,id FROM vm_os WHERE id='43'' duration=162
2022-04-18 19:33:51.270 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT group_key,name,id FROM vm_os_group WHERE id='7'' duration=135
2022-04-18 19:33:51.271 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT vm5_data,vxlan_mode,node_network_gateway,node_network_timeout,ha_error,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,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='8'' duration=513
2022-04-18 19:33:51.273 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT vm5_data,iso,type,host,account,storage2node,bus,target_dev,boot_order,state,size_mib_new,size_mib,expand_part,is_main,internal_name,name,id FROM vm_disk WHERE host='42' AND is_main='1'' duration=197
2022-04-18 19:33:51.273 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT hdd_overselling,available_mib,size_mib,state,node,storage,id FROM vm_storage2node WHERE id='18'' duration=151
2022-04-18 19:33:51.273 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT imported_from,vm5_data,is_network,storage_params,state,type,comment,name,id FROM vm_storage WHERE id='8'' duration=213
2022-04-18 19:33:51.274 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT hdd_overselling,ha_params,params,pool_name,enabled,is_main,cluster,storage,id FROM vm_storage2cluster WHERE storage='8' AND cluster='8'' duration=147
2022-04-18 19:33:51.274 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT vm5_data,auth_source,state,roles,email,id FROM vm_account WHERE id='19'' duration=135
2022-04-18 19:33:51.274 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 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='43'' duration=158
2022-04-18 19:33:51.274 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT disk.id AS id, disk.name AS name, disk.size_mib AS size_mib, 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='42'' duration=212
2022-04-18 19:33:51.275 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='SELECT i.id, i.name, i.mac_address, IF(i.vxlan is null, FALSE, TRUE) as 'is_vxlan', b.id as 'node_bridge', b.name as 'node_bridge_name' FROM vm_host_interfaces i LEFT JOIN vm_node_bridge b ON i.node_bridge = b.id WHERE i.host='42' ORDER BY b.is_main_network DESC, i.id' duration=203
2022-04-18 19:33:51.275 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 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='42' AND family='2'' duration=154
2022-04-18 19:33:51.275 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 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='42' AND family='10'' duration=156
2022-04-18 19:33:51.275 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Create notify 'instance/1/notify/create' with content '{"additional_data":{"name":"host_guest_agent_repair","status":"created"},"notifies":["node/18/task/1986259490","node/18/host/42/task/1986259490","host/42/task/1986259490","task/1986259490"]}'
2022-04-18 19:33:51.290 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='INSERT INTO vm_task_log (id,consul_id,name,param,message_params,status,main_table,main_table_id,node,request_info) VALUES(321,1986259490,'host_guest_agent_repair','[\"--action\",\"host_guest_agent_repair\",\"--virt-type\",\"vmmgr5\",\"--params\",\"{\\\"disk\\\":{\\\"boot_order\\\":1,\\\"expand_part\\\":null,\\\"file_format\\\":\\\"qcow2\\\",\\\"id\\\":48,\\\"internal_name\\\":\\\"vm-mig-wind\\\",\\\"name\\\":\\\"vm-mig-wind\\\",\\\"pool_name\\\":\\\"File\\\",\\\"size_mib\\\":20000,\\\"storage_id\\\":8,\\\"storage_params\\\":{\\\"pool\\\":{\\\"vm_storage_path\\\":\\\"/vm\\\"}},\\\"storage_type\\\":\\\"file\\\",\\\"target_bus\\\":\\\"virtio\\\",\\\"target_dev\\\":\\\"vda\\\"},\\\"domain_name\\\":\\\"vm-mig-wind\\\",\\\"ha_enabled\\\":false,\\\"node\\\":{\\\"id\\\":18,\\\"image_storage_path\\\":\\\"/image\\\",\\\"ip_addr\\\":\\\"172.31.225.172\\\",\\\"os_version\\\":\\\"CentOS 7.9.2009\\\",\\\"port\\\":22,\\\"virt_type\\\":\\\"vmmgr5\\\"},\\\"os_group\\\":\\\"windows\\\"}\"]','{\"name\":\"vm-mig-wind\",\"node\":\"host-node-1\"}','created','vm_host',42,18,'{\"callback_counter\":22,\"first_start\":1737700271690000,\"need_log\":true,\"request\":{\"extra_tags\":[],\"id\":\"128dcd7ebd6ec8e0450d1c6ca4c6b7aa\",\"ip\":\"10.70.2.173\",\"user\":{\"id\":3,\"name\":\"[e-mail]\"}},\"runtime\":21001010}')' duration=1411
2022-04-18 19:33:51.294 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e002c840 query='INSERT INTO vm_host_log (id,name,host,task,params,request_trustee,request_owner) VALUES(168,'host_guest_agent_repair',42,321,'{\"host\":\"vm-mig-wind\"}',3,3)' duration=1454
2022-04-18 19:33:51.294 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Create notify 'instance/1/notify/create' with content '{"notifies":["host_history/168","host/42/host_history/168"]}'
2022-04-18 19:33:51.294 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Create notify 'instance/1/notify/update' with content '{"notifies":["/42"]}'
2022-04-18 19:33:51.294 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Response body '{"id":42,"task":1986259490}'
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] request method: POST url: /task/321/internal_edit version: HTTP/1.0
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Handler 'task/{task_id}/internal_edit' choosen
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [connection]close
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [content-length]20
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [global-attributes]{"callback_counter":23,"first_start":1737700271690000,"need_log":true,"request":{"extra_tags":[],"id":"128dcd7ebd6ec8e0450d1c6ca4c6b7aa","ip":"10.70.2.173","user":{"id":3,"name":"[e-mail]"}},"runtime":2095014}
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [host]instance-1
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [instance-id]1
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [internal-auth]eyJyb2xlcyI6WyJAaW50ZXJuYWwiXX0=
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-forwarded-for]172.19.0.10
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-remote-ip]172.19.0.10
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-request-id]ccfd93cdf1911e1825ae7c248c2b1e29
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] RequestBody: {"status":"running"}
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] End of POST request
2022-04-18 19:33:51.301 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Invoke POST request callback
2022-04-18 19:33:51.317 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e004ea40 query='SELECT 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 id='321'' duration=1394
2022-04-18 19:33:51.319 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e004ea40 query='UPDATE vm_task_log SET status='running',date_start='2022-04-18 19:33:51' WHERE id=321' duration=2050
2022-04-18 19:33:51.320 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e004ea40 query='SELECT id FROM vm_host_log WHERE task='321'' duration=1214
2022-04-18 19:33:51.321 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e004ea40 query='SELECT request_ip,request_owner,request_trustee,params,rights,state,date_create,task,host,name,id FROM vm_host_log WHERE id='168'' duration=968
2022-04-18 19:33:51.322 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Create notify 'instance/1/notify/update' with content '{"notifies":["host_history/168","host/42/host_history/168"]}'
2022-04-18 19:33:51.322 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6e004ea40 query='SELECT id FROM vm_node_log WHERE task='321'' duration=191
2022-04-18 19:33:51.322 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Create notify 'instance/1/notify/update' with content '{"notifies":["task/1986259490"]}'
2022-04-18 19:33:51.322 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Response body '{"id":1986259490}'
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] request method: POST url: /task/1986259490/fail?name=host%5Fguest%5Fagent%5Frepair version: HTTP/1.0
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Handler 'task/{task_id}/fail' choosen
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [connection]close
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [content-length]1017
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [global-attributes]{"callback_counter":11,"first_start":1737700271690000,"need_log":true,"request":{"extra_tags":[],"id":"128dcd7ebd6ec8e0450d1c6ca4c6b7aa","ip":"10.70.2.173","user":{"id":3,"name":"[e-mail]"}},"runtime":1562998}
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [host]instance-1
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [instance-id]1
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [internal-auth]eyJyb2xlcyI6WyJAaW50ZXJuYWwiXX0=
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-forwarded-for]172.19.0.10
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-remote-ip]172.19.0.10
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-request-id]748e5ed0c5d1fb14bc7b2f86998439a7
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] RequestBody: {"output":{"content":"Traceback (most recent call last):\n  File \"/opt/ispsystem/vm/scripts/kvm/host_guest_agent_repair.py\", line 189, in <module>\n    main()\n  File \"/opt/ispsystem/vm/scripts/kvm/host_guest_agent_repair.py\", line 98, in main\n    raise Exception(result['error'])\nException: failed to install qemu guest agent: Command exited with message virt-customize: error: libguestfs error: inspect_os: sgdisk: \u0007Caution: \ninvalid backup GPT header, but valid main header; regenerating\nbackup header from main header.\n\nWarning! Main and backup partition tables differ! Use the 'c' and 'e' \noptions\non the recovery & transformation menu to examine the two tables.\n\nWarning! One or more CRCs don't match. You should repair the disk!\n\nInvalid partition data!\n\nIf reporting bugs, run virt-customize with debugging enabled and include \nthe complete output:\n\n  virt-customize -v -x [...]\n.\nUnhandled exception: Action failed with error:","type":"text"},"params":{"host_id":42,"node_id":18}}
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] End of POST request
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Invoke POST request callback
2022-04-18 19:43:58.634 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Executing event for hanlder task/{task_id}/fail
2022-04-18 19:43:58.635 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6d8026360 query='SELECT 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='1986259490' AND name='host_guest_agent_repair'' duration=348
2022-04-18 19:43:58.635 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] InternalAsyncCall path task/321/internal_edit
2022-04-18 19:43:58.635 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Create notify 'instance/1/notify/update' with content '{"notifies":["host/42","node/18/host/42"]}'
2022-04-18 19:43:58.635 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Task '1986259490', all after execute events completed
2022-04-18 19:43:58.635 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Response body 'null'
2022-04-18 19:43:58.638 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] request method: POST url: /task/321/internal_edit version: HTTP/1.0
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Handler 'task/{task_id}/internal_edit' choosen
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [connection]close
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [content-length]998
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [global-attributes]{"callback_counter":17,"first_start":1737700271690000,"need_log":true,"request":{"extra_tags":[],"id":"128dcd7ebd6ec8e0450d1c6ca4c6b7aa","ip":"10.70.2.173","user":{"id":3,"name":"[e-mail]"}},"runtime":2094001}
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [host]instance-1
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [instance-id]1
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [internal-auth]eyJyb2xlcyI6WyJAaW50ZXJuYWwiXX0=
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-forwarded-for]172.19.0.10
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-remote-ip]172.19.0.10
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Got header: [x-request-id]0747201f477aa5e0cece9cb45a99b580
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] RequestBody: {"output":{"content":"Traceback (most recent call last):\n  File \"/opt/ispsystem/vm/scripts/kvm/host_guest_agent_repair.py\", line 189, in <module>\n    main()\n  File \"/opt/ispsystem/vm/scripts/kvm/host_guest_agent_repair.py\", line 98, in main\n    raise Exception(result['error'])\nException: failed to install qemu guest agent: Command exited with message virt-customize: error: libguestfs error: inspect_os: sgdisk: \u0007Caution: \ninvalid backup GPT header, but valid main header; regenerating\nbackup header from main header.\n\nWarning! Main and backup partition tables differ! Use the 'c' and 'e' \noptions\non the recovery & transformation menu to examine the two tables.\n\nWarning! One or more CRCs don't match. You should repair the disk!\n\nInvalid partition data!\n\nIf reporting bugs, run virt-customize with debugging enabled and include \nthe complete output:\n\n  virt-customize -v -x [...]\n.\nUnhandled exception: Action failed with error:","type":"text"},"status":"failed"}
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] End of POST request
2022-04-18 19:43:58.639 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Invoke POST request callback
2022-04-18 19:43:58.648 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6d805b630 query='SELECT 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 id='321'' duration=436
2022-04-18 19:43:58.670 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6d805b630 query='UPDATE vm_task_log SET status='failed',date_end='2022-04-18 19:43:58',output='Traceback (most recent call last):\n  File \"/opt/ispsystem/vm/scripts/kvm/host_guest_agent_repair.py\", line 189, in <module>\n    main()\n  File \"/opt/ispsystem/vm/scripts/kvm/host_guest_agent_repair.py\", line 98, in main\n    raise Exception(result[\'error\'])\nException: failed to install qemu guest agent: Command exited with message virt-customize: error: libguestfs error: inspect_os: sgdisk: Caution: \ninvalid backup GPT header, but valid main header; regenerating\nbackup header from main header.\n\nWarning! Main and backup partition tables differ! Use the \'c\' and \'e\' \noptions\non the recovery & transformation menu to examine the two tables.\n\nWarning! One or more CRCs don\'t match. You should repair the disk!\n\nInvalid partition data!\n\nIf reporting bugs, run virt-customize with debugging enabled and include \nthe complete output:\n\n  virt-customize -v -x [...]\n.\nUnhandled exception: Action failed with error:' WHERE id=321' duration=21584
2022-04-18 19:43:58.670 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6d805b630 query='SELECT id FROM vm_host_log WHERE task='321'' duration=147
2022-04-18 19:43:58.670 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6d805b630 query='SELECT request_ip,request_owner,request_trustee,params,rights,state,date_create,task,host,name,id FROM vm_host_log WHERE id='168'' duration=155
2022-04-18 19:43:58.670 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Create notify 'instance/1/notify/update' with content '{"notifies":["host_history/168","host/42/host_history/168"]}'
2022-04-18 19:43:58.671 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] db: id=0x7fd6d805b630 query='SELECT id FROM vm_node_log WHERE task='321'' duration=236
2022-04-18 19:43:58.671 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Create notify 'instance/1/notify/update' with content '{"notifies":["task/1986259490"]}'
2022-04-18 19:43:58.671 [pid=333] [#128dcd7ebd6ec8e0450d1c6ca4c6b7aa/10.70.2.173/@[e-mail]] Response body '{"id":1986259490}'