cloudstack-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "ASF GitHub Bot (JIRA)" <j...@apache.org>
Subject [jira] [Commented] (CLOUDSTACK-9208) Assertion Error in VM_POWER_STATE handler.
Date Thu, 09 Mar 2017 21:42:37 GMT

    [ https://issues.apache.org/jira/browse/CLOUDSTACK-9208?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15903896#comment-15903896
] 

ASF GitHub Bot commented on CLOUDSTACK-9208:
--------------------------------------------

Github user blueorangutan commented on the issue:

    https://github.com/apache/cloudstack/pull/1997
  
    <b>Trillian test result (tid-943)</b>
    Environment: kvm-centos7 (x2), Advanced Networking with Mgmt server 7
    Total time taken: 28118 seconds
    Marvin logs: https://github.com/blueorangutan/acs-prs/releases/download/trillian/pr1997-t943-kvm-centos7.zip
    Intermitten failure detected: /marvin/tests/smoke/test_privategw_acl.py
    Intermitten failure detected: /marvin/tests/smoke/test_snapshots.py
    Test completed. 47 look ok, 2 have error(s)
    
    
    Test | Result | Time (s) | Test File
    --- | --- | --- | ---
    test_04_rvpc_privategw_static_routes | `Failure` | 366.74 | test_privategw_acl.py
    test_02_list_snapshots_with_removed_data_store | `Error` | 0.05 | test_snapshots.py
    test_01_vpc_site2site_vpn | Success | 160.63 | test_vpc_vpn.py
    test_01_vpc_remote_access_vpn | Success | 56.30 | test_vpc_vpn.py
    test_01_redundant_vpc_site2site_vpn | Success | 240.80 | test_vpc_vpn.py
    test_02_VPC_default_routes | Success | 264.18 | test_vpc_router_nics.py
    test_01_VPC_nics_after_destroy | Success | 524.91 | test_vpc_router_nics.py
    test_05_rvpc_multi_tiers | Success | 495.97 | test_vpc_redundant.py
    test_04_rvpc_network_garbage_collector_nics | Success | 1452.42 | test_vpc_redundant.py
    test_03_create_redundant_VPC_1tier_2VMs_2IPs_2PF_ACL_reboot_routers | Success | 548.44
| test_vpc_redundant.py
    test_02_redundant_VPC_default_routes | Success | 739.23 | test_vpc_redundant.py
    test_01_create_redundant_VPC_2tiers_4VMs_4IPs_4PF_ACL | Success | 1290.86 | test_vpc_redundant.py
    test_09_delete_detached_volume | Success | 156.61 | test_volumes.py
    test_08_resize_volume | Success | 156.53 | test_volumes.py
    test_07_resize_fail | Success | 161.56 | test_volumes.py
    test_06_download_detached_volume | Success | 156.36 | test_volumes.py
    test_05_detach_volume | Success | 155.84 | test_volumes.py
    test_04_delete_attached_volume | Success | 151.31 | test_volumes.py
    test_03_download_attached_volume | Success | 156.47 | test_volumes.py
    test_02_attach_volume | Success | 124.31 | test_volumes.py
    test_01_create_volume | Success | 621.21 | test_volumes.py
    test_03_delete_vm_snapshots | Success | 275.23 | test_vm_snapshots.py
    test_02_revert_vm_snapshots | Success | 100.72 | test_vm_snapshots.py
    test_01_create_vm_snapshots | Success | 133.67 | test_vm_snapshots.py
    test_deploy_vm_multiple | Success | 272.95 | test_vm_life_cycle.py
    test_deploy_vm | Success | 0.03 | test_vm_life_cycle.py
    test_advZoneVirtualRouter | Success | 0.03 | test_vm_life_cycle.py
    test_10_attachAndDetach_iso | Success | 26.64 | test_vm_life_cycle.py
    test_09_expunge_vm | Success | 125.24 | test_vm_life_cycle.py
    test_08_migrate_vm | Success | 30.89 | test_vm_life_cycle.py
    test_07_restore_vm | Success | 0.15 | test_vm_life_cycle.py
    test_06_destroy_vm | Success | 126.31 | test_vm_life_cycle.py
    test_03_reboot_vm | Success | 125.90 | test_vm_life_cycle.py
    test_02_start_vm | Success | 10.18 | test_vm_life_cycle.py
    test_01_stop_vm | Success | 40.37 | test_vm_life_cycle.py
    test_CreateTemplateWithDuplicateName | Success | 65.69 | test_templates.py
    test_08_list_system_templates | Success | 0.03 | test_templates.py
    test_07_list_public_templates | Success | 0.04 | test_templates.py
    test_05_template_permissions | Success | 0.08 | test_templates.py
    test_04_extract_template | Success | 5.18 | test_templates.py
    test_03_delete_template | Success | 5.12 | test_templates.py
    test_02_edit_template | Success | 90.17 | test_templates.py
    test_01_create_template | Success | 35.45 | test_templates.py
    test_10_destroy_cpvm | Success | 161.49 | test_ssvm.py
    test_09_destroy_ssvm | Success | 133.15 | test_ssvm.py
    test_08_reboot_cpvm | Success | 101.62 | test_ssvm.py
    test_07_reboot_ssvm | Success | 133.76 | test_ssvm.py
    test_06_stop_cpvm | Success | 131.89 | test_ssvm.py
    test_05_stop_ssvm | Success | 163.89 | test_ssvm.py
    test_04_cpvm_internals | Success | 1.27 | test_ssvm.py
    test_03_ssvm_internals | Success | 3.53 | test_ssvm.py
    test_02_list_cpvm_vm | Success | 0.13 | test_ssvm.py
    test_01_list_sec_storage_vm | Success | 0.16 | test_ssvm.py
    test_01_snapshot_root_disk | Success | 11.13 | test_snapshots.py
    test_04_change_offering_small | Success | 209.62 | test_service_offerings.py
    test_03_delete_service_offering | Success | 0.04 | test_service_offerings.py
    test_02_edit_service_offering | Success | 0.06 | test_service_offerings.py
    test_01_create_service_offering | Success | 0.13 | test_service_offerings.py
    test_02_sys_template_ready | Success | 0.14 | test_secondary_storage.py
    test_01_sys_vm_start | Success | 0.20 | test_secondary_storage.py
    test_09_reboot_router | Success | 30.32 | test_routers.py
    test_08_start_router | Success | 25.28 | test_routers.py
    test_07_stop_router | Success | 10.19 | test_routers.py
    test_06_router_advanced | Success | 0.06 | test_routers.py
    test_05_router_basic | Success | 0.05 | test_routers.py
    test_04_restart_network_wo_cleanup | Success | 5.60 | test_routers.py
    test_03_restart_network_cleanup | Success | 60.56 | test_routers.py
    test_02_router_internal_adv | Success | 1.12 | test_routers.py
    test_01_router_internal_basic | Success | 0.59 | test_routers.py
    test_router_dns_guestipquery | Success | 74.76 | test_router_dns.py
    test_router_dns_externalipquery | Success | 0.08 | test_router_dns.py
    test_router_dhcphosts | Success | 271.73 | test_router_dhcphosts.py
    test_router_dhcp_opts | Success | 21.73 | test_router_dhcphosts.py
    test_01_updatevolumedetail | Success | 0.08 | test_resource_detail.py
    test_01_reset_vm_on_reboot | Success | 131.06 | test_reset_vm_on_reboot.py
    test_createRegion | Success | 0.04 | test_regions.py
    test_create_pvlan_network | Success | 5.27 | test_pvlan.py
    test_dedicatePublicIpRange | Success | 0.47 | test_public_ip_range.py
    test_03_vpc_privategw_restart_vpc_cleanup | Success | 496.24 | test_privategw_acl.py
    test_02_vpc_privategw_static_routes | Success | 336.02 | test_privategw_acl.py
    test_01_vpc_privategw_acl | Success | 82.37 | test_privategw_acl.py
    test_01_primary_storage_nfs | Success | 36.50 | test_primary_storage.py
    test_createPortablePublicIPRange | Success | 15.20 | test_portable_publicip.py
    test_createPortablePublicIPAcquire | Success | 16.02 | test_portable_publicip.py
    test_isolate_network_password_server | Success | 56.51 | test_password_server.py
    test_UpdateStorageOverProvisioningFactor | Success | 0.16 | test_over_provisioning.py
    test_oobm_zchange_password | Success | 30.79 | test_outofbandmanagement.py
    test_oobm_multiple_mgmt_server_ownership | Success | 16.36 | test_outofbandmanagement.py
    test_oobm_issue_power_status | Success | 10.28 | test_outofbandmanagement.py
    test_oobm_issue_power_soft | Success | 15.37 | test_outofbandmanagement.py
    test_oobm_issue_power_reset | Success | 15.37 | test_outofbandmanagement.py
    test_oobm_issue_power_on | Success | 15.43 | test_outofbandmanagement.py
    test_oobm_issue_power_off | Success | 15.42 | test_outofbandmanagement.py
    test_oobm_issue_power_cycle | Success | 15.38 | test_outofbandmanagement.py
    test_oobm_enabledisable_across_clusterzones | Success | 87.78 | test_outofbandmanagement.py
    test_oobm_enable_feature_valid | Success | 5.17 | test_outofbandmanagement.py
    test_oobm_enable_feature_invalid | Success | 0.10 | test_outofbandmanagement.py
    test_oobm_disable_feature_valid | Success | 0.25 | test_outofbandmanagement.py
    test_oobm_disable_feature_invalid | Success | 0.11 | test_outofbandmanagement.py
    test_oobm_configure_invalid_driver | Success | 0.10 | test_outofbandmanagement.py
    test_oobm_configure_default_driver | Success | 0.09 | test_outofbandmanagement.py
    test_oobm_background_powerstate_sync | Success | 18.45 | test_outofbandmanagement.py
    test_extendPhysicalNetworkVlan | Success | 15.37 | test_non_contigiousvlan.py
    test_01_nic | Success | 419.51 | test_nic.py
    test_releaseIP | Success | 157.56 | test_network.py
    test_reboot_router | Success | 398.74 | test_network.py
    test_public_ip_user_account | Success | 10.27 | test_network.py
    test_public_ip_admin_account | Success | 40.35 | test_network.py
    test_network_rules_acquired_public_ip_3_Load_Balancer_Rule | Success | 67.09 | test_network.py
    test_network_rules_acquired_public_ip_2_nat_rule | Success | 61.66 | test_network.py
    test_network_rules_acquired_public_ip_1_static_nat_rule | Success | 123.38 | test_network.py
    test_delete_account | Success | 263.14 | test_network.py
    test_02_port_fwd_on_non_src_nat | Success | 55.77 | test_network.py
    test_01_port_fwd_on_src_nat | Success | 108.78 | test_network.py
    test_nic_secondaryip_add_remove | Success | 212.87 | test_multipleips_per_nic.py
    login_test_saml_user | Success | 19.33 | test_login.py
    test_assign_and_removal_lb | Success | 134.05 | test_loadbalance.py
    test_02_create_lb_rule_non_nat | Success | 187.42 | test_loadbalance.py
    test_01_create_lb_rule_src_nat | Success | 199.93 | test_loadbalance.py
    test_03_list_snapshots | Success | 0.07 | test_list_ids_parameter.py
    test_02_list_templates | Success | 0.04 | test_list_ids_parameter.py
    test_01_list_volumes | Success | 0.03 | test_list_ids_parameter.py
    test_07_list_default_iso | Success | 0.07 | test_iso.py
    test_05_iso_permissions | Success | 0.07 | test_iso.py
    test_04_extract_Iso | Success | 5.14 | test_iso.py
    test_03_delete_iso | Success | 95.19 | test_iso.py
    test_02_edit_iso | Success | 0.07 | test_iso.py
    test_01_create_iso | Success | 21.04 | test_iso.py
    test_04_rvpc_internallb_haproxy_stats_on_all_interfaces | Success | 213.46 | test_internal_lb.py
    test_03_vpc_internallb_haproxy_stats_on_all_interfaces | Success | 133.39 | test_internal_lb.py
    test_02_internallb_roundrobin_1RVPC_3VM_HTTP_port80 | Success | 469.77 | test_internal_lb.py
    test_01_internallb_roundrobin_1VPC_3VM_HTTP_port80 | Success | 411.73 | test_internal_lb.py
    test_dedicateGuestVlanRange | Success | 10.29 | test_guest_vlan_range.py
    test_UpdateConfigParamWithScope | Success | 0.15 | test_global_settings.py
    test_rolepermission_lifecycle_update | Success | 6.26 | test_dynamicroles.py
    test_rolepermission_lifecycle_list | Success | 6.06 | test_dynamicroles.py
    test_rolepermission_lifecycle_delete | Success | 5.90 | test_dynamicroles.py
    test_rolepermission_lifecycle_create | Success | 5.95 | test_dynamicroles.py
    test_rolepermission_lifecycle_concurrent_updates | Success | 6.05 | test_dynamicroles.py
    test_role_lifecycle_update_role_inuse | Success | 5.95 | test_dynamicroles.py
    test_role_lifecycle_update | Success | 11.02 | test_dynamicroles.py
    test_role_lifecycle_list | Success | 5.93 | test_dynamicroles.py
    test_role_lifecycle_delete | Success | 11.13 | test_dynamicroles.py
    test_role_lifecycle_create | Success | 5.94 | test_dynamicroles.py
    test_role_inuse_deletion | Success | 5.93 | test_dynamicroles.py
    test_role_account_acls_multiple_mgmt_servers | Success | 8.64 | test_dynamicroles.py
    test_role_account_acls | Success | 8.57 | test_dynamicroles.py
    test_default_role_deletion | Success | 6.04 | test_dynamicroles.py
    test_04_create_fat_type_disk_offering | Success | 0.08 | test_disk_offerings.py
    test_03_delete_disk_offering | Success | 0.04 | test_disk_offerings.py
    test_02_edit_disk_offering | Success | 0.07 | test_disk_offerings.py
    test_02_create_sparse_type_disk_offering | Success | 0.08 | test_disk_offerings.py
    test_01_create_disk_offering | Success | 0.11 | test_disk_offerings.py
    test_deployvm_userdispersing | Success | 45.85 | test_deploy_vms_with_varied_deploymentplanners.py
    test_deployvm_userconcentrated | Success | 20.67 | test_deploy_vms_with_varied_deploymentplanners.py
    test_deployvm_firstfit | Success | 55.74 | test_deploy_vms_with_varied_deploymentplanners.py
    test_deployvm_userdata_post | Success | 20.57 | test_deploy_vm_with_userdata.py
    test_deployvm_userdata | Success | 50.84 | test_deploy_vm_with_userdata.py
    test_02_deploy_vm_root_resize | Success | 6.09 | test_deploy_vm_root_resize.py
    test_01_deploy_vm_root_resize | Success | 6.02 | test_deploy_vm_root_resize.py
    test_00_deploy_vm_root_resize | Success | 212.69 | test_deploy_vm_root_resize.py
    test_deploy_vm_from_iso | Success | 202.67 | test_deploy_vm_iso.py
    test_DeployVmAntiAffinityGroup | Success | 66.05 | test_affinity_groups.py
    test_change_service_offering_for_vm_with_snapshots | Skipped | 0.00 | test_vm_snapshots.py
    test_01_test_vm_volume_snapshot | Skipped | 0.00 | test_vm_snapshots.py
    test_06_copy_template | Skipped | 0.00 | test_templates.py
    test_static_role_account_acls | Skipped | 0.02 | test_staticroles.py
    test_11_ss_nfs_version_on_ssvm | Skipped | 0.02 | test_ssvm.py
    test_01_scale_vm | Skipped | 0.00 | test_scale_vm.py
    test_01_primary_storage_iscsi | Skipped | 0.05 | test_primary_storage.py
    test_nested_virtualization_vmware | Skipped | 0.00 | test_nested_virtualization.py
    test_06_copy_iso | Skipped | 0.00 | test_iso.py
    test_deploy_vgpu_enabled_vm | Skipped | 0.04 | test_deploy_vgpu_enabled_vm.py
    test_3d_gpu_support | Skipped | 0.04 | test_deploy_vgpu_enabled_vm.py



> Assertion Error in VM_POWER_STATE handler.
> ------------------------------------------
>
>                 Key: CLOUDSTACK-9208
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-9208
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>            Reporter: Kshitij Kansal
>            Assignee: Kshitij Kansal
>            Priority: Minor
>
> 1. Enable the assertions.
> LOG
> 2015-12-31 04:09:06,687 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-981a85d4)
(logid:863754b8) Found 0 networks to update RvR status.
> 2015-12-31 04:09:07,394 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) Ping from 5(10.147.40.18)
> 2015-12-31 04:09:07,394 DEBUG [c.c.v.VirtualMachinePowerStateSyncImpl] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) Process host VM state report from ping process. host: 5
> 2015-12-31 04:09:07,416 INFO [c.c.v.VirtualMachinePowerStateSyncImpl] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) Unable to find matched VM in CloudStack DB. name: New Virtual Machine
> 2015-12-31 04:09:07,420 DEBUG [c.c.v.VirtualMachinePowerStateSyncImpl] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) Process VM state report. host: 5, number of records in report: 5
> 2015-12-31 04:09:07,420 DEBUG [c.c.v.VirtualMachinePowerStateSyncImpl] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) VM state report. host: 5, vm id: 69, power state: PowerOff
> 2015-12-31 04:09:07,530 DEBUG [c.c.v.VirtualMachinePowerStateSyncImpl] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) VM state report is updated. host: 5, vm id: 69, power state: PowerOff
> 2015-12-31 04:09:07,540 INFO [c.c.v.VirtualMachineManagerImpl] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) VM r-69-VM is at Stopped and we received a power-off report while there is
no pending jobs on it
> 2015-12-31 04:09:07,541 ERROR [o.a.c.f.m.MessageDispatcher] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) Unexpected exception when calling com.cloud.vm.ClusteredVirtualMachineManagerImpl.HandlePowerStateReport
> java.lang.reflect.InvocationTargetException
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:606)
> at org.apache.cloudstack.framework.messagebus.MessageDispatcher.dispatch(MessageDispatcher.java:75)
> at org.apache.cloudstack.framework.messagebus.MessageDispatcher.onPublishMessage(MessageDispatcher.java:45)
> at org.apache.cloudstack.framework.messagebus.MessageBusBase$SubscriptionNode.notifySubscribers(MessageBusBase.java:441)
> at org.apache.cloudstack.framework.messagebus.MessageBusBase.publish(MessageBusBase.java:178)
> at com.cloud.vm.VirtualMachinePowerStateSyncImpl.processReport(VirtualMachinePowerStateSyncImpl.java:87)
> at com.cloud.vm.VirtualMachinePowerStateSyncImpl.processHostVmStatePingReport(VirtualMachinePowerStateSyncImpl.java:70)
> at com.cloud.vm.VirtualMachineManagerImpl.processCommands(VirtualMachineManagerImpl.java:2879)
> at com.cloud.agent.manager.AgentManagerImpl.handleCommands(AgentManagerImpl.java:309)
> at com.cloud.agent.manager.DirectAgentAttache$PingTask.runInContext(DirectAgentAttache.java:192)
> at org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
> at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
> at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
> at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
> at org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:304)
> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178)
> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.AssertionError: Who's not checking the agent id before sending?
... (finger wagging)
> at com.cloud.agent.manager.AgentManagerImpl.send(AgentManagerImpl.java:429)
> at com.cloud.agent.manager.AgentManagerImpl.send(AgentManagerImpl.java:364)
> at com.cloud.vm.VirtualMachineManagerImpl.sendStop(VirtualMachineManagerImpl.java:1339)
> ... 27 more
> 2015-12-31 04:09:07,543 WARN [c.c.a.m.DirectAgentAttache] (DirectAgentCronJob-3:ctx-3ba82e46)
(logid:02dcbd48) Unable to complete the ping task
> java.lang.RuntimeException: InvocationTargetException when invoking event handler for
subject: vm.powerstate
> at org.apache.cloudstack.framework.messagebus.MessageDispatcher.dispatch(MessageDispatcher.java:84)
> at org.apache.cloudstack.framework.messagebus.MessageDispatcher.onPublishMessage(MessageDispatcher.java:45)
> at org.apache.cloudstack.framework.messagebus.MessageBusBase$SubscriptionNode.notifySubscribers(MessageBusBase.java:441)
> at org.apache.cloudstack.framework.messagebus.MessageBusBase.publish(MessageBusBase.java:178)
> at com.cloud.vm.VirtualMachinePowerStateSyncImpl.processReport(VirtualMachinePowerStateSyncImpl.java:87)
> at com.cloud.vm.VirtualMachinePowerStateSyncImpl.processHostVmStatePingReport(VirtualMachinePowerStateSyncImpl.java:70)
> at com.cloud.vm.VirtualMachineManagerImpl.processCommands(VirtualMachineManagerImpl.java:2879)
> at com.cloud.agent.manager.AgentManagerImpl.handleCommands(AgentManagerImpl.java:309)
> at com.cloud.agent.manager.DirectAgentAttache$PingTask.runInContext(DirectAgentAttache.java:192)
> at org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
> at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
> at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
> at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
> at org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:304)
> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178)
> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> 2015-12-31 04:09:10,972 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-ff090f45)
(logid:38f2d7f8) Zone 1 is ready to launch console proxy
> 2015-12-31 04:09:10,973 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-ff090f45)
(logid:38f2d7f8) Zone 2 is not ready to launch console proxy yet
> 2015-12-31 04:09:11,153 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-4d8194c3)
(logid:bdeb5f78) Zone 1 is ready to launch secondary storage VM
> 2015-12-31 04:09:11,166 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-4d8194c3)
(logid:bdeb5f78) Zone 2 is not ready to launch secondary storage VM yet
> 2015-12-31 04:09:11,551 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-8:null)
(logid SeqA 2-481000: Processing Seq 2-481000: { Cmd , MgmtId: -1, via: 2, Ver: v1, Flags:
11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":45,"_loadInfo":"
> {\n \"connections\": []\n}
> ","wait":0}}] }
> 2015-12-31 04:09:11,557 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-8:null)
(logid SeqA 2-481000: Sending Seq 2-481000: { Ans: , MgmtId: 7020459589851, via: 2, Ver: v1,
Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
> 2015-12-31 04:09:16,474 INFO [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-904c4f5a)
(logid:7376bd5c) Begin cleanup expired async-jobs
> 2015-12-31 04:09:16,488 INFO [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-904c4f5a)
(logid:7376bd5c) End cleanup expired async-jobs
> 2015-12-31 04:09:21,589 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-9:null)
(logid SeqA 2-481001: Processing Seq 2-481001: { Cmd , MgmtId: -1, via: 2, Ver: v1, Flags:
11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":45,"_loadInfo":"
> {\n \"connections\": []\n}
> ","wait":0}}] }
> 2015-12-31 04:09:21,596 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-9:null)
(logid SeqA 2-481001: Sending Seq 2-481001: { Ans: , MgmtId: 7020459589851, via: 2, Ver: v1,
Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
> 2015-12-31 04:09:26,474 INFO [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-9f3afa6f)
(logid:31dbd0f4) Begin cleanup expired async-jobs
> 2015-12-31 04:09:26,486 INFO [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-9f3afa6f)
(logid:31dbd0f4) End cleanup expired async-jobs
> 2015-12-31 04:09:31,589 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-10:null)
(logid SeqA 2-481002: Processing Seq 2-481002: { Cmd , MgmtId: -1, via: 2, Ver: v1, Flags:
11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":45,"_loadInfo":"
> {\n \"connections\": []\n}
> ","wait":0}}] }
> 2015-12-31 04:09:31,596 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler



--
This message was sent by Atlassian JIRA
(v6.3.15#6346)

Mime
View raw message