SuccessConsole Output

Skipping 59 KB.. Full Log
ame=a98f9fa3-1b44-4dd0-9b20-d482cf07c480, displayName=a98f9fa3-1b44-4dd0-9b20-d482cf07c480 displayName, mail=a98f9fa3-1b44-4dd0-9b20-d482cf07c480@mail.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991562, lastModified=null, properties={}}} to event bus
06:09:51.791 [Thread-10] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/3c04d0d1-4f75-43f7-b15c-5984fb038eea/config/users.xml
06:09:51.795 [Thread-9] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/3c04d0d1-4f75-43f7-b15c-5984fb038eea/config/users.xml
06:09:51.797 [Thread-7] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/3c04d0d1-4f75-43f7-b15c-5984fb038eea/config/users.xml
06:09:51.802 [Thread-7] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=7c4e25f5-e6f7-44e5-bee7-2e27cd794994, displayName=7c4e25f5-e6f7-44e5-bee7-2e27cd794994 displayName, mail=7c4e25f5-e6f7-44e5-bee7-2e27cd794994@mail.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991596, lastModified=null, properties={}}} to event bus
06:09:51.802 [Thread-10] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=a9272d9d-d8b9-4539-9445-f259e307ddd9, displayName=a9272d9d-d8b9-4539-9445-f259e307ddd9 displayName, mail=a9272d9d-d8b9-4539-9445-f259e307ddd9@mail.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991591, lastModified=null, properties={}}} to event bus
06:09:51.802 [Thread-9] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=28a56020-d4f8-47ab-a2fc-34fd981a2c2a, displayName=28a56020-d4f8-47ab-a2fc-34fd981a2c2a displayName, mail=28a56020-d4f8-47ab-a2fc-34fd981a2c2a@mail.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991591, lastModified=null, properties={}}} to event bus
06:09:51.888 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.user.xml.XmlUserDatabase at /tmp/523932a4-886d-47a4-a8f4-3adee2b12823/config/users.xml
06:09:51.897 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.user.xml.XmlUserDatabase from store /tmp/523932a4-886d-47a4-a8f4-3adee2b12823/config/users.xml
06:09:51.906 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/523932a4-886d-47a4-a8f4-3adee2b12823/config/users.xml
06:09:51.908 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/523932a4-886d-47a4-a8f4-3adee2b12823/config/users.xml
06:09:51.911 [main] INFO  sonia.scm.user.DefaultUserManager - create user zaphod of type xml
06:09:51.912 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991912, lastModified=null, properties={}}} to event bus
06:09:51.913 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/523932a4-886d-47a4-a8f4-3adee2b12823/config/users.xml
06:09:51.915 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991912, lastModified=null, properties={}}} to event bus
06:09:51.917 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.user.xml.XmlUserDatabase at /tmp/f800202f-00a8-4b36-8f44-ca4c5948c9c2/config/users.xml
06:09:51.926 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.user.xml.XmlUserDatabase from store /tmp/f800202f-00a8-4b36-8f44-ca4c5948c9c2/config/users.xml
06:09:51.943 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/f800202f-00a8-4b36-8f44-ca4c5948c9c2/config/users.xml
06:09:51.949 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/f800202f-00a8-4b36-8f44-ca4c5948c9c2/config/users.xml
06:09:51.952 [main] INFO  sonia.scm.user.DefaultUserManager - create user zaphod of type xml
06:09:51.953 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991953, lastModified=null, properties={}}} to event bus
06:09:51.954 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/f800202f-00a8-4b36-8f44-ca4c5948c9c2/config/users.xml
06:09:52.053 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991953, lastModified=null, properties={}}} to event bus
06:09:52.053 [main] INFO  sonia.scm.user.DefaultUserManager - delete user zaphod of type xml
06:09:52.054 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_DELETE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991953, lastModified=null, properties={}}} to event bus
06:09:52.055 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/f800202f-00a8-4b36-8f44-ca4c5948c9c2/config/users.xml
06:09:52.057 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=DELETE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908991953, lastModified=null, properties={}}} to event bus
06:09:52.060 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.user.xml.XmlUserDatabase at /tmp/8b89e2f5-9830-46c7-b330-18c0ccdf3a9e/config/users.xml
06:09:52.069 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.user.xml.XmlUserDatabase from store /tmp/8b89e2f5-9830-46c7-b330-18c0ccdf3a9e/config/users.xml
06:09:52.079 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/8b89e2f5-9830-46c7-b330-18c0ccdf3a9e/config/users.xml
06:09:52.081 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/8b89e2f5-9830-46c7-b330-18c0ccdf3a9e/config/users.xml
06:09:52.084 [main] INFO  sonia.scm.user.DefaultUserManager - create user zaphod of type xml
06:09:52.087 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992087, lastModified=null, properties={}}} to event bus
06:09:52.087 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/8b89e2f5-9830-46c7-b330-18c0ccdf3a9e/config/users.xml
06:09:52.089 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992087, lastModified=null, properties={}}} to event bus
06:09:52.090 [main] INFO  sonia.scm.user.DefaultUserManager - create user trillian of type xml
06:09:52.092 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=trillian, displayName=Tricia McMillan, mail=tricia.mcmillan@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992091, lastModified=null, properties={}}} to event bus
06:09:52.092 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/8b89e2f5-9830-46c7-b330-18c0ccdf3a9e/config/users.xml
06:09:52.099 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=trillian, displayName=Tricia McMillan, mail=tricia.mcmillan@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992091, lastModified=null, properties={}}} to event bus
06:09:52.108 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.user.xml.XmlUserDatabase at /tmp/c78b7950-5b08-4c29-be9c-7ad8e145206e/config/users.xml
06:09:52.186 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.user.xml.XmlUserDatabase from store /tmp/c78b7950-5b08-4c29-be9c-7ad8e145206e/config/users.xml
06:09:52.198 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/c78b7950-5b08-4c29-be9c-7ad8e145206e/config/users.xml
06:09:52.205 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/c78b7950-5b08-4c29-be9c-7ad8e145206e/config/users.xml
06:09:52.208 [main] INFO  sonia.scm.user.DefaultUserManager - create user zaphod of type xml
06:09:52.209 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992209, lastModified=null, properties={}}} to event bus
06:09:52.210 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/c78b7950-5b08-4c29-be9c-7ad8e145206e/config/users.xml
06:09:52.211 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992209, lastModified=null, properties={}}} to event bus
06:09:52.212 [main] INFO  sonia.scm.user.DefaultUserManager - modify user zaphod of type xml
06:09:52.217 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_MODIFY, user=User{name=zaphod, displayName=Tricia McMillan, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992209, lastModified=1383908992217, properties={}}} to event bus
06:09:52.218 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/c78b7950-5b08-4c29-be9c-7ad8e145206e/config/users.xml
06:09:52.220 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=MODIFY, user=User{name=zaphod, displayName=Tricia McMillan, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992209, lastModified=1383908992217, properties={}}} to event bus
06:09:52.225 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.user.xml.XmlUserDatabase at /tmp/8e4ea7e2-92a9-4124-b7f9-841082dcff61/config/users.xml
06:09:52.237 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.user.xml.XmlUserDatabase from store /tmp/8e4ea7e2-92a9-4124-b7f9-841082dcff61/config/users.xml
06:09:52.245 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/8e4ea7e2-92a9-4124-b7f9-841082dcff61/config/users.xml
06:09:52.247 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/8e4ea7e2-92a9-4124-b7f9-841082dcff61/config/users.xml
06:09:52.252 [main] INFO  sonia.scm.user.DefaultUserManager - create user zaphod of type xml
06:09:52.254 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992254, lastModified=null, properties={}}} to event bus
06:09:52.255 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/8e4ea7e2-92a9-4124-b7f9-841082dcff61/config/users.xml
06:09:52.256 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=zaphod, displayName=Zaphod Beeblebrox, mail=zaphod.beeblebrox@hitchhiker.com, password=(not set), admin=false, type=xml, active=true, creationDate=1383908992254, lastModified=null, properties={}}} to event bus
06:09:52.257 [main] INFO  sonia.scm.user.DefaultUserManager - create user zaphod of type xml
Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.978 sec
Running sonia.scm.upgrade.ClientDateFormatConverterTest
06:09:52.360 [main] DEBUG sonia.scm.upgrade.ClientDateFormatConverter - converted extjs date format "Y-m-d" to moments date format "YYYY-MM-DD"
06:09:52.364 [main] DEBUG sonia.scm.upgrade.ClientDateFormatConverter - converted extjs date format "H:i:s" to moments date format "HH:mm:ss"
06:09:52.369 [main] DEBUG sonia.scm.upgrade.ClientDateFormatConverter - converted extjs date format "Y-m-d H:i:s" to moments date format "YYYY-MM-DD HH:mm:ss"
06:09:52.376 [main] DEBUG sonia.scm.upgrade.ClientDateFormatConverter - converted extjs date format "Y/m/d" to moments date format "YYYY/MM/DD"
06:09:52.380 [main] DEBUG sonia.scm.upgrade.ClientDateFormatConverter - converted extjs date format "F j, Y, g:i a" to moments date format "MMMM D, YYYY, h:mm a"
06:09:52.385 [main] DEBUG sonia.scm.upgrade.ClientDateFormatConverter - converted extjs date format "Y-m-d {0}" to moments date format "YYYY-MM-DD {0}"
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.032 sec
Running sonia.scm.web.security.ChainAuthenticationManagerTest
06:09:52.607 [main] DEBUG sonia.scm.web.security.ChainAuthenticatonManager - authenticator sonia.scm.web.security.ChainAuthenticationManagerTest$SingleUserAuthenticaionHandler ends with result, user: null, state: NOT_FOUND
06:09:52.607 [main] DEBUG sonia.scm.web.security.ChainAuthenticatonManager - authenticator sonia.scm.web.security.ChainAuthenticationManagerTest$SingleUserAuthenticaionHandler ends with result, user: trillian, state: SUCCESS
06:09:52.608 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post AuthenticationEvent{user=User{name=trillian, displayName=Tricia McMillan, mail=tricia.mcmillan@hitchhiker.com, password=(is set), admin=false, type=trilliansType, active=true, creationDate=null, lastModified=null, properties={}}} to event bus
06:09:52.610 [main] DEBUG sonia.scm.web.security.ChainAuthenticatonManager - authenticator sonia.scm.web.security.ChainAuthenticationManagerTest$SingleUserAuthenticaionHandler ends with result, user: perfect, state: SUCCESS
06:09:52.611 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post AuthenticationEvent{user=User{name=perfect, displayName=Ford Prefect, mail=ford.perfect@hitchhiker.com, password=(is set), admin=false, type=perfectsType, active=true, creationDate=null, lastModified=null, properties={}}} to event bus
06:09:52.614 [main] DEBUG sonia.scm.web.security.ChainAuthenticatonManager - authenticator sonia.scm.web.security.ChainAuthenticationManagerTest$SingleUserAuthenticaionHandler ends with result, user: null, state: NOT_FOUND
06:09:52.614 [main] DEBUG sonia.scm.web.security.ChainAuthenticatonManager - authenticator sonia.scm.web.security.ChainAuthenticationManagerTest$SingleUserAuthenticaionHandler ends with result, user: null, state: FAILED
06:09:52.617 [main] DEBUG sonia.scm.web.security.ChainAuthenticatonManager - authenticator sonia.scm.web.security.ChainAuthenticationManagerTest$SingleUserAuthenticaionHandler ends with result, user: trillian, state: SUCCESS
06:09:52.617 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post AuthenticationEvent{user=User{name=trillian, displayName=Tricia McMillan, mail=tricia.mcmillan@hitchhiker.com, password=(is set), admin=false, type=a2, active=true, creationDate=null, lastModified=null, properties={}}} to event bus
06:09:52.620 [main] DEBUG sonia.scm.web.security.ChainAuthenticatonManager - authenticator sonia.scm.web.security.ChainAuthenticationManagerTest$SingleUserAuthenticaionHandler ends with result, user: null, state: NOT_FOUND
06:09:52.621 [main] DEBUG sonia.scm.web.security.ChainAuthenticatonManager - authenticator sonia.scm.web.security.ChainAuthenticationManagerTest$SingleUserAuthenticaionHandler ends with result, user: null, state: NOT_FOUND
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.232 sec
Running sonia.scm.web.security.DefaultAuthenticationHandlerTest
06:09:52.634 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.user.xml.XmlUserDatabase at /tmp/9563637d-38d8-4e69-8b5b-b2d21caa8021/config/users.xml
06:09:52.717 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.user.xml.XmlUserDatabase from store /tmp/9563637d-38d8-4e69-8b5b-b2d21caa8021/config/users.xml
06:09:52.727 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/9563637d-38d8-4e69-8b5b-b2d21caa8021/config/users.xml
06:09:52.729 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/9563637d-38d8-4e69-8b5b-b2d21caa8021/config/users.xml
06:09:52.730 [main] INFO  sonia.scm.user.DefaultUserManager - create user slarti of type xml
06:09:52.732 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=slarti, displayName=Slartibartfaß, mail=slartibartfass@hitchhiker.com, password=(is set), admin=false, type=xml, active=true, creationDate=1383908992732, lastModified=null, properties={}}} to event bus
06:09:52.733 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/9563637d-38d8-4e69-8b5b-b2d21caa8021/config/users.xml
06:09:52.734 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=slarti, displayName=Slartibartfaß, mail=slartibartfass@hitchhiker.com, password=(is set), admin=false, type=xml, active=true, creationDate=1383908992732, lastModified=null, properties={}}} to event bus
06:09:52.738 [main] DEBUG sonia.scm.web.security.DefaultAuthenticationHandler - user slarti successfully prepared for login
06:09:52.741 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.user.xml.XmlUserDatabase at /tmp/aa2df47c-c13a-41be-a773-bea7f0a8ac2d/config/users.xml
06:09:52.752 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.user.xml.XmlUserDatabase from store /tmp/aa2df47c-c13a-41be-a773-bea7f0a8ac2d/config/users.xml
06:09:52.766 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/aa2df47c-c13a-41be-a773-bea7f0a8ac2d/config/users.xml
06:09:52.768 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/aa2df47c-c13a-41be-a773-bea7f0a8ac2d/config/users.xml
06:09:52.769 [main] INFO  sonia.scm.user.DefaultUserManager - create user slarti of type xml
06:09:52.833 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=slarti, displayName=Slartibartfaß, mail=slartibartfass@hitchhiker.com, password=(is set), admin=false, type=xml, active=true, creationDate=1383908992833, lastModified=null, properties={}}} to event bus
06:09:52.833 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/aa2df47c-c13a-41be-a773-bea7f0a8ac2d/config/users.xml
06:09:52.835 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=slarti, displayName=Slartibartfaß, mail=slartibartfass@hitchhiker.com, password=(is set), admin=false, type=xml, active=true, creationDate=1383908992833, lastModified=null, properties={}}} to event bus
06:09:52.837 [main] DEBUG sonia.scm.web.security.DefaultAuthenticationHandler - password for user slarti is wrong
06:09:52.839 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.user.xml.XmlUserDatabase at /tmp/0ead7504-91d0-4945-9da4-7238ba99dd99/config/users.xml
06:09:52.848 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.user.xml.XmlUserDatabase from store /tmp/0ead7504-91d0-4945-9da4-7238ba99dd99/config/users.xml
06:09:52.857 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/0ead7504-91d0-4945-9da4-7238ba99dd99/config/users.xml
06:09:52.863 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/0ead7504-91d0-4945-9da4-7238ba99dd99/config/users.xml
06:09:52.864 [main] INFO  sonia.scm.user.DefaultUserManager - create user slarti of type xml
06:09:52.865 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=BEFORE_CREATE, user=User{name=slarti, displayName=Slartibartfaß, mail=slartibartfass@hitchhiker.com, password=(is set), admin=false, type=xml, active=true, creationDate=1383908992865, lastModified=null, properties={}}} to event bus
06:09:52.867 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.user.xml.XmlUserDatabase to /tmp/0ead7504-91d0-4945-9da4-7238ba99dd99/config/users.xml
06:09:52.870 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=slarti, displayName=Slartibartfaß, mail=slartibartfass@hitchhiker.com, password=(is set), admin=false, type=xml, active=true, creationDate=1383908992865, lastModified=null, properties={}}} to event bus
06:09:52.870 [main] DEBUG sonia.scm.web.security.DefaultAuthenticationHandler - could not find user notSlarti
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.248 sec
Running sonia.scm.cache.GuavaCacheManagerTest
06:09:52.885 [main] DEBUG sonia.scm.cache.GuavaCacheManager - cache test-1 does not exists, creating a new instance from default configuration: GuavaCacheConfiguration{}
06:09:52.953 [main] INFO  sonia.scm.cache.GuavaCacheManager - close guava cache manager
06:09:52.953 [main] DEBUG sonia.scm.cache.GuavaCache - clear cache test-1
06:09:52.958 [pool-7-thread-1] DEBUG sonia.scm.cache.GuavaCacheManager - cache test-2 does not exists, creating a new instance from default configuration: GuavaCacheConfiguration{}
06:09:52.962 [main] INFO  sonia.scm.cache.GuavaCacheManager - close guava cache manager
06:09:52.962 [main] DEBUG sonia.scm.cache.GuavaCache - clear cache test-2
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.083 sec
Running sonia.scm.cache.GuavaCacheTest
06:09:52.969 [main] DEBUG sonia.scm.cache.GuavaCacheManager - cache test does not exists, creating a new instance from default configuration: GuavaCacheConfiguration{}
06:09:52.969 [main] DEBUG sonia.scm.cache.GuavaCache - clear cache test
06:09:52.974 [main] INFO  sonia.scm.cache.GuavaCacheManager - close guava cache manager
06:09:52.974 [main] DEBUG sonia.scm.cache.GuavaCache - clear cache test
06:09:52.975 [main] DEBUG sonia.scm.cache.GuavaCacheManager - cache test does not exists, creating a new instance from default configuration: GuavaCacheConfiguration{}
06:09:52.976 [main] INFO  sonia.scm.cache.GuavaCacheManager - close guava cache manager
06:09:52.977 [main] DEBUG sonia.scm.cache.GuavaCache - clear cache test
06:09:52.978 [main] DEBUG sonia.scm.cache.GuavaCacheManager - cache test does not exists, creating a new instance from default configuration: GuavaCacheConfiguration{}
06:09:52.979 [main] INFO  sonia.scm.cache.GuavaCacheManager - close guava cache manager
06:09:52.979 [main] DEBUG sonia.scm.cache.GuavaCache - clear cache test
06:09:52.981 [main] DEBUG sonia.scm.cache.GuavaCacheManager - cache test does not exists, creating a new instance from default configuration: GuavaCacheConfiguration{}
06:09:52.981 [main] INFO  sonia.scm.cache.GuavaCacheManager - close guava cache manager
06:09:52.982 [main] DEBUG sonia.scm.cache.GuavaCache - clear cache test
06:09:52.983 [main] DEBUG sonia.scm.cache.GuavaCacheManager - cache test does not exists, creating a new instance from default configuration: GuavaCacheConfiguration{}
06:09:52.988 [main] INFO  sonia.scm.cache.GuavaCacheManager - close guava cache manager
06:09:52.988 [main] DEBUG sonia.scm.cache.GuavaCache - clear cache test
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.022 sec
Running sonia.scm.cache.EhCacheManagerTest
06:09:53.091 [main] WARN  net.sf.ehcache.config.ConfigurationFactory - No configuration found. Configuring ehcache from ehcache-failsafe.xml  found in the classpath: jar:file:/scratch/jenkins/workspace/scm-manager/.repository/net/sf/ehcache/ehcache-core/2.6.6/ehcache-core-2.6.6.jar!/ehcache-failsafe.xml
06:09:53.469 [main] WARN  sonia.scm.cache.EhCacheManager - could not find cache test-1, create new from defaults
06:09:53.674 [main] WARN  net.sf.ehcache.config.ConfigurationFactory - No configuration found. Configuring ehcache from ehcache-failsafe.xml  found in the classpath: jar:file:/scratch/jenkins/workspace/scm-manager/.repository/net/sf/ehcache/ehcache-core/2.6.6/ehcache-core-2.6.6.jar!/ehcache-failsafe.xml
06:09:53.918 [pool-8-thread-1] WARN  sonia.scm.cache.EhCacheManager - could not find cache test-2, create new from defaults
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.936 sec
Running sonia.scm.cache.GuavaCacheCopyTest
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
Running sonia.scm.cache.EhCacheTest
06:09:53.947 [main] WARN  net.sf.ehcache.config.ConfigurationFactory - No configuration found. Configuring ehcache from ehcache-failsafe.xml  found in the classpath: jar:file:/scratch/jenkins/workspace/scm-manager/.repository/net/sf/ehcache/ehcache-core/2.6.6/ehcache-core-2.6.6.jar!/ehcache-failsafe.xml
06:09:53.966 [main] WARN  sonia.scm.cache.EhCacheManager - could not find cache test, create new from defaults
06:09:54.072 [main] DEBUG sonia.scm.cache.EhCache - clear cache test
06:09:54.090 [main] WARN  net.sf.ehcache.config.ConfigurationFactory - No configuration found. Configuring ehcache from ehcache-failsafe.xml  found in the classpath: jar:file:/scratch/jenkins/workspace/scm-manager/.repository/net/sf/ehcache/ehcache-core/2.6.6/ehcache-core-2.6.6.jar!/ehcache-failsafe.xml
06:09:54.175 [main] WARN  sonia.scm.cache.EhCacheManager - could not find cache test, create new from defaults
06:09:54.188 [main] WARN  net.sf.ehcache.config.ConfigurationFactory - No configuration found. Configuring ehcache from ehcache-failsafe.xml  found in the classpath: jar:file:/scratch/jenkins/workspace/scm-manager/.repository/net/sf/ehcache/ehcache-core/2.6.6/ehcache-core-2.6.6.jar!/ehcache-failsafe.xml
06:09:54.194 [main] WARN  sonia.scm.cache.EhCacheManager - could not find cache test, create new from defaults
06:09:54.204 [main] WARN  net.sf.ehcache.config.ConfigurationFactory - No configuration found. Configuring ehcache from ehcache-failsafe.xml  found in the classpath: jar:file:/scratch/jenkins/workspace/scm-manager/.repository/net/sf/ehcache/ehcache-core/2.6.6/ehcache-core-2.6.6.jar!/ehcache-failsafe.xml
06:09:54.275 [main] WARN  sonia.scm.cache.EhCacheManager - could not find cache test, create new from defaults
06:09:54.284 [main] WARN  net.sf.ehcache.config.ConfigurationFactory - No configuration found. Configuring ehcache from ehcache-failsafe.xml  found in the classpath: jar:file:/scratch/jenkins/workspace/scm-manager/.repository/net/sf/ehcache/ehcache-core/2.6.6/ehcache-core-2.6.6.jar!/ehcache-failsafe.xml
06:09:54.296 [main] WARN  sonia.scm.cache.EhCacheManager - could not find cache test, create new from defaults
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.363 sec
Running sonia.scm.cache.GuavaConfigurationReaderTest
06:09:54.401 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.001.xml
06:09:54.409 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.002.xml
06:09:54.412 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.003.xml
06:09:54.434 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/tmp/junit1823684121709077994/junit992765714662074202.tmp
06:09:54.518 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.001.xml
06:09:54.525 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - no module configuration found
06:09:54.527 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/tmp/junit4493652175345561998/junit6811744880899969119.tmp
06:09:54.540 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.002.xml
06:09:54.542 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - no module configuration found
06:09:54.572 [main] WARN  sonia.scm.cache.GuavaCacheConfigurationReader - could not find manual configuration at Mock for File, hashCode: 593348385
06:09:54.647 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.001.xml
06:09:54.654 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - no module configuration found
06:09:54.654 [main] WARN  sonia.scm.cache.GuavaCacheConfigurationReader - could not find manual configuration at Mock for File, hashCode: 1931494437
06:09:54.666 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.001.xml
06:09:54.673 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.002.xml
06:09:54.677 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.003.xml
06:09:54.684 [main] WARN  sonia.scm.cache.GuavaCacheConfigurationReader - could not find manual configuration at Mock for File, hashCode: 595847525
06:09:54.755 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - read cache configuration from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/gcache.001.xml
06:09:54.758 [main] DEBUG sonia.scm.cache.GuavaCacheConfigurationReader - no module configuration found
06:09:54.758 [main] WARN  sonia.scm.cache.GuavaCacheConfigurationReader - could not find manual configuration at Mock for File, hashCode: 1746180017
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.448 sec
Running sonia.scm.cache.EhConfigurationReaderTest
06:09:54.793 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.001.xml
06:09:55.004 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.002.xml
06:09:55.006 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.003.xml
06:09:55.007 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/tmp/junit2972006382284173234/junit3928768759553562405.tmp
06:09:55.159 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.001.xml
06:09:55.165 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/tmp/junit2561474916757644912/junit3215027520863335013.tmp
06:09:55.241 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.006.xml
06:09:55.243 [main] WARN  sonia.scm.cache.EhCacheConfigurationReader - could not find manual configuration at Mock for File, hashCode: 1491989704
06:09:55.250 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.001.xml
06:09:55.252 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.005.xml
06:09:55.254 [main] WARN  sonia.scm.cache.EhCacheConfigurationReader - could not find manual configuration at Mock for File, hashCode: 1819949616
06:09:55.264 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.001.xml
06:09:55.267 [main] WARN  sonia.scm.cache.EhCacheConfigurationReader - could not find manual configuration at Mock for File, hashCode: 2096818063
06:09:55.281 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.006.xml
06:09:55.284 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/tmp/junit894322663221735856/junit8089175637919191056.tmp
06:09:55.359 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.001.xml
06:09:55.361 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.002.xml
06:09:55.362 [main] DEBUG sonia.scm.cache.EhCacheConfigurationReader - read cache configuration from url file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/test-classes/sonia/scm/cache/ehcache.003.xml
06:09:55.364 [main] WARN  sonia.scm.cache.EhCacheConfigurationReader - could not find manual configuration at Mock for File, hashCode: 312798617
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.609 sec
Running sonia.scm.cache.EhCacheCopyTest
06:09:55.376 [main] WARN  net.sf.ehcache.config.ConfigurationFactory - No configuration found. Configuring ehcache from ehcache-failsafe.xml  found in the classpath: jar:file:/scratch/jenkins/workspace/scm-manager/.repository/net/sf/ehcache/ehcache-core/2.6.6/ehcache-core-2.6.6.jar!/ehcache-failsafe.xml
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 sec
Running sonia.scm.repository.DefaultRepositoryManagerTest
06:09:55.487 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/dummy.xml
06:09:55.500 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/hg.xml
06:09:55.503 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/git.xml
06:09:55.508 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/repositories.xml
06:09:55.530 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/repositories.xml
06:09:55.597 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:55.597 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.598 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/git.xml
06:09:55.600 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:55.600 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/git.xml
06:09:55.601 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:55.602 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.602 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/hg.xml
06:09:55.604 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:55.604 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/hg.xml
06:09:55.605 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:55.606 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.606 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/dummy.xml
06:09:55.608 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:55.608 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/dummy.xml
06:09:55.611 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/dummy.xml
06:09:55.616 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/hg.xml
06:09:55.619 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/git.xml
06:09:55.623 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/repositories.xml
06:09:55.633 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/repositories.xml
06:09:55.634 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:55.634 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.635 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/dummy.xml
06:09:55.639 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:55.639 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.639 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/hg.xml
06:09:55.642 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:55.643 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.643 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/git.xml
06:09:55.647 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository scm of type hg
06:09:55.715 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/d48a975a-fcfc-4628-9865-2d276b655992/repositories/hg/scm
06:09:55.717 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=2nOMb76w71, name=scm, contact=null, description=null, publicReadable=false, archived=false, permissions=null, type=hg, url=null, lastModified=null, creationDate=1383908995715, properties={}}} to event bus
06:09:55.718 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/repositories.xml
06:09:55.720 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=2nOMb76w71, name=scm, contact=null, description=null, publicReadable=false, archived=false, permissions=null, type=hg, url=null, lastModified=null, creationDate=1383908995715, properties={}}} to event bus
06:09:55.720 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository scm-test of type hg
06:09:55.722 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/d48a975a-fcfc-4628-9865-2d276b655992/repositories/hg/scm-test
06:09:55.722 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=1vOMb76wE2, name=scm-test, contact=null, description=null, publicReadable=false, archived=false, permissions=null, type=hg, url=null, lastModified=null, creationDate=1383908995722, properties={}}} to event bus
06:09:55.723 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/repositories.xml
06:09:55.725 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=1vOMb76wE2, name=scm-test, contact=null, description=null, publicReadable=false, archived=false, permissions=null, type=hg, url=null, lastModified=null, creationDate=1383908995722, properties={}}} to event bus
06:09:55.725 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository project1/test-1 of type git
06:09:55.727 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/d48a975a-fcfc-4628-9865-2d276b655992/repositories/git/project1/test-1
06:09:55.728 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=ChOMb76wJ3, name=project1/test-1, contact=null, description=null, publicReadable=false, archived=false, permissions=null, type=git, url=null, lastModified=null, creationDate=1383908995727, properties={}}} to event bus
06:09:55.729 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/repositories.xml
06:09:55.731 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=ChOMb76wJ3, name=project1/test-1, contact=null, description=null, publicReadable=false, archived=false, permissions=null, type=git, url=null, lastModified=null, creationDate=1383908995727, properties={}}} to event bus
06:09:55.731 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository project1/test-2 of type git
06:09:55.733 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/d48a975a-fcfc-4628-9865-2d276b655992/repositories/git/project1/test-2
06:09:55.733 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=33OMb76wP4, name=project1/test-2, contact=null, description=null, publicReadable=false, archived=false, permissions=null, type=git, url=null, lastModified=null, creationDate=1383908995733, properties={}}} to event bus
06:09:55.734 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/d48a975a-fcfc-4628-9865-2d276b655992/config/repositories.xml
06:09:55.741 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=33OMb76wP4, name=project1/test-2, contact=null, description=null, publicReadable=false, archived=false, permissions=null, type=git, url=null, lastModified=null, creationDate=1383908995733, properties={}}} to event bus
06:09:55.745 [main] DEBUG sonia.scm.repository.DefaultRepositoryManager - could not find repository with type git and uri project1/test-3/ka/some/path
06:09:55.748 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/dummy.xml
06:09:55.757 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/hg.xml
06:09:55.763 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/git.xml
06:09:55.836 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/repositories.xml
06:09:55.846 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/repositories.xml
06:09:55.846 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:55.847 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.848 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/hg.xml
06:09:55.849 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:55.850 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/hg.xml
06:09:55.851 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:55.852 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.852 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/dummy.xml
06:09:55.853 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:55.854 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/dummy.xml
06:09:55.854 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:55.855 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.856 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/git.xml
06:09:55.856 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:55.858 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/36b57cc8-a995-43be-9a28-7286c832ed82/config/git.xml
06:09:55.861 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - delete repository HeartOfGold of type dummy
06:09:55.864 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/dummy.xml
06:09:55.870 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/hg.xml
06:09:55.883 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/git.xml
06:09:55.891 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/repositories.xml
06:09:55.914 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/repositories.xml
06:09:55.915 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:55.916 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.918 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/git.xml
06:09:55.918 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:55.920 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/git.xml
06:09:55.920 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:55.922 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:55.922 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/dummy.xml
06:09:56.014 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.015 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/dummy.xml
06:09:56.015 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:56.017 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.018 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/hg.xml
06:09:56.018 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.019 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/65bf9ac3-5e9a-47b0-bc77-5630cfdd8c02/config/hg.xml
06:09:56.024 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/dummy.xml
06:09:56.030 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/hg.xml
06:09:56.035 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/git.xml
06:09:56.046 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/repositories.xml
06:09:56.064 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/repositories.xml
06:09:56.066 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:56.067 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.068 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/git.xml
06:09:56.068 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.070 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/git.xml
06:09:56.071 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:56.072 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.073 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/dummy.xml
06:09:56.074 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.076 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/dummy.xml
06:09:56.076 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:56.077 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.079 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/hg.xml
06:09:56.079 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.080 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/hg.xml
06:09:56.088 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/dummy.xml
06:09:56.096 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/hg.xml
06:09:56.212 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/git.xml
06:09:56.217 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/repositories.xml
06:09:56.234 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/repositories.xml
06:09:56.235 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:56.235 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.235 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/git.xml
06:09:56.239 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:56.239 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.240 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/dummy.xml
06:09:56.243 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:56.243 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.243 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/hg.xml
06:09:56.247 [main] DEBUG sonia.scm.repository.AbstractRepositoryManager - register PRE_RECEIVE hook class sonia.scm.repository.RepositoryManagerTestBase$CountingReceiveHook
06:09:56.247 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:56.249 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/repositories/dummy/HeartOfGold
06:09:56.250 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=D4OMb774i1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996248, properties={}}} to event bus
06:09:56.251 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/f63a2c0c-8b54-4fb7-b9cb-fd111de39d8f/config/repositories.xml
06:09:56.314 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=D4OMb774i1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996248, properties={}}} to event bus
06:09:56.319 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post sonia.scm.repository.PreReceiveRepositoryHookEvent@74914a0a to event bus
06:09:56.320 [main] DEBUG sonia.scm.repository.DefaultRepositoryManager - execute PRE_RECEIVE hook sonia.scm.repository.RepositoryManagerTestBase$CountingReceiveHook for repository HeartOfGold
06:09:56.320 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post sonia.scm.repository.PreReceiveRepositoryHookEvent@7220b722 to event bus
06:09:56.321 [main] DEBUG sonia.scm.repository.DefaultRepositoryManager - execute PRE_RECEIVE hook sonia.scm.repository.RepositoryManagerTestBase$CountingReceiveHook for repository HeartOfGold
06:09:56.324 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/dummy.xml
06:09:56.329 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/hg.xml
06:09:56.333 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/git.xml
06:09:56.338 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/repositories.xml
06:09:56.355 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/repositories.xml
06:09:56.355 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:56.356 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.356 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/hg.xml
06:09:56.357 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.359 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/hg.xml
06:09:56.360 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:56.361 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.361 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/dummy.xml
06:09:56.363 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.364 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/dummy.xml
06:09:56.364 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:56.366 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.366 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/git.xml
06:09:56.368 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.369 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/git.xml
06:09:56.372 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:56.372 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/repositories/dummy/HeartOfGold
06:09:56.440 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=6aOMb776i1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996372, properties={}}} to event bus
06:09:56.440 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/f0ebbd9e-91ab-4cb3-a312-ec628fe6f933/config/repositories.xml
06:09:56.441 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=6aOMb776i1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996372, properties={}}} to event bus
06:09:56.446 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/dummy.xml
06:09:56.461 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/hg.xml
06:09:56.469 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/git.xml
06:09:56.488 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/repositories.xml
06:09:56.588 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/repositories.xml
06:09:56.589 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:56.590 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.590 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/hg.xml
06:09:56.591 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.594 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/hg.xml
06:09:56.595 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:56.596 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.597 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/dummy.xml
06:09:56.599 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.599 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/dummy.xml
06:09:56.601 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:56.601 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.602 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/git.xml
06:09:56.605 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.605 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/git.xml
06:09:56.610 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/dummy.xml
06:09:56.682 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/hg.xml
06:09:56.691 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/git.xml
06:09:56.701 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/repositories.xml
06:09:56.714 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/repositories.xml
06:09:56.714 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:56.715 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.715 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/git.xml
06:09:56.719 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:56.719 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.719 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/hg.xml
06:09:56.722 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:56.723 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.723 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/dummy.xml
06:09:56.726 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:56.727 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/repositories/dummy/HeartOfGold
06:09:56.728 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=9LOMb77CR1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996727, properties={}}} to event bus
06:09:56.729 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/c2dd4115-541f-430e-ad93-7427ba1bde0f/config/repositories.xml
06:09:56.730 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=9LOMb77CR1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996727, properties={}}} to event bus
06:09:56.731 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - delete repository HeartOfGold of type dummy
06:09:56.796 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/dummy.xml
06:09:56.800 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/hg.xml
06:09:56.805 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/git.xml
06:09:56.809 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/repositories.xml
06:09:56.818 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/repositories.xml
06:09:56.818 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:56.819 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.819 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/git.xml
06:09:56.821 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.822 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/git.xml
06:09:56.822 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:56.823 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.824 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/dummy.xml
06:09:56.825 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.825 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/dummy.xml
06:09:56.826 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:56.827 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:56.827 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/hg.xml
06:09:56.829 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:56.829 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/hg.xml
06:09:56.832 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:56.833 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/repositories/dummy/HeartOfGold
06:09:56.833 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=2FOMb77E81, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996832, properties={}}} to event bus
06:09:56.834 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/repositories.xml
06:09:56.835 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=2FOMb77E81, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996832, properties={}}} to event bus
06:09:56.836 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/dummy.xml
06:09:56.844 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/hg.xml
06:09:56.848 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/git.xml
06:09:57.065 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/repositories.xml
06:09:57.089 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/repositories.xml
06:09:57.153 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:57.154 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.154 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/git.xml
06:09:57.157 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:57.158 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.158 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/hg.xml
06:09:57.161 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:57.161 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.162 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/dummy.xml
06:09:57.165 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - delete repository HeartOfGold of type dummy
06:09:57.165 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_DELETE, repository=Repository{id=2FOMb77E81, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=true, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996832, properties={}}} to event bus
06:09:57.166 [main] INFO  sonia.scm.io.DefaultFileSystem - destroy directory /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/repositories/dummy/HeartOfGold
06:09:57.167 [main] WARN  sonia.scm.repository.AbstractSimpleRepositoryHandler - directory /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/repositories/dummy is not a child of /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/repositories/dummy
06:09:57.168 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/34cbaf58-3952-497d-88f0-8bd31a4f2f4e/config/repositories.xml
06:09:57.169 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=DELETE, repository=Repository{id=2FOMb77E81, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=true, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908996832, properties={}}} to event bus
06:09:57.172 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/dummy.xml
06:09:57.176 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/hg.xml
06:09:57.180 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/git.xml
06:09:57.185 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/repositories.xml
06:09:57.198 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/repositories.xml
06:09:57.202 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:57.202 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.202 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/hg.xml
06:09:57.203 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.204 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/hg.xml
06:09:57.205 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:57.206 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.207 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/git.xml
06:09:57.209 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.209 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/git.xml
06:09:57.210 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:57.211 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.211 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/dummy.xml
06:09:57.213 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.274 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/c3f0b3df-6f37-4bc2-b521-cc77a0a5f67a/config/dummy.xml
06:09:57.276 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - modify repository HeartOfGold of type dummy
06:09:57.279 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/dummy.xml
06:09:57.283 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/hg.xml
06:09:57.287 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/git.xml
06:09:57.292 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/repositories.xml
06:09:57.301 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/repositories.xml
06:09:57.301 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:57.301 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.302 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/git.xml
06:09:57.303 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.304 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/git.xml
06:09:57.305 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:57.306 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.306 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/hg.xml
06:09:57.306 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.307 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/hg.xml
06:09:57.307 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:57.308 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.308 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/dummy.xml
06:09:57.308 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.309 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/dummy.xml
06:09:57.311 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:57.315 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/repositories/dummy/HeartOfGold
06:09:57.315 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=4EOMb77Lv1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997315, properties={}}} to event bus
06:09:57.316 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/340bcecf-05a6-49f8-8fac-b1781b81d939/config/repositories.xml
06:09:57.317 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=4EOMb77Lv1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997315, properties={}}} to event bus
06:09:57.321 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/dummy.xml
06:09:57.436 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/hg.xml
06:09:57.447 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/git.xml
06:09:57.517 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/repositories.xml
06:09:57.537 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/repositories.xml
06:09:57.538 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:57.538 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.539 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/git.xml
06:09:57.541 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.541 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/git.xml
06:09:57.542 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:57.544 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.544 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/hg.xml
06:09:57.545 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.548 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/hg.xml
06:09:57.549 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:57.551 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.551 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/dummy.xml
06:09:57.552 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.553 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/dummy.xml
06:09:57.558 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:57.559 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/repositories/dummy/HeartOfGold
06:09:57.561 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=1nOMb77Pr1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997559, properties={}}} to event bus
06:09:57.561 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/b23cc19e-93ec-46a5-acc3-3618966ba7b9/config/repositories.xml
06:09:57.564 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=1nOMb77Pr1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997559, properties={}}} to event bus
06:09:57.569 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/e18ca927-8794-4170-b06a-93591487b109/config/dummy.xml
06:09:57.637 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/e18ca927-8794-4170-b06a-93591487b109/config/hg.xml
06:09:57.641 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/e18ca927-8794-4170-b06a-93591487b109/config/git.xml
06:09:57.645 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/e18ca927-8794-4170-b06a-93591487b109/config/repositories.xml
06:09:57.654 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/e18ca927-8794-4170-b06a-93591487b109/config/repositories.xml
06:09:57.655 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:57.655 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.656 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/e18ca927-8794-4170-b06a-93591487b109/config/hg.xml
06:09:57.657 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.658 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/e18ca927-8794-4170-b06a-93591487b109/config/hg.xml
06:09:57.659 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:57.659 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.660 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/e18ca927-8794-4170-b06a-93591487b109/config/dummy.xml
06:09:57.661 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.661 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/e18ca927-8794-4170-b06a-93591487b109/config/dummy.xml
06:09:57.662 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:57.663 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.663 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/e18ca927-8794-4170-b06a-93591487b109/config/git.xml
06:09:57.665 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.665 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/e18ca927-8794-4170-b06a-93591487b109/config/git.xml
06:09:57.668 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:57.669 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/e18ca927-8794-4170-b06a-93591487b109/repositories/dummy/HeartOfGold
06:09:57.670 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=3TOMb77Rc1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997669, properties={}}} to event bus
06:09:57.671 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/e18ca927-8794-4170-b06a-93591487b109/config/repositories.xml
06:09:57.672 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=3TOMb77Rc1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997669, properties={}}} to event bus
06:09:57.673 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - delete repository HeartOfGold of type dummy
06:09:57.674 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_DELETE, repository=Repository{id=3TOMb77Rc1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997669, properties={}}} to event bus
06:09:57.674 [main] INFO  sonia.scm.io.DefaultFileSystem - destroy directory /tmp/e18ca927-8794-4170-b06a-93591487b109/repositories/dummy/HeartOfGold
06:09:57.675 [main] WARN  sonia.scm.repository.AbstractSimpleRepositoryHandler - directory /tmp/e18ca927-8794-4170-b06a-93591487b109/repositories/dummy is not a child of /tmp/e18ca927-8794-4170-b06a-93591487b109/repositories/dummy
06:09:57.676 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/e18ca927-8794-4170-b06a-93591487b109/config/repositories.xml
06:09:57.677 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=DELETE, repository=Repository{id=3TOMb77Rc1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997669, properties={}}} to event bus
06:09:57.680 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/dummy.xml
06:09:57.684 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/hg.xml
06:09:57.688 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/git.xml
06:09:57.754 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/repositories.xml
06:09:57.763 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/repositories.xml
06:09:57.764 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:57.764 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.765 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/dummy.xml
06:09:57.766 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.767 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/dummy.xml
06:09:57.768 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:57.769 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.769 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/hg.xml
06:09:57.770 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.771 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/hg.xml
06:09:57.772 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:57.772 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.773 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/git.xml
06:09:57.774 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.775 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/git.xml
06:09:57.777 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:57.778 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/repositories/dummy/HeartOfGold
06:09:57.779 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=5UOMb77TO1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997778, properties={}}} to event bus
06:09:57.780 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/repositories.xml
06:09:57.781 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=5UOMb77TO1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997778, properties={}}} to event bus
06:09:57.782 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository happyVerticalPeopleTransporter of type dummy
06:09:57.783 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/repositories/dummy/happyVerticalPeopleTransporter
06:09:57.784 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=9BOMb77TT2, name=happyVerticalPeopleTransporter, contact=zaphod.beeblebrox@hitchhiker.com, description=Happy Vertical People Transporter, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997783, properties={}}} to event bus
06:09:57.785 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/b9f4aaea-b348-47e4-a512-8c78a98e5efb/config/repositories.xml
06:09:57.787 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=9BOMb77TT2, name=happyVerticalPeopleTransporter, contact=zaphod.beeblebrox@hitchhiker.com, description=Happy Vertical People Transporter, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997783, properties={}}} to event bus
06:09:57.790 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/dummy.xml
06:09:57.800 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/hg.xml
06:09:57.808 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/git.xml
06:09:57.877 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/repositories.xml
06:09:57.886 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/repositories.xml
06:09:57.887 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:57.887 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.888 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/hg.xml
06:09:57.889 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.889 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/hg.xml
06:09:57.891 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:57.891 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.892 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/git.xml
06:09:57.893 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.893 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/git.xml
06:09:57.894 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:57.895 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:57.895 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/dummy.xml
06:09:57.896 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:57.897 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/dummy.xml
06:09:57.900 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:57.901 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/repositories/dummy/HeartOfGold
06:09:57.902 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=AbOMb77VN1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997901, properties={}}} to event bus
06:09:57.902 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/repositories.xml
06:09:57.904 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=AbOMb77VN1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997901, properties={}}} to event bus
06:09:57.905 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - modify repository HeartOfGold of type dummy
06:09:57.906 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_MODIFY, repository=Repository{id=AbOMb77VN1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=prototype ship, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908997901, properties={}}} to event bus
06:09:57.907 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/342fa4ae-14e1-458e-8321-8d36cbc604ab/config/repositories.xml
06:09:57.908 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=MODIFY, repository=Repository{id=AbOMb77VN1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=prototype ship, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=1383908997907, creationDate=1383908997901, properties={}}} to event bus
06:09:57.911 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/dummy.xml
06:09:57.915 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/hg.xml
06:09:57.920 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/git.xml
06:09:57.927 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/repositories.xml
06:09:58.143 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/repositories.xml
06:09:58.143 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:58.144 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.145 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/git.xml
06:09:58.147 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:58.148 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/git.xml
06:09:58.149 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:58.149 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.151 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/dummy.xml
06:09:58.151 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:58.152 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/dummy.xml
06:09:58.154 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:58.154 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.155 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/hg.xml
06:09:58.156 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:58.157 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/hg.xml
06:09:58.161 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:58.163 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/repositories/dummy/HeartOfGold
06:09:58.164 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=CkOMb77Za1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908998163, properties={}}} to event bus
06:09:58.166 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/7d688665-dad5-4a83-8db2-2063990bba8b/config/repositories.xml
06:09:58.167 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=CkOMb77Za1, name=HeartOfGold, contact=zaphod.beeblebrox@hitchhiker.com, description=Heart of Gold is the first prototype ship to successfully utilise the revolutionary Infinite Improbability Drive, publicReadable=false, archived=false, permissions=null, type=dummy, url=http://hitchhiker.com/dummy/HeartOfGold, lastModified=null, creationDate=1383908998163, properties={}}} to event bus
06:09:58.170 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository HeartOfGold of type dummy
06:09:58.234 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/dummy.xml
06:09:58.238 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/hg.xml
06:09:58.242 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/git.xml
06:09:58.247 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/repositories.xml
06:09:58.264 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/repositories.xml
06:09:58.264 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:58.265 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.265 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/git.xml
06:09:58.267 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:58.267 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/git.xml
06:09:58.268 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:58.269 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.269 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/dummy.xml
06:09:58.270 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:58.271 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/dummy.xml
06:09:58.271 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:58.272 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.273 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/hg.xml
06:09:58.274 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - store config
06:09:58.274 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.SimpleRepositoryConfig to /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/hg.xml
06:09:58.277 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/dummy.xml
06:09:58.281 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/hg.xml
06:09:58.290 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.SimpleRepositoryConfig at /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/git.xml
06:09:58.356 [main] DEBUG sonia.scm.store.JAXBStoreFactory - create store for sonia.scm.repository.xml.XmlRepositoryDatabase at /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/repositories.xml
06:09:58.365 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.xml.XmlRepositoryDatabase from store /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/repositories.xml
06:09:58.366 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$2 for type Type{name=git, displayName=Git}
06:09:58.366 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.367 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/git.xml
06:09:58.370 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DummyRepositoryHandler for type Type{name=dummy, displayName=Dummy}
06:09:58.370 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.370 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/dummy.xml
06:09:58.373 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - added RepositoryHandler class sonia.scm.repository.DefaultRepositoryManagerTest$1 for type Type{name=hg, displayName=Mercurial}
06:09:58.374 [main] DEBUG sonia.scm.repository.AbstractRepositoryHandler - load config from store
06:09:58.374 [main] DEBUG sonia.scm.store.JAXBStore - load class sonia.scm.repository.SimpleRepositoryConfig from store /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/hg.xml
06:09:58.378 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - create repository 42Puzzle of type dummy
06:09:58.379 [main] INFO  sonia.scm.io.DefaultFileSystem - create directory /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/repositories/dummy/42Puzzle
06:09:58.380 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_CREATE, repository=Repository{id=EXOMb77d51, name=42Puzzle, contact=douglas.adams@hitchhiker.com, description=The 42 Puzzle, publicReadable=false, archived=false, permissions=null, type=dummy, url=null, lastModified=null, creationDate=1383908998379, properties={}}} to event bus
06:09:58.381 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/repositories.xml
06:09:58.382 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=CREATE, repository=Repository{id=EXOMb77d51, name=42Puzzle, contact=douglas.adams@hitchhiker.com, description=The 42 Puzzle, publicReadable=false, archived=false, permissions=null, type=dummy, url=null, lastModified=null, creationDate=1383908998379, properties={}}} to event bus
06:09:58.383 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - modify repository 42Puzzle of type dummy
06:09:58.384 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_MODIFY, repository=Repository{id=EXOMb77d51, name=42Puzzle, contact=douglas.adams@hitchhiker.com, description=changed description, publicReadable=false, archived=false, permissions=null, type=dummy, url=null, lastModified=null, creationDate=1383908998379, properties={}}} to event bus
06:09:58.385 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/repositories.xml
06:09:58.387 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=MODIFY, repository=Repository{id=EXOMb77d51, name=42Puzzle, contact=douglas.adams@hitchhiker.com, description=changed description, publicReadable=false, archived=false, permissions=null, type=dummy, url=null, lastModified=1383908998385, creationDate=1383908998379, properties={}}} to event bus
06:09:58.387 [main] INFO  sonia.scm.repository.DefaultRepositoryManager - delete repository 42Puzzle of type dummy
06:09:58.388 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=BEFORE_DELETE, repository=Repository{id=EXOMb77d51, name=42Puzzle, contact=douglas.adams@hitchhiker.com, description=changed description, publicReadable=false, archived=false, permissions=null, type=dummy, url=null, lastModified=1383908998385, creationDate=1383908998379, properties={}}} to event bus
06:09:58.389 [main] INFO  sonia.scm.io.DefaultFileSystem - destroy directory /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/repositories/dummy/42Puzzle
06:09:58.390 [main] WARN  sonia.scm.repository.AbstractSimpleRepositoryHandler - directory /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/repositories/dummy is not a child of /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/repositories/dummy
06:09:58.391 [main] DEBUG sonia.scm.store.JAXBStore - store sonia.scm.repository.xml.XmlRepositoryDatabase to /tmp/3782b9ea-8b49-4504-86da-6b4387e72e81/config/repositories.xml
06:09:58.391 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post RepositoryEvent{eventType=DELETE, repository=Repository{id=EXOMb77d51, name=42Puzzle, contact=douglas.adams@hitchhiker.com, description=changed description, publicReadable=false, archived=false, permissions=null, type=dummy, url=null, lastModified=1383908998385, creationDate=1383908998379, properties={}}} to event bus
Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.989 sec
Running sonia.scm.event.GuavaScmEventBusTest
06:09:58.551 [main] DEBUG sonia.scm.event.GuavaScmEventBus - register sonia.scm.event.GuavaScmEventBusTest$2@2f473a2e to event bus, async = false
06:09:58.568 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post java.lang.Object@7f25b750 to event bus
06:09:58.576 [main] DEBUG sonia.scm.event.GuavaScmEventBus - register sonia.scm.event.GuavaScmEventBusTest$1@1b4865b1 to event bus, async = true
06:09:58.577 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post UserEvent{eventType=CREATE, user=User{name=test, displayName=test, mail=null, password=(not set), admin=false, type=null, active=true, creationDate=null, lastModified=null, properties={}}} to event bus
06:09:58.586 [main] DEBUG sonia.scm.event.GuavaScmEventBus - register sonia.scm.event.GuavaScmEventBusTest$3@5c419e74 to event bus, async = false
06:09:58.587 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post java.lang.Object@78c70f32 to event bus
06:09:58.590 [main] DEBUG sonia.scm.event.GuavaScmEventBus - register sonia.scm.event.GuavaScmEventBusTest$4@6f1dde0c to event bus, async = false
06:09:58.591 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post java.lang.Object@4c127627 to event bus
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.197 sec
Running sonia.scm.security.RepositoryPermissionResolverTest
06:09:58.604 [main] WARN  sonia.scm.security.RepositoryPermissionResolver - permission 'user:scm:read' is not a repository permission
06:09:58.605 [main] WARN  sonia.scm.security.RepositoryPermissionResolver - permission 'group:asd:wRitE' is not a repository permission
06:09:58.607 [main] WARN  sonia.scm.security.RepositoryPermissionResolver - type is not a valid permission type
java.lang.IllegalArgumentException: No enum const class sonia.scm.repository.PermissionType.ASD
	at java.lang.Enum.valueOf(Enum.java:196) ~[na:1.6.0_24]
	at sonia.scm.repository.PermissionType.valueOf(PermissionType.java:41) ~[scm-core-1.35-SNAPSHOT.jar:na]
	at sonia.scm.security.RepositoryPermissionResolver.createRepositoryPermission(RepositoryPermissionResolver.java:126) [classes/:na]
	at sonia.scm.security.RepositoryPermissionResolver.resolvePermission(RepositoryPermissionResolver.java:89) [classes/:na]
	at sonia.scm.security.RepositoryPermissionResolverTest.testResolveUnknownTypePermission(RepositoryPermissionResolverTest.java:99) [test-classes/:na]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_24]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_24]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_24]
	at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_24]
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47) [junit-4.11.jar:na]
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.11.jar:na]
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44) [junit-4.11.jar:na]
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [junit-4.11.jar:na]
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271) [junit-4.11.jar:na]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70) [junit-4.11.jar:na]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50) [junit-4.11.jar:na]
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238) [junit-4.11.jar:na]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63) [junit-4.11.jar:na]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236) [junit-4.11.jar:na]
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53) [junit-4.11.jar:na]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229) [junit-4.11.jar:na]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:309) [junit-4.11.jar:na]
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:35) [surefire-junit4-2.7.2.jar:2.7.2]
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:115) [surefire-junit4-2.7.2.jar:2.7.2]
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:97) [surefire-junit4-2.7.2.jar:2.7.2]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_24]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_24]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_24]
	at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_24]
	at org.apache.maven.surefire.booter.ProviderFactory$ClassLoaderProxy.invoke(ProviderFactory.java:103) [surefire-booter-2.7.2.jar:2.7.2]
	at $Proxy0.invoke(Unknown Source) [na:na]
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:150) [surefire-booter-2.7.2.jar:2.7.2]
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcess(SurefireStarter.java:91) [surefire-booter-2.7.2.jar:2.7.2]
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:69) [surefire-booter-2.7.2.jar:2.7.2]
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
Running sonia.scm.security.DefaultKeyGeneratorTest
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.691 sec
Running sonia.scm.security.DefaultSecuritySystemTest
06:10:00.320 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.400 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.407 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.411 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 63b76797-0501-4b17-9e8b-2b21513ff45e to configuration store
06:10:00.414 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/ecadc65e-df4a-4e93-ab45-adb6533e5043/config/security.xml
06:10:00.436 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.437 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 85f61ca6-5a93-4bde-aae0-4f6c5ccbdb64 to configuration store
06:10:00.437 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/ecadc65e-df4a-4e93-ab45-adb6533e5043/config/security.xml
06:10:00.440 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=dent, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.440 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item f8728e8f-19f9-4d61-a3f6-b50c9bd5912f to configuration store
06:10:00.441 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/ecadc65e-df4a-4e93-ab45-adb6533e5043/config/security.xml
06:10:00.443 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=marvin, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.518 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.524 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.527 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.530 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 192c1187-573f-468f-8744-3ff6d1a36a16 to configuration store
06:10:00.530 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/aa663dcb-0bcb-490e-afc5-706f7344e32f/config/security.xml
06:10:00.532 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.533 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - remove item 192c1187-573f-468f-8744-3ff6d1a36a16 from configuration store
06:10:00.533 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/aa663dcb-0bcb-490e-afc5-706f7344e32f/config/security.xml
06:10:00.535 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 192c1187-573f-468f-8744-3ff6d1a36a16 to configuration store
06:10:00.535 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/aa663dcb-0bcb-490e-afc5-706f7344e32f/config/security.xml
06:10:00.537 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:WRITE}} to event bus
06:10:00.539 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.544 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.547 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.549 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 298b5c5a-bb77-4541-ba97-63697a9c554a to configuration store
06:10:00.549 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/7811c0f6-c78c-4e40-8475-7fbeb8effca4/config/security.xml
06:10:00.551 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.563 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.635 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.639 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.650 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.661 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.680 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.684 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 05dc035b-f343-439e-9146-07b1db9f52f4 to configuration store
06:10:00.684 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/72151ce4-768a-4f7e-a9f0-f2dc89669f16/config/security.xml
06:10:00.686 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.689 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.760 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.766 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.768 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.773 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.775 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.778 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 34882118-49fb-40c9-8d52-d7e20309de1d to configuration store
06:10:00.778 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/54a6ce12-152a-4de9-8af9-f991446961d5/config/security.xml
06:10:00.780 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.781 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 89d45290-cd82-4077-99bc-bb8401ecff2a to configuration store
06:10:00.781 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/54a6ce12-152a-4de9-8af9-f991446961d5/config/security.xml
06:10:00.783 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=dent, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.784 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item c4d4ea2d-6a15-442c-a6eb-7c97701adf30 to configuration store
06:10:00.784 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/54a6ce12-152a-4de9-8af9-f991446961d5/config/security.xml
06:10:00.787 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=hitchhiker, groupPermisison=true, permission=repository:*:READ}} to event bus
06:10:00.789 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.802 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.805 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.809 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 9324b32a-24e4-4c2f-87d5-5e6d04bb53b5 to configuration store
06:10:00.810 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/461a1d90-b829-46bb-8607-ed8a5d95b505/config/security.xml
06:10:00.812 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.876 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.881 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.884 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.886 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item 611eb9d5-3f54-4990-81ce-14dc2155dfb1 to configuration store
06:10:00.886 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/0e62318b-b9e5-491b-8ebb-3c82af09314c/config/security.xml
06:10:00.888 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.889 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - remove item 611eb9d5-3f54-4990-81ce-14dc2155dfb1 from configuration store
06:10:00.889 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/0e62318b-b9e5-491b-8ebb-3c82af09314c/config/security.xml
06:10:00.891 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.893 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.897 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.900 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.902 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item bb89ee52-67d4-4d58-90ca-a559ee957fb8 to configuration store
06:10:00.902 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/558b581d-2190-45ca-87be-d354d46325fa/config/security.xml
06:10:00.904 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
06:10:00.906 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStoreFactory - create new configuration store for type class sonia.scm.security.AssignedPermission with name security
06:10:00.911 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - read permission descriptor from file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.913 [main] DEBUG sonia.scm.security.DefaultSecuritySystem - found 3 permissions at file:/scratch/jenkins/workspace/scm-manager/scm-webapp/target/classes/META-INF/scm/permissions.xml
06:10:00.915 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - put item a40a8692-dea1-4821-989f-613186fa84bc to configuration store
06:10:00.916 [main] DEBUG sonia.scm.store.JAXBConfigurationEntryStore - store configuration to /tmp/0e5484d4-05fa-419e-8b17-f7e403993b58/config/security.xml
06:10:00.918 [main] DEBUG sonia.scm.event.GuavaScmEventBus - post StoredAssignedPermissionEvent{type=CREATE, permission=StoredAssignedPermission{name=trillian, groupPermisison=false, permission=repository:*:READ}} to event bus
Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.616 sec
Running sonia.scm.security.ScmRealmTest
06:10:01.663 [main] DEBUG sonia.scm.security.ScmRealm - user trillian is member of g2, g1, _authenticated, g4, g3
06:10:04.866 [main] DEBUG sonia.scm.security.ScmRealm - user trillian is member of _authenticated
06:10:04.875 [main] DEBUG sonia.scm.security.ScmRealm - authenticator null marked user trillian as admin
06:10:04.880 [main] DEBUG sonia.scm.security.ScmRealm - user trillian of type null is marked as admin by local database
06:10:04.880 [main] DEBUG sonia.scm.security.ScmRealm - user trillian is member of _authenticated
06:10:04.881 [main] DEBUG sonia.scm.security.AuthorizationCollector - grant admin role for user trillian
06:10:04.885 [main] DEBUG sonia.scm.security.ScmRealm - user trillian is member of _authenticated
06:10:04.891 [main] DEBUG sonia.scm.security.ScmRealm - authenticator null marked user trillian as admin
06:10:04.896 [main] DEBUG sonia.scm.security.ScmRealm - user trillian of type null is marked as admin by local database
06:10:04.896 [main] DEBUG sonia.scm.security.ScmRealm - user trillian is member of _authenticated
06:10:04.898 [main] DEBUG sonia.scm.security.AuthorizationCollector - grant admin role for user trillian
06:10:04.901 [main] DEBUG sonia.scm.security.ScmRealm - user trillian is member of _authenticated
06:10:04.910 [main] DEBUG sonia.scm.security.ScmRealm - user trillian is member of g2, g1, _authenticated, g4, g3
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.993 sec
Running sonia.scm.security.ConfigurableLoginAttemptHandlerTest
06:10:04.991 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - reset login attempts for hansolo, because of time
06:10:04.992 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - increase failed login attempts for hansolo
06:10:04.992 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - increase failed login attempts for hansolo
06:10:04.993 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - reset login attempts for hansolo, because of successful login
06:10:04.993 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - reset login attempts for hansolo, because of time
06:10:04.995 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - increase failed login attempts for hansolo
06:10:04.995 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - increase failed login attempts for hansolo
06:10:04.997 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - reset login attempts for hansolo, because of time
06:10:04.997 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - increase failed login attempts for hansolo
06:10:04.998 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - increase failed login attempts for hansolo
06:10:06.199 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - reset login attempts for hansolo, because of time
06:10:06.200 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - reset login attempts for hansolo, because of time
06:10:06.200 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - increase failed login attempts for hansolo
06:10:06.200 [main] DEBUG sonia.scm.security.ConfigurableLoginAttemptHandler - increase failed login attempts for hansolo
06:10:06.200 [main] WARN  sonia.scm.security.ConfigurableLoginAttemptHandler - account hansolo is temporary locked, because of LoginAttempt{counter=2, lastAttempt=1383909006200}
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.213 sec

Results :

Tests run: 122, Failures: 0, Errors: 0, Skipped: 0

[JENKINS] Recording test results
[INFO] 
[INFO] --- web-compressor:1.5:partial-compress-template (default) @ scm-webapp ---
Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:7603: WARNING - Parse error. illegal use of unknown JSDoc tag "hide"; ignoring it
     * @hide repeat doc
       ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:7644: WARNING - Parse error. illegal use of unknown JSDoc tag "hide"; ignoring it
     * @hide repeat doc
       ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:7691: WARNING - Parse error. illegal use of unknown JSDoc tag "singleton"; ignoring it
 * @singleton
   ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:47308: WARNING - Parse error. illegal use of unknown JSDoc tag "xtype"; ignoring it
 * @xtype grid
   ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:47312: WARNING - Parse error. illegal use of unknown JSDoc tag "cfg"; ignoring it
     * @cfg {String} autoExpandColumn
       ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:53419: WARNING - Parse error. illegal use of unknown JSDoc tag "xtype"; ignoring it
 * @xtype fileuploadfield
   ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:53423: WARNING - Parse error. illegal use of unknown JSDoc tag "cfg"; ignoring it
     * @cfg {String} buttonText The button text to display on the upload button (defaults to
       ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:53429: WARNING - Parse error. illegal use of unknown JSDoc tag "cfg"; ignoring it
     * @cfg {Boolean} buttonOnly True to display the file upload field as a button with no visible
       ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:53434: WARNING - Parse error. illegal use of unknown JSDoc tag "cfg"; ignoring it
     * @cfg {Number} buttonOffset The number of pixels of space reserved between the button and the text field
       ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:53439: WARNING - Parse error. illegal use of unknown JSDoc tag "cfg"; ignoring it
     * @cfg {Object} buttonCfg A standard {@link Ext.Button} config object.
       ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager println
WARNING: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor/resources/048d821e-2b03-4b68-ba25-5dd36b6cc294:53446: WARNING - Parse error. illegal use of unknown JSDoc tag "hide"; ignoring it
     * @hide
       ^

Nov 8, 2013 6:10:29 AM com.google.javascript.jscomp.LoggerErrorManager printSummary
WARNING: 0 error(s), 11 warning(s)
[INFO] 
[INFO] --- maven-war-plugin:2.2:war (default-war) @ scm-webapp ---
[INFO] Packaging webapp
[INFO] Assembling webapp [scm-webapp] in [/scratch/jenkins/workspace/scm-manager/scm-webapp/target/scm-webapp]
[INFO] Processing war project
[INFO] Copying webapp webResources [/scratch/jenkins/workspace/scm-manager/scm-webapp/target/web-compressor] to [/scratch/jenkins/workspace/scm-manager/scm-webapp/target/scm-webapp]
[INFO] Copying webapp webResources [/scratch/jenkins/workspace/scm-manager/scm-webapp/target/dependency-rewrite] to [/scratch/jenkins/workspace/scm-manager/scm-webapp/target/scm-webapp]
[INFO] Copying webapp resources [/scratch/jenkins/workspace/scm-manager/scm-webapp/src/main/webapp]
[INFO] Webapp assembled in [2796 msecs]
[INFO] Building war: /scratch/jenkins/workspace/scm-manager/scm-webapp/target/scm-webapp.war
[INFO] WEB-INF/web.xml already added, skipping
[INFO] 
[INFO] --- maven-install-plugin:2.4:install (default-install) @ scm-webapp ---
[INFO] Installing /scratch/jenkins/workspace/scm-manager/scm-webapp/target/scm-webapp.war to /scratch/jenkins/workspace/scm-manager/.repository/sonia/scm/scm-webapp/1.35-SNAPSHOT/scm-webapp-1.35-SNAPSHOT.war
[INFO] Installing /scratch/jenkins/workspace/scm-manager/scm-webapp/pom.xml to /scratch/jenkins/workspace/scm-manager/.repository/sonia/scm/scm-webapp/1.35-SNAPSHOT/scm-webapp-1.35-SNAPSHOT.pom