2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] request method: POST url: /host/3/restart version: HTTP/1.0
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Handler 'host/{host_id}/restart' choosen
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [connection]close
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [content-length]2
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [host]instance-1
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [instance-id]1
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [internal-auth]eyJlbWFpbF9jb25maXJtZWQiOnRydWUsImV4cGlyZXNfYXQiOiIiLCJpbnN0YW5jZV9vd25lciI6ZmFsc2UsImxhbmciOiJydSIsImxhc3Rfbm90aWZ5IjoyMDE2ODYsIm93bmVyX2VtYWlsIjoibi5tYW1hZXZAaXNwc3lzdGVtLmNvbSIsIm93bmVyX2lkIjo1LCJyb2xlcyI6WyJAYWRtaW4iXSwic2VzX2lkIjo4LCJzZXNzaW9uIjoiOC0xMGQxNTczMy1jZmE0LTRkYTAtYjM4ZC02ZmFmODNkYTM5M2YiLCJzdV9pbnN0YW5jZSI6ZmFsc2UsInRydXN0ZWVfZW1haWwiOiJuLm1hbWFldkBpc3BzeXN0ZW0uY29tIiwidHJ1c3RlZV9pZCI6NSwieHNyZl90b2tlbiI6IjgtMTBkMTU3MzMtY2ZhNC00ZGEwLWIzOGQtNmZhZjgzZGEzOTNmIn0=
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [x-forwarded-for]172.18.0.27
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [x-remote-ip]172.18.0.27
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [x-request-id]71e5661dd1a5b151a8162add49f33379
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27] Got header: [x-xsrf-token]8-10d15733-cfa4-4da0-b38d-6faf83da393f
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] RequestBody: {}
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] End of POST request
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] Invoke POST request callback
2023-07-25 06:21:50.825 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] Executing event for hanlder host/{host_id}/restart
2023-07-25 06:21:50.826 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT snapshot_curr,snapshot_ram,snapshot_limit,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_additional_enabled,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='3'' duration=748
2023-07-25 06:21:50.826 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] WriterAsyncProcess
2023-07-25 06:21:50.826 [pid=36472] [**NO INFO**] WriterAsyncProcess post
2023-07-25 06:21:50.826 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] LimitAssert
2023-07-25 06:21:50.827 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT id FROM vm_task_log WHERE status='deferred' AND defer_reason='host_stop:3'' duration=323
2023-07-25 06:21:50.827 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 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='5'' duration=381
2023-07-25 06:21:50.828 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT vm5_data,spice_enabled,node_os_family,vxlan_mode,node_network_gateway,node_network_timeout,ha_error,ha_cluster_id,ha_agent_version,ha_checking_host,ha_enabled,net_bandwidth_mbitps,dns_servers,host_per_node_limit,proxy_enabled,domain_change_allowed,manage_disk_enabled,iso_enabled,cpu_overselling,overselling,qemu_version,domain_template,image_storage_path,os_storage_path,interface_count,imported_from,host_filter,host_distribution_policy,datacenter_type,virtualization_type,time_zone,comment,name,id FROM vm_cluster WHERE id='1'' duration=323
2023-07-25 06:21:50.828 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT vm5_data,auth_source,state,roles,email,id FROM vm_account WHERE id='3'' duration=210
2023-07-25 06:21:50.829 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 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='22'' duration=241
2023-07-25 06:21:50.829 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT disk.id AS id, disk.name AS name, disk.size_mib AS size_mib, disk.boot_order AS boot_order, disk.expand_part AS expand_part, vm_storage2node.id AS pool_id, vm_storage2cluster.pool_name AS pool_name, vm_storage2node.storage AS storage_id FROM vm_disk disk LEFT JOIN vm_storage2node ON vm_storage2node.id=disk.storage2node LEFT JOIN vm_node ON vm_node.id=vm_storage2node.node LEFT JOIN vm_storage2cluster ON vm_storage2cluster.storage=vm_storage2node.storage AND vm_storage2cluster.cluster=vm_node.cluster WHERE disk.host='3'' duration=419
2023-07-25 06:21:50.830 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT i.id AS id, i.name AS name, i.mac_address AS mac_address, i.vxlan IS NOT NULL AS is_vxlan, i.model AS model, x.id AS vxlan_id, b.id AS node_bridge, b.name AS node_bridge_name, b.is_main_network AS is_main_network FROM vm_host_interfaces AS i LEFT JOIN vm_node_bridge b ON i.node_bridge = b.id LEFT JOIN vm_vxlan x ON x.id = i.vxlan WHERE (i.host = '3') ORDER BY i.id, b.is_main_network DESC' duration=406
2023-07-25 06:21:50.830 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 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 id = '5'' duration=166
2023-07-25 06:21:50.830 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 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='3' AND family='2'' duration=181
2023-07-25 06:21:50.831 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 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='3' AND family='10'' duration=184
2023-07-25 06:21:50.831 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT ip_addr FROM vm_ip WHERE host='3' ORDER BY id LIMIT 1' duration=153
2023-07-25 06:21:50.831 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT value,name,id FROM vm_settings WHERE name='task_timeout'' duration=144
2023-07-25 06:21:50.831 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] db: id=0x7f5a78010790 query='SELECT value,name,id FROM vm_settings WHERE name='consul_task_ttl_in_sec'' duration=118
2023-07-25 06:22:20.832 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] Task registration error: Operation canceled
2023-07-25 06:22:20.832 [pid=36472] [#71e5661dd1a5b151a8162add49f33379/172.18.0.27/@n.mamaev@ispsystem.com] Response body '{"error":{"code":5233,"msg":"Task registration error"}}'