8:31 p.m.
I tried to add UPS logging by following the instructions in the UPS user guide but
couldn't get it working.
This is what I see in the server.log file.
...
2015-06-16 15:49:52,284 INFO [org.jboss.as] (Controller Boot Thread) JBAS015961: Http
management interface listening on http://127.0.0.1:9990/management
2015-06-16 15:49:52,284 INFO [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin
console listening on http://127.0.0.1:9990
2015-06-16 15:49:52,284 INFO [org.jboss.as] (Controller Boot Thread) JBAS015874: WildFly
8.2.0.Final "Tweek" started in 13573ms - Started 579 of 637 services (101
services are lazy, passive or on-demand)
2015-06-16 15:50:27,011 ERROR [io.undertow.request] (default task-1) UT005023: Exception
handling request to /ag-push/rest/registry/device: java.lang.RuntimeException: Unable to
resolve realm public key remotely, status = 404
at
org.keycloak.adapters.AdapterDeploymentContext.resolveRealmKey(AdapterDeploymentContext.java:69)
[keycloak-adapter-core-1.0.4.Final.jar:]
at
org.keycloak.adapters.AdapterDeploymentContext.resolveDeployment(AdapterDeploymentContext.java:55)
[keycloak-adapter-core-1.0.4.Final.jar:]
at
org.keycloak.adapters.undertow.ServletKeycloakAuthMech.authenticate(ServletKeycloakAuthMech.java:54)
[keycloak-undertow-adapter-1.0.4.Final.jar:]
at
io.undertow.security.impl.SecurityContextImpl$AuthAttempter.transition(SecurityContextImpl.java:281)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.impl.SecurityContextImpl$AuthAttempter.transition(SecurityContextImpl.java:298)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.impl.SecurityContextImpl$AuthAttempter.access$100(SecurityContextImpl.java:268)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.impl.SecurityContextImpl.attemptAuthentication(SecurityContextImpl.java:131)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.impl.SecurityContextImpl.authTransition(SecurityContextImpl.java:106)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.impl.SecurityContextImpl.authenticate(SecurityContextImpl.java:99)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.servlet.handlers.security.ServletAuthenticationCallHandler.handleRequest(ServletAuthenticationCallHandler.java:54)
[undertow-servlet-1.1.0.Final.jar:1.1.0.Final]
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.handlers.AuthenticationConstraintHandler.handleRequest(AuthenticationConstraintHandler.java:51)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.handlers.AbstractConfidentialityHandler.handleRequest(AbstractConfidentialityHandler.java:45)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.servlet.handlers.security.ServletConfidentialityConstraintHandler.handleRequest(ServletConfidentialityConstraintHandler.java:63)
[undertow-servlet-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.servlet.handlers.security.ServletSecurityConstraintHandler.handleRequest(ServletSecurityConstraintHandler.java:56)
[undertow-servlet-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.handlers.AuthenticationMechanismsHandler.handleRequest(AuthenticationMechanismsHandler.java:58)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.servlet.handlers.security.CachedAuthenticatedSessionHandler.handleRequest(CachedAuthenticatedSessionHandler.java:70)
[undertow-servlet-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.security.handlers.SecurityInitialHandler.handleRequest(SecurityInitialHandler.java:76)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
org.wildfly.extension.undertow.security.jacc.JACCContextIdHandler.handleRequest(JACCContextIdHandler.java:61)
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
org.keycloak.adapters.undertow.ServletPreAuthActionsHandler.handleRequest(ServletPreAuthActionsHandler.java:69)
[keycloak-undertow-adapter-1.0.4.Final.jar:]
at
org.keycloak.adapters.undertow.ServletPreAuthActionsHandler.handleRequest(ServletPreAuthActionsHandler.java:69)
[keycloak-undertow-adapter-1.0.4.Final.jar:]
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.servlet.handlers.ServletInitialHandler.handleFirstRequest(ServletInitialHandler.java:261)
[undertow-servlet-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:247)
[undertow-servlet-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.servlet.handlers.ServletInitialHandler.access$000(ServletInitialHandler.java:76)
[undertow-servlet-1.1.0.Final.jar:1.1.0.Final]
at
io.undertow.servlet.handlers.ServletInitialHandler$1.handleRequest(ServletInitialHandler.java:166)
[undertow-servlet-1.1.0.Final.jar:1.1.0.Final]
at io.undertow.server.Connectors.executeRootHandler(Connectors.java:197)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at io.undertow.server.HttpServerExchange$1.run(HttpServerExchange.java:759)
[undertow-core-1.1.0.Final.jar:1.1.0.Final]
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [rt.jar:1.7.0_71]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [rt.jar:1.7.0_71]
at java.lang.Thread.run(Unknown Source) [rt.jar:1.7.0_71]
The error occurs each time I try to do a registration after server restart, until I log
into the UPS console, then the errors stop.
- Kelvin
----------------------------------------------------------------------------------
From: aerogear-users-bounces(a)lists.jboss.org
[mailto:aerogear-users-bounces@lists.jboss.org] On Behalf Of Matthias Wessendorf
Sent: Monday, June 15, 2015 4:10 AM
To: aerogear-users(a)lists.jboss.org
Subject: Re: [Aerogear-users] UPS load on startup
Hi,
yes, openshift gets susspended after 48 hours (I think) of inactivity - but I think your
error is different to Kevin's
Kevin any chance to get a log file / stack-trace from the 500 ?
Is that just on Android/Cordova, or does that also reproduce w/ doing (test) registration
w/ curl, like:
https://aerogear.org/docs/specs/aerogear-unifiedpush-rest-1.0.x/registry/...
Thanks
On Mon, Jun 15, 2015 at 12:29 PM, Alex Ballesté <alexandre.balleste(a)udl.cat> wrote:
Hi, I noticed the same behaviour in my aerogear test server, but I thought that was
something related with openshift. If service is not used for a while seems like it become
suspended until you access again.
I tried to reproduce restarting the server but I couldn't... Just found something in
the logs this morning after 2 days without using it. (At 2:51 I sent the notification)
Log was
-----------------------------
2015/06/13 00:00:00,109 INFO [GCMPushNotificationSender] (EJB default - 2) Deleting
['0'] outdated PushMessageInformation objects
2015/06/13 12:05:30,766 INFO [org.jboss.as.osgi] (MSC service thread 1-5) JBAS011942:
Stopping OSGi Framework
2015/06/15 02:51:14,161 INFO [org.jboss.as.configadmin] (ServerService Thread Pool -- 35)
JBAS016200: Activating ConfigAdmin Subsystem
2015/06/15 02:51:14,264 INFO [org.jboss.as.jacorb] (ServerService Thread Pool -- 41)
JBAS016300: Activating JacORB Subsystem
2015/06/15 02:51:14,356 INFO [org.jboss.as.security] (ServerService Thread Pool -- 58)
JBAS013101: Activating Security Subsystem
2015/06/15 02:51:14,258 INFO [org.jboss.as.clustering.infinispan] (ServerService Thread
Pool -- 40) JBAS010280: Activating Infinispan subsystem.
...
...
-------------------------------------
It seem like on saturday 13 service was stopped. And started again on monday 16 at 2:51
(by my notification???) . I also got this error during the startup process
--------------------------
2015/06/15 02:51:46,443 INFO [org.keycloak.adapters.as7.KeycloakAuthenticatorValve] (MSC
service thread 1-5) **** using /WEB-INF/keycloak.json
2015/06/15 02:51:46,760 INFO [JPAPushMessageInformationDao] (EJB default - 2) Deleting
['2'] outdated PushMessageInformation objects
2015/06/15 02:51:46,951 INFO [org.keycloak.services.resources.KeycloakApplication] (MSC
service thread 1-1) Not importing realm aerogear from resource /WEB-INF/ups-realm.json.
It already exists.
2015/06/15 02:51:46,954 INFO [JPAPushMessageInformationDao] (EJB default - 1) Deleting
['2'] outdated PushMessageInformation objects
2015/06/15 02:51:46,966 WARN [com.arjuna.ats.arjuna] (EJB default - 1) ARJUNA012125:
TwoPhaseCoordinator.beforeCompletion - failed for SynchronizationImple<
0:ffff0a21a655:16c5d4f8:557e75e5:f,
org.hibernate.engine.transaction.synchronization.internal.RegisteredSynchronization@d8bbe6
>: javax.persistence.OptimisticLockException: org.hibernate.StaleStateException: Batch
update returned unexpected row count from update [0]; actual row count: 0; expected: 1
at
org.hibernate.ejb.AbstractEntityManagerImpl.wrapStaleStateException(AbstractEntityManagerImpl.java:1402)
[hibernate-entitymanager-4.0.1.Final.jar:4.0.1.Final]
at
org.hibernate.ejb.AbstractEntityManagerImpl.convert(AbstractEntityManagerImpl.java:1308)
[hibernate-entitymanager-4.0.1.Final.jar:4.0.1.Final]
at
org.hibernate.ejb.AbstractEntityManagerImpl.convert(AbstractEntityManagerImpl.java:1289)
[hibernate-entitymanager-4.0.1.Final.jar:4.0.1.Final]
at
org.hibernate.ejb.AbstractEntityManagerImpl.convert(AbstractEntityManagerImpl.java:1295)
[hibernate-entitymanager-4.0.1.Final.jar:4.0.1.Final]
at
org.hibernate.ejb.AbstractEntityManagerImpl$CallbackExceptionMapperImpl.mapManagedFlushFailure(AbstractEntityManagerImpl.java:1481)
[hibernate-entitymanager-4.0.1.Final.jar:4.0.1.Final]
at
org.hibernate.engine.transaction.synchronization.internal.SynchronizationCallbackCoordinatorImpl.beforeCompletion(SynchronizationCallbackCoordinatorImpl.java:109)
[hibernate-core-4.0.1.Final.jar:4.0.1.Final]
at
org.hibernate.engine.transaction.synchronization.internal.RegisteredSynchronization.beforeCompletion(RegisteredSynchronization.java:53)
[hibernate-core-4.0.1.Final.jar:4.0.1.Final]
------------------------
Later another generated message at 2:57 was received an processed fine. I don't know
if it's something related with hosting or with UPS. I'm running 1.0.2 too.
Sorry if this information is not relevant
Alex Ballesté
El 13/06/15 a les 08:01, Matthias Wessendorf ha escrit:
any chance of stack trace?
On Saturday, June 13, 2015, Kelvin Lunsford <kelvin(a)qantel.com> wrote:
I restarted Wildfly and I had to log into the UPS console to stop the registration
errors.
The error callback for the plugin push.register() function returns the message "The
server returned the error code 500".
- Kelvin
---------------------------------------------------------------------------
From: aerogear-users-bounces(a)lists.jboss.org
[mailto:aerogear-users-bounces@lists.jboss.org] On Behalf Of Matthias Wessendorf
Sent: Friday, June 12, 2015 12:01 AM
To: aerogear-users(a)lists.jboss.org
Subject: Re: [Aerogear-users] UPS load on startup
hrm,
that's strange - not noticed so far.
Any details on the error message ? Is that reproducable w/ something like curl ?
On Fri, Jun 12, 2015 at 3:05 AM, Kelvin Lunsford <kelvin(a)qantel.com> wrote:
I'm developing a mobile app and testing USP 1.0.2 on Wildfly 8.2.0.
Runs great but I've noticed that when the server is restarted registration requests
from my mobile app fail until I try to access the ag-push console with a browser and bring
up a login page. Then registration works.
Anyone noticed this?
- Kelvin
_______________________________________________
Aerogear-users mailing list
Aerogear-users(a)lists.jboss.org
https://lists.jboss.org/mailman/listinfo/aerogear-users
--
Matthias Wessendorf
blog: http://matthiaswessendorf.wordpress.com/
sessions: http://www.slideshare.net/mwessendorf
twitter: http://twitter.com/mwessendorf
_______________________________________________
Aerogear-users mailing list
Aerogear-users(a)lists.jboss.org
https://lists.jboss.org/mailman/listinfo/aerogear-users
--
Sent from Gmail Mobile
_______________________________________________
Aerogear-users mailing list
Aerogear-users(a)lists.jboss.org
https://lists.jboss.org/mailman/listinfo/aerogear-users
--
Alexandre Ballesté Crevillén alexandre.balleste at udl.cat
====================
Universitat de Lleida
Àrea de sistemes d'Informació i Comunicacions
Analista/Programador
University of Lleida
Information and Communication Systems Service
Tlf: +34 973 702148
Fax: +34 973 702130
=====================
Avís legal/Aviso legal/Avertiment legal/Legal notice
_______________________________________________
Aerogear-users mailing list
Aerogear-users(a)lists.jboss.org
https://lists.jboss.org/mailman/listinfo/aerogear-users
--
Matthias Wessendorf
blog: http://matthiaswessendorf.wordpress.com/
sessions: http://www.slideshare.net/mwessendorf
twitter: http://twitter.com/mwessendorf