TestPeers.ref

   1 5 nodes & 3 slices
   2 +++ timer start
   3 ==================== ('INIT',)
   4 initializing s[1] https://lurch.cs.princeton.edu:443/PLCAPI/
   5 initialized aa[1] {'Username': 'root@plc1.org', 'AuthMethod': 'password', 'Role': 'admin', 'AuthString': 'root'}
   6 initialized a[1] {'Username': 'plc1@planet-lab.org', 'AuthMethod': 'password', 'Role': 'admin', 'AuthString': 'peer'}
   7 initializing s[2] https://planetlab-devbox.inria.fr:443/PLCAPI/
   8 initialized aa[2] {'Username': 'root@plc2.org', 'AuthMethod': 'password', 'Role': 'admin', 'AuthString': 'root'}
   9 initialized a[2] {'Username': 'plc2@planet-lab.org', 'AuthMethod': 'password', 'Role': 'admin', 'AuthString': 'peer'}
  10 s[1] <ServerProxy for lurch.cs.princeton.edu:443/PLCAPI/>
  11 aa[1] {'Username': 'root@plc1.org', 'AuthMethod': 'password', 'Role': 'admin', 'AuthString': 'root'}
  12 a[1] {'Username': 'plc1@planet-lab.org', 'AuthMethod': 'password', 'Role': 'admin', 'AuthString': 'peer'}
  13 s[2] <ServerProxy for planetlab-devbox.inria.fr:443/PLCAPI/>
  14 aa[2] {'Username': 'root@plc2.org', 'AuthMethod': 'password', 'Role': 'admin', 'AuthString': 'root'}
  15 a[2] {'Username': 'plc2@planet-lab.org', 'AuthMethod': 'password', 'Role': 'admin', 'AuthString': 'peer'}
  16 01:== created peer admin account 3, plc1@planet-lab.org - peer
  17 02:== created peer admin account 3, plc2@planet-lab.org - peer
  18 01:== enabled+admin on account 3:plc1@planet-lab.org
  19 02:== enabled+admin on account 3:plc2@planet-lab.org
  20 01:Created person 4 as the peer person
  21 02:Created person 4 as the peer person
  22 01:Created peer 1
  23 PLEASE manually set password for person_id=4 in DB1
  24 02:Created peer 1
  25 PLEASE manually set password for person_id=4 in DB2
  26 Attempting to set passwd for person_id=4 in DB1UPDATE 1
  27  -> system returns 0
  28 Attempting to set passwd for person_id=4 in DB2UPDATE 1
  29  -> system returns 0
  30 01:== Created site 2 with max_slices=3
  31 02:== Created site 2 with max_slices=3
  32 +++ 17 seconds ellapsed
  33 === refresh before persons&keys creation
  34 +++ 19 seconds ellapsed
  35 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 1, 'new_nodes': 0}
  36 +++ 23 seconds ellapsed
  37 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 1, 'new_nodes': 0}
  38 +++ 27 seconds ellapsed
  39 01: Checking keys: got 0 local (e=0) & 0 foreign (e=0)
  40 02: Checking keys: got 0 local (e=0) & 0 foreign (e=0)
  41 01: Checking persons: got 4 local (e=4) & 1 foreign (e=1)
  42 02: Checking persons: got 4 local (e=4) & 1 foreign (e=1)
  43 ==================== ('Creating persons&keys',)
  44 01:== created user account 6, user1-1@plc1.org - password1
  45 01:== added key ssh-rsa 1111111111111111 user1-key1 to person user1-1@plc1.org
  46 01:== added key ssh-rsa 1111111111111111 user1-key2 to person user1-1@plc1.org
  47 01:== added key ssh-rsa 1111111111111111 user1-key3 to person user1-1@plc1.org
  48 01:== added key ssh-rsa 1111111111111111 user1-key4 to person user1-1@plc1.org
  49 02:== created user account 6, user2-1@plc2.org - password2
  50 02:== added key ssh-rsa 2222222222222222 user1-key1 to person user2-1@plc2.org
  51 02:== added key ssh-rsa 2222222222222222 user1-key2 to person user2-1@plc2.org
  52 02:== added key ssh-rsa 2222222222222222 user1-key3 to person user2-1@plc2.org
  53 02:== added key ssh-rsa 2222222222222222 user1-key4 to person user2-1@plc2.org
  54 01:== created user account 7, user1-2@plc1.org - password1
  55 01:== added key ssh-rsa 1111111111111111 user2-key1 to person user1-2@plc1.org
  56 01:== added key ssh-rsa 1111111111111111 user2-key2 to person user1-2@plc1.org
  57 01:== added key ssh-rsa 1111111111111111 user2-key3 to person user1-2@plc1.org
  58 01:== added key ssh-rsa 1111111111111111 user2-key4 to person user1-2@plc1.org
  59 02:== created user account 7, user2-2@plc2.org - password2
  60 02:== added key ssh-rsa 2222222222222222 user2-key1 to person user2-2@plc2.org
  61 02:== added key ssh-rsa 2222222222222222 user2-key2 to person user2-2@plc2.org
  62 02:== added key ssh-rsa 2222222222222222 user2-key3 to person user2-2@plc2.org
  63 02:== added key ssh-rsa 2222222222222222 user2-key4 to person user2-2@plc2.org
  64 ==================== ('1 extra del/add cycle for unique indexes',)
  65 02:== deleted person_id 6
  66 02:== deleted person_id 7
  67 02:== created user account 8, user2-1@plc2.org - password2
  68 02:== added key ssh-rsa 2222222222222222 user1-key1 to person user2-1@plc2.org
  69 02:== added key ssh-rsa 2222222222222222 user1-key2 to person user2-1@plc2.org
  70 02:== added key ssh-rsa 2222222222222222 user1-key3 to person user2-1@plc2.org
  71 02:== added key ssh-rsa 2222222222222222 user1-key4 to person user2-1@plc2.org
  72 02:== created user account 9, user2-2@plc2.org - password2
  73 02:== added key ssh-rsa 2222222222222222 user2-key1 to person user2-2@plc2.org
  74 02:== added key ssh-rsa 2222222222222222 user2-key2 to person user2-2@plc2.org
  75 02:== added key ssh-rsa 2222222222222222 user2-key3 to person user2-2@plc2.org
  76 02:== added key ssh-rsa 2222222222222222 user2-key4 to person user2-2@plc2.org
  77 01: Checking keys: got 8 local (e=8) & 0 foreign (e=0)
  78 02: Checking keys: got 8 local (e=8) & 0 foreign (e=0)
  79 01: Checking persons: got 6 local (e=6) & 1 foreign (e=1)
  80 02: Checking persons: got 6 local (e=6) & 1 foreign (e=1)
  81 === refresh after persons&keys creation
  82 +++ 47 seconds ellapsed
  83 01:== Refreshing peer got  {'new_keys': 8, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 2, 'new_nodes': 0}
  84 +++ 52 seconds ellapsed
  85 02:== Refreshing peer got  {'new_keys': 8, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 2, 'new_nodes': 0}
  86 +++ 56 seconds ellapsed
  87 01: Checking keys: got 8 local (e=8) & 8 foreign (e=8)
  88 02: Checking keys: got 8 local (e=8) & 8 foreign (e=8)
  89 01: Checking persons: got 6 local (e=6) & 3 foreign (e=3)
  90 02: Checking persons: got 6 local (e=6) & 3 foreign (e=3)
  91 +++ 58 seconds ellapsed
  92 ==================== ('RESETTING NODES',)
  93 01:== Cleaning all nodes
  94 02:== Cleaning all nodes
  95 === refresh cleaned nodes
  96 +++ 59 seconds ellapsed
  97 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 0}
  98 +++ 64 seconds ellapsed
  99 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 100 +++ 68 seconds ellapsed
 101 01: Checking nodes: got 0 local (e=0) & 0 foreign (e=0)
 102 02: Checking nodes: got 0 local (e=0) & 0 foreign (e=0)
 103 ==================== ('CREATING NODES',)
 104 01:== Added node 1 n101.plc1.org
 105 02:== Added node 1 n202.plc2.org
 106 01:== Added node 2 n101.plc1.org
 107 02:== Added node 2 n202.plc2.org
 108 01:== Added node 3 n101.plc1.org
 109 02:== Added node 3 n202.plc2.org
 110 01:== Added node 4 n101.plc1.org
 111 02:== Added node 4 n202.plc2.org
 112 01:== Added node 5 n101.plc1.org
 113 02:== Added node 5 n202.plc2.org
 114 01: Checking nodes: got 5 local (e=5) & 0 foreign (e=0)
 115 02: Checking nodes: got 5 local (e=5) & 0 foreign (e=0)
 116 === refresh after node creation
 117 +++ 81 seconds ellapsed
 118 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 5}
 119 +++ 86 seconds ellapsed
 120 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 5}
 121 +++ 90 seconds ellapsed
 122 01: Checking nodes: got 5 local (e=5) & 5 foreign (e=5)
 123 02: Checking nodes: got 5 local (e=5) & 5 foreign (e=5)
 124 02:== Deleted node 1, returns 1
 125 02:== Deleted node 2, returns 1
 126 02:== Deleted node 3, returns 1
 127 02:== Deleted node 4, returns 1
 128 02:== Deleted node 5, returns 1
 129 ==================== ('2 extra del/add cycles on plc2 for different indexes',)
 130 02:== Added node 11 n202.plc2.org
 131 02:== Added node 12 n202.plc2.org
 132 02:== Added node 13 n202.plc2.org
 133 02:== Added node 14 n202.plc2.org
 134 02:== Added node 15 n202.plc2.org
 135 02:== Deleted node 11, returns 1
 136 02:== Deleted node 12, returns 1
 137 02:== Deleted node 13, returns 1
 138 02:== Deleted node 14, returns 1
 139 02:== Deleted node 15, returns 1
 140 02:== Added node 16 n202.plc2.org
 141 02:== Added node 17 n202.plc2.org
 142 02:== Added node 18 n202.plc2.org
 143 02:== Added node 19 n202.plc2.org
 144 02:== Added node 20 n202.plc2.org
 145 02:== Deleted node 16, returns 1
 146 02:== Deleted node 17, returns 1
 147 02:== Deleted node 18, returns 1
 148 02:== Deleted node 19, returns 1
 149 02:== Deleted node 20, returns 1
 150 02: Checking nodes: got 0 local (e=0) & 5 foreign (e=5)
 151 === refresh after deletion on plc2
 152 +++ 101 seconds ellapsed
 153 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': -5}
 154 +++ 106 seconds ellapsed
 155 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 156 +++ 110 seconds ellapsed
 157 01: Checking nodes: got 5 local (e=5) & 0 foreign (e=0)
 158 02: Checking nodes: got 0 local (e=0) & 5 foreign (e=5)
 159 ==================== ('ADD on plc2 for different indexes',)
 160 02:== Added node 21 n202.plc2.org
 161 02:== Added node 22 n202.plc2.org
 162 02:== Added node 23 n202.plc2.org
 163 02:== Added node 24 n202.plc2.org
 164 02:== Added node 25 n202.plc2.org
 165 01: Checking nodes: got 5 local (e=5) & 0 foreign (e=0)
 166 02: Checking nodes: got 5 local (e=5) & 5 foreign (e=5)
 167 === refresh after re-creation on plc2
 168 +++ 114 seconds ellapsed
 169 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 5}
 170 +++ 119 seconds ellapsed
 171 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 172 +++ 124 seconds ellapsed
 173 01: Checking nodes: got 5 local (e=5) & 5 foreign (e=5)
 174 02: Checking nodes: got 5 local (e=5) & 5 foreign (e=5)
 175 +++ 125 seconds ellapsed
 176 ==================== ('RESETTING SLICES TEST',)
 177 01:== Cleaning all nodes
 178 01:==== Cleaning node 1
 179 01:==== Cleaning node 2
 180 01:==== Cleaning node 3
 181 01:==== Cleaning node 4
 182 01:==== Cleaning node 5
 183 02:== Cleaning all nodes
 184 02:==== Cleaning node 21
 185 02:==== Cleaning node 22
 186 02:==== Cleaning node 23
 187 02:==== Cleaning node 24
 188 02:==== Cleaning node 25
 189 01:== Added node 16 n101.plc1.org
 190 02:== Added node 26 n202.plc2.org
 191 01:== Added node 17 n101.plc1.org
 192 02:== Added node 27 n202.plc2.org
 193 01:== Added node 18 n101.plc1.org
 194 02:== Added node 28 n202.plc2.org
 195 01:== Added node 19 n101.plc1.org
 196 02:== Added node 29 n202.plc2.org
 197 01:== Added node 20 n101.plc1.org
 198 02:== Added node 30 n202.plc2.org
 199 01:== Cleaning all slices
 200 01:==== Cleaning slice 3
 201 02:== Cleaning all slices
 202 02:==== Cleaning slice 3
 203 === refresh After slices init
 204 +++ 144 seconds ellapsed
 205 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 0}
 206 +++ 149 seconds ellapsed
 207 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 208 +++ 154 seconds ellapsed
 209 ==================== ('CREATING SLICES on plc1',)
 210 01:== created slice 4 - max nodes=5
 211 01:== Attached person user1-1@plc1.org to slice one_s101
 212 01:== Attached person user1-2@plc1.org to slice one_s101
 213 01:== created slice 5 - max nodes=5
 214 01:== Attached person user1-1@plc1.org to slice one_s102
 215 01:== Attached person user1-2@plc1.org to slice one_s102
 216 01:== created slice 6 - max nodes=5
 217 01:== Attached person user1-1@plc1.org to slice one_s103
 218 01:== Attached person user1-2@plc1.org to slice one_s103
 219 01: Checking slices: got 5 local (e=5) & 0 foreign (e=0)
 220 02: Checking slices: got 2 local (e=2) & 0 foreign (e=0)
 221 === refresh after slice created on plc1
 222 +++ 167 seconds ellapsed
 223 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 0}
 224 +++ 172 seconds ellapsed
 225 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 3, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 226 +++ 177 seconds ellapsed
 227 01: Checking slices: got 5 local (e=5) & 0 foreign (e=0)
 228 02: Checking slices: got 2 local (e=2) & 3 foreign (e=3)
 229 01: local slice one_s101 (e=0)  on nodes  []
 230 01: local slice one_s102 (e=0)  on nodes  []
 231 01: local slice one_s103 (e=0)  on nodes  []
 232 02: foreign slice one_s101 (e=0)  on nodes  []
 233 02: foreign slice one_s102 (e=0)  on nodes  []
 234 02: foreign slice one_s103 (e=0)  on nodes  []
 235 ==================== ('ADDING LOCAL NODES IN SLICES',)
 236 01:== added in slice 4 local  ['n101.plc1.org', 'n102.plc1.org', 'n103.plc1.org', 'n104.plc1.org', 'n105.plc1.org']
 237 01:== added in slice 5 local  ['n101.plc1.org', 'n102.plc1.org', 'n103.plc1.org', 'n104.plc1.org', 'n105.plc1.org']
 238 01:== added in slice 6 local  ['n101.plc1.org', 'n102.plc1.org', 'n103.plc1.org', 'n104.plc1.org', 'n105.plc1.org']
 239 01: local slice one_s101 (e=5)  on nodes  [16, 17, 18, 19, 20]
 240 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 241 01: local slice one_s102 (e=5)  on nodes  [16, 17, 18, 19, 20]
 242 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 243 01: local slice one_s103 (e=5)  on nodes  [16, 17, 18, 19, 20]
 244 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 245 02: foreign slice one_s101 (e=0)  on nodes  []
 246 02: foreign slice one_s102 (e=0)  on nodes  []
 247 02: foreign slice one_s103 (e=0)  on nodes  []
 248 === refresh After local nodes were added on plc1
 249 +++ 197 seconds ellapsed
 250 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 0}
 251 +++ 202 seconds ellapsed
 252 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 253 +++ 207 seconds ellapsed
 254 01: local slice one_s101 (e=5)  on nodes  [16, 17, 18, 19, 20]
 255 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 256 01: local slice one_s102 (e=5)  on nodes  [16, 17, 18, 19, 20]
 257 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 258 01: local slice one_s103 (e=5)  on nodes  [16, 17, 18, 19, 20]
 259 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 260 02: foreign slice one_s101 (e=5)  on nodes  [8, 9, 10, 6, 7]
 261 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 262 02: foreign slice one_s102 (e=5)  on nodes  [8, 9, 10, 6, 7]
 263 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 264 02: foreign slice one_s103 (e=5)  on nodes  [8, 9, 10, 6, 7]
 265 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 266 ==================== ('ADDING FOREIGN NODES IN SLICES',)
 267 01:== added in slice 4 foreign  ['n201.plc2.org', 'n202.plc2.org', 'n203.plc2.org', 'n204.plc2.org', 'n205.plc2.org']
 268 01:== added in slice 5 foreign  ['n201.plc2.org', 'n202.plc2.org', 'n203.plc2.org', 'n204.plc2.org', 'n205.plc2.org']
 269 01:== added in slice 6 foreign  ['n201.plc2.org', 'n202.plc2.org', 'n203.plc2.org', 'n204.plc2.org', 'n205.plc2.org']
 270 01: local slice one_s101 (e=10)  on nodes  [16, 17, 18, 19, 20, 11, 12, 13, 14, 15]
 271 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 272 [FOR:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 273 01: local slice one_s102 (e=10)  on nodes  [16, 17, 18, 19, 20, 11, 12, 13, 14, 15]
 274 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 275 [FOR:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 276 01: local slice one_s103 (e=10)  on nodes  [16, 17, 18, 19, 20, 11, 12, 13, 14, 15]
 277 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 278 [FOR:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 279 02: foreign slice one_s101 (e=5)  on nodes  [8, 9, 10, 6, 7]
 280 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 281 02: foreign slice one_s102 (e=5)  on nodes  [8, 9, 10, 6, 7]
 282 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 283 02: foreign slice one_s103 (e=5)  on nodes  [8, 9, 10, 6, 7]
 284 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 285 === refresh After foreign nodes were added in plc1
 286 +++ 227 seconds ellapsed
 287 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 0}
 288 +++ 232 seconds ellapsed
 289 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 290 +++ 237 seconds ellapsed
 291 01: local slice one_s101 (e=10)  on nodes  [16, 17, 18, 19, 20, 11, 12, 13, 14, 15]
 292 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 293 [FOR:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 294 01: local slice one_s102 (e=10)  on nodes  [16, 17, 18, 19, 20, 11, 12, 13, 14, 15]
 295 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 296 [FOR:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 297 01: local slice one_s103 (e=10)  on nodes  [16, 17, 18, 19, 20, 11, 12, 13, 14, 15]
 298 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 299 [FOR:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 300 02: foreign slice one_s101 (e=10)  on nodes  [8, 9, 10, 6, 7, 26, 27, 28, 29, 30]
 301 [LOC:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 302 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 303 02: foreign slice one_s102 (e=10)  on nodes  [8, 9, 10, 6, 7, 26, 27, 28, 29, 30]
 304 [LOC:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 305 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 306 02: foreign slice one_s103 (e=10)  on nodes  [8, 9, 10, 6, 7, 26, 27, 28, 29, 30]
 307 [LOC:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 308 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 309 01: 3 slivers (exp. 3) in GetSlivers for node n101.plc1.org
 310 >>slivername =  one_s101
 311 {  'attributes': [],
 312    'expires': normalized,
 313    'instantiation': 'plc-instantiated',
 314    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 315                  'key_type': 'ssh'},
 316               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 317                  'key_type': 'ssh'},
 318               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 319                  'key_type': 'ssh'},
 320               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 321                  'key_type': 'ssh'},
 322               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 323                  'key_type': 'ssh'},
 324               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 325                  'key_type': 'ssh'},
 326               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 327                  'key_type': 'ssh'},
 328               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 329                  'key_type': 'ssh'}],
 330    'name': 'one_s101',
 331    'slice_id': 4}
 332 >>slivername =  one_s102
 333 {  'attributes': [],
 334    'expires': normalized,
 335    'instantiation': 'plc-instantiated',
 336    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 337                  'key_type': 'ssh'},
 338               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 339                  'key_type': 'ssh'},
 340               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 341                  'key_type': 'ssh'},
 342               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 343                  'key_type': 'ssh'},
 344               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 345                  'key_type': 'ssh'},
 346               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 347                  'key_type': 'ssh'},
 348               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 349                  'key_type': 'ssh'},
 350               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 351                  'key_type': 'ssh'}],
 352    'name': 'one_s102',
 353    'slice_id': 5}
 354 >>slivername =  one_s103
 355 {  'attributes': [],
 356    'expires': normalized,
 357    'instantiation': 'plc-instantiated',
 358    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 359                  'key_type': 'ssh'},
 360               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 361                  'key_type': 'ssh'},
 362               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 363                  'key_type': 'ssh'},
 364               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 365                  'key_type': 'ssh'},
 366               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 367                  'key_type': 'ssh'},
 368               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 369                  'key_type': 'ssh'},
 370               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 371                  'key_type': 'ssh'},
 372               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 373                  'key_type': 'ssh'}],
 374    'name': 'one_s103',
 375    'slice_id': 6}
 376 02: 3 slivers (exp. 3) in GetSlivers for node n201.plc2.org
 377 >>slivername =  one_s101
 378 {  'attributes': [],
 379    'expires': normalized,
 380    'instantiation': 'plc-instantiated',
 381    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 382                  'key_type': 'ssh'},
 383               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 384                  'key_type': 'ssh'},
 385               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 386                  'key_type': 'ssh'},
 387               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 388                  'key_type': 'ssh'},
 389               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 390                  'key_type': 'ssh'},
 391               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 392                  'key_type': 'ssh'},
 393               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 394                  'key_type': 'ssh'},
 395               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 396                  'key_type': 'ssh'}],
 397    'name': 'one_s101',
 398    'slice_id': 4}
 399 >>slivername =  one_s102
 400 {  'attributes': [],
 401    'expires': normalized,
 402    'instantiation': 'plc-instantiated',
 403    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 404                  'key_type': 'ssh'},
 405               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 406                  'key_type': 'ssh'},
 407               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 408                  'key_type': 'ssh'},
 409               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 410                  'key_type': 'ssh'},
 411               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 412                  'key_type': 'ssh'},
 413               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 414                  'key_type': 'ssh'},
 415               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 416                  'key_type': 'ssh'},
 417               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 418                  'key_type': 'ssh'}],
 419    'name': 'one_s102',
 420    'slice_id': 5}
 421 >>slivername =  one_s103
 422 {  'attributes': [],
 423    'expires': normalized,
 424    'instantiation': 'plc-instantiated',
 425    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 426                  'key_type': 'ssh'},
 427               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 428                  'key_type': 'ssh'},
 429               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 430                  'key_type': 'ssh'},
 431               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 432                  'key_type': 'ssh'},
 433               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 434                  'key_type': 'ssh'},
 435               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 436                  'key_type': 'ssh'},
 437               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 438                  'key_type': 'ssh'},
 439               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 440                  'key_type': 'ssh'}],
 441    'name': 'one_s103',
 442    'slice_id': 6}
 443 ==================== ('DELETING FOREIGN NODES FROM SLICES',)
 444 01:== deleted in slice 4 foreign  ['n201.plc2.org', 'n202.plc2.org', 'n203.plc2.org', 'n204.plc2.org', 'n205.plc2.org']
 445 01:== deleted in slice 5 foreign  ['n201.plc2.org', 'n202.plc2.org', 'n203.plc2.org', 'n204.plc2.org', 'n205.plc2.org']
 446 01:== deleted in slice 6 foreign  ['n201.plc2.org', 'n202.plc2.org', 'n203.plc2.org', 'n204.plc2.org', 'n205.plc2.org']
 447 01: local slice one_s101 (e=5)  on nodes  [16, 17, 18, 19, 20]
 448 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 449 01: local slice one_s102 (e=5)  on nodes  [16, 17, 18, 19, 20]
 450 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 451 01: local slice one_s103 (e=5)  on nodes  [16, 17, 18, 19, 20]
 452 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 453 02: foreign slice one_s101 (e=10)  on nodes  [8, 9, 10, 6, 7, 26, 27, 28, 29, 30]
 454 [LOC:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 455 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 456 02: foreign slice one_s102 (e=10)  on nodes  [8, 9, 10, 6, 7, 26, 27, 28, 29, 30]
 457 [LOC:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 458 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 459 02: foreign slice one_s103 (e=10)  on nodes  [8, 9, 10, 6, 7, 26, 27, 28, 29, 30]
 460 [LOC:5] :  n201.plc2.org  n202.plc2.org  n203.plc2.org  n204.plc2.org  n205.plc2.org
 461 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 462 01: 3 slivers (exp. 3) in GetSlivers for node n101.plc1.org
 463 >>slivername =  one_s101
 464 {  'attributes': [],
 465    'expires': normalized,
 466    'instantiation': 'plc-instantiated',
 467    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 468                  'key_type': 'ssh'},
 469               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 470                  'key_type': 'ssh'},
 471               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 472                  'key_type': 'ssh'},
 473               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 474                  'key_type': 'ssh'},
 475               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 476                  'key_type': 'ssh'},
 477               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 478                  'key_type': 'ssh'},
 479               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 480                  'key_type': 'ssh'},
 481               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 482                  'key_type': 'ssh'}],
 483    'name': 'one_s101',
 484    'slice_id': 4}
 485 >>slivername =  one_s102
 486 {  'attributes': [],
 487    'expires': normalized,
 488    'instantiation': 'plc-instantiated',
 489    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 490                  'key_type': 'ssh'},
 491               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 492                  'key_type': 'ssh'},
 493               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 494                  'key_type': 'ssh'},
 495               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 496                  'key_type': 'ssh'},
 497               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 498                  'key_type': 'ssh'},
 499               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 500                  'key_type': 'ssh'},
 501               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 502                  'key_type': 'ssh'},
 503               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 504                  'key_type': 'ssh'}],
 505    'name': 'one_s102',
 506    'slice_id': 5}
 507 >>slivername =  one_s103
 508 {  'attributes': [],
 509    'expires': normalized,
 510    'instantiation': 'plc-instantiated',
 511    'keys': [  {  'key': 'ssh-rsa 1111111111111111 user1-key1',
 512                  'key_type': 'ssh'},
 513               {  'key': 'ssh-rsa 1111111111111111 user1-key2',
 514                  'key_type': 'ssh'},
 515               {  'key': 'ssh-rsa 1111111111111111 user1-key3',
 516                  'key_type': 'ssh'},
 517               {  'key': 'ssh-rsa 1111111111111111 user1-key4',
 518                  'key_type': 'ssh'},
 519               {  'key': 'ssh-rsa 1111111111111111 user2-key1',
 520                  'key_type': 'ssh'},
 521               {  'key': 'ssh-rsa 1111111111111111 user2-key2',
 522                  'key_type': 'ssh'},
 523               {  'key': 'ssh-rsa 1111111111111111 user2-key3',
 524                  'key_type': 'ssh'},
 525               {  'key': 'ssh-rsa 1111111111111111 user2-key4',
 526                  'key_type': 'ssh'}],
 527    'name': 'one_s103',
 528    'slice_id': 6}
 529 === refresh After foreign nodes were removed on plc1
 530 +++ 259 seconds ellapsed
 531 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 0}
 532 +++ 264 seconds ellapsed
 533 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 534 +++ 269 seconds ellapsed
 535 01: local slice one_s101 (e=5)  on nodes  [16, 17, 18, 19, 20]
 536 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 537 01: local slice one_s102 (e=5)  on nodes  [16, 17, 18, 19, 20]
 538 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 539 01: local slice one_s103 (e=5)  on nodes  [16, 17, 18, 19, 20]
 540 [LOC:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 541 02: foreign slice one_s101 (e=5)  on nodes  [8, 9, 10, 6, 7]
 542 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 543 02: foreign slice one_s102 (e=5)  on nodes  [8, 9, 10, 6, 7]
 544 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 545 02: foreign slice one_s103 (e=5)  on nodes  [8, 9, 10, 6, 7]
 546 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 547 ==================== ('DELETING LOCAL NODES FROM SLICES',)
 548 01:== deleted in slice 4 local  ['n101.plc1.org', 'n102.plc1.org', 'n103.plc1.org', 'n104.plc1.org', 'n105.plc1.org']
 549 01:== deleted in slice 5 local  ['n101.plc1.org', 'n102.plc1.org', 'n103.plc1.org', 'n104.plc1.org', 'n105.plc1.org']
 550 01:== deleted in slice 6 local  ['n101.plc1.org', 'n102.plc1.org', 'n103.plc1.org', 'n104.plc1.org', 'n105.plc1.org']
 551 01: local slice one_s101 (e=0)  on nodes  []
 552 01: local slice one_s102 (e=0)  on nodes  []
 553 01: local slice one_s103 (e=0)  on nodes  []
 554 02: foreign slice one_s101 (e=5)  on nodes  [8, 9, 10, 6, 7]
 555 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 556 02: foreign slice one_s102 (e=5)  on nodes  [8, 9, 10, 6, 7]
 557 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 558 02: foreign slice one_s103 (e=5)  on nodes  [8, 9, 10, 6, 7]
 559 [FOR:5] :  n101.plc1.org  n102.plc1.org  n103.plc1.org  n104.plc1.org  n105.plc1.org
 560 === refresh After local nodes were removed on plc1
 561 +++ 287 seconds ellapsed
 562 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 0}
 563 +++ 292 seconds ellapsed
 564 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 565 +++ 297 seconds ellapsed
 566 01: local slice one_s101 (e=0)  on nodes  []
 567 01: local slice one_s102 (e=0)  on nodes  []
 568 01: local slice one_s103 (e=0)  on nodes  []
 569 02: foreign slice one_s101 (e=0)  on nodes  []
 570 02: foreign slice one_s102 (e=0)  on nodes  []
 571 02: foreign slice one_s103 (e=0)  on nodes  []
 572 ==================== ('CHECKING SLICES CLEAN UP',)
 573 01:== Cleaning all slices
 574 01:==== Cleaning slice 4
 575 01:==== Cleaning slice 5
 576 01:==== Cleaning slice 6
 577 01: Checking slices: got 2 local (e=2) & 0 foreign (e=0)
 578 02: Checking slices: got 2 local (e=2) & 3 foreign (e=3)
 579 === refresh After slices clenaup
 580 +++ 309 seconds ellapsed
 581 01:== Refreshing peer got  {'new_keys': 0, 'new_slices': 0, 'plcname': 'Thierry plc1', 'new_persons': 0, 'new_nodes': 0}
 582 +++ 315 seconds ellapsed
 583 02:== Refreshing peer got  {'new_keys': 0, 'new_slices': -3, 'plcname': 'Thierry plc2 on devbox', 'new_persons': 0, 'new_nodes': 0}
 584 +++ 320 seconds ellapsed
 585 01: Checking slices: got 2 local (e=2) & 0 foreign (e=0)
 586 02: Checking slices: got 2 local (e=2) & 0 foreign (e=0)
 587 +++ 322 seconds ellapsed