On Sun, May 7, 2017 at 5:14 PM Roy Golan <rgolan@redhat.com> wrote:
On Sat, May 6, 2017 at 2:42 PM Niyazi Elvan <niyazielvan@gmail.com> wrote:
Hello,

I am trying to test oVirt 4.1 functionality using vdsm-fake. I managed to run vdsm-fake with the following docker  command :

docker run  -d -p 8080:8080 -p54321:54321 docker.io/rmohr/ovirt-vdsmfake


Starting from today ovirt CI is building containers(still not to docker.io) after each patch. You can see the job here [1] and simply


small correction, docker load expects a file an not a url

 
docker load -i $(curl -q -o - http://jenkins.ovirt.org/job/ovirt-vdsmfake_master_build-artifacts-el7-x86_64/lastSuccessfulBuild/artifact/exported-artifacts/vdsmfake-container-image.tar)

docker run vdsmfake:latest

In time the image will be thinner and will go into docker.io, utilization already downloaded layers.

[1] http://jenkins.ovirt.org/job/ovirt-vdsmfake_master_build-artifacts-el7-x86_64/
 
it is running on a different host than ovirt 4.1. so in the /etc/hosts file instead of using 127.0.0.1 I added the vdsm-fake host's ip address.

I am adding test0,test1 ... looks good at the beginning but after a while host is set to non-operational due to reason EMULATED_MACHINES_INCOMPATIBLE_WITH_CLUSTER_LEVEL

ovirt-engine is complaining about available memory of host that it is below the threshold 1024 MB , available looks 0.

here are the relevant logs from ovirt-engine and vdsm-fake. Any ideas ?

Thank you.

ENGINE LOG

2017-05-06 14:27:43,643+03 INFO  [org.ovirt.engine.core.bll.hostdeploy.AddVdsCommand] (default task-15) [002e2037-0ed9-429e-acb9-6ea363c8f44d] Running command: AddVdsCommand internal: false. Entities affected :  ID: 00000002-0002-0002-0002-00000000017a Type: ClusterAction group CREATE_HOST with role type ADMIN
2017-05-06 14:27:43,666+03 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (default task-15) [7790960e] Before acquiring and wait lock 'EngineLock:{exclusiveLocks='[00000001-0001-0001-0001-000000000311=<REGISTER_VDS, ACTION_TYPE_FAILED_OBJECT_LOCKED>]', sharedLocks='null'}'
2017-05-06 14:27:43,667+03 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (default task-15) [7790960e] Lock-wait acquired to object 'EngineLock:{exclusiveLocks='[00000001-0001-0001-0001-000000000311=<REGISTER_VDS, ACTION_TYPE_FAILED_OBJECT_LOCKED>]', sharedLocks='null'}'
2017-05-06 14:27:43,672+03 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (default task-15) [7790960e] Running command: AddVdsSpmIdCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:27:43,682+03 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (default task-15) [7790960e] Lock freed to object 'EngineLock:{exclusiveLocks='[00000001-0001-0001-0001-000000000311=<REGISTER_VDS, ACTION_TYPE_FAILED_OBJECT_LOCKED>]', sharedLocks='null'}'
2017-05-06 14:27:43,685+03 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (default task-15) [7790960e] START, RemoveVdsVDSCommand(HostName = test3, RemoveVdsVDSCommandParameters:{runAsync='true', hostId='88cbdeab-37f4-47f3-a761-1cee75a62bcb'}), log id: 7fcf255f
2017-05-06 14:27:43,686+03 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (default task-15) [7790960e] FINISH, RemoveVdsVDSCommand, log id: 7fcf255f
2017-05-06 14:27:43,689+03 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-15) [7790960e] START, AddVdsVDSCommand(HostName = test3, AddVdsVDSCommandParameters:{runAsync='true', hostId='88cbdeab-37f4-47f3-a761-1cee75a62bcb'}), log id: 48a00f2
2017-05-06 14:27:43,689+03 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-15) [7790960e] AddVds - entered , starting logic to add VDS '88cbdeab-37f4-47f3-a761-1cee75a62bcb'
2017-05-06 14:27:43,692+03 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-15) [7790960e] AddVds - VDS '88cbdeab-37f4-47f3-a761-1cee75a62bcb' was added, will try to add it to the resource manager
2017-05-06 14:27:43,692+03 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (default task-15) [7790960e] Entered VdsManager constructor
2017-05-06 14:27:43,696+03 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (default task-15) [7790960e] Initialize vdsBroker 'test3:54321'
2017-05-06 14:27:43,704+03 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (default task-15) [7790960e] VDS '88cbdeab-37f4-47f3-a761-1cee75a62bcb' was added to the Resource Manager
2017-05-06 14:27:43,704+03 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-15) [7790960e] FINISH, AddVdsVDSCommand, log id: 48a00f2
2017-05-06 14:27:43,716+03 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-15) [7790960e] EVENT_ID: VDS_ALERT_FENCE_IS_NOT_CONFIGURED(9,000), Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host test3.
2017-05-06 14:27:43,755+03 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-15) [7790960e] EVENT_ID: USER_ADD_VDS(42), Correlation ID: 002e2037-0ed9-429e-acb9-6ea363c8f44d, Job ID: 404e989c-1ac6-43de-bc91-1e9548de9d49, Call Stack: null, Custom Event ID: -1, Message: Host test3 was added by admin@internal-authz.
2017-05-06 14:27:46,748+03 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (Stomp Reactor) [b859ba6] Connecting to test3/192.168.1.27
2017-05-06 14:27:56,818+03 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler5) [507a0cb7] START, GetHardwareInfoVDSCommand(HostName = test3, VdsIdAndVdsVDSCommandParametersBase:{runAsync='true', hostId='88cbdeab-37f4-47f3-a761-1cee75a62bcb', vds='Host[test3,88cbdeab-37f4-47f3-a761-1cee75a62bcb]'}), log id: 3db67a
2017-05-06 14:27:56,830+03 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler5) [507a0cb7] FINISH, GetHardwareInfoVDSCommand, log id: 3db67a
2017-05-06 14:27:56,893+03 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler5) [1179ed4f] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:27:56,929+03 INFO  [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler5) [5cae97a7] Running command: SetNonOperationalVdsCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:27:56,936+03 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler5) [5cae97a7] START, SetVdsStatusVDSCommand(HostName = test3, SetVdsStatusVDSCommandParameters:{runAsync='true', hostId='88cbdeab-37f4-47f3-a761-1cee75a62bcb', status='NonOperational', nonOperationalReason='EMULATED_MACHINES_INCOMPATIBLE_WITH_CLUSTER_LEVEL', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 769664ce
2017-05-06 14:27:56,940+03 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler5) [5cae97a7] FINISH, SetVdsStatusVDSCommand, log id: 769664ce
2017-05-06 14:27:56,960+03 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler5) [5cae97a7] EVENT_ID: EMULATED_MACHINES_INCOMPATIBLE_WITH_CLUSTER_LEVEL(9,609), Correlation ID: 5cae97a7, Job ID: 892ef43d-db32-4092-81ae-06a1da6d5060, Call Stack: null, Custom Event ID: -1, Message: Host test3 does not comply with the cluster Default emulated machines. The current cluster compatibility level supports [pc-i440fx-rhel7.3.0, pc-i440fx-2.6, pseries-rhel7.3.0] and the host emulated machines are pc-0.10,pc-0.11,pc-0.12,pc-0.13,pc-0.14,pc-0.15,pc-1.0,pc-1.0,pc-i440fx-2.1,pseries-rhel7.2.0,pc-i440fx-rhel7.2.0,rhel6.4.0,rhel6.5.0,rhel6.6.0,rhel6.7.0,rhel6.8.0,rhel6.9.0,rhel7.0.0,rhel7.2.0,rhel7.5.0,pc,isapc.
2017-05-06 14:27:57,001+03 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler5) [5cae97a7] START, GetHardwareInfoVDSCommand(HostName = test3, VdsIdAndVdsVDSCommandParametersBase:{runAsync='true', hostId='88cbdeab-37f4-47f3-a761-1cee75a62bcb', vds='Host[test3,88cbdeab-37f4-47f3-a761-1cee75a62bcb]'}), log id: 546bc127
2017-05-06 14:27:57,007+03 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler5) [5cae97a7] FINISH, GetHardwareInfoVDSCommand, log id: 546bc127
2017-05-06 14:27:57,044+03 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler5) [445f8699] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:27:57,064+03 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler5) [445f8699] EVENT_ID: VDS_DETECTED(13), Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host test3 was set to NonOperational.
2017-05-06 14:27:57,086+03 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler5) [30399168] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:27:57,099+03 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler5) [74b1e5e7] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:27:57,102+03 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.HostMonitoring] (DefaultQuartzScheduler5) [74b1e5e7] Host 'test3'(88cbdeab-37f4-47f3-a761-1cee75a62bcb) is already in NonOperational status for reason 'EMULATED_MACHINES_INCOMPATIBLE_WITH_CLUSTER_LEVEL'. SetNonOperationalVds command is skipped.
2017-05-06 14:27:58,714+03 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (DefaultQuartzScheduler1) [] Fetched 0 VMs from VDS '88cbdeab-37f4-47f3-a761-1cee75a62bcb'
2017-05-06 14:28:12,261+03 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler10) [] EVENT_ID: VDS_TIME_DRIFT_ALERT(604), Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Host test3 has time-drift of 3599 seconds while maximum configured value is 300 seconds.
2017-05-06 14:28:12,281+03 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler10) [] EVENT_ID: VDS_LOW_MEM(531), Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Available memory of host test3 [0 MB] is under defined threshold [1024 MB].
2017-05-06 14:30:00,021+03 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (DefaultQuartzScheduler6) [7e9c9b85] Autorecovering 1 hosts
2017-05-06 14:30:00,022+03 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (DefaultQuartzScheduler6) [7e9c9b85] Autorecovering hosts id: 88cbdeab-37f4-47f3-a761-1cee75a62bcb , name : test3
2017-05-06 14:30:00,033+03 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler6) [64ba5626] Lock Acquired to object 'EngineLock:{exclusiveLocks='[88cbdeab-37f4-47f3-a761-1cee75a62bcb=<VDS, ACTION_TYPE_FAILED_OBJECT_LOCKED>]', sharedLocks='null'}'
2017-05-06 14:30:00,042+03 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler6) [64ba5626] Running command: ActivateVdsCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDSAction group MANIPULATE_HOST with role type ADMIN
2017-05-06 14:30:00,042+03 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler6) [64ba5626] Before acquiring lock in order to prevent monitoring for host 'test3' from data-center 'Default'
2017-05-06 14:30:00,042+03 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler6) [64ba5626] Lock acquired, from now a monitoring of host will be skipped for host 'test3' from data-center 'Default'
2017-05-06 14:30:00,048+03 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler6) [64ba5626] START, SetVdsStatusVDSCommand(HostName = test3, SetVdsStatusVDSCommandParameters:{runAsync='true', hostId='88cbdeab-37f4-47f3-a761-1cee75a62bcb', status='Unassigned', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 771398
2017-05-06 14:30:00,055+03 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler6) [64ba5626] FINISH, SetVdsStatusVDSCommand, log id: 771398
2017-05-06 14:30:00,064+03 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler6) [64ba5626] Activate host finished. Lock released. Monitoring can run now for host 'test3' from data-center 'Default'
2017-05-06 14:30:00,073+03 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler6) [64ba5626] EVENT_ID: VDS_ACTIVATE_ASYNC(9,502), Correlation ID: 64ba5626, Call Stack: null, Custom Event ID: -1, Message: Host test3 was autorecovered.
2017-05-06 14:30:00,075+03 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler6) [64ba5626] Lock freed to object 'EngineLock:{exclusiveLocks='[88cbdeab-37f4-47f3-a761-1cee75a62bcb=<VDS, ACTION_TYPE_FAILED_OBJECT_LOCKED>]', sharedLocks='null'}'
2017-05-06 14:30:01,769+03 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler4) [4f87a9b3] START, GetHardwareInfoVDSCommand(HostName = test3, VdsIdAndVdsVDSCommandParametersBase:{runAsync='true', hostId='88cbdeab-37f4-47f3-a761-1cee75a62bcb', vds='Host[test3,88cbdeab-37f4-47f3-a761-1cee75a62bcb]'}), log id: f56da49
2017-05-06 14:30:01,779+03 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler4) [4f87a9b3] FINISH, GetHardwareInfoVDSCommand, log id: f56da49
2017-05-06 14:30:01,844+03 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler4) [541ddee4] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:30:01,903+03 INFO  [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler4) [57a8f4c5] Running command: SetNonOperationalVdsCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:30:01,909+03 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler4) [57a8f4c5] START, SetVdsStatusVDSCommand(HostName = test3, SetVdsStatusVDSCommandParameters:{runAsync='true', hostId='88cbdeab-37f4-47f3-a761-1cee75a62bcb', status='NonOperational', nonOperationalReason='EMULATED_MACHINES_INCOMPATIBLE_WITH_CLUSTER_LEVEL', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 2f95d0c2
2017-05-06 14:30:01,921+03 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler4) [57a8f4c5] FINISH, SetVdsStatusVDSCommand, log id: 2f95d0c2
2017-05-06 14:30:02,024+03 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler4) [57a8f4c5] EVENT_ID: EMULATED_MACHINES_INCOMPATIBLE_WITH_CLUSTER_LEVEL(9,609), Correlation ID: 57a8f4c5, Job ID: c0f8e1c5-0876-46f0-b9f3-a82cd5cbf25c, Call Stack: null, Custom Event ID: -1, Message: Host test3 does not comply with the cluster Default emulated machines. The current cluster compatibility level supports [pc-i440fx-rhel7.3.0, pc-i440fx-2.6, pseries-rhel7.3.0] and the host emulated machines are pc-0.10,pc-0.11,pc-0.12,pc-0.13,pc-0.14,pc-0.15,pc-1.0,pc-1.0,pc-i440fx-2.1,pseries-rhel7.2.0,pc-i440fx-rhel7.2.0,rhel6.4.0,rhel6.5.0,rhel6.6.0,rhel6.7.0,rhel6.8.0,rhel6.9.0,rhel7.0.0,rhel7.2.0,rhel7.5.0,pc,isapc.
2017-05-06 14:30:02,067+03 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler4) [57a8f4c5] EVENT_ID: VDS_DETECTED(13), Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host test3 was set to NonOperational.
2017-05-06 14:30:02,104+03 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler4) [1b34fa25] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 88cbdeab-37f4-47f3-a761-1cee75a62bcb Type: VDS
2017-05-06 14:30:02,109+03 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.HostMonitoring] (DefaultQuartzScheduler4) [1b34fa25] Host 'test3'(88cbdeab-37f4-47f3-a761-1cee75a62bcb) is already in NonOperational status for reason 'EMULATED_MACHINES_INCOMPATIBLE_WITH_CLUSTER_LEVEL'. SetNonOperationalVds command is skipped.
^C


VDSM-FAKE LOG

May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,070 Message CONNECT
May  6 15:27:57 vdsm-fake journal: accept-version:1.2
May  6 15:27:57 vdsm-fake journal: heart-beat:0,24000
May  6 15:27:57 vdsm-fake journal: host:test3
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: SUBSCRIBE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.events
May  6 15:27:57 vdsm-fake journal: ack:auto
May  6 15:27:57 vdsm-fake journal: id:4504105f-66e8-4163-b515-9960ca956814
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: SUBSCRIBE
May  6 15:27:57 vdsm-fake journal: destination:jms.topic.vdsm_responses
May  6 15:27:57 vdsm-fake journal: ack:auto
May  6 15:27:57 vdsm-fake journal: id:d101be23-5fa8-4ce3-8fac-7949efdb5fbb
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,072 Message CONNECT
May  6 15:27:57 vdsm-fake journal: accept-version:1.2
May  6 15:27:57 vdsm-fake journal: heart-beat:0,24000
May  6 15:27:57 vdsm-fake journal: host:test3
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,072 Message CONNECTED
May  6 15:27:57 vdsm-fake journal: heart-beat:24000,0
May  6 15:27:57 vdsm-fake journal: session:9ab26f9f-17a0-4d77-833f-f206a07ce7e5
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,072 StompCommonClient Message sent: CONNECTED
May  6 15:27:57 vdsm-fake journal: heart-beat:24000,0
May  6 15:27:57 vdsm-fake journal: session:9ab26f9f-17a0-4d77-833f-f206a07ce7e5
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,072 Message SUBSCRIBE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.events
May  6 15:27:57 vdsm-fake journal: ack:auto
May  6 15:27:57 vdsm-fake journal: id:4504105f-66e8-4163-b515-9960ca956814
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,073 Message ACK
May  6 15:27:57 vdsm-fake journal: id:4504105f-66e8-4163-b515-9960ca956814
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,073 StompCommonClient Message sent: ACK
May  6 15:27:57 vdsm-fake journal: id:4504105f-66e8-4163-b515-9960ca956814
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,073 Message SUBSCRIBE
May  6 15:27:57 vdsm-fake journal: destination:jms.topic.vdsm_responses
May  6 15:27:57 vdsm-fake journal: ack:auto
May  6 15:27:57 vdsm-fake journal: id:d101be23-5fa8-4ce3-8fac-7949efdb5fbb
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,073 Message ACK
May  6 15:27:57 vdsm-fake journal: id:d101be23-5fa8-4ce3-8fac-7949efdb5fbb
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,073 StompCommonClient Message sent: ACK
May  6 15:27:57 vdsm-fake journal: id:d101be23-5fa8-4ce3-8fac-7949efdb5fbb
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,076 Message SEND
May  6 15:27:57 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:27:57 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:27:57 vdsm-fake journal: content-length:105
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getCapabilities","params":{},"id":"ef5c6197-ec90-4459-a284-49001b18c2db"} 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,077 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,089 JsonRpcServer$MessageHandler Request is Host.getCapabilities got response {"jsonrpc":"2.0","result":{"HBAInventory":{"iSCSI":[{"InitiatorName":"iqn.1994-05.com.example:ef52ec17bb0"}],"FC":[]},"vlans":{},"lastClientIface":"ovirtmgmt","cpuSpeed":"1200.000","autoNumaBalancing":"1","cpuModel":"Intel(R) Xeon(R) CPU E5606 @ 2.13GHz","reservedMem":"321","numaNodes":{"0":{"totalMemory":3988,"cpus":[1,3,5,7,9,11,13,15]},"1":{"totalMemory":3988,"cpus":[0,2,4,6,8,10,12,14]}},"selinux":{"mode":"1"},"packages2":{"qemu-kvm":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"libvirt":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"spice-server":{"release":"5.fc17","buildtime":"1336983054","version":"0.10.1"},"qemu-img":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"kernel":{"release":"5.fc17.x86_64","buildtime":"1357699251.0","version":"3.6.11"},"mom":{"release":"1.fc17","buildtime":"1354824066","version":"0.3.0"},"vdsm":{"release":"0.141.gita11e8f2.fc17","buildtime":"1359653302","version":"4.10.3"}},"networks":{"ovirtmgmt":{"iface":"ovirtmgmt","cfg":{"BOOTPROTO":"dhcp","DEVICE":"ovirtmgmt","ONBOOT":"yes","DELAY":"0","TYPE":"Ethernet"},"netmask":"255.255.252.0","bridged":true,"addr":"146.11.117.90","ports":["em1"],"stp":"off","gateway":"10.34.63.254","mtu":"1500","switch":"legacy"}},"uuid":"840d548e-03d3-4425-bb69-fe6b5886929a_80:A9:FE:B3:73:B0:E9","operatingSystem":{"release":"1","name":"Fedora","version":"17"},"management_ip":"","nics":{"em1":{"hwaddr":"53:5F:BD:FB:5F:78","cfg":{"BOOTPROTO":"dhcp","HWADDR":"53:5F:BD:FB:5F:78","DEVICE":"em1","ONBOOT":"yes","BRIDGE":"ovirtmgmt","UUID":"eb19ec8d-1ab7-455e-934e-097a6b198ecf","NETBOOT":"yes","TYPE":"Ethernet","NM_CONTROLLED":"yes","NAME":"Boot Disk"},"netmask":"","addr":"","speed":1000,"mtu":"1500"},"em2":{"hwaddr":"DB:F2:C8:76:DE:81","cfg":{"BOOTPROTO":"dhcp","HWADDR":"DB:F2:C8:76:DE:81","DEVICE":"em2","ONBOOT":"no","BRIDGE":"ovirtmgmt","UUID":"afd4d997-3e24-4e64-92cc-6306a8427d77","NETBOOT":"yes","TYPE":"Ethernet","NM_CONTROLLED":"yes"},"netmask":"","addr":"","speed":1000,"mtu":"1500"}},"kvmEnabled":"true","lastClient":"10.36.6.76","software_version":"4.10","cpuThreads":"4","hooks":{},"numaNodeDistance":{"0":[10,20],"1":[20,10]},"netConfigDirty":"False","guestOverhead":"65","ISCSIInitiatorName":"iqn.1994-05.com.example:ef52ec17bb0","rngSources":["RANDOM"],"bridges":{"ovirtmgmt":{"netmask":"255.255.252.0","cfg":{"BOOTPROTO":"dhcp","DEVICE":"ovirtmgmt","ONBOOT":"yes","DELAY":"0","TYPE":"Ethernet"},"addr":"146.11.117.90","ports":["em1"],"stp":"off","gateway":"96.127.51.142","mtu":"1500"}},"kdumpStatus":"1","cpuSockets":"1","supportedProtocols":["2.2","2.3"],"emulatedMachines":["pc-0.10","pc-0.11","pc-0.12","pc-0.13","pc-0.14","pc-0.15","pc-1.0","pc-1.0","pc-i440fx-2.1","pseries-rhel7.2.0","pc-i440fx-rhel7.2.0","rhel6.4.0","rhel6.5.0","rhel6.6.0","rhel6.7.0","rhel6.8.0","rhel6.9.0","rhel7.0.0","rhel7.2.0","rhel7.5.0","pc","isapc"],"onlineCpus":[1,3,5,7,9,11,13,15,0,2,4,6,8,10,12,14],"software_revision":"0.141","version_name":"Snow Man","supportedENGINEs":["3.0","3.1","3.2","3.3","3.4","3.5","3.6","4.0","4.1"],"vmTypes":["kvm"],"cpuCores":"4","bondings":{"bond0":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond2":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond1":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond4":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond3":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"}},"cpuFlags":"fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,mmx,fxsr,sse,sse2,ss,syscall,nx,pdpe1gb,rdtscp,lm,constant_tsc,rep_good,nopl,eagerfpu,pni,pclmulqdq,vmx,ssse3,fma,cx16,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,hypervisor,lahf_lm,abm,tpr_shadow,vnmi,flexpriority,ept,fsgsbase,bmi1,avx2,smep,bmi2,erms,invpcid,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_Penryn,model_Westmere,model_SandyBridge","memSize":"7976","clusterLevels":["3.0","3.1","3.2","3.3","3.4","3.5","3.6","4.0","4.1"]},"id":"ef5c6197-ec90-4459-a284-49001b18c2db"}
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,090 Message MESSAGE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:57 vdsm-fake journal: content-length:4222
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: {"jsonrpc":"2.0","result":{"HBAInventory":{"iSCSI":[{"InitiatorName":"iqn.1994-05.com.example:ef52ec17bb0"}],"FC":[]},"vlans":{},"lastClientIface":"ovirtmgmt","cpuSpeed":"1200.000","autoNumaBalancing":"1","cpuModel":"Intel(R) Xeon(R) CPU E5606 @ 2.13GHz","reservedMem":"321","numaNodes":{"0":{"totalMemory":3988,"cpus":[1,3,5,7,9,11,13,15]},"1":{"totalMemory":3988,"cpus":[0,2,4,6,8,10,12,14]}},"selinux":{"mode":"1"},"packages2":{"qemu-kvm":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"libvirt":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"spice-server":{"release":"5.fc17","buildtime":"1336983054","version":"0.10.1"},"qemu-img":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"kernel":{"release":"5.fc17.x86_64","buildtime":"1357699251.0","version":"3.6.11"},"mom":{"release":"1.fc17","buildtime":"1354824066","version":"0.3.0"},"vdsm":{"release":"0.141.gita11e8f2.fc17","buildtime":"1359653302","version":"4.10.3"}},"networks":{"ovirtmgmt":{"iface":"ovirtmgmt","cfg":{"BOOTPROTO":"dhcp","DEVICE":"ovirtmgmt","ONBOOT":"yes","DELAY":"0","TYPE":"Ethernet"},"netmask":"255.255.252.0","bridged":true,"addr":"146.11.117.90","ports":["em1"],"stp":"off","gateway":"10.34.63.254","mtu":"1500","switch":"legacy"}},"uuid":"840d548e-03d3-4425-bb69-fe6b5886929a_80:A9:FE:B3:73:B0:E9","operatingSystem":{"release":"1","name":"Fedora","version":"17"},"management_ip":"","nics":{"em1":{"hwaddr":"53:5F:BD:FB:5F:78","cfg":{"BOOTPROTO":"dhcp","HWADDR":"53:5F:BD:FB:5F:78","DEVICE":"em1","ONBOOT":"yes","BRIDGE":"ovirtmgmt","UUID":"eb19ec8d-1ab7-455e-934e-097a6b198ecf","NETBOOT":"yes","TYPE":"Ethernet","NM_CONTROLLED":"yes","NAME":"Boot Disk"},"netmask":"","addr":"","speed":1000,"mtu":"1500"},"em2":{"hwaddr":"DB:F2:C8:76:DE:81","cfg":{"BOOTPROTO":"dhcp","HWADDR":"DB:F2:C8:76:DE:81","DEVICE":"em2","ONBOOT":"no","BRIDGE":"ovirtmgmt","UUID":"afd4d997-3e24-4e64-92cc-6306a8427d77","NETBOOT":"yes","TYPE":"Ethernet","NM_CONTROLLED":"yes"},"netmask":"","addr":"","speed":1000,"mtu":"1500"}},"kvmEnabled":"true","lastClient":"10.36.6.76","software_version":"4.10","cpuThreads":"4","hooks":{},"numaNodeDistance":{"0":[10,20],"1":[20,10]},"netConfigDirty":"False","guestOverhead":"65","ISCSIInitiatorName":"iqn.1994-05.com.example:ef52ec17bb0","rngSources":["RANDOM"],"bridges":{"ovirtmgmt":{"netmask":"255.255.252.0","cfg":{"BOOTPROTO":"dhcp","DEVICE":"ovirtmgmt","ONBOOT":"yes","DELAY":"0","TYPE":"Ethernet"},"addr":"146.11.117.90","ports":["em1"],"stp":"off","gateway":"96.127.51.142","mtu":"1500"}},"kdumpStatus":"1","cpuSockets":"1","supportedProtocols":["2.2","2.3"],"emulatedMachines":["pc-0.10","pc-0.11","pc-0.12","pc-0.13","pc-0.14","pc-0.15","pc-1.0","pc-1.0","pc-i440fx-2.1","pseries-rhel7.2.0","pc-i440fx-rhel7.2.0","rhel6.4.0","rhel6.5.0","rhel6.6.0","rhel6.7.0","rhel6.8.0","rhel6.9.0","rhel7.0.0","rhel7.2.0","rhel7.5.0","pc","isapc"],"onlineCpus":[1,3,5,7,9,11,13,15,0,2,4,6,8,10,12,14],"software_revision":"0.141","version_name":"Snow Man","supportedENGINEs":["3.0","3.1","3.2","3.3","3.4","3.5","3.6","4.0","4.1"],"vmTypes":["kvm"],"cpuCores":"4","bondings":{"bond0":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond2":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond1":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond4":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond3":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"}},"cpuFlags":"fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,mmx,fxsr,sse,sse2,ss,syscall,nx,pdpe1gb,rdtscp,lm,constant_tsc,rep_good,nopl,eagerfpu,pni,pclmulqdq,vmx,ssse3,fma,cx16,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,hypervisor,lahf_lm,abm,tpr_shadow,vnmi,flexpriority,ept,fsgsbase,bmi1,avx2,smep,bmi2,erms,invpcid,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_Penryn,model_Westmere,model_SandyBridge","memSize":"7976","clusterLevels":["3.0","3.1","3.2","3.3","3.4","3.5","3.6","4.0","4.1"]},"id":"ef5c6197-ec90-4459-a284-49001b18c2db"} 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,091 StompCommonClient Message sent: MESSAGE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:57 vdsm-fake journal: content-length:4222
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: <JsonRpcResponse id: "ef5c6197-ec90-4459-a284-49001b18c2db" result: {HBAInventory={iSCSI=[{InitiatorName=iqn.1994-05.com.example:ef52ec17bb0}], FC=[]}, vlans={}, lastClientIface=ovirtmgmt, cpuSpeed=1200.000, autoNumaBalancing=1, cpuModel=Intel(R) Xeon(R) CPU E5606 @ 2.13GHz, reservedMem=321, numaNodes={0={totalMemory=3988, cpus=[1, 3, 5, 7, 9, 11, 13, 15]}, 1={totalMemory=3988, cpus=[0, 2, 4, 6, 8, 10, 12, 14]}}, selinux={mode=1}, packages2={qemu-kvm={release=2.fc17, buildtime=1349642820, version=1.0.1}, libvirt={release=2.fc17, buildtime=1349642820, version=1.0.1}, spice-server={release=5.fc17, buildtime=1336983054, version=0.10.1}, qemu-img={release=2.fc17, buildtime=1349642820, version=1.0.1}, kernel={release=5.fc17.x86_64, buildtime=1357699251.0, version=3.6.11}, mom={release=1.fc17, buildtime=1354824066, version=0.3.0}, vdsm={release=0.141.gita11e8f2.fc17, buildtime=1359653302, version=4.10.3}}, networks={ovirtmgmt={iface=ovirtmgmt, cfg={BOOTPROTO=dhcp, DEVICE=ovirtmgmt, ONBOOT=yes, DELAY=0, TYPE=Ethernet}, netmask=255.255.252.0, bridged=true, addr=146.11.117.90, ports=[em1], stp=off, gateway=10.34.63.254, mtu=1500, switch=legacy}}, uuid=840d548e-03d3-4425-bb69-fe6b5886929a_80:A9:FE:B3:73:B0:E9, operatingSystem={release=1, name=Fedora, version=17}, management_ip=, nics={em1={hwaddr=53:5F:BD:FB:5F:78, cfg={BOOTPROTO=dhcp, HWADDR=53:5F:BD:FB:5F:78, DEVICE=em1, ONBOOT=yes, BRIDGE=ovirtmgmt, UUID=eb19ec8d-1ab7-455e-934e-097a6b198ecf, NETBOOT=yes, TYPE=Ethernet, NM_CONTROLLED=yes, NAME=Boot Disk}, netmask=, addr=, speed=1000, mtu=1500}, em2={hwaddr=DB:F2:C8:76:DE:81, cfg={BOOTPROTO=dhcp, HWADDR=DB:F2:C8:76:DE:81, DEVICE=em2, ONBOOT=no, BRIDGE=ovirtmgmt, UUID=afd4d997-3e24-4e64-92cc-6306a8427d77, NETBOOT=yes, TYPE=Ethernet, NM_CONTROLLED=yes}, netmask=, addr=, speed=1000, mtu=1500}}, kvmEnabled=true, lastClient=10.36.6.76, software_version=4.10, cpuThreads=4, hooks={}, numaNodeDistance={0=[10, 20], 1=[20, 10]}, netConfigDirty=False, guestOverhead=65, ISCSIInitiatorName=iqn.1994-05.com.example:ef52ec17bb0, rngSources=[RANDOM], bridges={ovirtmgmt={netmask=255.255.252.0, cfg={BOOTPROTO=dhcp, DEVICE=ovirtmgmt, ONBOOT=yes, DELAY=0, TYPE=Ethernet}, addr=146.11.117.90, ports=[em1], stp=off, gateway=96.127.51.142, mtu=1500}}, kdumpStatus=1, cpuSockets=1, supportedProtocols=[2.2, 2.3], emulatedMachines=[pc-0.10, pc-0.11, pc-0.12, pc-0.13, pc-0.14, pc-0.15, pc-1.0, pc-1.0, pc-i440fx-2.1, pseries-rhel7.2.0, pc-i440fx-rhel7.2.0, rhel6.4.0, rhel6.5.0, rhel6.6.0, rhel6.7.0, rhel6.8.0, rhel6.9.0, rhel7.0.0, rhel7.2.0, rhel7.5.0, pc, isapc], onlineCpus=[1, 3, 5, 7, 9, 11, 13, 15, 0, 2, 4, 6, 8, 10, 12, 14], software_revision=0.141, version_name=Snow Man, supportedENGINEs=[3.0, 3.1, 3.2, 3.3, 3.4, 3.5, 3.6, 4.0, 4.1], vmTypes=[kvm], cpuCores=4, bondings={bond0={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}, bond2={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}, bond1={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}, bond4={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}, bond3={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}}, cpuFlags=fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,mmx,fxsr,sse,sse2,ss,syscall,nx,pdpe1gb,rdtscp,lm,constant_tsc,rep_good,nopl,eagerfpu,pni,pclmulqdq,vmx,ssse3,fma,cx16,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,hypervisor,lahf_lm,abm,tpr_shadow,vnmi,flexpriority,ept,fsgsbase,bmi1,avx2,smep,bmi2,erms,invpcid,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_Penryn,model_Westmere,model_SandyBridge, memSize=7976, clusterLevels=[3.0, 3.1, 3.2, 3.3, 3.4, 3.5, 3.6, 4.0, 4.1]}>
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,138 Message SEND
May  6 15:27:57 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:27:57 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:27:57 vdsm-fake journal: content-length:105
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getHardwareInfo","params":{},"id":"809d902a-a461-409f-9f4c-f58ccfadfe97"} 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,139 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,140 JsonRpcServer$MessageHandler Request is Host.getHardwareInfo got response {"jsonrpc":"2.0","result":{"systemFamily":"","systemSerialNumber":"CZJ2320M6N","systemProductName":"ProLiant DL160 G6","systemManufacturer":"HP","systemUUID":"840d548e-03d3-4425-bb69-fe6b5886929a","systemVersion":""},"id":"809d902a-a461-409f-9f4c-f58ccfadfe97"}
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,140 Message MESSAGE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:57 vdsm-fake journal: content-length:261
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: {"jsonrpc":"2.0","result":{"systemFamily":"","systemSerialNumber":"CZJ2320M6N","systemProductName":"ProLiant DL160 G6","systemManufacturer":"HP","systemUUID":"840d548e-03d3-4425-bb69-fe6b5886929a","systemVersion":""},"id":"809d902a-a461-409f-9f4c-f58ccfadfe97"} 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,140 StompCommonClient Message sent: MESSAGE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:57 vdsm-fake journal: content-length:261
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: <JsonRpcResponse id: "809d902a-a461-409f-9f4c-f58ccfadfe97" result: {systemFamily=, systemSerialNumber=CZJ2320M6N, systemProductName=ProLiant DL160 G6, systemManufacturer=HP, systemUUID=840d548e-03d3-4425-bb69-fe6b5886929a, systemVersion=}>
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,281 Message SEND
May  6 15:27:57 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:27:57 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:27:57 vdsm-fake journal: content-length:105
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getCapabilities","params":{},"id":"c974c4bb-ad2f-4056-81a2-a4ee53bf81a3"} 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,282 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,283 JsonRpcServer$MessageHandler Request is Host.getCapabilities got response {"jsonrpc":"2.0","result":{"HBAInventory":{"iSCSI":[{"InitiatorName":"iqn.1994-05.com.example:ef52ec17bb0"}],"FC":[]},"vlans":{},"lastClientIface":"ovirtmgmt","cpuSpeed":"1200.000","autoNumaBalancing":"1","cpuModel":"Intel(R) Xeon(R) CPU E5606 @ 2.13GHz","reservedMem":"321","numaNodes":{"0":{"totalMemory":3988,"cpus":[1,3,5,7,9,11,13,15]},"1":{"totalMemory":3988,"cpus":[0,2,4,6,8,10,12,14]}},"selinux":{"mode":"1"},"packages2":{"qemu-kvm":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"libvirt":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"spice-server":{"release":"5.fc17","buildtime":"1336983054","version":"0.10.1"},"qemu-img":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"kernel":{"release":"5.fc17.x86_64","buildtime":"1357699251.0","version":"3.6.11"},"mom":{"release":"1.fc17","buildtime":"1354824066","version":"0.3.0"},"vdsm":{"release":"0.141.gita11e8f2.fc17","buildtime":"1359653302","version":"4.10.3"}},"networks":{"ovirtmgmt":{"iface":"ovirtmgmt","cfg":{"BOOTPROTO":"dhcp","DEVICE":"ovirtmgmt","ONBOOT":"yes","DELAY":"0","TYPE":"Ethernet"},"netmask":"255.255.252.0","bridged":true,"addr":"146.11.117.90","ports":["em1"],"stp":"off","gateway":"10.34.63.254","mtu":"1500","switch":"legacy"}},"uuid":"840d548e-03d3-4425-bb69-fe6b5886929a_80:A9:FE:B3:73:B0:E9","operatingSystem":{"release":"1","name":"Fedora","version":"17"},"management_ip":"","nics":{"em1":{"hwaddr":"53:5F:BD:FB:5F:78","cfg":{"BOOTPROTO":"dhcp","HWADDR":"53:5F:BD:FB:5F:78","DEVICE":"em1","ONBOOT":"yes","BRIDGE":"ovirtmgmt","UUID":"eb19ec8d-1ab7-455e-934e-097a6b198ecf","NETBOOT":"yes","TYPE":"Ethernet","NM_CONTROLLED":"yes","NAME":"Boot Disk"},"netmask":"","addr":"","speed":1000,"mtu":"1500"},"em2":{"hwaddr":"DB:F2:C8:76:DE:81","cfg":{"BOOTPROTO":"dhcp","HWADDR":"DB:F2:C8:76:DE:81","DEVICE":"em2","ONBOOT":"no","BRIDGE":"ovirtmgmt","UUID":"afd4d997-3e24-4e64-92cc-6306a8427d77","NETBOOT":"yes","TYPE":"Ethernet","NM_CONTROLLED":"yes"},"netmask":"","addr":"","speed":1000,"mtu":"1500"}},"kvmEnabled":"true","lastClient":"10.36.6.76","software_version":"4.10","cpuThreads":"4","hooks":{},"numaNodeDistance":{"0":[10,20],"1":[20,10]},"netConfigDirty":"False","guestOverhead":"65","ISCSIInitiatorName":"iqn.1994-05.com.example:ef52ec17bb0","rngSources":["RANDOM"],"bridges":{"ovirtmgmt":{"netmask":"255.255.252.0","cfg":{"BOOTPROTO":"dhcp","DEVICE":"ovirtmgmt","ONBOOT":"yes","DELAY":"0","TYPE":"Ethernet"},"addr":"146.11.117.90","ports":["em1"],"stp":"off","gateway":"96.127.51.142","mtu":"1500"}},"kdumpStatus":"1","cpuSockets":"1","supportedProtocols":["2.2","2.3"],"emulatedMachines":["pc-0.10","pc-0.11","pc-0.12","pc-0.13","pc-0.14","pc-0.15","pc-1.0","pc-1.0","pc-i440fx-2.1","pseries-rhel7.2.0","pc-i440fx-rhel7.2.0","rhel6.4.0","rhel6.5.0","rhel6.6.0","rhel6.7.0","rhel6.8.0","rhel6.9.0","rhel7.0.0","rhel7.2.0","rhel7.5.0","pc","isapc"],"onlineCpus":[1,3,5,7,9,11,13,15,0,2,4,6,8,10,12,14],"software_revision":"0.141","version_name":"Snow Man","supportedENGINEs":["3.0","3.1","3.2","3.3","3.4","3.5","3.6","4.0","4.1"],"vmTypes":["kvm"],"cpuCores":"4","bondings":{"bond0":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond2":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond1":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond4":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond3":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"}},"cpuFlags":"fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,mmx,fxsr,sse,sse2,ss,syscall,nx,pdpe1gb,rdtscp,lm,constant_tsc,rep_good,nopl,eagerfpu,pni,pclmulqdq,vmx,ssse3,fma,cx16,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,hypervisor,lahf_lm,abm,tpr_shadow,vnmi,flexpriority,ept,fsgsbase,bmi1,avx2,smep,bmi2,erms,invpcid,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_Penryn,model_Westmere,model_SandyBridge","memSize":"7976","clusterLevels":["3.0","3.1","3.2","3.3","3.4","3.5","3.6","4.0","4.1"]},"id":"c974c4bb-ad2f-4056-81a2-a4ee53bf81a3"}
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,283 Message MESSAGE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:57 vdsm-fake journal: content-length:4222
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: {"jsonrpc":"2.0","result":{"HBAInventory":{"iSCSI":[{"InitiatorName":"iqn.1994-05.com.example:ef52ec17bb0"}],"FC":[]},"vlans":{},"lastClientIface":"ovirtmgmt","cpuSpeed":"1200.000","autoNumaBalancing":"1","cpuModel":"Intel(R) Xeon(R) CPU E5606 @ 2.13GHz","reservedMem":"321","numaNodes":{"0":{"totalMemory":3988,"cpus":[1,3,5,7,9,11,13,15]},"1":{"totalMemory":3988,"cpus":[0,2,4,6,8,10,12,14]}},"selinux":{"mode":"1"},"packages2":{"qemu-kvm":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"libvirt":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"spice-server":{"release":"5.fc17","buildtime":"1336983054","version":"0.10.1"},"qemu-img":{"release":"2.fc17","buildtime":"1349642820","version":"1.0.1"},"kernel":{"release":"5.fc17.x86_64","buildtime":"1357699251.0","version":"3.6.11"},"mom":{"release":"1.fc17","buildtime":"1354824066","version":"0.3.0"},"vdsm":{"release":"0.141.gita11e8f2.fc17","buildtime":"1359653302","version":"4.10.3"}},"networks":{"ovirtmgmt":{"iface":"ovirtmgmt","cfg":{"BOOTPROTO":"dhcp","DEVICE":"ovirtmgmt","ONBOOT":"yes","DELAY":"0","TYPE":"Ethernet"},"netmask":"255.255.252.0","bridged":true,"addr":"146.11.117.90","ports":["em1"],"stp":"off","gateway":"10.34.63.254","mtu":"1500","switch":"legacy"}},"uuid":"840d548e-03d3-4425-bb69-fe6b5886929a_80:A9:FE:B3:73:B0:E9","operatingSystem":{"release":"1","name":"Fedora","version":"17"},"management_ip":"","nics":{"em1":{"hwaddr":"53:5F:BD:FB:5F:78","cfg":{"BOOTPROTO":"dhcp","HWADDR":"53:5F:BD:FB:5F:78","DEVICE":"em1","ONBOOT":"yes","BRIDGE":"ovirtmgmt","UUID":"eb19ec8d-1ab7-455e-934e-097a6b198ecf","NETBOOT":"yes","TYPE":"Ethernet","NM_CONTROLLED":"yes","NAME":"Boot Disk"},"netmask":"","addr":"","speed":1000,"mtu":"1500"},"em2":{"hwaddr":"DB:F2:C8:76:DE:81","cfg":{"BOOTPROTO":"dhcp","HWADDR":"DB:F2:C8:76:DE:81","DEVICE":"em2","ONBOOT":"no","BRIDGE":"ovirtmgmt","UUID":"afd4d997-3e24-4e64-92cc-6306a8427d77","NETBOOT":"yes","TYPE":"Ethernet","NM_CONTROLLED":"yes"},"netmask":"","addr":"","speed":1000,"mtu":"1500"}},"kvmEnabled":"true","lastClient":"10.36.6.76","software_version":"4.10","cpuThreads":"4","hooks":{},"numaNodeDistance":{"0":[10,20],"1":[20,10]},"netConfigDirty":"False","guestOverhead":"65","ISCSIInitiatorName":"iqn.1994-05.com.example:ef52ec17bb0","rngSources":["RANDOM"],"bridges":{"ovirtmgmt":{"netmask":"255.255.252.0","cfg":{"BOOTPROTO":"dhcp","DEVICE":"ovirtmgmt","ONBOOT":"yes","DELAY":"0","TYPE":"Ethernet"},"addr":"146.11.117.90","ports":["em1"],"stp":"off","gateway":"96.127.51.142","mtu":"1500"}},"kdumpStatus":"1","cpuSockets":"1","supportedProtocols":["2.2","2.3"],"emulatedMachines":["pc-0.10","pc-0.11","pc-0.12","pc-0.13","pc-0.14","pc-0.15","pc-1.0","pc-1.0","pc-i440fx-2.1","pseries-rhel7.2.0","pc-i440fx-rhel7.2.0","rhel6.4.0","rhel6.5.0","rhel6.6.0","rhel6.7.0","rhel6.8.0","rhel6.9.0","rhel7.0.0","rhel7.2.0","rhel7.5.0","pc","isapc"],"onlineCpus":[1,3,5,7,9,11,13,15,0,2,4,6,8,10,12,14],"software_revision":"0.141","version_name":"Snow Man","supportedENGINEs":["3.0","3.1","3.2","3.3","3.4","3.5","3.6","4.0","4.1"],"vmTypes":["kvm"],"cpuCores":"4","bondings":{"bond0":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond2":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond1":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond4":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"},"bond3":{"slaves":[],"hwaddr":"00:00:00:00:00:00","cfg":{},"netmask":"","addr":"","mtu":"150"}},"cpuFlags":"fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,mmx,fxsr,sse,sse2,ss,syscall,nx,pdpe1gb,rdtscp,lm,constant_tsc,rep_good,nopl,eagerfpu,pni,pclmulqdq,vmx,ssse3,fma,cx16,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,hypervisor,lahf_lm,abm,tpr_shadow,vnmi,flexpriority,ept,fsgsbase,bmi1,avx2,smep,bmi2,erms,invpcid,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_Penryn,model_Westmere,model_SandyBridge","memSize":"7976","clusterLevels":["3.0","3.1","3.2","3.3","3.4","3.5","3.6","4.0","4.1"]},"id":"c974c4bb-ad2f-4056-81a2-a4ee53bf81a3"} 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,287 StompCommonClient Message sent: MESSAGE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:57 vdsm-fake journal: content-length:4222
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: <JsonRpcResponse id: "c974c4bb-ad2f-4056-81a2-a4ee53bf81a3" result: {HBAInventory={iSCSI=[{InitiatorName=iqn.1994-05.com.example:ef52ec17bb0}], FC=[]}, vlans={}, lastClientIface=ovirtmgmt, cpuSpeed=1200.000, autoNumaBalancing=1, cpuModel=Intel(R) Xeon(R) CPU E5606 @ 2.13GHz, reservedMem=321, numaNodes={0={totalMemory=3988, cpus=[1, 3, 5, 7, 9, 11, 13, 15]}, 1={totalMemory=3988, cpus=[0, 2, 4, 6, 8, 10, 12, 14]}}, selinux={mode=1}, packages2={qemu-kvm={release=2.fc17, buildtime=1349642820, version=1.0.1}, libvirt={release=2.fc17, buildtime=1349642820, version=1.0.1}, spice-server={release=5.fc17, buildtime=1336983054, version=0.10.1}, qemu-img={release=2.fc17, buildtime=1349642820, version=1.0.1}, kernel={release=5.fc17.x86_64, buildtime=1357699251.0, version=3.6.11}, mom={release=1.fc17, buildtime=1354824066, version=0.3.0}, vdsm={release=0.141.gita11e8f2.fc17, buildtime=1359653302, version=4.10.3}}, networks={ovirtmgmt={iface=ovirtmgmt, cfg={BOOTPROTO=dhcp, DEVICE=ovirtmgmt, ONBOOT=yes, DELAY=0, TYPE=Ethernet}, netmask=255.255.252.0, bridged=true, addr=146.11.117.90, ports=[em1], stp=off, gateway=10.34.63.254, mtu=1500, switch=legacy}}, uuid=840d548e-03d3-4425-bb69-fe6b5886929a_80:A9:FE:B3:73:B0:E9, operatingSystem={release=1, name=Fedora, version=17}, management_ip=, nics={em1={hwaddr=53:5F:BD:FB:5F:78, cfg={BOOTPROTO=dhcp, HWADDR=53:5F:BD:FB:5F:78, DEVICE=em1, ONBOOT=yes, BRIDGE=ovirtmgmt, UUID=eb19ec8d-1ab7-455e-934e-097a6b198ecf, NETBOOT=yes, TYPE=Ethernet, NM_CONTROLLED=yes, NAME=Boot Disk}, netmask=, addr=, speed=1000, mtu=1500}, em2={hwaddr=DB:F2:C8:76:DE:81, cfg={BOOTPROTO=dhcp, HWADDR=DB:F2:C8:76:DE:81, DEVICE=em2, ONBOOT=no, BRIDGE=ovirtmgmt, UUID=afd4d997-3e24-4e64-92cc-6306a8427d77, NETBOOT=yes, TYPE=Ethernet, NM_CONTROLLED=yes}, netmask=, addr=, speed=1000, mtu=1500}}, kvmEnabled=true, lastClient=10.36.6.76, software_version=4.10, cpuThreads=4, hooks={}, numaNodeDistance={0=[10, 20], 1=[20, 10]}, netConfigDirty=False, guestOverhead=65, ISCSIInitiatorName=iqn.1994-05.com.example:ef52ec17bb0, rngSources=[RANDOM], bridges={ovirtmgmt={netmask=255.255.252.0, cfg={BOOTPROTO=dhcp, DEVICE=ovirtmgmt, ONBOOT=yes, DELAY=0, TYPE=Ethernet}, addr=146.11.117.90, ports=[em1], stp=off, gateway=96.127.51.142, mtu=1500}}, kdumpStatus=1, cpuSockets=1, supportedProtocols=[2.2, 2.3], emulatedMachines=[pc-0.10, pc-0.11, pc-0.12, pc-0.13, pc-0.14, pc-0.15, pc-1.0, pc-1.0, pc-i440fx-2.1, pseries-rhel7.2.0, pc-i440fx-rhel7.2.0, rhel6.4.0, rhel6.5.0, rhel6.6.0, rhel6.7.0, rhel6.8.0, rhel6.9.0, rhel7.0.0, rhel7.2.0, rhel7.5.0, pc, isapc], onlineCpus=[1, 3, 5, 7, 9, 11, 13, 15, 0, 2, 4, 6, 8, 10, 12, 14], software_revision=0.141, version_name=Snow Man, supportedENGINEs=[3.0, 3.1, 3.2, 3.3, 3.4, 3.5, 3.6, 4.0, 4.1], vmTypes=[kvm], cpuCores=4, bondings={bond0={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}, bond2={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}, bond1={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}, bond4={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}, bond3={slaves=[], hwaddr=00:00:00:00:00:00, cfg={}, netmask=, addr=, mtu=150}}, cpuFlags=fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,mmx,fxsr,sse,sse2,ss,syscall,nx,pdpe1gb,rdtscp,lm,constant_tsc,rep_good,nopl,eagerfpu,pni,pclmulqdq,vmx,ssse3,fma,cx16,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,hypervisor,lahf_lm,abm,tpr_shadow,vnmi,flexpriority,ept,fsgsbase,bmi1,avx2,smep,bmi2,erms,invpcid,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_Penryn,model_Westmere,model_SandyBridge, memSize=7976, clusterLevels=[3.0, 3.1, 3.2, 3.3, 3.4, 3.5, 3.6, 4.0, 4.1]}>
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,315 Message SEND
May  6 15:27:57 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:27:57 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:27:57 vdsm-fake journal: content-length:105
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getHardwareInfo","params":{},"id":"788f5039-0a75-4854-bdf0-ae7b8b59b253"} 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,316 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,316 JsonRpcServer$MessageHandler Request is Host.getHardwareInfo got response {"jsonrpc":"2.0","result":{"systemFamily":"","systemSerialNumber":"CZJ2320M6N","systemProductName":"ProLiant DL160 G6","systemManufacturer":"HP","systemUUID":"840d548e-03d3-4425-bb69-fe6b5886929a","systemVersion":""},"id":"788f5039-0a75-4854-bdf0-ae7b8b59b253"}
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,317 Message MESSAGE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:57 vdsm-fake journal: content-length:261
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: {"jsonrpc":"2.0","result":{"systemFamily":"","systemSerialNumber":"CZJ2320M6N","systemProductName":"ProLiant DL160 G6","systemManufacturer":"HP","systemUUID":"840d548e-03d3-4425-bb69-fe6b5886929a","systemVersion":""},"id":"788f5039-0a75-4854-bdf0-ae7b8b59b253"} 
May  6 15:27:57 vdsm-fake journal: 2017-05-06 12:27:57,317 StompCommonClient Message sent: MESSAGE
May  6 15:27:57 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:57 vdsm-fake journal: content-length:261
May  6 15:27:57 vdsm-fake journal:
May  6 15:27:57 vdsm-fake journal: <JsonRpcResponse id: "788f5039-0a75-4854-bdf0-ae7b8b59b253" result: {systemFamily=, systemSerialNumber=CZJ2320M6N, systemProductName=ProLiant DL160 G6, systemManufacturer=HP, systemUUID=840d548e-03d3-4425-bb69-fe6b5886929a, systemVersion=}>
May  6 15:27:59 vdsm-fake journal: 2017-05-06 12:27:59,018 Message SEND
May  6 15:27:59 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:27:59 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:27:59 vdsm-fake journal: content-length:103
May  6 15:27:59 vdsm-fake journal:
May  6 15:27:59 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getAllVmStats","params":{},"id":"352f24a8-7215-433d-b3cb-e68ab63cdf64"} 
May  6 15:27:59 vdsm-fake journal: 2017-05-06 12:27:59,019 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:27:59 vdsm-fake journal: 2017-05-06 12:27:59,021 JsonRpcServer$MessageHandler Request is Host.getAllVmStats got response {"jsonrpc":"2.0","result":[],"id":"352f24a8-7215-433d-b3cb-e68ab63cdf64"}
May  6 15:27:59 vdsm-fake journal: 2017-05-06 12:27:59,021 Message MESSAGE
May  6 15:27:59 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:59 vdsm-fake journal: content-length:73
May  6 15:27:59 vdsm-fake journal:
May  6 15:27:59 vdsm-fake journal: {"jsonrpc":"2.0","result":[],"id":"352f24a8-7215-433d-b3cb-e68ab63cdf64"} 
May  6 15:27:59 vdsm-fake journal: 2017-05-06 12:27:59,022 StompCommonClient Message sent: MESSAGE
May  6 15:27:59 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:27:59 vdsm-fake journal: content-length:73
May  6 15:27:59 vdsm-fake journal:
May  6 15:27:59 vdsm-fake journal: <JsonRpcResponse id: "352f24a8-7215-433d-b3cb-e68ab63cdf64" result: []>
May  6 15:28:12 vdsm-fake journal: 2017-05-06 12:28:12,451 Message SEND
May  6 15:28:12 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:28:12 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:28:12 vdsm-fake journal: content-length:98
May  6 15:28:12 vdsm-fake journal:
May  6 15:28:12 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getStats","params":{},"id":"5a9900a6-c5a6-4b73-8624-6390b3cb2154"} 
May  6 15:28:12 vdsm-fake journal: 2017-05-06 12:28:12,452 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:28:12 vdsm-fake journal: 2017-05-06 12:28:12,555 JsonRpcServer$MessageHandler Request is Host.getStats got response {"jsonrpc":"2.0","result":{"dateTime":"2017-05-06T12:28:12 GMT","generationID":"f554221c-bbe4-4ad1-8cdf-11eff9359359","thpState":"always","cpuSysVdsmd":"0.25","anonHugePages":"662","rxRate":"0.00","txDropped":"0","network":{"bond0":{"txErrors":"0","txRate":"11","name":"bond0","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond2":{"txErrors":"0","txRate":"10","name":"bond2","state":"up","txDropped":"0","rxRate":"13","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond1":{"txErrors":"0","txRate":"10","name":"bond1","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond4":{"txErrors":"0","txRate":"12","name":"bond4","state":"up","txDropped":"0","rxRate":"13","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em1":{"txErrors":"0","txRate":"12","name":"em1","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond3":{"txErrors":"0","txRate":"12","name":"bond3","state":"up","txDropped":"0","rxRate":"14","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em2":{"txErrors":"0","txRate":"10","name":"em2","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"}},"memShared":0,"cpuLoad":"13","cpuUser":"10","memCommitted":0,"cpuSys":"18","vmCount":0,"rxDropped":"14965","ksmState":false,"ksmPages":100,"swapFree":20031,"memAvailable":6435,"momStatus":"active","netConfigDirty":"False","memFree":"0","diskStats":{"/var/log/core":{"free":"44231"},"/var/log":{"free":"44231"},"/var/run/vdsm/":{"free":"3978"},"/tmp":{"free":"44231"}},"storageDomains":{},"vmMigrating":0,"cpuIdle":"90","swapTotal":20031,"cpuUserVdsmd":"0.50","numaNodeMemFree":{"0":{"memFree":0,"memPercent":"8"},"1":{"memFree":0,"memPercent":"8"}},"txRate":"","statsAge":"0.43","memUsed":"8","vmActive":0,"ksmCpu":0,"elapsedTime":"1494073692"},"id":"5a9900a6-c5a6-4b73-8624-6390b3cb2154"}
May  6 15:28:12 vdsm-fake journal: 2017-05-06 12:28:12,556 Message MESSAGE
May  6 15:28:12 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:12 vdsm-fake journal: content-length:2040
May  6 15:28:12 vdsm-fake journal:
May  6 15:28:12 vdsm-fake journal: {"jsonrpc":"2.0","result":{"dateTime":"2017-05-06T12:28:12 GMT","generationID":"f554221c-bbe4-4ad1-8cdf-11eff9359359","thpState":"always","cpuSysVdsmd":"0.25","anonHugePages":"662","rxRate":"0.00","txDropped":"0","network":{"bond0":{"txErrors":"0","txRate":"11","name":"bond0","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond2":{"txErrors":"0","txRate":"10","name":"bond2","state":"up","txDropped":"0","rxRate":"13","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond1":{"txErrors":"0","txRate":"10","name":"bond1","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond4":{"txErrors":"0","txRate":"12","name":"bond4","state":"up","txDropped":"0","rxRate":"13","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em1":{"txErrors":"0","txRate":"12","name":"em1","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond3":{"txErrors":"0","txRate":"12","name":"bond3","state":"up","txDropped":"0","rxRate":"14","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em2":{"txErrors":"0","txRate":"10","name":"em2","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"}},"memShared":0,"cpuLoad":"13","cpuUser":"10","memCommitted":0,"cpuSys":"18","vmCount":0,"rxDropped":"14965","ksmState":false,"ksmPages":100,"swapFree":20031,"memAvailable":6435,"momStatus":"active","netConfigDirty":"False","memFree":"0","diskStats":{"/var/log/core":{"free":"44231"},"/var/log":{"free":"44231"},"/var/run/vdsm/":{"free":"3978"},"/tmp":{"free":"44231"}},"storageDomains":{},"vmMigrating":0,"cpuIdle":"90","swapTotal":20031,"cpuUserVdsmd":"0.50","numaNodeMemFree":{"0":{"memFree":0,"memPercent":"8"},"1":{"memFree":0,"memPercent":"8"}},"txRate":"","statsAge":"0.43","memUsed":"8","vmActive":0,"ksmCpu":0,"elapsedTime":"1494073692"},"id":"5a9900a6-c5a6-4b73-8624-6390b3cb2154"} 
May  6 15:28:12 vdsm-fake journal: 2017-05-06 12:28:12,556 StompCommonClient Message sent: MESSAGE
May  6 15:28:12 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:12 vdsm-fake journal: content-length:2040
May  6 15:28:12 vdsm-fake journal:
May  6 15:28:12 vdsm-fake journal: <JsonRpcResponse id: "5a9900a6-c5a6-4b73-8624-6390b3cb2154" result: {dateTime=2017-05-06T12:28:12 GMT, generationID=f554221c-bbe4-4ad1-8cdf-11eff9359359, thpState=always, cpuSysVdsmd=0.25, anonHugePages=662, rxRate=0.00, txDropped=0, network={bond0={txErrors=0, txRate=11, name=bond0, state=up, txDropped=0, rxRate=11, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, bond2={txErrors=0, txRate=10, name=bond2, state=up, txDropped=0, rxRate=13, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, bond1={txErrors=0, txRate=10, name=bond1, state=up, txDropped=0, rxRate=12, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, bond4={txErrors=0, txRate=12, name=bond4, state=up, txDropped=0, rxRate=13, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, em1={txErrors=0, txRate=12, name=em1, state=up, txDropped=0, rxRate=11, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, bond3={txErrors=0, txRate=12, name=bond3, state=up, txDropped=0, rxRate=14, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, em2={txErrors=0, txRate=10, name=em2, state=up, txDropped=0, rxRate=11, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}}, memShared=0, cpuLoad=13, cpuUser=10, memCommitted=0, cpuSys=18, vmCount=0, rxDropped=14965, ksmState=false, ksmPages=100, swapFree=20031, memAvailable=6435, momStatus=active, netConfigDirty=False, memFree=0, diskStats={/var/log/core={free=44231}, /var/log={free=44231}, /var/run/vdsm/={free=3978}, /tmp={free=44231}}, storageDomains={}, vmMigrating=0, cpuIdle=90, swapTotal=20031, cpuUserVdsmd=0.50, numaNodeMemFree={0={memFree=0, memPercent=8}, 1={memFree=0, memPercent=8}}, txRate=, statsAge=0.43, memUsed=8, vmActive=0, ksmCpu=0, elapsedTime=1494073692}>
May  6 15:28:14 vdsm-fake journal: 2017-05-06 12:28:14,031 Message SEND
May  6 15:28:14 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:28:14 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:28:14 vdsm-fake journal: content-length:103
May  6 15:28:14 vdsm-fake journal:
May  6 15:28:14 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getAllVmStats","params":{},"id":"7cb1262e-c06d-4126-a80a-0f42ade17f1d"} 
May  6 15:28:14 vdsm-fake journal: 2017-05-06 12:28:14,032 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:28:14 vdsm-fake journal: 2017-05-06 12:28:14,034 JsonRpcServer$MessageHandler Request is Host.getAllVmStats got response {"jsonrpc":"2.0","result":[],"id":"7cb1262e-c06d-4126-a80a-0f42ade17f1d"}
May  6 15:28:14 vdsm-fake journal: 2017-05-06 12:28:14,035 Message MESSAGE
May  6 15:28:14 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:14 vdsm-fake journal: content-length:73
May  6 15:28:14 vdsm-fake journal:
May  6 15:28:14 vdsm-fake journal: {"jsonrpc":"2.0","result":[],"id":"7cb1262e-c06d-4126-a80a-0f42ade17f1d"} 
May  6 15:28:14 vdsm-fake journal: 2017-05-06 12:28:14,036 StompCommonClient Message sent: MESSAGE
May  6 15:28:14 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:14 vdsm-fake journal: content-length:73
May  6 15:28:14 vdsm-fake journal:
May  6 15:28:14 vdsm-fake journal: <JsonRpcResponse id: "7cb1262e-c06d-4126-a80a-0f42ade17f1d" result: []>
May  6 15:28:27 vdsm-fake journal: 2017-05-06 12:28:27,641 Message SEND
May  6 15:28:27 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:28:27 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:28:27 vdsm-fake journal: content-length:98
May  6 15:28:27 vdsm-fake journal:
May  6 15:28:27 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getStats","params":{},"id":"7579860d-76d0-4686-82b5-a7d4b424365f"} 
May  6 15:28:27 vdsm-fake journal: 2017-05-06 12:28:27,642 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:28:27 vdsm-fake journal: 2017-05-06 12:28:27,744 JsonRpcServer$MessageHandler Request is Host.getStats got response {"jsonrpc":"2.0","result":{"dateTime":"2017-05-06T12:28:27 GMT","generationID":"f554221c-bbe4-4ad1-8cdf-11eff9359359","thpState":"always","cpuSysVdsmd":"0.25","anonHugePages":"662","rxRate":"0.00","txDropped":"0","network":{"bond0":{"txErrors":"0","txRate":"12","name":"bond0","state":"up","txDropped":"0","rxRate":"10","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond2":{"txErrors":"0","txRate":"10","name":"bond2","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond1":{"txErrors":"0","txRate":"11","name":"bond1","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond4":{"txErrors":"0","txRate":"11","name":"bond4","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em1":{"txErrors":"0","txRate":"11","name":"em1","state":"up","txDropped":"0","rxRate":"14","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond3":{"txErrors":"0","txRate":"11","name":"bond3","state":"up","txDropped":"0","rxRate":"13","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em2":{"txErrors":"0","txRate":"14","name":"em2","state":"up","txDropped":"0","rxRate":"10","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"}},"memShared":0,"cpuLoad":"10","cpuUser":"19","memCommitted":0,"cpuSys":"13","vmCount":0,"rxDropped":"14965","ksmState":false,"ksmPages":100,"swapFree":20031,"memAvailable":6435,"momStatus":"active","netConfigDirty":"False","memFree":"0","diskStats":{"/var/log/core":{"free":"44231"},"/var/log":{"free":"44231"},"/var/run/vdsm/":{"free":"3978"},"/tmp":{"free":"44231"}},"storageDomains":{},"vmMigrating":0,"cpuIdle":"81","swapTotal":20031,"cpuUserVdsmd":"0.50","numaNodeMemFree":{"0":{"memFree":0,"memPercent":"9"},"1":{"memFree":0,"memPercent":"9"}},"txRate":"","statsAge":"0.43","memUsed":"9","vmActive":0,"ksmCpu":0,"elapsedTime":"1494073707"},"id":"7579860d-76d0-4686-82b5-a7d4b424365f"}
May  6 15:28:27 vdsm-fake journal: 2017-05-06 12:28:27,745 Message MESSAGE
May  6 15:28:27 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:27 vdsm-fake journal: content-length:2040
May  6 15:28:27 vdsm-fake journal:
May  6 15:28:27 vdsm-fake journal: {"jsonrpc":"2.0","result":{"dateTime":"2017-05-06T12:28:27 GMT","generationID":"f554221c-bbe4-4ad1-8cdf-11eff9359359","thpState":"always","cpuSysVdsmd":"0.25","anonHugePages":"662","rxRate":"0.00","txDropped":"0","network":{"bond0":{"txErrors":"0","txRate":"12","name":"bond0","state":"up","txDropped":"0","rxRate":"10","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond2":{"txErrors":"0","txRate":"10","name":"bond2","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond1":{"txErrors":"0","txRate":"11","name":"bond1","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond4":{"txErrors":"0","txRate":"11","name":"bond4","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em1":{"txErrors":"0","txRate":"11","name":"em1","state":"up","txDropped":"0","rxRate":"14","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond3":{"txErrors":"0","txRate":"11","name":"bond3","state":"up","txDropped":"0","rxRate":"13","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em2":{"txErrors":"0","txRate":"14","name":"em2","state":"up","txDropped":"0","rxRate":"10","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"}},"memShared":0,"cpuLoad":"10","cpuUser":"19","memCommitted":0,"cpuSys":"13","vmCount":0,"rxDropped":"14965","ksmState":false,"ksmPages":100,"swapFree":20031,"memAvailable":6435,"momStatus":"active","netConfigDirty":"False","memFree":"0","diskStats":{"/var/log/core":{"free":"44231"},"/var/log":{"free":"44231"},"/var/run/vdsm/":{"free":"3978"},"/tmp":{"free":"44231"}},"storageDomains":{},"vmMigrating":0,"cpuIdle":"81","swapTotal":20031,"cpuUserVdsmd":"0.50","numaNodeMemFree":{"0":{"memFree":0,"memPercent":"9"},"1":{"memFree":0,"memPercent":"9"}},"txRate":"","statsAge":"0.43","memUsed":"9","vmActive":0,"ksmCpu":0,"elapsedTime":"1494073707"},"id":"7579860d-76d0-4686-82b5-a7d4b424365f"} 
May  6 15:28:27 vdsm-fake journal: 2017-05-06 12:28:27,746 StompCommonClient Message sent: MESSAGE
May  6 15:28:27 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:27 vdsm-fake journal: content-length:2040
May  6 15:28:27 vdsm-fake journal:
May  6 15:28:27 vdsm-fake journal: <JsonRpcResponse id: "7579860d-76d0-4686-82b5-a7d4b424365f" result: {dateTime=2017-05-06T12:28:27 GMT, generationID=f554221c-bbe4-4ad1-8cdf-11eff9359359, thpState=always, cpuSysVdsmd=0.25, anonHugePages=662, rxRate=0.00, txDropped=0, network={bond0={txErrors=0, txRate=12, name=bond0, state=up, txDropped=0, rxRate=10, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, bond2={txErrors=0, txRate=10, name=bond2, state=up, txDropped=0, rxRate=11, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, bond1={txErrors=0, txRate=11, name=bond1, state=up, txDropped=0, rxRate=12, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, bond4={txErrors=0, txRate=11, name=bond4, state=up, txDropped=0, rxRate=12, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, em1={txErrors=0, txRate=11, name=em1, state=up, txDropped=0, rxRate=14, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, bond3={txErrors=0, txRate=11, name=bond3, state=up, txDropped=0, rxRate=13, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}, em2={txErrors=0, txRate=14, name=em2, state=up, txDropped=0, rxRate=10, rxErrors=0, rxDropped=14965, macAddr=A9:FE:B3:73:B0:E9}}, memShared=0, cpuLoad=10, cpuUser=19, memCommitted=0, cpuSys=13, vmCount=0, rxDropped=14965, ksmState=false, ksmPages=100, swapFree=20031, memAvailable=6435, momStatus=active, netConfigDirty=False, memFree=0, diskStats={/var/log/core={free=44231}, /var/log={free=44231}, /var/run/vdsm/={free=3978}, /tmp={free=44231}}, storageDomains={}, vmMigrating=0, cpuIdle=81, swapTotal=20031, cpuUserVdsmd=0.50, numaNodeMemFree={0={memFree=0, memPercent=9}, 1={memFree=0, memPercent=9}}, txRate=, statsAge=0.43, memUsed=9, vmActive=0, ksmCpu=0, elapsedTime=1494073707}>
May  6 15:28:29 vdsm-fake journal: 2017-05-06 12:28:29,047 Message SEND
May  6 15:28:29 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:28:29 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:28:29 vdsm-fake journal: content-length:103
May  6 15:28:29 vdsm-fake journal:
May  6 15:28:29 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getAllVmStats","params":{},"id":"daa452fe-bc58-4a48-84a6-315d43bb8e28"} 
May  6 15:28:29 vdsm-fake journal: 2017-05-06 12:28:29,048 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:28:29 vdsm-fake journal: 2017-05-06 12:28:29,050 JsonRpcServer$MessageHandler Request is Host.getAllVmStats got response {"jsonrpc":"2.0","result":[],"id":"daa452fe-bc58-4a48-84a6-315d43bb8e28"}
May  6 15:28:29 vdsm-fake journal: 2017-05-06 12:28:29,051 Message MESSAGE
May  6 15:28:29 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:29 vdsm-fake journal: content-length:73
May  6 15:28:29 vdsm-fake journal:
May  6 15:28:29 vdsm-fake journal: {"jsonrpc":"2.0","result":[],"id":"daa452fe-bc58-4a48-84a6-315d43bb8e28"} 
May  6 15:28:29 vdsm-fake journal: 2017-05-06 12:28:29,052 StompCommonClient Message sent: MESSAGE
May  6 15:28:29 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:29 vdsm-fake journal: content-length:73
May  6 15:28:29 vdsm-fake journal:
May  6 15:28:29 vdsm-fake journal: <JsonRpcResponse id: "daa452fe-bc58-4a48-84a6-315d43bb8e28" result: []>
May  6 15:28:42 vdsm-fake journal: 2017-05-06 12:28:42,853 Message SEND
May  6 15:28:42 vdsm-fake journal: destination:jms.topic.vdsm_requests
May  6 15:28:42 vdsm-fake journal: reply-to:jms.topic.vdsm_responses
May  6 15:28:42 vdsm-fake journal: content-length:98
May  6 15:28:42 vdsm-fake journal:
May  6 15:28:42 vdsm-fake journal: {"jsonrpc":"2.0","method":"Host.getStats","params":{},"id":"3a84b849-011a-4da2-b11f-6e96881a6dd2"} 
May  6 15:28:42 vdsm-fake journal: 2017-05-06 12:28:42,855 JsonRpcServer$MessageHandler client policy identifier test3
May  6 15:28:42 vdsm-fake journal: 2017-05-06 12:28:42,958 JsonRpcServer$MessageHandler Request is Host.getStats got response {"jsonrpc":"2.0","result":{"dateTime":"2017-05-06T12:28:42 GMT","generationID":"f554221c-bbe4-4ad1-8cdf-11eff9359359","thpState":"always","cpuSysVdsmd":"0.25","anonHugePages":"662","rxRate":"0.00","txDropped":"0","network":{"bond0":{"txErrors":"0","txRate":"14","name":"bond0","state":"up","txDropped":"0","rxRate":"10","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond2":{"txErrors":"0","txRate":"10","name":"bond2","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond1":{"txErrors":"0","txRate":"12","name":"bond1","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond4":{"txErrors":"0","txRate":"11","name":"bond4","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em1":{"txErrors":"0","txRate":"13","name":"em1","state":"up","txDropped":"0","rxRate":"13","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond3":{"txErrors":"0","txRate":"13","name":"bond3","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"em2":{"txErrors":"0","txRate":"13","name":"em2","state":"up","txDropped":"0","rxRate":"12","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"}},"memShared":0,"cpuLoad":"14","cpuUser":"19","memCommitted":0,"cpuSys":"14","vmCount":0,"rxDropped":"14965","ksmState":false,"ksmPages":100,"swapFree":20031,"memAvailable":6435,"momStatus":"active","netConfigDirty":"False","memFree":"0","diskStats":{"/var/log/core":{"free":"44231"},"/var/log":{"free":"44231"},"/var/run/vdsm/":{"free":"3978"},"/tmp":{"free":"44231"}},"storageDomains":{},"vmMigrating":0,"cpuIdle":"81","swapTotal":20031,"cpuUserVdsmd":"0.50","numaNodeMemFree":{"0":{"memFree":0,"memPercent":"7"},"1":{"memFree":0,"memPercent":"7"}},"txRate":"","statsAge":"0.43","memUsed":"7","vmActive":0,"ksmCpu":0,"elapsedTime":"1494073722"},"id":"3a84b849-011a-4da2-b11f-6e96881a6dd2"}
May  6 15:28:42 vdsm-fake journal: 2017-05-06 12:28:42,959 Message MESSAGE
May  6 15:28:42 vdsm-fake journal: destination:jms.queue.reponses
May  6 15:28:42 vdsm-fake journal: content-length:2040
May  6 15:28:42 vdsm-fake journal:
May  6 15:28:42 vdsm-fake journal: {"jsonrpc":"2.0","result":{"dateTime":"2017-05-06T12:28:42 GMT","generationID":"f554221c-bbe4-4ad1-8cdf-11eff9359359","thpState":"always","cpuSysVdsmd":"0.25","anonHugePages":"662","rxRate":"0.00","txDropped":"0","network":{"bond0":{"txErrors":"0","txRate":"14","name":"bond0","state":"up","txDropped":"0","rxRate":"10","rxErrors":"0","rxDropped":"14965","macAddr":"A9:FE:B3:73:B0:E9"},"bond2":{"txErrors":"0","txRate":"10","name":"bond2","state":"up","txDropped":"0","rxRate":"11","rxErrors":"0","rxDropped":"14965","macAddr":