2/5 16:00:47 DaemonCore: Command received via UDP from host <194.225.74.162:42180>
2/5 16:00:47 DaemonCore: received command 440 (MATCH_INFO), calling handler (command_match_info)
2/5 16:00:47 vm1: match_info called
2/5 16:00:47 vm1: Received match <x.x.x.27:33172>#1202213106#8#...
2/5 16:00:47 vm1: State change: match notification protocol successful
2/5 16:00:47 vm1: Changing state: Unclaimed -> Matched
2/5 16:00:47 DaemonCore: Command received via UDP from host <194.225.74.162:42180>
2/5 16:00:47 DaemonCore: received command 440 (MATCH_INFO), calling handler (command_match_info)
2/5 16:00:47 vm2: match_info called
2/5 16:00:47 vm2: Received match <x.x.x.27:33172>#1202213106#9#...
2/5 16:00:47 vm2: State change: match notification protocol successful
2/5 16:00:47 vm2: Changing state: Unclaimed -> Matched
2/5 16:00:47 DaemonCore: Command received via UDP from host <194.225.74.162:42180>
2/5 16:00:47 DaemonCore: received command 440 (MATCH_INFO), calling handler (command_match_info)
2/5 16:00:47 vm3: match_info called
2/5 16:00:47 vm3: Received match <x.x.x.27:33172>#1202213106#10#...
2/5 16:00:47 vm3: State change: match notification protocol successful
2/5 16:00:47 vm3: Changing state: Unclaimed -> Matched
2/5 16:00:47 DaemonCore: Command received via TCP from host <x.x.x.27:60659>
2/5 16:00:47 DaemonCore: received command 442 (REQUEST_CLAIM), calling handler (command_request_claim)
2/5 16:00:47 vm1: Request accepted.
2/5 16:00:47 vm1: Remote owner is DedicatedScheduler@mpi0.y.y.y
2/5 16:00:47 vm1: State change: claiming protocol successful
2/5 16:00:47 vm1: Changing state: Matched -> Claimed
2/5 16:00:47 DaemonCore: Command received via TCP from host <x.x.x.27:39248>
2/5 16:00:47 DaemonCore: received command 442 (REQUEST_CLAIM), calling handler (command_request_claim)
2/5 16:00:47 vm3: Request accepted.
2/5 16:00:47 vm3: Remote owner is DedicatedScheduler@mpi0.y.y.y
2/5 16:00:47 vm3: State change: claiming protocol successful
2/5 16:00:47 vm3: Changing state: Matched -> Claimed
2/5 16:00:47 DaemonCore: Command received via TCP from host <x.x.x.27:52666>
2/5 16:00:47 DaemonCore: received command 442 (REQUEST_CLAIM), calling handler (command_request_claim)
2/5 16:00:47 vm2: Request accepted.
2/5 16:00:47 vm2: Remote owner is DedicatedScheduler@mpi0.y.y.y
2/5 16:00:47 vm2: State change: claiming protocol successful
2/5 16:00:47 vm2: Changing state: Matched -> Claimed
2/5 16:00:51 DaemonCore: Command received via TCP from host <x.x.x.27:39003>
2/5 16:00:51 DaemonCore: received command 444 (ACTIVATE_CLAIM), calling handler (command_activate_claim)
2/5 16:00:51 vm3: Got activate_claim request from shadow (<x.x.x.27:39003>)
2/5 16:00:51 vm3: Remote job ID is 41.0
2/5 16:00:51 vm3: Got universe "PARALLEL" (11) from request classad
2/5 16:00:51 vm3: State change: claim-activation protocol successful
2/5 16:00:51 vm3: Changing activity: Idle -> Busy
2/5 16:00:51 DaemonCore: Command received via TCP from host <x.x.x.27:40467>
2/5 16:00:51 DaemonCore: received command 444 (ACTIVATE_CLAIM), calling handler (command_activate_claim)
2/5 16:00:51 vm1: Got activate_claim request from shadow (<x.x.x.27:40467>)
2/5 16:00:51 vm1: Remote job ID is 41.0
2/5 16:00:51 vm1: Got universe "PARALLEL" (11) from request classad
2/5 16:00:51 vm1: State change: claim-activation protocol successful
2/5 16:00:51 vm1: Changing activity: Idle -> Busy
2/5 16:00:51 DaemonCore: Command received via TCP from host <x.x.x.27:47841>
2/5 16:00:51 DaemonCore: received command 444 (ACTIVATE_CLAIM), calling handler (command_activate_claim)
2/5 16:00:51 vm2: Got activate_claim request from shadow (<x.x.x.27:47841>)
2/5 16:00:51 vm2: Remote job ID is 41.0
2/5 16:00:51 vm2: Got universe "PARALLEL" (11) from request classad
2/5 16:00:51 vm2: State change: claim-activation protocol successful
2/5 16:00:51 vm2: Changing activity: Idle -> Busy
2/5 16:01:00 DaemonCore: Command received via TCP from host <x.x.x.27:37164>
2/5 16:01:00 DaemonCore: received command 404 (DEACTIVATE_CLAIM_FORCIBLY), calling handler (command_handler)
2/5 16:01:00 vm3: Called deactivate_claim_forcibly()
2/5 16:01:00 DaemonCore: Command received via TCP from host <x.x.x.27:50342>
2/5 16:01:00 DaemonCore: received command 404 (DEACTIVATE_CLAIM_FORCIBLY), calling handler (command_handler)
2/5 16:01:00 vm1: Called deactivate_claim_forcibly()
2/5 16:01:00 DaemonCore: Command received via TCP from host <x.x.x.27:40911>
2/5 16:01:00 DaemonCore: received command 404 (DEACTIVATE_CLAIM_FORCIBLY), calling handler (command_handler)
2/5 16:01:00 vm2: Called deactivate_claim_forcibly()
2/5 16:01:00 Starter pid 6717 exited with status 0
2/5 16:01:00 vm3: State change: starter exited
2/5 16:01:00 vm3: Changing activity: Busy -> Idle
2/5 16:01:00 Starter pid 6718 exited with status 0
2/5 16:01:00 vm1: State change: starter exited
2/5 16:01:00 vm1: Changing activity: Busy -> Idle
2/5 16:01:00 Starter pid 6719 exited with status 0
2/5 16:01:00 vm2: State change: starter exited
2/5 16:01:00 vm2: Changing activity: Busy -> Idle
2/5 16:01:00 DaemonCore: Command received via TCP from host <x.x.x.27:49029>
2/5 16:01:00 DaemonCore: received command 403 (DEACTIVATE_CLAIM), calling handler (command_handler)
2/5 16:01:00 vm3: Called deactivate_claim()
2/5 16:01:00 DaemonCore: Command received via TCP from host <x.x.x.27:46605>
2/5 16:01:00 DaemonCore: received command 403 (DEACTIVATE_CLAIM), calling handler (command_handler)
2/5 16:01:00 vm1: Called deactivate_claim()
2/5 16:01:00 DaemonCore: Command received via TCP from host <x.x.x.27:34139>
2/5 16:01:00 DaemonCore: received command 403 (DEACTIVATE_CLAIM), calling handler (command_handler)
2/5 16:01:00 vm2: Called deactivate_claim()
2/5 16:01:10 DaemonCore: Command received via TCP from host <x.x.x.27:38720>
2/5 16:01:10 DaemonCore: received command 443 (RELEASE_CLAIM), calling handler (command_release_claim)
2/5 16:01:10 vm1: State change: received RELEASE_CLAIM command
2/5 16:01:10 vm1: Changing state and activity: Claimed/Idle -> Preempting/Vacating
2/5 16:01:10 vm1: State change: No preempting claim, returning to owner
2/5 16:01:10 vm1: Changing state and activity: Preempting/Vacating -> Owner/Idle
2/5 16:01:10 vm1: State change: IS_OWNER is false
2/5 16:01:10 vm1: Changing state: Owner -> Unclaimed
2/5 16:01:10 DaemonCore: Command received via TCP from host <x.x.x.27:52119>
2/5 16:01:10 DaemonCore: received command 443 (RELEASE_CLAIM), calling handler (command_release_claim)
2/5 16:01:10 vm2: State change: received RELEASE_CLAIM command
2/5 16:01:10 vm2: Changing state and activity: Claimed/Idle -> Preempting/Vacating
2/5 16:01:10 vm2: State change: No preempting claim, returning to owner
2/5 16:01:10 vm2: Changing state and activity: Preempting/Vacating -> Owner/Idle
2/5 16:01:10 vm2: State change: IS_OWNER is false
2/5 16:01:10 vm2: Changing state: Owner -> Unclaimed
2/5 16:01:10 DaemonCore: Command received via TCP from host <x.x.x.27:41030>
2/5 16:01:10 DaemonCore: received command 443 (RELEASE_CLAIM), calling handler (command_release_claim)
2/5 16:01:10 vm3: State change: received RELEASE_CLAIM command
2/5 16:01:10 vm3: Changing state and activity: Claimed/Idle -> Preempting/Vacating
2/5 16:01:10 vm3: State change: No preempting claim, returning to owner
2/5 16:01:10 vm3: Changing state and activity: Preempting/Vacating -> Owner/Idle
2/5 16:01:10 vm3: State change: IS_OWNER is false
2/5 16:01:10 vm3: Changing state: Owner -> Unclaimed
