gistfile1.txt

David-Santiagos-Computer:servlet David$ lein pallet converge com.battletheory.deploy.nodes/main 0 -P virtualbox
20:51:43.954 [main] DEBUG pallet.main-invoker - OS              Mac OS X 10.7.2
20:51:43.965 [main] DEBUG pallet.main-invoker - Arch            x86_64
20:51:43.968 [main] DEBUG pallet.main-invoker - Admin user      david
20:51:44.083 [main] DEBUG pallet.main-invoker - private-key-path /Users/David/.ssh/id_rsa true
20:51:44.092 [main] DEBUG pallet.main-invoker - public-key-path /Users/David/.ssh/id_rsa.pub true
20:51:44.113 [main] DEBUG pallet.core - pallet version: 0.6.5
20:51:44.117 [main] INFO  pallet.core - retrieving nodes
20:51:51.503 [main] INFO  pallet.core - converging nodes
20:51:51.624 [pool-2-thread-1] INFO  pallet.core - adjust-node-count :main -1
20:51:51.626 [pool-2-thread-1] INFO  pallet.core - destroying 1 nodes for :main
20:51:51.904 [pool-2-thread-1] INFO  pallet.compute.vmfest - Shutting down         main-0	           main	 public: 10.0.1.21
20:51:53.544 [pool-2-thread-1] INFO  pallet.compute.vmfest - Machine state is :powered-off
20:51:54.621 [pool-2-thread-1] DEBUG vmfest.virtualbox.conditions - formatting wrapped exception {:type :vbox-runtime, :original-message "VirtualBox error: The machine 'main-0' is already locked for a session (or being unlocked) (0x80BB0007)", :origin-id "662c175e-a69d-40b8-a77a-1d719d0ab062", :origin-component "Machine", :error-code 2159738887, :original-error-type :VBOX_E_INVALID_OBJECT_STATE, :text "The machine 'main-0' is already locked for a session (or being unlocked)"}
20:51:54.649 [main] ERROR pallet.futures - Adjust node count exception: VirtualBox error: The machine 'main-0' is already locked for a session (or being unlocked) (0x80BB0007)
org.virtualbox_4_0.VBoxException: VirtualBox error: The machine 'main-0' is already locked for a session (or being unlocked) (0x80BB0007)
	at org.virtualbox_4_0.IMachine.lockMachine(IMachine.java:954) ~[vboxjws-4.0.2.jar:na]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_26]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_26]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_26]
	at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
	at clojure.lang.Reflector.invokeMatchingMethod(Reflector.java:90) ~[clojure-1.2.0.jar:na]
	at clojure.lang.Reflector.invokeInstanceMethod(Reflector.java:28) ~[clojure-1.2.0.jar:na]
	at vmfest.manager$wait_for_lockable_session_state$fn__11124.invoke(manager.clj:201) ~[na:na]
	at vmfest.manager$wait_for_lockable_session_state.doInvoke(manager.clj:201) ~[na:na]
	at clojure.lang.RestFn.invoke(RestFn.java:424) ~[clojure-1.2.0.jar:na]
	at pallet.compute.vmfest.VmfestService.shutdown_node(vmfest.clj:428) ~[na:na]
	at pallet.compute.vmfest.VmfestService.destroy_node(vmfest.clj:449) ~[na:na]
	at pallet.compute.vmfest.VmfestService.destroy_nodes_in_group(vmfest.clj:444) ~[na:na]
	at pallet.core$destroy_nodes.invoke(core.clj:434) ~[na:na]
	at pallet.core$adjust_node_count.invoke(core.clj:462) ~[na:na]
	at pallet.core$parallel_adjust_node_counts$p_a_n_c_future__5151$fn__5152.invoke(core.clj:484) ~[na:na]
	at clojure.lang.AFn.call(AFn.java:18) ~[clojure-1.2.0.jar:na]
	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) ~[na:1.6.0_26]
	at java.util.concurrent.FutureTask.run(FutureTask.java:138) ~[na:1.6.0_26]
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886) ~[na:1.6.0_26]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908) ~[na:1.6.0_26]
	at java.lang.Thread.run(Thread.java:680) ~[na:1.6.0_26]
20:51:54.686 [main] DEBUG pallet.futures - Adjust node count exception
clojure.contrib.condition.Condition: Cannot open session with machine '8d2eb705-5967-4e13-9706-6dbe4b8bcf26' reason:VirtualBox error: The machine 'main-0' is already locked for a session (or being unlocked) (0x80BB0007)
	at clojure.contrib.condition.Condition.fillInStackTrace(Unknown Source) ~[clojure-contrib-1.2.0.jar:na]
	at java.lang.Throwable.<init>(Throwable.java:218) ~[na:1.6.0_26]
	at clojure.contrib.condition.Condition.<init>(Unknown Source) ~[clojure-contrib-1.2.0.jar:na]
	at vmfest.virtualbox.conditions$wrap_exception.invoke(conditions.clj:122) ~[na:na]
	at vmfest.manager$wait_for_lockable_session_state$fn__11124.invoke(manager.clj:201) ~[na:na]
	at vmfest.manager$wait_for_lockable_session_state.doInvoke(manager.clj:201) ~[na:na]
	at clojure.lang.RestFn.invoke(RestFn.java:424) ~[clojure-1.2.0.jar:na]
	at pallet.compute.vmfest.VmfestService.shutdown_node(vmfest.clj:428) ~[na:na]
	at pallet.compute.vmfest.VmfestService.destroy_node(vmfest.clj:449) ~[na:na]
	at pallet.compute.vmfest.VmfestService.destroy_nodes_in_group(vmfest.clj:444) ~[na:na]
	at pallet.core$destroy_nodes.invoke(core.clj:434) ~[na:na]
	at pallet.core$adjust_node_count.invoke(core.clj:462) ~[na:na]
	at pallet.core$parallel_adjust_node_counts$p_a_n_c_future__5151$fn__5152.invoke(core.clj:484) ~[na:na]
	at clojure.lang.AFn.call(AFn.java:18) ~[clojure-1.2.0.jar:na]
	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) ~[na:1.6.0_26]
	at java.util.concurrent.FutureTask.run(FutureTask.java:138) ~[na:1.6.0_26]
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886) ~[na:1.6.0_26]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908) ~[na:1.6.0_26]
	at java.lang.Thread.run(Thread.java:680) ~[na:1.6.0_26]
Caused by: org.virtualbox_4_0.VBoxException: VirtualBox error: The machine 'main-0' is already locked for a session (or being unlocked) (0x80BB0007)
	at org.virtualbox_4_0.IMachine.lockMachine(IMachine.java:954) ~[vboxjws-4.0.2.jar:na]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_26]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_26]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_26]
	at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
	at clojure.lang.Reflector.invokeMatchingMethod(Reflector.java:90) ~[clojure-1.2.0.jar:na]
	at clojure.lang.Reflector.invokeInstanceMethod(Reflector.java:28) ~[clojure-1.2.0.jar:na]
	... 15 common frames omitted
20:51:54.690 [main] DEBUG pallet.core - pallet version: 0.6.5
20:51:54.764 [main] INFO  pallet.core - lift-nodes phases [:settings :configure], groups [:main]
20:51:54.779 [main] INFO  pallet.core - apply-phase :pallet.phase/pre-settings for :main with 0 nodes
20:51:54.782 [main] INFO  pallet.core - apply-phase :settings for :main with 0 nodes
20:51:54.783 [main] INFO  pallet.core - apply-phase :pallet.phase/post-settings for :main with 0 nodes
20:51:54.783 [main] INFO  pallet.core - apply-phase :pallet.phase/pre-configure for :main with 0 nodes
20:51:54.783 [main] INFO  pallet.core - apply-phase :configure for :main with 0 nodes
20:51:54.785 [main] INFO  pallet.core - apply-phase :pallet.phase/post-configure for :main with 0 nodes
0