Startup fails on Sandbox after deployment

0
I have absolutely no idea where to start... I never had this problem before. Here is the stack trace: Aug 6 00:19:00.656 127.0.0.1 tr10096: ERROR - OSGi: [com.mendix.core.util.SecurityActivator] The start method has thrown an exception (bundle: mxruntime, service: ) Aug 6 00:19:00.663 127.0.0.1 tr10096: ERROR - OSGi: (1/72) org.apache.felix.log.LogException: java.lang.SecurityException: Failed creating security permission -> ALLOW {org.osgi.service.condpermadmin.BundleLocationCondition "project.jar"(org.osgi.framework.BundlePermission "" "provide,require, host,fragment")(org.osgi.service.event.TopicPermission "" "publish,subscribe")(java.util.PropertyPermission "mail.smtp.auth" "read,write")(java.util.PropertyPermission "mail.smtp.host" "read,write")(java.util.PropertyPermission "mail.smtp.password" "read,write")(java.util.PropertyPermission "mail.smtp.port" "read,write")(java.util.PropertyPermission "mail.smtp.starttls.enable" "read,write")(java.util.PropertyPermission "mail.smtp.user" "read,write")(java.util.PropertyPermission "ical4j." "read,write")(java.util.PropertyPermission "net.fortuna." "read,write")(java.util.Prope Aug 6 00:19:00.663 127.0.0.1 tr10096: ERROR - OSGi: (2/72) at com.mendix.core.util.SecurityActivator$$anonfun$setupSecurity$1.apply(SecurityActivator.scala:54) Aug 6 00:19:00.663 127.0.0.1 tr10096: ERROR - OSGi: (3/72) at com.mendix.core.util.SecurityActivator$$anonfun$setupSecurity$1.apply(SecurityActivator.scala:48) Aug 6 00:19:00.664 127.0.0.1 tr10096: ERROR - OSGi: (4/72) at scala.collection.immutable.List.foreach(List.scala:383) Aug 6 00:19:00.664 127.0.0.1 tr10096: ERROR - OSGi: (5/72) at com.mendix.core.util.SecurityActivator.setupSecurity(SecurityActivator.scala:48) Aug 6 00:19:00.664 127.0.0.1 tr10096: ERROR - OSGi: (6/72) at com.mendix.core.util.SecurityActivator.start(SecurityActivator.scala:31) Aug 6 00:19:00.664 127.0.0.1 tr10096: ERROR - OSGi: (7/72) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) Aug 6 00:19:00.665 127.0.0.1 tr10096: ERROR - OSGi: (8/72) at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) Aug 6 00:19:00.665 127.0.0.1 tr10096: ERROR - OSGi: (9/72) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) Aug 6 00:19:00.665 127.0.0.1 tr10096: ERROR - OSGi: (10/72) at java.lang.reflect.Method.invoke(Unknown Source) Aug 6 00:19:00.665 127.0.0.1 tr10096: ERROR - OSGi: (11/72) at org.apache.felix.scr.impl.helper.BaseMethod.invokeMethod(BaseMethod.java:236) Aug 6 00:19:00.665 127.0.0.1 tr10096: ERROR - OSGi: (12/72) at org.apache.felix.scr.impl.helper.BaseMethod.access$500(BaseMethod.java:37) Aug 6 00:19:00.666 127.0.0.1 tr10096: ERROR - OSGi: (13/72) at org.apache.felix.scr.impl.helper.BaseMethod$Resolved.invoke(BaseMethod.java:613) Aug 6 00:19:00.666 127.0.0.1 tr10096: ERROR - OSGi: (14/72) at org.apache.felix.scr.impl.helper.BaseMethod.invoke(BaseMethod.java:496) Aug 6 00:19:00.666 127.0.0.1 tr10096: ERROR - OSGi: (15/72) at org.apache.felix.scr.impl.helper.ActivateMethod.invoke(ActivateMethod.java:149) Aug 6 00:19:00.666 127.0.0.1 tr10096: ERROR - OSGi: (16/72) at org.apache.felix.scr.impl.manager.ImmediateComponentManager.createImplementationObject(ImmediateComponentManager.java:239) Aug 6 00:19:00.667 127.0.0.1 tr10096: ERROR - OSGi: (17/72) at org.apache.felix.scr.impl.manager.ImmediateComponentManager.createComponent(ImmediateComponentManager.java:119) Aug 6 00:19:00.667 127.0.0.1 tr10096: ERROR - OSGi: (18/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager$Unsatisfied.activate(AbstractComponentManager.java:1518) Aug 6 00:19:00.667 127.0.0.1 tr10096: ERROR - OSGi: (19/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:550) Aug 6 00:19:00.668 127.0.0.1 tr10096: ERROR - OSGi: (20/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:261) Aug 6 00:19:00.668 127.0.0.1 tr10096: ERROR - OSGi: (21/72) at org.apache.felix.scr.impl.config.ImmediateComponentHolder.enableComponents(ImmediateComponentHolder.java:328) Aug 6 00:19:00.668 127.0.0.1 tr10096: ERROR - OSGi: (22/72) at org.apache.felix.scr.impl.BundleComponentActivator.initialize(BundleComponentActivator.java:158) Aug 6 00:19:00.668 127.0.0.1 tr10096: ERROR - OSGi: (23/72) at org.apache.felix.scr.impl.BundleComponentActivator.<init>(BundleComponentActivator.java:113) Aug 6 00:19:00.669 127.0.0.1 tr10096: ERROR - OSGi: (24/72) at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:261) Aug 6 00:19:00.669 127.0.0.1 tr10096: ERROR - OSGi: (25/72) at org.apache.felix.scr.impl.Activator.loadAllComponents(Activator.java:199) Aug 6 00:19:00.669 127.0.0.1 tr10096: ERROR - OSGi: (26/72) at org.apache.felix.scr.impl.Activator.start(Activator.java:108) Aug 6 00:19:00.669 127.0.0.1 tr10096: ERROR - OSGi: (27/72) at org.apache.felix.framework.util.SecureAction$Actions.run(SecureAction.java:1605) Aug 6 00:19:00.670 127.0.0.1 tr10096: ERROR - OSGi: (28/72) at java.security.AccessController.doPrivileged(Native Method) Aug 6 00:19:00.670 127.0.0.1 tr10096: ERROR - OSGi: (29/72) at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:636) Aug 6 00:19:00.670 127.0.0.1 tr10096: ERROR - OSGi: (30/72) at org.apache.felix.framework.Felix.activateBundle(Felix.java:2146) Aug 6 00:19:00.670 127.0.0.1 tr10096: ERROR - OSGi: (31/72) at org.apache.felix.framework.Felix.startBundle(Felix.java:2064) Aug 6 00:19:00.670 127.0.0.1 tr10096: ERROR - OSGi: (32/72) at org.apache.felix.framework.Felix.setActiveStartLevel(Felix.java:1291) Aug 6 00:19:00.671 127.0.0.1 tr10096: ERROR - OSGi: (33/72) at org.apache.felix.framework.FrameworkStartLevelImpl.run(FrameworkStartLevelImpl.java:304) Aug 6 00:19:00.671 127.0.0.1 tr10096: ERROR - OSGi: (34/72) at java.lang.Thread.run(Unknown Source) Aug 6 00:19:00.671 127.0.0.1 tr10096: ERROR - OSGi: (35/72) Aug 6 00:19:00.671 127.0.0.1 tr10096: ERROR - OSGi: (36/72) Caused by: java.lang.IllegalArgumentException: expecting close parenthesis Aug 6 00:19:00.672 127.0.0.1 tr10096: ERROR - OSGi: (37/72) at org.apache.felix.framework.security.condpermadmin.ConditionalPermissionInfoImpl.parsePermissionInfo(ConditionalPermissionInfoImpl.java:209) Aug 6 00:19:00.672 127.0.0.1 tr10096: ERROR - OSGi: (38/72) at org.apache.felix.framework.security.condpermadmin.ConditionalPermissionInfoImpl.<init>(ConditionalPermissionInfoImpl.java:279) Aug 6 00:19:00.673 127.0.0.1 tr10096: ERROR - OSGi: (39/72) at org.apache.felix.framework.security.condpermadmin.ConditionalPermissionAdminImpl.newConditionalPermissionInfo(ConditionalPermissionAdminImpl.java:1022) Aug 6 00:19:00.673 127.0.0.1 tr10096: ERROR - OSGi: (40/72) at com.mendix.core.util.SecurityActivator$$anonfun$setupSecurity$1.apply(SecurityActivator.scala:50) Aug 6 00:19:00.673 127.0.0.1 tr10096: ERROR - OSGi: (41/72) at com.mendix.core.util.SecurityActivator$$anonfun$setupSecurity$1.apply(SecurityActivator.scala:48) Aug 6 00:19:00.673 127.0.0.1 tr10096: ERROR - OSGi: (42/72) at scala.collection.immutable.List.foreach(List.scala:383) Aug 6 00:19:00.673 127.0.0.1 tr10096: ERROR - OSGi: (43/72) at com.mendix.core.util.SecurityActivator.setupSecurity(SecurityActivator.scala:48) Aug 6 00:19:00.674 127.0.0.1 tr10096: ERROR - OSGi: (44/72) at com.mendix.core.util.SecurityActivator.start(SecurityActivator.scala:31) Aug 6 00:19:00.674 127.0.0.1 tr10096: ERROR - OSGi: (45/72) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) Aug 6 00:19:00.674 127.0.0.1 tr10096: ERROR - OSGi: (46/72) at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) Aug 6 00:19:00.674 127.0.0.1 tr10096: ERROR - OSGi: (47/72) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) Aug 6 00:19:00.675 127.0.0.1 tr10096: ERROR - OSGi: (48/72) at java.lang.reflect.Method.invoke(Unknown Source) Aug 6 00:19:00.675 127.0.0.1 tr10096: ERROR - OSGi: (49/72) at org.apache.felix.scr.impl.helper.BaseMethod.invokeMethod(BaseMethod.java:236) Aug 6 00:19:00.675 127.0.0.1 tr10096: ERROR - OSGi: (50/72) at org.apache.felix.scr.impl.helper.BaseMethod.access$500(BaseMethod.java:37) Aug 6 00:19:00.675 127.0.0.1 tr10096: ERROR - OSGi: (51/72) at org.apache.felix.scr.impl.helper.BaseMethod$Resolved.invoke(BaseMethod.java:613) Aug 6 00:19:00.676 127.0.0.1 tr10096: ERROR - OSGi: (52/72) at org.apache.felix.scr.impl.helper.BaseMethod.invoke(BaseMethod.java:496) Aug 6 00:19:00.676 127.0.0.1 tr10096: ERROR - OSGi: (53/72) at org.apache.felix.scr.impl.helper.ActivateMethod.invoke(ActivateMethod.java:149) Aug 6 00:19:00.676 127.0.0.1 tr10096: ERROR - OSGi: (54/72) at org.apache.felix.scr.impl.manager.ImmediateComponentManager.createImplementationObject(ImmediateComponentManager.java:239) Aug 6 00:19:00.676 127.0.0.1 tr10096: ERROR - OSGi: (55/72) at org.apache.felix.scr.impl.manager.ImmediateComponentManager.createComponent(ImmediateComponentManager.java:119) Aug 6 00:19:00.676 127.0.0.1 tr10096: ERROR - OSGi: (56/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager$Unsatisfied.activate(AbstractComponentManager.java:1518) Aug 6 00:19:00.677 127.0.0.1 tr10096: ERROR - OSGi: (57/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:550) Aug 6 00:19:00.677 127.0.0.1 tr10096: ERROR - OSGi: (58/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:261) Aug 6 00:19:00.678 127.0.0.1 tr10096: ERROR - OSGi: (59/72) at org.apache.felix.scr.impl.config.ImmediateComponentHolder.enableComponents(ImmediateComponentHolder.java:328) Aug 6 00:19:00.678 127.0.0.1 tr10096: ERROR - OSGi: (60/72) at org.apache.felix.scr.impl.BundleComponentActivator.initialize(BundleComponentActivator.java:158) Aug 6 00:19:00.678 127.0.0.1 tr10096: ERROR - OSGi: (61/72) at org.apache.felix.scr.impl.BundleComponentActivator.<init>(BundleComponentActivator.java:113) Aug 6 00:19:00.678 127.0.0.1 tr10096: ERROR - OSGi: (62/72) at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:261) Aug 6 00:19:00.678 127.0.0.1 tr10096: ERROR - OSGi: (63/72) at org.apache.felix.scr.impl.Activator.loadAllComponents(Activator.java:199) Aug 6 00:19:00.679 127.0.0.1 tr10096: ERROR - OSGi: (64/72) at org.apache.felix.scr.impl.Activator.start(Activator.java:108) Aug 6 00:19:00.679 127.0.0.1 tr10096: ERROR - OSGi: (65/72) at org.apache.felix.framework.util.SecureAction$Actions.run(SecureAction.java:1605) Aug 6 00:19:00.679 127.0.0.1 tr10096: ERROR - OSGi: (66/72) at java.security.AccessController.doPrivileged(Native Method) Aug 6 00:19:00.679 127.0.0.1 tr10096: ERROR - OSGi: (67/72) at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:636) Aug 6 00:19:00.680 127.0.0.1 tr10096: ERROR - OSGi: (68/72) at org.apache.felix.framework.Felix.activateBundle(Felix.java:2146) Aug 6 00:19:00.680 127.0.0.1 tr10096: ERROR - OSGi: (69/72) at org.apache.felix.framework.Felix.startBundle(Felix.java:2064) Aug 6 00:19:00.680 127.0.0.1 tr10096: ERROR - OSGi: (70/72) at org.apache.felix.framework.Felix.setActiveStartLevel(Felix.java:1291) Aug 6 00:19:00.681 127.0.0.1 tr10096: ERROR - OSGi: (71/72) at org.apache.felix.framework.FrameworkStartLevelImpl.run(FrameworkStartLevelImpl.java:304) Aug 6 00:19:00.681 127.0.0.1 tr10096: ERROR - OSGi: (72/72) at java.lang.Thread.run(Unknown Source) Aug 6 00:19:00.681 127.0.0.1 tr10096: ERROR - OSGi: [com.mendix.core.util.SecurityActivator] Component instance could not be created, activation failed (bundle: mxruntime, service: ) Aug 6 00:19:00.687 127.0.0.1 tr10096: INFO - Core: Mendix Runtime 5.17.0 (build 5038). Copyright © 2003-2015 Mendix bv. All rights reserved. Aug 6 00:19:01.392 127.0.0.1 tr10096: INFO - XMPPConnector: appnode-vizier-tr10096@beta.mendixcloud.net connected. Aug 6 00:19:01.405 127.0.0.1 tr10096: INFO - XMPPConnector: Registered 'cp@beta.mendixcloud.net/Smack' as cloud portal contact Aug 6 00:19:01.463 127.0.0.1 tr10096: INFO - Logging: Logging to file: /srv/cloud/slots/tr10096/deploy/data/log/m2ee.log, max size: 2048KiB, max rotation: 10 Aug 6 00:19:03.541 127.0.0.1 tr10096: INFO - ConnectionBus: Executing 211 database synchronization command(s)... Aug 6 00:19:04.133 127.0.0.1 tr10096: INFO - ConnectionBus: Executing database synchronization commands finished. Aug 6 00:19:04.235 127.0.0.1 tr10096: INFO - Core: Storage service: Local file system storage, uploaded files path: /srv/cloud/slots/tr10096/deploy/data/files Aug 6 00:19:04.252 127.0.0.1 tr10096: INFO - ConnectionBus: (1/2) Database: PostgreSQL 9.3.4, name: 'dbnode-vizier-db96' Aug 6 00:19:04.252 127.0.0.1 tr10096: INFO - ConnectionBus: (2/2) Driver: PostgreSQL Native Driver PostgreSQL 9.4 JDBC4.1 (build 1201) Aug 6 00:19:04.409 127.0.0.1 tr10096: INFO - Core: Project company name is 'Mendix' Aug 6 00:19:04.409 127.0.0.1 tr10096: INFO - Core: License expiration date is 'null' Aug 6 00:19:04.409 127.0.0.1 tr10096: INFO - Core: License type is: 'Perpetual' Aug 6 00:19:05.571 127.0.0.1 tr10096: INFO - Core: Running after-startup-action... Aug 6 00:19:05.590 127.0.0.1 tr10096: INFO - AppCloudServices: Starting OpenId handler ... OpenIDReturnURL = https://mec.mendixcloud.com/openid/callback; OpenIdProvider: https://mxid2.mendixcloud.com/mxid2/discover Aug 6 00:19:06.219 127.0.0.1 tr10096: INFO - AppCloudServices: Starting OpenId handler ... DONE Aug 6 00:19:06.222 127.0.0.1 tr10096: INFO - Core: Successfully ran after-startup-action. Aug 6 00:19:06.307 127.0.0.1 tr10096: INFO - Core: Mendix Runtime successfully started, the application is now available. Aug 6 00:19:24.550 127.0.0.1 tr10096: INFO - AppCloudServices: Found local discovery of RP return_url endpoint. Aug 6 00:19:25.815 127.0.0.1 tr10096: INFO - AppCloudServices: Found local discovery of RP return_url endpoint. Aug 6 00:19:26.028 127.0.0.1 tr10096: INFO - AppCloudServices: [OpenID Verify Response] receivingurl: https://mec.mendixcloud.com/openid/callback?openid.ns=http%3A%2F%2Fspecs.openid.net%2Fauth%2F2.0&openid.op_endpoint=https%3A%2F%2Fmxid2.mendixcloud.com%2Fmxid2%2F&openid.claimed_id=https%3A%2F%2Fmxid2.mendixcloud.com%2Fmxid2%2Fid%3Fid%3D90cdbf1f-0173-4929-aef4-42cfda8ca68b&openid.response_nonce=2015-08-05T22%3A19%3A25Z0&openid.mode=id_res&openid.identity=https%3A%2F%2Fmxid2.mendixcloud.com%2Fmxid2%2Fid%3Fid%3D90cdbf1f-0173-4929-aef4-42cfda8ca68b&openid.return_to=https%3A%2F%2Fmec.mendixcloud.com%2Fopenid%2Fcallback&openid.assoc_handle=1434433675166-S-f6c34051-267b-41b7-9d0f-4dffc040600a&openid.signed=op_endpoint%2Cclaimed_id%2Cidentity%2Creturn_to%2Cresponse_nonce%2Cassoc_handle&openid.sig=9Cdi3up9wYpw5o0TCqqKaUQ82qAncbI18uu3LN%2BDWnk%3D&mxid2.continuation=https%3A%2F%2Fmec.mendixcloud.com%2Findex.html%3Fprofile%3Ddesktop; to: openid.return_to:https://mec.mendixcloud.com/openid/callback Aug 6 00:19:26.115 127.0.0.1 tr10096: INFO - OpenID: User 'https://mxid2.mendixcloud.com/mxid2/id?id=90cdbf1f-0173-4929-aef4-42cfda8ca68b' does not exist in database. Triggering OnFirstLogin action... Aug 6 00:19:27.988 127.0.0.1 tr10096: INFO - OpenID: User 'https://mxid2.mendixcloud.com/mxid2/id?id=90cdbf1f-0173-4929-aef4-42cfda8ca68b' does not exist in database. Triggering OnFirstLogin action... Account created. Aug 6 00:19:27.990 127.0.0.1 tr10096: INFO - OpenID: User https://mxid2.mendixcloud.com/mxid2/id?id=90cdbf1f-0173-4929-aef4-42cfda8ca68b authenticated. Starting session.. Aug 6 00:42:46.643 127.0.0.1 tr10096: INFO - OpenID: User https://mxid2.mendixcloud.com/mxid2/id?id=90cdbf1f-0173-4929-aef4-42cfda8ca68b authenticated. Starting session.. Aug 6 00:42:46.657 127.0.0.1 tr10096: INFO - Core: Removing session for user 'https://mxid2.mendixcloud.com/mxid2/id?id=90cdbf1f-0173-4929-aef4-42cfda8ca68b' Aug 6 00:42:47.642 127.0.0.1 tr10096: INFO - WebUI: Anonymous user 'Anonymous_58290a39-fbcd-4567-8a96-3b1c53c68c94' created (Number of concurrent sessions: 1). Aug 6 00:44:35.871 127.0.0.1 tr10096: INFO - Core: Mendix Runtime is shutting down now... Aug 6 00:44:35.871 127.0.0.1 tr10096: INFO - Core: Removing session for user 'Anonymous_58290a39-fbcd-4567-8a96-3b1c53c68c94' Aug 6 00:44:35.922 127.0.0.1 tr10096: INFO - Core: Mendix Runtime is now shut down. Aug 6 00:44:35.977 127.0.0.1 tr10096: WARNING - Jetty: handle failed Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (1/32) java.lang.RuntimeException: Failed to put log message into the queue Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (2/32) at com.mendix.logging.impl.LogQueue.put(LogQueue.java:53) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (3/32) at com.mendix.logging.impl.LogNode.trace(LogNode.java:209) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (4/32) at com.mendix.logging.impl.JettyLogger.debug(JettyLogger.java:33) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (5/32) at org.eclipse.jetty.io.nio.ChannelEndPoint.fill(ChannelEndPoint.java:254) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (6/32) at org.eclipse.jetty.server.nio.BlockingChannelConnector$BlockingChannelEndPoint.fill(BlockingChannelConnector.java:242) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (7/32) at org.eclipse.jetty.http.HttpParser.fill(HttpParser.java:1040) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (8/32) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:280) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (9/32) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (10/32) at org.eclipse.jetty.server.BlockingHttpConnection.handle(BlockingHttpConnection.java:72) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (11/32) at org.eclipse.jetty.server.nio.BlockingChannelConnector$BlockingChannelEndPoint.run(BlockingChannelConnector.java:298) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (12/32) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608) Aug 6 00:44:35.978 127.0.0.1 tr10096: WARNING - Jetty: (13/32) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (14/32) at java.lang.Thread.run(Unknown Source) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (15/32) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (16/32) Caused by: java.lang.InterruptedException: null Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (17/32) at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(Unknown Source) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (18/32) at java.util.concurrent.locks.ReentrantLock.lockInterruptibly(Unknown Source) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (19/32) at java.util.concurrent.LinkedBlockingQueue.put(Unknown Source) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (20/32) at com.mendix.logging.impl.LogQueue.put(LogQueue.java:51) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (21/32) at com.mendix.logging.impl.LogNode.trace(LogNode.java:209) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (22/32) at com.mendix.logging.impl.JettyLogger.debug(JettyLogger.java:33) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (23/32) at org.eclipse.jetty.io.nio.ChannelEndPoint.fill(ChannelEndPoint.java:254) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (24/32) at org.eclipse.jetty.server.nio.BlockingChannelConnector$BlockingChannelEndPoint.fill(BlockingChannelConnector.java:242) Aug 6 00:44:35.979 127.0.0.1 tr10096: WARNING - Jetty: (25/32) at org.eclipse.jetty.http.HttpParser.fill(HttpParser.java:1040) Aug 6 00:44:35.980 127.0.0.1 tr10096: WARNING - Jetty: (26/32) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:280) Aug 6 00:44:35.980 127.0.0.1 tr10096: WARNING - Jetty: (27/32) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235) Aug 6 00:44:35.980 127.0.0.1 tr10096: WARNING - Jetty: (28/32) at org.eclipse.jetty.server.BlockingHttpConnection.handle(BlockingHttpConnection.java:72) Aug 6 00:44:35.980 127.0.0.1 tr10096: WARNING - Jetty: (29/32) at org.eclipse.jetty.server.nio.BlockingChannelConnector$BlockingChannelEndPoint.run(BlockingChannelConnector.java:298) Aug 6 00:44:35.980 127.0.0.1 tr10096: WARNING - Jetty: (30/32) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608) Aug 6 00:44:35.980 127.0.0.1 tr10096: WARNING - Jetty: (31/32) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543) Aug 6 00:44:35.980 127.0.0.1 tr10096: WARNING - Jetty: (32/32) at java.lang.Thread.run(Unknown Source) Aug 6 00:44:44.333 127.0.0.1 tr10096: ERROR - OSGi: [com.mendix.core.util.SecurityActivator] The start method has thrown an exception (bundle: mxruntime, service: ) Aug 6 00:44:44.343 127.0.0.1 tr10096: ERROR - OSGi: (1/72) org.apache.felix.log.LogException: java.lang.SecurityException: Failed creating security permission -> ALLOW {org.osgi.service.condpermadmin.BundleLocationCondition "project.jar"(org.osgi.framework.BundlePermission "" "provide,require, host,fragment")(org.osgi.service.event.TopicPermission "" "publish,subscribe")(java.util.PropertyPermission "mail.smtp.auth" "read,write")(java.util.PropertyPermission "mail.smtp.host" "read,write")(java.util.PropertyPermission "mail.smtp.password" "read,write")(java.util.PropertyPermission "mail.smtp.port" "read,write")(java.util.PropertyPermission "mail.smtp.starttls.enable" "read,write")(java.util.PropertyPermission "mail.smtp.user" "read,write")(java.util.PropertyPermission "ical4j." "read,write")(java.util.PropertyPermission "net.fortuna." "read,write")(java.util.Prope Aug 6 00:44:44.343 127.0.0.1 tr10096: ERROR - OSGi: (2/72) at com.mendix.core.util.SecurityActivator$$anonfun$setupSecurity$1.apply(SecurityActivator.scala:54) Aug 6 00:44:44.343 127.0.0.1 tr10096: ERROR - OSGi: (3/72) at com.mendix.core.util.SecurityActivator$$anonfun$setupSecurity$1.apply(SecurityActivator.scala:48) Aug 6 00:44:44.344 127.0.0.1 tr10096: ERROR - OSGi: (4/72) at scala.collection.immutable.List.foreach(List.scala:383) Aug 6 00:44:44.344 127.0.0.1 tr10096: ERROR - OSGi: (5/72) at com.mendix.core.util.SecurityActivator.setupSecurity(SecurityActivator.scala:48) Aug 6 00:44:44.344 127.0.0.1 tr10096: ERROR - OSGi: (6/72) at com.mendix.core.util.SecurityActivator.start(SecurityActivator.scala:31) Aug 6 00:44:44.344 127.0.0.1 tr10096: ERROR - OSGi: (7/72) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) Aug 6 00:44:44.344 127.0.0.1 tr10096: ERROR - OSGi: (8/72) at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (9/72) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (10/72) at java.lang.reflect.Method.invoke(Unknown Source) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (11/72) at org.apache.felix.scr.impl.helper.BaseMethod.invokeMethod(BaseMethod.java:236) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (12/72) at org.apache.felix.scr.impl.helper.BaseMethod.access$500(BaseMethod.java:37) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (13/72) at org.apache.felix.scr.impl.helper.BaseMethod$Resolved.invoke(BaseMethod.java:613) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (14/72) at org.apache.felix.scr.impl.helper.BaseMethod.invoke(BaseMethod.java:496) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (15/72) at org.apache.felix.scr.impl.helper.ActivateMethod.invoke(ActivateMethod.java:149) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (16/72) at org.apache.felix.scr.impl.manager.ImmediateComponentManager.createImplementationObject(ImmediateComponentManager.java:239) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (17/72) at org.apache.felix.scr.impl.manager.ImmediateComponentManager.createComponent(ImmediateComponentManager.java:119) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (18/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager$Unsatisfied.activate(AbstractComponentManager.java:1518) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (19/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:550) Aug 6 00:44:44.345 127.0.0.1 tr10096: ERROR - OSGi: (20/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:261) Aug 6 00:44:44.346 127.0.0.1 tr10096: ERROR - OSGi: (21/72) at org.apache.felix.scr.impl.config.ImmediateComponentHolder.enableComponents(ImmediateComponentHolder.java:328) Aug 6 00:44:44.346 127.0.0.1 tr10096: ERROR - OSGi: (22/72) at org.apache.felix.scr.impl.BundleComponentActivator.initialize(BundleComponentActivator.java:158) Aug 6 00:44:44.346 127.0.0.1 tr10096: ERROR - OSGi: (23/72) at org.apache.felix.scr.impl.BundleComponentActivator.<init>(BundleComponentActivator.java:113) Aug 6 00:44:44.346 127.0.0.1 tr10096: ERROR - OSGi: (24/72) at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:261) Aug 6 00:44:44.346 127.0.0.1 tr10096: ERROR - OSGi: (25/72) at org.apache.felix.scr.impl.Activator.loadAllComponents(Activator.java:199) Aug 6 00:44:44.346 127.0.0.1 tr10096: ERROR - OSGi: (26/72) at org.apache.felix.scr.impl.Activator.start(Activator.java:108) Aug 6 00:44:44.346 127.0.0.1 tr10096: ERROR - OSGi: (27/72) at org.apache.felix.framework.util.SecureAction$Actions.run(SecureAction.java:1605) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (28/72) at java.security.AccessController.doPrivileged(Native Method) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (29/72) at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:636) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (30/72) at org.apache.felix.framework.Felix.activateBundle(Felix.java:2146) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (31/72) at org.apache.felix.framework.Felix.startBundle(Felix.java:2064) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (32/72) at org.apache.felix.framework.Felix.setActiveStartLevel(Felix.java:1291) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (33/72) at org.apache.felix.framework.FrameworkStartLevelImpl.run(FrameworkStartLevelImpl.java:304) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (34/72) at java.lang.Thread.run(Unknown Source) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (35/72) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (36/72) Caused by: java.lang.IllegalArgumentException: expecting close parenthesis Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (37/72) at org.apache.felix.framework.security.condpermadmin.ConditionalPermissionInfoImpl.parsePermissionInfo(ConditionalPermissionInfoImpl.java:209) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (38/72) at org.apache.felix.framework.security.condpermadmin.ConditionalPermissionInfoImpl.<init>(ConditionalPermissionInfoImpl.java:279) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (39/72) at org.apache.felix.framework.security.condpermadmin.ConditionalPermissionAdminImpl.newConditionalPermissionInfo(ConditionalPermissionAdminImpl.java:1022) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (40/72) at com.mendix.core.util.SecurityActivator$$anonfun$setupSecurity$1.apply(SecurityActivator.scala:50) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (41/72) at com.mendix.core.util.SecurityActivator$$anonfun$setupSecurity$1.apply(SecurityActivator.scala:48) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (42/72) at scala.collection.immutable.List.foreach(List.scala:383) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (43/72) at com.mendix.core.util.SecurityActivator.setupSecurity(SecurityActivator.scala:48) Aug 6 00:44:44.347 127.0.0.1 tr10096: ERROR - OSGi: (44/72) at com.mendix.core.util.SecurityActivator.start(SecurityActivator.scala:31) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (45/72) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (46/72) at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (47/72) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (48/72) at java.lang.reflect.Method.invoke(Unknown Source) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (49/72) at org.apache.felix.scr.impl.helper.BaseMethod.invokeMethod(BaseMethod.java:236) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (50/72) at org.apache.felix.scr.impl.helper.BaseMethod.access$500(BaseMethod.java:37) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (51/72) at org.apache.felix.scr.impl.helper.BaseMethod$Resolved.invoke(BaseMethod.java:613) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (52/72) at org.apache.felix.scr.impl.helper.BaseMethod.invoke(BaseMethod.java:496) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (53/72) at org.apache.felix.scr.impl.helper.ActivateMethod.invoke(ActivateMethod.java:149) Aug 6 00:44:44.348 127.0.0.1 tr10096: ERROR - OSGi: (54/72) at org.apache.felix.scr.impl.manager.ImmediateComponentManager.createImplementationObject(ImmediateComponentManager.java:239) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (55/72) at org.apache.felix.scr.impl.manager.ImmediateComponentManager.createComponent(ImmediateComponentManager.java:119) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (56/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager$Unsatisfied.activate(AbstractComponentManager.java:1518) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (57/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:550) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (58/72) at org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:261) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (59/72) at org.apache.felix.scr.impl.config.ImmediateComponentHolder.enableComponents(ImmediateComponentHolder.java:328) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (60/72) at org.apache.felix.scr.impl.BundleComponentActivator.initialize(BundleComponentActivator.java:158) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (61/72) at org.apache.felix.scr.impl.BundleComponentActivator.<init>(BundleComponentActivator.java:113) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (62/72) at org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:261) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (63/72) at org.apache.felix.scr.impl.Activator.loadAllComponents(Activator.java:199) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (64/72) at org.apache.felix.scr.impl.Activator.start(Activator.java:108) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (65/72) at org.apache.felix.framework.util.SecureAction$Actions.run(SecureAction.java:1605) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (66/72) at java.security.AccessController.doPrivileged(Native Method) Aug 6 00:44:44.349 127.0.0.1 tr10096: ERROR - OSGi: (67/72) at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:636) Aug 6 00:44:44.350 127.0.0.1 tr10096: ERROR - OSGi: (68/72) at org.apache.felix.framework.Felix.activateBundle(Felix.java:2146) Aug 6 00:44:44.350 127.0.0.1 tr10096: ERROR - OSGi: (69/72) at org.apache.felix.framework.Felix.startBundle(Felix.java:2064) Aug 6 00:44:44.350 127.0.0.1 tr10096: ERROR - OSGi: (70/72) at org.apache.felix.framework.Felix.setActiveStartLevel(Felix.java:1291) Aug 6 00:44:44.350 127.0.0.1 tr10096: ERROR - OSGi: (71/72) at org.apache.felix.framework.FrameworkStartLevelImpl.run(FrameworkStartLevelImpl.java:304) Aug 6 00:44:44.350 127.0.0.1 tr10096: ERROR - OSGi: (72/72) at java.lang.Thread.run(Unknown Source) Aug 6 00:44:44.350 127.0.0.1 tr10096: ERROR - OSGi: [com.mendix.core.util.SecurityActivator] Component instance could not be created, activation failed (bundle: mxruntime, service: ) Aug 6 00:44:44.356 127.0.0.1 tr10096: INFO - Core: Mendix Runtime 5.17.0 (build 5038). Copyright © 2003-2015 Mendix bv. All rights reserved. Aug 6 00:44:45.073 127.0.0.1 tr10096: INFO - XMPPConnector: appnode-vizier-tr10096@beta.mendixcloud.net connected. Aug 6 00:44:45.086 127.0.0.1 tr10096: INFO - XMPPConnector: Registered 'cp@beta.mendixcloud.net/Smack' as cloud portal contact Aug 6 00:44:45.143 127.0.0.1 tr10096: INFO - Logging: Logging to file: /srv/cloud/slots/tr10096/deploy/data/log/m2ee.log, max size: 2048KiB, max rotation: 10 Aug 6 00:44:47.227 127.0.0.1 tr10096: INFO - Core: Storage service: Local file system storage, uploaded files path: /srv/cloud/slots/tr10096/deploy/data/files Aug 6 00:44:47.247 127.0.0.1 tr10096: INFO - ConnectionBus: (1/2) Database: PostgreSQL 9.3.4, name: 'dbnode-vizier-db96' Aug 6 00:44:47.247 127.0.0.1 tr10096: INFO - ConnectionBus: (2/2) Driver: PostgreSQL Native Driver PostgreSQL 9.4 JDBC4.1 (build 1201) Aug 6 00:44:47.391 127.0.0.1 tr10096: INFO - Core: Project company name is 'Mendix' Aug 6 00:44:47.391 127.0.0.1 tr10096: INFO - Core: License expiration date is 'null' Aug 6 00:44:47.391 127.0.0.1 tr10096: INFO - Core: License type is: 'Perpetual' Aug 6 00:44:47.861 127.0.0.1 tr10096: INFO - Core: Running after-startup-action... Aug 6 00:44:47.879 127.0.0.1 tr10096: INFO - AppCloudServices: Starting OpenId handler ... OpenIDReturnURL = https://mec.mendixcloud.com/openid/callback; OpenIdProvider: https://mxid2.mendixcloud.com/mxid2/discover Aug 6 00:44:48.532 127.0.0.1 tr10096: INFO - AppCloudServices: Starting OpenId handler ... DONE Aug 6 00:44:48.535 127.0.0.1 tr10096: INFO - Core: Successfully ran after-startup-action. Aug 6 00:44:48.623 127.0.0.1 tr10096: INFO - Core: Mendix Runtime successfully started, the application is now available. Aug 6 00:46:56.872 127.0.0.1 tr10096: INFO - AppCloudServices: Found local discovery of RP returnurl endpoint. Aug 6 00:46:58.441 127.0.0.1 tr10096: INFO - AppCloudServices: Found local discovery of RP returnurl endpoint. Aug 6 00:46:58.624 127.0.0.1 tr10096: INFO - AppCloudServices: [OpenID Verify Response] receivingurl: https://mec.mendixcloud.com/openid/callback?openid.ns=http%3A%2F%2Fspecs.openid.net%2Fauth%2F2.0&openid.opendpoint=https%3A%2F%2Fmxid2.mendixcloud.com%2Fmxid2%2F&openid.claimedid=https%3A%2F%2Fmxid2.mendixcloud.com%2Fmxid2%2Fid%3Fid%3D90cdbf1f-0173-4929-aef4-42cfda8ca68b&openid.responsenonce=2015-08-05T22%3A46%3A58Z0&openid.mode=idres&openid.identity=https%3A%2F%2Fmxid2.mendixcloud.com%2Fmxid2%2Fid%3Fid%3D90cdbf1f-0173-4929-aef4-42cfda8ca68b&openid.returnto=https%3A%2F%2Fmec.mendixcloud.com%2Fopenid%2Fcallback&openid.assochandle=1434433675166-S-5882509d-0bb9-42bc-85e1-ab5a57d0bae0&openid.signed=opendpoint%2Cclaimedid%2Cidentity%2Creturnto%2Cresponsenonce%2Cassochandle&openid.sig=c28KPcnDxhEsftNefq9D%2FagiQTyNFILlUfU17X5SrxQ%3D&mxid2.continuation=https%3A%2F%2Fmec.mendixcloud.com%2Findex.html%3Fprofile%3Ddesktop; to: openid.returnto:https://mec.mendixcloud.com/openid/callback Aug 6 00:47:00.091 127.0.0.1 tr10096: INFO - OpenID: User https://mxid2.mendixcloud.com/mxid2/id?id=90cdbf1f-0173-4929-aef4-42cfda8ca68b authenticated. Starting session..
asked
0 answers