[20120123T15:42:34.184Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Reverting the fields of OpaqueRef:b84243cb-a1a4-6d03-557a-b6c5ab15f186 to the ones of OpaqueRef:d863f672-0562-88e2-1652-b139ffe370bb (pre-MNR)
[20120123T15:42:34.185Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] copying metadata into OpaqueRef:b84243cb-a1a4-6d03-557a-b6c5ab15f186
[20120123T15:42:34.296Z| warn|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] VM oim could run on any of these hosts: [ xenhard ]
[20120123T15:42:34.296Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Reverting OpaqueRef:b84243cb-a1a4-6d03-557a-b6c5ab15f186 to OpaqueRef:d863f672-0562-88e2-1652-b139ffe370bb
[20120123T15:42:34.297Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.299Z|debug|xenhard|4988 unix-RPC||dummytaskhelper] task dispatch:session.slave_login D:20a0040314ba created by task R:024b1cc949f1
[20120123T15:42:34.301Z| info|xenhard|4988 unix-RPC|session.slave_login D:6dcafed719d7|xapi] Session.create trackid=08f12eebe71021126d6d4a7d5539a1f8 pool=true uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49
[20120123T15:42:34.302Z|debug|xenhard|4988 unix-RPC|session.slave_login D:6dcafed719d7|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.304Z|debug|xenhard|4989 unix-RPC||dummytaskhelper] task dispatch:session.get_uuid D:c3e2e9aa737f created by task D:6dcafed719d7
[20120123T15:42:34.307Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Cleaning up the old VBDs and VDIs to have more free space
[20120123T15:42:34.307Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.309Z|debug|xenhard|4990 unix-RPC||dummytaskhelper] task dispatch:VBD.destroy D:e9e064c54310 created by task R:024b1cc949f1
[20120123T15:42:34.369Z| info|xenhard|4990 unix-RPC|dispatch:VBD.destroy D:e9e064c54310|taskhelper] task VBD.destroy R:f2e734d53c40 (uuid:47479028-fb52-5fe5-9b10-292b8402a870) created (trackid=08f12eebe71021126d6d4a7d5539a1f8) by task R:024b1cc949f1
[20120123T15:42:34.369Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|audit] VBD.destroy: VBD = 'd92b50bf-16b4-de2f-b8c8-454157f51904'
[20120123T15:42:34.369Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|xapi] VBD.destroy (uuid = d92b50bf-16b4-de2f-b8c8-454157f51904; ref = OpaqueRef:832212b5-d2cf-d434-d348-c1822b00efb8)
[20120123T15:42:34.369Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|backtrace] Raised at xapi_vbd_helpers.ml:340.12-178 -> rbac.ml:229.16-23
[20120123T15:42:34.369Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|backtrace] Raised at rbac.ml:238.10-15 -> server_helpers.ml:78.11-41
[20120123T15:42:34.369Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|dispatcher] Server_helpers.exec exception_handler: Got exception OPERATION_NOT_ALLOWED: [ VBD 'd92b50bf-16b4-de2f-b8c8-454157f51904' still attached to '29f39b05-72b5-9512-3207-5c400aec4bcf' ]
[20120123T15:42:34.370Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|dispatcher] Raised at string.ml:150.25-34 -> stringext.ml:108.13-29
[20120123T15:42:34.370Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|backtrace] Raised at string.ml:150.25-34 -> stringext.ml:108.13-29
[20120123T15:42:34.375Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|xapi] Raised at server_helpers.ml:93.14-15 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.377Z|debug|xenhard|4990 unix-RPC|VBD.destroy R:f2e734d53c40|xapi] Raised at pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.377Z|debug|xenhard|4990 unix-RPC|dispatch:VBD.destroy D:e9e064c54310|xapi] Raised at pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.378Z|debug|xenhard|4990 unix-RPC|dispatch:VBD.destroy D:e9e064c54310|backtrace] Raised at pervasiveext.ml:26.22-25 -> server_helpers.ml:152.10-106 -> server.ml:25830.19-167 -> server_helpers.ml:118.4-7
[20120123T15:42:34.378Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Raised at client.ml:6.37-75 -> client.ml:9544.12-64 -> list.ml:69.12-15 -> xapi_vm_snapshot.ml:297.2-66 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.378Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.380Z|debug|xenhard|4991 unix-RPC||dummytaskhelper] task dispatch:session.logout D:b1cfb77ed961 created by task R:024b1cc949f1
[20120123T15:42:34.383Z| info|xenhard|4991 unix-RPC|session.logout D:297336744d09|xapi] Session.destroy trackid=08f12eebe71021126d6d4a7d5539a1f8
[20120123T15:42:34.385Z|error|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] revert failed: Api_errors.Server_error("OPERATION_NOT_ALLOWED", _)
[20120123T15:42:34.402Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Raised at xapi_vm_snapshot.ml:436.15-114 -> message_forwarding.ml:231.27-46 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.406Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Raised at pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.410Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|backtrace] Raised at pervasiveext.ml:26.22-25 -> rbac.ml:229.16-23
[20120123T15:42:34.410Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|backtrace] Raised at rbac.ml:238.10-15 -> server_helpers.ml:78.11-41
[20120123T15:42:34.410Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|dispatcher] Server_helpers.exec exception_handler: Got exception VM_REVERT_FAILED: [ OpaqueRef:d863f672-0562-88e2-1652-b139ffe370bb; OpaqueRef:b84243cb-a1a4-6d03-557a-b6c5ab15f186 ]
[20120123T15:42:34.410Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|dispatcher] Raised at string.ml:150.25-34 -> stringext.ml:108.13-29
[20120123T15:42:34.410Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|backtrace] Raised at string.ml:150.25-34 -> stringext.ml:108.13-29
[20120123T15:42:34.418Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Raised at server_helpers.ml:93.14-15 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.443Z|debug|xenhard|4987 inet-RPC|VM.revert R:024b1cc949f1|xapi] Raised at pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.443Z|debug|xenhard|4987 inet-RPC|dispatch:VM.revert D:e2054e573345|xapi] Raised at pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
[20120123T15:42:34.443Z|debug|xenhard|4987 inet-RPC|dispatch:VM.revert D:e2054e573345|backtrace] Raised at pervasiveext.ml:26.22-25 -> server_helpers.ml:152.10-106 -> server.ml:7864.19-167 -> server_helpers.ml:118.4-7
[20120123T15:42:34.445Z|debug|xenhard|4987 inet-RPC||http_critical] Connection terminated
[20120123T15:42:34.464Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|audit] VM.revert: snapshot = '1a8d64f5-421b-624a-c599-bae3e0ccd809 (vmdc_snap_1327332834)'
[20120123T15:42:34.476Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Reverting the fields of OpaqueRef:b84243cb-a1a4-6d03-557a-b6c5ab15f186 to the ones of OpaqueRef:d863f672-0562-88e2-1652-b139ffe370bb (pre-MNR)
[20120123T15:42:34.477Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] copying metadata into OpaqueRef:b84243cb-a1a4-6d03-557a-b6c5ab15f186
[20120123T15:42:34.613Z| warn|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] VM oim could run on any of these hosts: [ xenhard ]
[20120123T15:42:34.613Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Reverting OpaqueRef:b84243cb-a1a4-6d03-557a-b6c5ab15f186 to OpaqueRef:d863f672-0562-88e2-1652-b139ffe370bb
[20120123T15:42:34.614Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.616Z|debug|xenhard|4994 unix-RPC||dummytaskhelper] task dispatch:session.slave_login D:0bd630d4ccc5 created by task R:9f46f1105a44
[20120123T15:42:34.619Z| info|xenhard|4994 unix-RPC|session.slave_login D:b4a7156d499a|xapi] Session.create trackid=3a372599d55ab302531f82944b88a863 pool=true uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49
[20120123T15:42:34.620Z|debug|xenhard|4994 unix-RPC|session.slave_login D:b4a7156d499a|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.622Z|debug|xenhard|4995 unix-RPC||dummytaskhelper] task dispatch:session.get_uuid D:8399bb333dbc created by task D:b4a7156d499a
[20120123T15:42:34.625Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Cleaning up the old VBDs and VDIs to have more free space
[20120123T15:42:34.625Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.626Z|debug|xenhard|4996 unix-RPC||dummytaskhelper] task dispatch:VBD.destroy D:fb743210fb22 created by task R:9f46f1105a44
[20120123T15:42:34.631Z| info|xenhard|4996 unix-RPC|dispatch:VBD.destroy D:fb743210fb22|taskhelper] task VBD.destroy R:2f8407321eb2 (uuid:8b0c5815-6ad1-fcef-d962-35ff171caa04) created (trackid=3a372599d55ab302531f82944b88a863) by task R:9f46f1105a44
[20120123T15:42:34.631Z|debug|xenhard|4996 unix-RPC|VBD.destroy R:2f8407321eb2|audit] VBD.destroy: VBD = 'd92b50bf-16b4-de2f-b8c8-454157f51904'
[20120123T15:42:34.631Z|debug|xenhard|4996 unix-RPC|VBD.destroy R:2f8407321eb2|xapi] VBD.destroy (uuid = d92b50bf-16b4-de2f-b8c8-454157f51904; ref = OpaqueRef:832212b5-d2cf-d434-d348-c1822b00efb8)
[20120123T15:42:34.682Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.686Z|debug|xenhard|4997 unix-RPC||dummytaskhelper] task dispatch:VBD.destroy D:873a58651f21 created by task R:9f46f1105a44
[20120123T15:42:34.691Z| info|xenhard|4997 unix-RPC|dispatch:VBD.destroy D:873a58651f21|taskhelper] task VBD.destroy R:20cbe12ec84c (uuid:d9ee091e-8563-d38e-cf78-3e5be070a94b) created (trackid=3a372599d55ab302531f82944b88a863) by task R:9f46f1105a44
[20120123T15:42:34.692Z|debug|xenhard|4997 unix-RPC|VBD.destroy R:20cbe12ec84c|audit] VBD.destroy: VBD = 'd6f66df0-cd70-60b1-8770-4df5c2ffd704'
[20120123T15:42:34.692Z|debug|xenhard|4997 unix-RPC|VBD.destroy R:20cbe12ec84c|xapi] VBD.destroy (uuid = d6f66df0-cd70-60b1-8770-4df5c2ffd704; ref = OpaqueRef:1e011a47-c8f6-7654-1a84-091b2d490afd)
[20120123T15:42:34.704Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.706Z|debug|xenhard|4998 unix-RPC||dummytaskhelper] task dispatch:VDI.destroy D:440a20efb9de created by task R:9f46f1105a44
[20120123T15:42:34.718Z| info|xenhard|4998 unix-RPC|dispatch:VDI.destroy D:440a20efb9de|taskhelper] task VDI.destroy R:9e558dcf9561 (uuid:6d0273e0-9e24-6d9e-612e-441b1207d0f6) created (trackid=3a372599d55ab302531f82944b88a863) by task R:9f46f1105a44
[20120123T15:42:34.718Z|debug|xenhard|4998 unix-RPC|VDI.destroy R:9e558dcf9561|audit] VDI.destroy: VDI = '57ee64f5-aa90-48b5-96ab-ff36d58c1819'
[20120123T15:42:34.719Z|debug|xenhard|4998 unix-RPC|VDI.destroy R:9e558dcf9561|xapi] Marking SR for VDI.destroy (task=OpaqueRef:9e558dcf-9561-2135-28d6-9b9735310068)
[20120123T15:42:34.724Z|debug|xenhard|4998 unix-RPC|VDI.destroy R:9e558dcf9561|sm] SM nfs vdi_detach sr=OpaqueRef:9c4027f8-f0ae-35a0-6c76-7271b4147803 vdi=OpaqueRef:a71879a6-6aa4-9abf-e0b7-19256b76bcfc
[20120123T15:42:34.728Z| info|xenhard|4998 unix-RPC|sm_exec D:25370f31754e|xapi] Session.create trackid=3bfc79a2e4857ec192bc5573aee71646 pool=false uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49
[20120123T15:42:34.729Z|debug|xenhard|4998 unix-RPC|sm_exec D:25370f31754e|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.731Z|debug|xenhard|4999 unix-RPC||dummytaskhelper] task dispatch:session.get_uuid D:c08264aa0494 created by task D:25370f31754e
[20120123T15:42:34.814Z|debug|xenhard|5000 unix-RPC||dummytaskhelper] task dispatch:host.get_other_config D:de4912844fcf created by task R:9e558dcf9561
[20120123T15:42:34.854Z| info|xenhard|4998 unix-RPC|sm_exec D:25370f31754e|xapi] Session.destroy trackid=3bfc79a2e4857ec192bc5573aee71646
[20120123T15:42:34.856Z|debug|xenhard|4998 unix-RPC|VDI.destroy R:9e558dcf9561|sm] SM nfs vdi_delete sr=OpaqueRef:9c4027f8-f0ae-35a0-6c76-7271b4147803 vdi=OpaqueRef:a71879a6-6aa4-9abf-e0b7-19256b76bcfc
[20120123T15:42:34.860Z| info|xenhard|4998 unix-RPC|sm_exec D:4ca13a629f38|xapi] Session.create trackid=797210584c42dcf90cd5469527f7f23c pool=false uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49
[20120123T15:42:34.862Z|debug|xenhard|4998 unix-RPC|sm_exec D:4ca13a629f38|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:34.863Z|debug|xenhard|5001 unix-RPC||dummytaskhelper] task dispatch:session.get_uuid D:5bcea4f8c121 created by task D:4ca13a629f38
[20120123T15:42:34.952Z|debug|xenhard|5002 unix-RPC||dummytaskhelper] task dispatch:host.get_other_config D:c4e7c4fa931f created by task R:9e558dcf9561
[20120123T15:42:35.123Z|debug|xenhard|5003 unix-RPC||dummytaskhelper] task dispatch:VDI.get_by_uuid D:270f761a7907 created by task R:9e558dcf9561
[20120123T15:42:35.130Z|debug|xenhard|5004 unix-RPC||dummytaskhelper] task dispatch:VDI.db_forget D:7d2d64956d9e created by task R:9e558dcf9561
[20120123T15:42:35.137Z| info|xenhard|5004 unix-RPC|dispatch:VDI.db_forget D:7d2d64956d9e|taskhelper] task VDI.db_forget R:17dad86dc7c3 (uuid:a8978ce0-0642-1b67-7d57-9c63eafab29c) created (trackid=797210584c42dcf90cd5469527f7f23c) by task R:9e558dcf9561
[20120123T15:42:35.137Z|debug|xenhard|5004 unix-RPC|VDI.db_forget R:17dad86dc7c3|xapi] db_forget uuid=57ee64f5-aa90-48b5-96ab-ff36d58c1819
[20120123T15:42:35.158Z|debug|xenhard|5005 unix-RPC||dummytaskhelper] task dispatch:SR.get_virtual_allocation D:757c5f2ac5cb created by task R:9e558dcf9561
[20120123T15:42:35.166Z|debug|xenhard|5006 unix-RPC||dummytaskhelper] task dispatch:SR.get_by_uuid D:c5326a1ee039 created by task R:9e558dcf9561
[20120123T15:42:35.172Z|debug|xenhard|5007 unix-RPC||dummytaskhelper] task dispatch:SR.set_virtual_allocation D:fb7230460545 created by task R:9e558dcf9561
[20120123T15:42:35.179Z|debug|xenhard|5008 unix-RPC||dummytaskhelper] task dispatch:SR.set_physical_size D:b6c892eeaa46 created by task R:9e558dcf9561
[20120123T15:42:35.186Z|debug|xenhard|5009 unix-RPC||dummytaskhelper] task dispatch:SR.set_physical_utilisation D:7c1b68f2b5dc created by task R:9e558dcf9561
[20120123T15:42:35.198Z| info|xenhard|5010 unix-RPC|session.login_with_password D:f8d8139a4758|xapi] Session.create trackid=e30e82d14999324895687c918e7328a7 pool=false uname=root is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49
[20120123T15:42:35.199Z|debug|xenhard|5010 unix-RPC|session.login_with_password D:f8d8139a4758|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.201Z|debug|xenhard|5011 unix-RPC||dummytaskhelper] task dispatch:session.get_uuid D:2d070c9187e8 created by task D:f8d8139a4758
[20120123T15:42:35.208Z| info|xenhard|4998 unix-RPC|sm_exec D:4ca13a629f38|xapi] Session.destroy trackid=797210584c42dcf90cd5469527f7f23c
[20120123T15:42:35.211Z|debug|xenhard|4998 unix-RPC|VDI.destroy R:9e558dcf9561|xapi] Unmarking SR after VDI.destroy (task=OpaqueRef:9e558dcf-9561-2135-28d6-9b9735310068)
[20120123T15:42:35.225Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Cloning the snapshoted disks
[20120123T15:42:35.226Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.227Z|debug|xenhard|5015 unix-RPC||dummytaskhelper] task dispatch:VBD.get_record D:e33deef78c06 created by task R:9f46f1105a44
[20120123T15:42:35.231Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.233Z|debug|xenhard|5017 unix-RPC||dummytaskhelper] task dispatch:VBD.get_record D:24ad0eebc8aa created by task R:9f46f1105a44
[20120123T15:42:35.237Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.239Z|debug|xenhard|5019 unix-RPC||dummytaskhelper] task dispatch:VDI.clone D:26e2a18d460e created by task R:9f46f1105a44
[20120123T15:42:35.244Z| info|xenhard|5019 unix-RPC|dispatch:VDI.clone D:26e2a18d460e|taskhelper] task Async.VDI.clone R:a1c9a388b71b (uuid:2b3145ea-c335-2452-d10b-565166751878) created (trackid=3a372599d55ab302531f82944b88a863) by task R:9f46f1105a44
[20120123T15:42:35.245Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.245Z| info|xenhard|5021|Async.VDI.clone R:a1c9a388b71b|dispatcher] spawning a new thread to handle the current task (trackid=3a372599d55ab302531f82944b88a863)
[20120123T15:42:35.245Z|debug|xenhard|5021|Async.VDI.clone R:a1c9a388b71b|audit] VDI.clone: VDI = 'd98aeb0c-5399-44be-8d2f-99f60dff543e'
[20120123T15:42:35.246Z|debug|xenhard|5021|Async.VDI.clone R:a1c9a388b71b|xapi] Marking SR for VDI.clone (task=OpaqueRef:a1c9a388-b71b-2590-dada-3fce8db6e116)
[20120123T15:42:35.248Z|debug|xenhard|5022 unix-RPC||dummytaskhelper] task dispatch:session.slave_login D:a144e68b89a2 created by task R:9f46f1105a44
[20120123T15:42:35.252Z|debug|xenhard|5021|Async.VDI.clone R:a1c9a388b71b|sm] SM nfs vdi_clone sr=OpaqueRef:9c4027f8-f0ae-35a0-6c76-7271b4147803 vdi=OpaqueRef:f6000c4f-4f0a-c894-ef7e-4011882de140 driver_params=[epochhint=e051eaf9-999a-b8d9-c2a2-c25b3d1feeb5]
[20120123T15:42:35.252Z| info|xenhard|5022 unix-RPC|session.slave_login D:8ce5703226cf|xapi] Session.create trackid=fb8ea774e43f21a0e66b95da68e91883 pool=true uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49
[20120123T15:42:35.253Z|debug|xenhard|5022 unix-RPC|session.slave_login D:8ce5703226cf|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.255Z| info|xenhard|5021|sm_exec D:b3adcb1296d9|xapi] Session.create trackid=d028c65950d6e5c8e0aebf9410fca5d9 pool=false uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49
[20120123T15:42:35.262Z|debug|xenhard|5021|sm_exec D:b3adcb1296d9|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.264Z|debug|xenhard|5024 unix-RPC||dummytaskhelper] task dispatch:session.get_uuid D:f22563a3b965 created by task D:8ce5703226cf
[20120123T15:42:35.268Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Listening for events relating to tasks OpaqueRef:a1c9a388-b71b-2590-dada-3fce8db6e116 and OpaqueRef:9f46f110-5a44-8cbd-fc43-41eb7b32446d
[20120123T15:42:35.268Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.270Z|debug|xenhard|5025 unix-RPC||dummytaskhelper] task dispatch:session.get_uuid D:ea39c0da989e created by task D:b3adcb1296d9
[20120123T15:42:35.273Z|debug|xenhard|5026 unix-RPC||dummytaskhelper] task dispatch:event.register D:9e663f0a147d created by task R:9f46f1105a44
[20120123T15:42:35.276Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.286Z|debug|xenhard|5028 unix-RPC||dummytaskhelper] task dispatch:task.get_record D:b5ef15408edf created by task R:9f46f1105a44
[20120123T15:42:35.291Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.302Z|debug|xenhard|5030 unix-RPC||dummytaskhelper] task dispatch:task.get_record D:f2124e9874d8 created by task R:9f46f1105a44
[20120123T15:42:35.305Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.307Z|debug|xenhard|5032 unix-RPC||dummytaskhelper] task dispatch:event.next D:61e1765a4bcd created by task R:9f46f1105a44
[20120123T15:42:35.311Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.312Z|debug|xenhard|5033 unix-RPC||dummytaskhelper] task dispatch:event.next D:c1b21f186d0f created by task R:9f46f1105a44
[20120123T15:42:35.355Z|debug|xenhard|5035 unix-RPC||dummytaskhelper] task dispatch:host.get_other_config D:b9d855139530 created by task R:a1c9a388b71b
[20120123T15:42:35.649Z|debug|xenhard|5037 unix-RPC||dummytaskhelper] task dispatch:VDI.db_introduce D:d831ef22e921 created by task R:a1c9a388b71b
[20120123T15:42:35.656Z| info|xenhard|5037 unix-RPC|dispatch:VDI.db_introduce D:d831ef22e921|taskhelper] task VDI.db_introduce R:1e004302f3dd (uuid:e42f7e1f-6fb3-afdb-1690-bfdb352603ee) created (trackid=d028c65950d6e5c8e0aebf9410fca5d9) by task R:a1c9a388b71b
[20120123T15:42:35.656Z|debug|xenhard|5037 unix-RPC|VDI.db_introduce R:1e004302f3dd|xapi] {pool,db}_introduce uuid=4b96b445-83ae-4da2-9318-5809c60844a6 name_label=
[20120123T15:42:35.660Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.663Z|debug|xenhard|5038 unix-RPC||dummytaskhelper] task dispatch:event.next D:3edba4c6a633 created by task R:9f46f1105a44
[20120123T15:42:35.673Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.676Z|debug|xenhard|5039 unix-RPC||dummytaskhelper] task dispatch:event.next D:7d211f251b13 created by task R:9f46f1105a44
[20120123T15:42:35.686Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.689Z|debug|xenhard|5040 unix-RPC||dummytaskhelper] task dispatch:event.next D:737620b55e93 created by task R:9f46f1105a44
[20120123T15:42:35.694Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.694Z|debug|xenhard|5041 unix-RPC||dummytaskhelper] task dispatch:VDI.set_sm_config D:6151fd146510 created by task R:a1c9a388b71b
[20120123T15:42:35.696Z|debug|xenhard|5042 unix-RPC||dummytaskhelper] task dispatch:event.next D:0d489cc453ed created by task R:9f46f1105a44
[20120123T15:42:35.696Z| info|xenhard|5041 unix-RPC|dispatch:VDI.set_sm_config D:6151fd146510|api_effect] VDI.set_sm_config
[20120123T15:42:35.700Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.702Z|debug|xenhard|5043 unix-RPC||dummytaskhelper] task dispatch:event.next D:b8160e511593 created by task R:9f46f1105a44
[20120123T15:42:35.703Z|debug|xenhard|5044 unix-RPC||dummytaskhelper] task dispatch:VDI.set_managed D:85896decd8a4 created by task R:a1c9a388b71b
[20120123T15:42:35.710Z|debug|xenhard|5045 unix-RPC||dummytaskhelper] task dispatch:VDI.set_virtual_size D:12f67f58ff01 created by task R:a1c9a388b71b
[20120123T15:42:35.721Z|debug|xenhard|5046 unix-RPC||dummytaskhelper] task dispatch:VDI.set_physical_utilisation D:b1fe53400385 created by task R:a1c9a388b71b
[20120123T15:42:35.727Z|debug|xenhard|5047 unix-RPC||dummytaskhelper] task dispatch:VDI.get_sm_config D:0845652e25cb created by task R:a1c9a388b71b
[20120123T15:42:35.733Z|debug|xenhard|5048 unix-RPC||dummytaskhelper] task dispatch:VDI.set_sm_config D:08127f2a51e4 created by task R:a1c9a388b71b
[20120123T15:42:35.734Z| info|xenhard|5048 unix-RPC|dispatch:VDI.set_sm_config D:08127f2a51e4|api_effect] VDI.set_sm_config
[20120123T15:42:35.746Z|debug|xenhard|5049 unix-RPC||dummytaskhelper] task dispatch:SR.get_virtual_allocation D:bda0295b3a9c created by task R:a1c9a388b71b
[20120123T15:42:35.753Z|debug|xenhard|5050 unix-RPC||dummytaskhelper] task dispatch:SR.get_by_uuid D:4273a2a02033 created by task R:a1c9a388b71b
[20120123T15:42:35.759Z|debug|xenhard|5051 unix-RPC||dummytaskhelper] task dispatch:SR.set_virtual_allocation D:0c170a2f81c9 created by task R:a1c9a388b71b
[20120123T15:42:35.766Z|debug|xenhard|5052 unix-RPC||dummytaskhelper] task dispatch:SR.set_physical_size D:19e7d8326eb3 created by task R:a1c9a388b71b
[20120123T15:42:35.772Z|debug|xenhard|5053 unix-RPC||dummytaskhelper] task dispatch:SR.set_physical_utilisation D:2bebef2f00f7 created by task R:a1c9a388b71b
[20120123T15:42:35.787Z| info|xenhard|5021|sm_exec D:b3adcb1296d9|xapi] Session.destroy trackid=d028c65950d6e5c8e0aebf9410fca5d9
[20120123T15:42:35.805Z|debug|xenhard|5021|Async.VDI.clone R:a1c9a388b71b|xapi] Unmarking SR after VDI.clone (task=OpaqueRef:a1c9a388-b71b-2590-dada-3fce8db6e116)
[20120123T15:42:35.814Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.819Z|debug|xenhard|5054 unix-RPC||dummytaskhelper] task dispatch:event.next D:b1aa8636b5e9 created by task R:9f46f1105a44
[20120123T15:42:35.830Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Finished listening for events relating to tasks OpaqueRef:a1c9a388-b71b-2590-dada-3fce8db6e116 and OpaqueRef:9f46f110-5a44-8cbd-fc43-41eb7b32446d
[20120123T15:42:35.830Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.832Z|debug|xenhard|5055 unix-RPC||dummytaskhelper] task dispatch:session.logout D:505fcf298815 created by task R:9f46f1105a44
[20120123T15:42:35.835Z| info|xenhard|5055 unix-RPC|session.logout D:8153e9aecb6d|xapi] Session.destroy trackid=fb8ea774e43f21a0e66b95da68e91883
[20120123T15:42:35.837Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.838Z|debug|xenhard|5056 unix-RPC||dummytaskhelper] task dispatch:task.destroy D:cb0cbbee0a48 created by task R:9f46f1105a44
[20120123T15:42:35.855Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Cloning the suspend VDI if needed
[20120123T15:42:35.856Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Copying the VBDs
[20120123T15:42:35.872Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Update the suspend_VDI
[20120123T15:42:35.874Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Cleaning up the old VIFs
[20120123T15:42:35.874Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.876Z|debug|xenhard|5057 unix-RPC||dummytaskhelper] task dispatch:VIF.destroy D:3f8a6e48775a created by task R:9f46f1105a44
[20120123T15:42:35.882Z| info|xenhard|5057 unix-RPC|dispatch:VIF.destroy D:3f8a6e48775a|taskhelper] task VIF.destroy R:74a3f5759100 (uuid:882c8bf0-a056-3521-9279-b0d2b4854ee2) created (trackid=3a372599d55ab302531f82944b88a863) by task R:9f46f1105a44
[20120123T15:42:35.882Z|debug|xenhard|5057 unix-RPC|VIF.destroy R:74a3f5759100|audit] VIF.destroy: VIF = '158cafe9-a9c8-e71d-ac30-1f7b70f8c465'
[20120123T15:42:35.882Z|debug|xenhard|5057 unix-RPC|VIF.destroy R:74a3f5759100|xapi] VIF.destroy
[20120123T15:42:35.896Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Setting up the new VIFs
[20120123T15:42:35.896Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] VIF.create running
[20120123T15:42:35.898Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Found mac_seed on VM: supplied MAC parameter = '3e:5e:f1:6a:e4:cf'
[20120123T15:42:35.905Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] VIF ref='OpaqueRef:a69ef002-7a79-fbd1-a58e-715fe09596c6' created (VM = 'OpaqueRef:b84243cb-a1a4-6d03-557a-b6c5ab15f186'; MAC address = '3e:5e:f1:6a:e4:cf')
[20120123T15:42:35.906Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Attempting to open /var/xapi/xapi
[20120123T15:42:35.908Z|debug|xenhard|5058 unix-RPC||dummytaskhelper] task dispatch:session.logout D:7e9dcd69bf21 created by task R:9f46f1105a44
[20120123T15:42:35.911Z| info|xenhard|5058 unix-RPC|session.logout D:3c7e72c3552b|xapi] Session.destroy trackid=3a372599d55ab302531f82944b88a863
[20120123T15:42:35.928Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] Reverting the guest metrics
[20120123T15:42:35.946Z|debug|xenhard|4993 inet-RPC|VM.revert R:9f46f1105a44|xapi] VM.revert done