Hi Marek,
Thanks for the clarification.
Yes, we will always be using Keycloak behind a load balancer.
I've updated all my nodes with master and everything seems to be working as expected.
I need to try out few more fail-over scenarios and will get back with my findings.
-- Rajat
-----Original Message-----
From: Marek Posolda [mailto:mposolda@redhat.com]
Sent: 06 August 2015 21:36
To: Nair, Rajat; Stian Thorgersen
Cc: keycloak-user(a)lists.jboss.org
Subject: Re: [keycloak-user] Distributed Keycloak user sessions using Infinispan
It's clear that your infinispan cluster works as expected. I think the issue is, that
you are sending curl requests directly to individual cluster nodes instead of
loadbalancer. At least I saw it as an issue during my testing and I suspect that in your
case it will be the same.
Like in your example you first retrieved the token by curl request to
. In this case, it doesn't work as issuer (iss field) in
access token starts with URL "http://test-server-110:8080" , which means that
this access token will be rejected on "http://test-server-111:8081" when sending
request to UserInfo endpoint here.
I've added a bit more info about error into UserInfo endpoint, so in latest master you
can see additional details (I suspect that you will really see the error message about
invalid issuer URL).
So the solution is, that you will need to send requests to loadbalancer instead of
individual cluster nodes. Like if your curl request to retrieve access token will be send
to "http://loadbalancer:8080" and the UserInfo will be also accessed through
loadbalancer, it will work because the issuer in access token will be
"http://loadbalancer:8080" .
You can try this and then add or remove cluster nodes as you wish. It will work as long as
at least one cluster node is available behind loadbalancer (no matter which one).
Maybe we can relax a bit on validation and validate just realm name instead of the full
URL during issuer validation (we already had it like this few months back AFAIR). But not
sure if it's really needed as in production, you will likely access your nodes always
via loadbalancer .
Is it correct?
Marek
On 6.8.2015 09:44, Marek Posolda wrote:
I've finally reproduced the issue and looking at it. Will update
you
once I have fix.
Marek
On 5.8.2015 14:14, Nair, Rajat wrote:
> Some more information -
>
> Quick summary - I'm trying to test HA of Keycloak user sessions when
> one of the nodes goes down, users should not have to login again as
> their session information would be available on other node. Keycloak
> cluster is setup to store users session on Infinispan (testing using
> distributed-cache and replicated-cache).
>
> To see the cache information on Keycloak nodes, I setup hawtio on
> these node. Initial state of caches on both the nodes are captured in
> these images (see 110.DC.Start.png and 111.DC.Start.png) Then user
> logs into server 111. We can see the session entry value increasing
> (see 111.DC.Login.On.111.PNG). When we look at session entry on 110
> server, we see that the count has increased there too.
> That means that they session is being successfully replicated (see
> 110.DC.Login.On.111.PNG).
>
> To verify if this works other way around, we logged into server 110,
> and its session entry count increased (see
> 110.DC.Login.On.110.And.111.PNG). When we check 111, we can see that
> session entry count increased on this server too. (see
> 111.DC.Login.On.110.And.111.png).
>
> We initially suspected that our sessions were not getting replicated.
> Using hawtio, we can see session entry count increasing on both
> servers. Could this mean that there is a bug in Keycloak's code while
> fetching user sessions? Is there any other way we can validate user
> sessions?
>
> -- Rajat
>
> -----Original Message-----
> From: Nair, Rajat
> Sent: 03 August 2015 12:43
> To: 'Stian Thorgersen'; Marek Posolda
> Cc: keycloak-user(a)lists.jboss.org
> Subject: RE: [keycloak-user] Distributed Keycloak user sessions using
> Infinispan
>
> Hi,
>
> Some more info from log of test-server-110 server (server names are
> test-server-110 and test-server-111) - Infinispan subsystem
> initialized logs for sessions cache -
> [org.jboss.as.clustering.infinispan] (ServerService Thread Pool --
> 39) WFLYCLINF0001: Activating Infinispan subsystem.
> [org.infinispan.remoting.transport.jgroups.JGroupsTransport]
> (ServerService Thread Pool -- 62) ISPN000078: Starting JGroups
> channel keycloak
> [org.infinispan.remoting.transport.jgroups.JGroupsTransport]
> (ServerService Thread Pool -- 62) ISPN000094: Received new cluster
> view for channel keycloak: [test-server-111|0] (1) [test-server-111]
> [org.infinispan.remoting.transport.jgroups.JGroupsTransport]
> (ServerService Thread Pool -- 62) ISPN000079: Channel keycloak local
> address is test-server-111, physical addresses are [XX.XX.XX.XX:7600]
> [org.jboss.as.clustering.infinispan] (ServerService Thread Pool --
> 63) WFLYCLINF0002: Started sessions cache from keycloak container
> [org.infinispan.CLUSTER] (remote-thread--p3-t3) ISPN000310: Starting
> cluster-wide rebalance for cache sessions, topology
> CacheTopology{id=1, rebalanceId=1,
> currentCH=DefaultConsistentHash{ns=80, owners = (1)[test-server-111:
> 80+0]}, pendingCH=DefaultConsistentHash{ns=80, owners =
> (2)[test-server-111: 40+40, test-server-110: 40+40]}, unionCH=null,
> actualMembers=[test-server-111, test-server-110]}
> [org.infinispan.CLUSTER] (remote-thread--p3-t2) ISPN000336: Finished
> cluster-wide rebalance for cache sessions, topology id = 1
>
> Session cache details -
> [org.infinispan.jmx.JmxUtil] (ServerService Thread Pool -- 63) Object
> name
> jboss.infinispan:type=Cache,name="sessions(dist_sync)",manager="keycl
> oak",component=Cache already registered
> [org.infinispan.topology.LocalTopologyManagerImpl]
> (ServerService Thread Pool -- 63) Node test-server-110 joining cache
> sessions [org.infinispan.topology.LocalTopologyManagerImpl]
> (ServerService Thread Pool -- 63) Updating local topology for cache
> sessions: CacheTopology{id=0, rebalanceId=0,
> currentCH=DefaultConsistentHash{ns=80, owners = (1)[test-server-111:
> 80+0]}, pendingCH=null, unionCH=null,
> actualMembers=[test-server-111]}
> [org.infinispan.topology.LocalTopologyManagerImpl]
> (transport-thread--p2-t5) Updating local topology for cache sessions:
> CacheTopology{id=1, rebalanceId=1,
> currentCH=DefaultConsistentHash{ns=80, owners = (1)[test-server-111:
> 80+0]}, pendingCH=DefaultConsistentHash{ns=80, owners =
> (2)[test-server-111: 40+40, test-server-110: 40+40]}, unionCH=null,
> actualMembers=[test-server-111, test-server-110]}
> [org.infinispan.topology.LocalTopologyManagerImpl]
> (transport-thread--p2-t5) Starting local rebalance for cache
> sessions, topology = CacheTopology{id=1, rebalanceId=1,
> currentCH=DefaultConsistentHash{ns=80, owners = (1)[test-server-111:
> 80+0]}, pendingCH=DefaultConsistentHash{ns=80, owners =
> (2)[test-server-111: 40+40, test-server-110: 40+40]}, unionCH=null,
> actualMembers=[test-server-111, test-server-110]}
> [org.infinispan.statetransfer.StateConsumerImpl]
> (transport-thread--p2-t5) Adding inbound state transfer for segments
> [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 17, 16, 19,
> 18, 21, 20, 23, 22, 25, 24, 27, 26, 29, 28, 31, 30, 34, 35, 32, 33,
> 38, 39, 36, 37, 42, 43, 40, 41, 46, 47, 44, 45, 51, 50, 49, 48, 55,
> 54, 53, 52, 59, 58, 57, 56, 63, 62, 61, 60, 68, 69, 70, 71, 64, 65,
> 66, 67, 76, 77, 78, 79, 72, 73, 74, 75] of cache sessions
> [org.infinispan.statetransfer.StateConsumerImpl]
> (transport-thread--p2-t5) Removing no longer owned entries for cache
> sessions [org.infinispan.statetransfer.InboundTransferTask]
> (stateTransferExecutor-thread--p5-t19) Finished receiving state for
> segments [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 17,
> 16, 19, 18, 21, 20, 23, 22, 25, 24, 27, 26, 29, 28, 31, 30, 34, 35,
> 32, 33, 38, 39, 36, 37, 42, 43, 40, 41, 46, 47, 44, 45, 51, 50, 49,
> 48, 55, 54, 53, 52, 59, 58, 57, 56, 63, 62, 61, 60, 68, 69, 70, 71,
> 64, 65, 66, 67, 76, 77, 78, 79, 72, 73, 74, 75] of cache sessions
> [org.infinispan.statetransfer.StateConsumerImpl]
> (stateTransferExecutor-thread--p5-t24) Finished receiving of segments
> for cache sessions for topology 1.
> [org.infinispan.topology.LocalTopologyManagerImpl]
> (transport-thread--p2-t10) Updating local topology for cache
> sessions: CacheTopology{id=2, rebalanceId=1,
> currentCH=DefaultConsistentHash{ns=80, owners = (2)[test-server-111:
> 40+40, test-server-110: 40+40]}, pendingCH=null, unionCH=null,
> actualMembers=[test-server-111, test-server-110]}
> [org.infinispan.statetransfer.StateConsumerImpl]
> (transport-thread--p2-t10) Removing no longer owned entries for cache
> sessions [org.infinispan.cache.impl.CacheImpl] (ServerService Thread
> Pool -- 63) Started cache sessions on test-server-110
> [org.wildfly.clustering.infinispan.spi.service.CacheBuilder]
> (ServerService Thread Pool -- 63) sessions keycloak cache started
>
>
> Looks like the servers are talking to each other (setup on unicast)
> and session cache between the servers are shared, but we still cannot
> successfully fetch user info when token is generated by one server
> (test-server-110) and data from another (test-server-111).
>
> Any suggestions/debugging approaches appreciated.
>
> -- Rajat
>
> -----Original Message-----
> From: Stian Thorgersen [mailto:stian@redhat.com]
> Sent: 29 July 2015 22:51
> To: Nair, Rajat; Marek Posolda
> Cc: keycloak-user(a)lists.jboss.org
> Subject: Re: [keycloak-user] Distributed Keycloak user sessions using
> Infinispan
>
> I'm away on holiday, Marek can you take a look at this?
>
> ----- Original Message -----
>> From: "Rajat Nair" <rajat.nair(a)hp.com>
>> To: "Stian Thorgersen" <stian(a)redhat.com>
>> Cc: keycloak-user(a)lists.jboss.org
>> Sent: Wednesday, 29 July, 2015 2:56:07 PM
>> Subject: RE: [keycloak-user] Distributed Keycloak user sessions
>> using Infinispan
>>
>> Follow up to our discussion -
>>
>> I upgrade my nodes to Keycloak 1.4 Final. Dropped and re-created
>> database Postgres database (shared between both the nodes) and
>> tested distributed user session using following commands -
>> - Fetch access token using following curl from one server
>> curl --write-out " %{http_code}" -s --request POST --header
>> "Content-Type:
>> application/x-www-form-urlencoded; charset=UTF-8" --data
>>
"username=user1@email.com&password=testpassword(a)&client_id=admin-client&grant_type=password"
>>
>>
"http://test-server-110:8080/auth/realms/test/protocol/openid-connect/token"
>>
>>
>> - Validated the token on different server using
>> curl --write-out " %{http_code}" -s --request GET --header
>> "Content-Type:
>> application/json" --header "Authorization: Bearer
>> [ACCESS_TOKEN_FROM_PREVIOUS_CALL]"
>>
"http://test-server-111:8081/auth/realms/test/protocol/openid-connect/userinfo"
>>
>>
>> And we get this -
>>
{"error":"invalid_grant","error_description":"Token
>> invalid"}
>> No more NPE and internal server error.
>>
>> If we use the same token and try to fetch user details on server
>> which issued the token - we get the correct data. (Note - I have
>> confirmed that the token has not expired)
>>
>>> One thing you can try is to make sure user session replication is
>>> working
>>> properly:
>>> 1. Start two nodes
>>> 2. Open admin console directly on node 1 - login as admin/admin 3.
>>> Open admin console directly on node 2 from another machine/browser
>>> or use incognito mode - login as admin/admin 4. On node 1 go to
>>> users -> view all
>>> -> click on admin -> sessions - > > you should see two sessions
5.
>>> -> On node
>>> 2 do the same and check you can see two sessions there as well
>> Now this is where things get strange. I followed the steps described
>> - used 2 different browsers - and I can see 2 sessions listed!
>>
>> Are the process we use to validate the token incorrect? Or is master
>> console on the web doing something different (like get the data from
>> Postgres database used by both the nodes).
>>
>> -- Rajat
>>
>> -----Original Message-----
>> From: Stian Thorgersen [mailto:stian@redhat.com]
>> Sent: 28 July 2015 10:19
>> To: Nair, Rajat
>> Cc: keycloak-user(a)lists.jboss.org
>> Subject: Re: [keycloak-user] Distributed Keycloak user sessions
>> using Infinispan
>>
>>
>>
>> ----- Original Message -----
>>> From: "Rajat Nair" <rajat.nair(a)hp.com>
>>> To: "Stian Thorgersen" <stian(a)redhat.com>
>>> Cc: keycloak-user(a)lists.jboss.org
>>> Sent: Monday, 27 July, 2015 7:33:25 PM
>>> Subject: RE: [keycloak-user] Distributed Keycloak user sessions
>>> using Infinispan
>>>
>>>> Can you send me your standalone-ha.xml and keycloak-server.json?
>>> Files attached. The service is started like -
>>> /opt/jboss/keycloak/bin/standalone.sh -c standalone-ha.xml
>>> -b=test-server-110
>>> -bmanagement=test-server-110 -u 230.0.0.4
>>> -Djboss.node.name=test-server-110
>>>
>>>> Also, any chance you can try it out with master? I've been testing
>>>> with that as we're about to do 1.4 release soon
>>> Glad to give back to the community. Will build and deploy the
>>> master on my nodes. Will send findings tomorrow.
>>>
>>> Regarding a scenario I described earlier - Case 2 1. Start with 1
>>> Node down. We bring it back up. We wait for some time so that
>>> Infinispan can sync.
>>> 2. Bring down other node.
>>> 3. Try to get user info using existing token.
>>>
>>> Is this a valid use-case?
>> Yes - I've tried the same use-case and it works fine every time. One
>> caveat is that access token can expire, but in this case you should
>> get a 403 returned, not a NPE exception and 500.
>>
>> One thing you can try is to make sure user session replication is
>> working
>> properly:
>>
>> 1. Start two nodes
>> 2. Open admin console directly on node 1 - login as admin/admin 3.
>> Open admin console directly on node 2 from another machine/browser
>> or use incognito mode - login as admin/admin 4. On node 1 go to
>> users -> view all -> click on admin -> sessions - you should see two
>> sessions 5. On node 2 do the same and check you can see two sessions
>> there as well
>>
>>> -- Rajat
>>>
>>> -----Original Message-----
>>> From: Stian Thorgersen [mailto:stian@redhat.com]
>>> Sent: 27 July 2015 19:16
>>> To: Nair, Rajat
>>> Cc: keycloak-user(a)lists.jboss.org
>>> Subject: Re: [keycloak-user] Distributed Keycloak user sessions
>>> using Infinispan
>>>
>>> Also, any chance you can try it out with master? I've been testing
>>> with that as we're about to do 1.4 release soon
>>>
>>> ----- Original Message -----
>>>> From: "Stian Thorgersen" <stian(a)redhat.com>
>>>> To: "Rajat Nair" <rajat.nair(a)hp.com>
>>>> Cc: keycloak-user(a)lists.jboss.org
>>>> Sent: Monday, 27 July, 2015 3:45:46 PM
>>>> Subject: Re: [keycloak-user] Distributed Keycloak user sessions
>>>> using Infinispan
>>>>
>>>> Can you send me your standalone-ha.xml and keycloak-server.json?
>>>>
>>>> ----- Original Message -----
>>>>> From: "Rajat Nair" <rajat.nair(a)hp.com>
>>>>> To: "Stian Thorgersen" <stian(a)redhat.com>
>>>>> Cc: keycloak-user(a)lists.jboss.org
>>>>> Sent: Monday, 27 July, 2015 3:41:36 PM
>>>>> Subject: RE: [keycloak-user] Distributed Keycloak user sessions
>>>>> using Infinispan
>>>>>
>>>>>> Do you have both nodes fully up and running before you kill one
>>>>>> node?
>>>>> Yes.
>>>>> This is what we tried -
>>>>> Case 1
>>>>> 1. Two node cluster (both running Keycloak engines) - both up and
>>>>> running.
>>>>> Configured load balancing using mod_cluster.
>>>>> 2. Login and get token.
>>>>> 3. Bring down one node.
>>>>> 4. Get user info using existing token. This is when we get NPE.
>>>>>
>>>>> Case 2
>>>>> 1. Start with 1 Node down. We bring it back up. We wait for some
>>>>> time so that Infinispan can sync.
>>>>> 2. Bring down other node.
>>>>> 3. Try to get user info using existing token. Again we see NPE.
>>>>>
>>>>>> It's a bug - if session is expired it should return an error
>>>>>> message, not a NPE (see
>>>>>>
https://issues.jboss.org/browse/KEYCLOAK-1710)
>>>>> Thanks for tracking this.
>>>>>
>>>>> -- Rajat
>>>>>
>>>>> ----- Original Message -----
>>>>>> From: "Rajat Nair" <rajat.nair(a)hp.com>
>>>>>> To: "Stian Thorgersen" <stian(a)redhat.com>
>>>>>> Cc: keycloak-user(a)lists.jboss.org
>>>>>> Sent: Monday, 27 July, 2015 3:20:27 PM
>>>>>> Subject: RE: [keycloak-user] Distributed Keycloak user sessions
>>>>>> using Infinispan
>>>>>>
>>>>>> Thanks for quick reply Stian.
>>>>>>
>>>>>>> What version?
>>>>>> We are using Keycloak 1.3.1 Final.
>>>>>>> Did you remember to change userSessions provider to
infinispan
>>>>>>> in keycloak-server.json?
>>>>>> Yes. We got following in keycloak-server.json -
>>>>>> "userSessions": {
>>>>>> "provider": "infinispan"
>>>>>> }
>>>>>>
>>>>>>> Firstly owners="2" should work fine as long as only
one node
>>>>>>> dies and the other remains active. Secondly it should return
a
>>>>>>> NPE, but an error if user session is not found.
>>>>>> Could you elaborate on your 2nd point?
>>>>> Do you have both nodes fully up and running before you kill one
>>>>> node?
>>>>>
>>>>> It's a bug - if session is expired it should return an error
>>>>> message, not a NPE (see
>>>>>
https://issues.jboss.org/browse/KEYCLOAK-1710)
>>>>>
>>>>>> -- Rajat
>>>>>>
>>>>>> -----Original Message-----
>>>>>> From: Stian Thorgersen [mailto:stian@redhat.com]
>>>>>> Sent: 27 July 2015 18:07
>>>>>> To: Nair, Rajat
>>>>>> Cc: keycloak-user(a)lists.jboss.org
>>>>>> Subject: Re: [keycloak-user] Distributed Keycloak user sessions
>>>>>> using Infinispan
>>>>>>
>>>>>> Did you remember to change userSessions provider to infinispan
>>>>>> in keycloak-server.json?
>>>>>>
>>>>>> ----- Original Message -----
>>>>>>> From: "Stian Thorgersen" <stian(a)redhat.com>
>>>>>>> To: "Rajat Nair" <rajat.nair(a)hp.com>
>>>>>>> Cc: keycloak-user(a)lists.jboss.org
>>>>>>> Sent: Monday, 27 July, 2015 2:24:17 PM
>>>>>>> Subject: Re: [keycloak-user] Distributed Keycloak user
sessions
>>>>>>> using Infinispan
>>>>>>>
>>>>>>> What version?
>>>>>>>
>>>>>>> Firstly owners="2" should work fine as long as only
one node
>>>>>>> dies and the other remains active. Secondly it should return
a
>>>>>>> NPE, but an error if user session is not found.
>>>>>>>
>>>>>>> ----- Original Message -----
>>>>>>>> From: "Rajat Nair" <rajat.nair(a)hp.com>
>>>>>>>> To: keycloak-user(a)lists.jboss.org
>>>>>>>> Sent: Monday, 27 July, 2015 2:03:47 PM
>>>>>>>> Subject: [keycloak-user] Distributed Keycloak user
sessions
>>>>>>>> using Infinispan
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Hi,
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> I’m in the process of setting up distributed user
sessions
>>>>>>>> using Infinispan on my Keycloak cluster. This is the
>>>>>>>> configuration I use –
>>>>>>>>
>>>>>>>> <cache-container name="keycloak"
>>>>>>>> jndi-name="java:jboss/infinispan/Keycloak">
>>>>>>>> lock-timeout="60000"/>
>>>>>>>>
>>>>>>>> <invalidation-cache name="realms"
mode="SYNC"/>
>>>>>>>>
>>>>>>>> <invalidation-cache name="users"
mode="SYNC"/>
>>>>>>>>
>>>>>>>> <distributed-cache name="sessions"
mode="SYNC"
>>>>>>>> owners="2"/>
>>>>>>>>
>>>>>>>> <distributed-cache name="loginFailures"
mode="SYNC"
>>>>>>>> owners="1"/>
>>>>>>>>
>>>>>>>> </cache-container>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> And in server.logs, I can see my servers communicate –
>>>>>>>>
>>>>>>>> 2015-07-27 10:27:24,662 INFO [org.infinispan.CLUSTER]
>>>>>>>> (remote-thread--p3-t7)
>>>>>>>> ISPN000310: Starting cluster-wide rebalance for cache
users,
>>>>>>>> topology CacheTopology{id=57, rebalanceId=17,
>>>>>>>> currentCH=ReplicatedConsistentHash{ns
>>>>>>>> =
>>>>>>>> 60, owners = (1)[test-server-110: 60]},
>>>>>>>> pendingCH=ReplicatedConsistentHash{ns = 60, owners =
>>>>>>>> (2)[test-server-110:
>>>>>>>> 30, test-server-111: 30]}, unionCH=null,
>>>>>>>> actualMembers=[test-server-110, test-server-111]}
>>>>>>>>
>>>>>>>> 2015-07-27 10:27:24,665 INFO [org.infinispan.CLUSTER]
>>>>>>>> (remote-thread--p3-t10)
>>>>>>>> ISPN000310: Starting cluster-wide rebalance for cache
realms,
>>>>>>>> topology CacheTopology{id=57, rebalanceId=17,
>>>>>>>> currentCH=ReplicatedConsistentHash{ns
>>>>>>>> =
>>>>>>>> 60, owners = (1)[test-server-110: 60]},
>>>>>>>> pendingCH=ReplicatedConsistentHash{ns = 60, owners =
>>>>>>>> (2)[test-server-110:
>>>>>>>> 30, test-server-111: 30]}, unionCH=null,
>>>>>>>> actualMembers=[test-server-110, test-server-111]}
>>>>>>>>
>>>>>>>> 2015-07-27 10:27:24,665 INFO [org.infinispan.CLUSTER]
>>>>>>>> (remote-thread--p3-t8)
>>>>>>>> ISPN000310: Starting cluster-wide rebalance for cache
>>>>>>>> loginFailures, topology CacheTopology{id=57,
rebalanceId=17,
>>>>>>>> currentCH=DefaultConsistentHash{ns=80,
>>>>>>>> owners =
>>>>>>>> (1)[test-server-110:
>>>>>>>> 80+0]},
>>>>>>>> pendingCH=DefaultConsistentHash{ns=80, owners =
>>>>>>>> (2)[test-server-110:
>>>>>>>> 40+0,
>>>>>>>> test-server-111: 40+0]}, unionCH=null,
>>>>>>>> actualMembers=[test-server-110, test-server-111]}
>>>>>>>>
>>>>>>>> 2015-07-27 10:27:24,669 INFO [org.infinispan.CLUSTER]
>>>>>>>> (remote-thread--p3-t9)
>>>>>>>> ISPN000310: Starting cluster-wide rebalance for cache
>>>>>>>> sessions, topology CacheTopology{id=56, rebalanceId=17,
>>>>>>>> currentCH=DefaultConsistentHash{ns=80,
>>>>>>>> owners = (1)[test-server-110: 80+0]},
>>>>>>>> pendingCH=DefaultConsistentHash{ns=80,
>>>>>>>> owners = (2)[test-server-110: 40+0, test-server-111:
>>>>>>>> 40+0]}, unionCH=null, actualMembers=[test-server-110,
>>>>>>>> test-server-111]}
>>>>>>>>
>>>>>>>> 2015-07-27 10:27:24,808 INFO [org.infinispan.CLUSTER]
>>>>>>>> (remote-thread--p3-t9)
>>>>>>>> ISPN000336: Finished cluster-wide rebalance for cache
>>>>>>>> loginFailures, topology id = 57
>>>>>>>>
>>>>>>>> 2015-07-27 10:27:24,810 INFO [org.infinispan.CLUSTER]
>>>>>>>> (remote-thread--p3-t12)
>>>>>>>> ISPN000336: Finished cluster-wide rebalance for cache
>>>>>>>> sessions, topology id = 56
>>>>>>>>
>>>>>>>> 2015-07-27 10:27:24,988 INFO [org.infinispan.CLUSTER]
>>>>>>>> (remote-thread--p3-t12)
>>>>>>>> ISPN000336: Finished cluster-wide rebalance for cache
realms,
>>>>>>>> topology id =
>>>>>>>> 57
>>>>>>>>
>>>>>>>> 2015-07-27 10:27:25,530 INFO [org.infinispan.CLUSTER]
>>>>>>>> (remote-thread--p3-t8)
>>>>>>>> ISPN000336: Finished cluster-wide rebalance for cache
users,
>>>>>>>> topology id =
>>>>>>>> 57
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> I can successfully login, get a token and fetch user
details
>>>>>>>> with this token.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Problem is, if one of the nodes on the cluster goes down
and
>>>>>>>> if we try to reuse a token which was already issued (so
>>>>>>>> workflow is – user logins in, get token, (a node in the
>>>>>>>> cluster goes down) and then fetch user details using
>>>>>>>> token) – we see an internal server exception. From the
logs –
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 2015-07-27 10:24:25,714 ERROR [io.undertow.request]
(default
>>>>>>>> task-1)
>>>>>>>> UT005023: Exception handling request to
>>>>>>>> /auth/realms/scaletest/protocol/openid-connect/userinfo:
>>>>>>>> java.lang.RuntimeException: request path:
>>>>>>>> /auth/realms/scaletest/protocol/openid-connect/userinfo
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.keycloak.services.filters.KeycloakSessionServletFilter
>>>>>>>> .d
>>>>>>>> oF
>>>>>>>> ilte
>>>>>>>> r(
>>>>>>>> KeycloakSessionServletFilter.java:54)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.
>>>>>>>> java
>>>>>>>> :6
>>>>>>>> 0)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl
>>>>>>>> .d
>>>>>>>> oF
>>>>>>>> ilte
>>>>>>>> r(
>>>>>>>> FilterHandler.java:132)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.FilterHandler.handleRequest(F
>>>>>>>> il
>>>>>>>> te
>>>>>>>> rHan
>>>>>>>> dl
>>>>>>>> er.java:85)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.security.ServletSecurityRoleH
>>>>>>>> an
>>>>>>>> dl
>>>>>>>> er.h
>>>>>>>> an
>>>>>>>> dleRequest(ServletSecurityRoleHandler.java:62)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.ServletDispatchingHandler.han
>>>>>>>> dl
>>>>>>>> eR
>>>>>>>> eque
>>>>>>>> st
>>>>>>>> (ServletDispatchingHandler.java:36)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.wildfly.extension.undertow.security.SecurityContextAss
>>>>>>>> oc
>>>>>>>> ia
>>>>>>>> tion
>>>>>>>> Ha
>>>>>>>>
ndler.handleRequest(SecurityContextAssociationHandler.java
>>>>>>>> :7
>>>>>>>> 8)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.server.handlers.PredicateHandler.handleRequest
>>>>>>>> (P
>>>>>>>> re
>>>>>>>> dica
>>>>>>>> te
>>>>>>>> Handler.java:43)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.security.SSLInformationAssoci
>>>>>>>> at
>>>>>>>> io
>>>>>>>> nHan
>>>>>>>> dl
>>>>>>>>
er.handleRequest(SSLInformationAssociationHandler.java:131
>>>>>>>> )
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.security.ServletAuthenticatio
>>>>>>>> nC
>>>>>>>> al
>>>>>>>> lHan
>>>>>>>> dl
>>>>>>>>
er.handleRequest(ServletAuthenticationCallHandler.java:57)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.server.handlers.PredicateHandler.handleRequest
>>>>>>>> (P
>>>>>>>> re
>>>>>>>> dica
>>>>>>>> te
>>>>>>>> Handler.java:43)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.security.handlers.AbstractConfidentialityHandl
>>>>>>>> er
>>>>>>>> .h
>>>>>>>> andl
>>>>>>>> eR
>>>>>>>> equest(AbstractConfidentialityHandler.java:46)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.security.ServletConfidentiali
>>>>>>>> ty
>>>>>>>> Co
>>>>>>>> nstr
>>>>>>>> ai
>>>>>>>>
ntHandler.handleRequest(ServletConfidentialityConstraintHa
>>>>>>>> nd
>>>>>>>> le
>>>>>>>> r.ja
>>>>>>>> va
>>>>>>>> :64)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.security.handlers.AuthenticationMechanismsHandler.
>>>>>>>> hand
>>>>>>>> le
>>>>>>>> Request(AuthenticationMechanismsHandler.java:58)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.security.CachedAuthenticatedS
>>>>>>>> es
>>>>>>>> si
>>>>>>>> onHa
>>>>>>>> nd
>>>>>>>>
ler.handleRequest(CachedAuthenticatedSessionHandler.java:7
>>>>>>>> 2)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.security.handlers.NotificationReceiverHandler.
>>>>>>>> ha
>>>>>>>> nd
>>>>>>>> leRe
>>>>>>>> qu
>>>>>>>> est(NotificationReceiverHandler.java:50)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.security.handlers.SecurityInitialHandler.handl
>>>>>>>> eR
>>>>>>>> eq
>>>>>>>> uest
>>>>>>>> (S
>>>>>>>> ecurityInitialHandler.java:76)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.server.handlers.PredicateHandler.handleRequest
>>>>>>>> (P
>>>>>>>> re
>>>>>>>> dica
>>>>>>>> te
>>>>>>>> Handler.java:43)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.wildfly.extension.undertow.security.jacc.JACCContextIdHandler.
>>>>>>>>
>>>>>>>> ha
>>>>>>>> ndleRequest(JACCContextIdHandler.java:61)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.server.handlers.PredicateHandler.handleRequest
>>>>>>>> (P
>>>>>>>> re
>>>>>>>> dica
>>>>>>>> te
>>>>>>>> Handler.java:43)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.server.handlers.PredicateHandler.handleRequest
>>>>>>>> (P
>>>>>>>> re
>>>>>>>> dica
>>>>>>>> te
>>>>>>>> Handler.java:43)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.server.handlers.MetricsHandler.handleRequest(M
>>>>>>>> et
>>>>>>>> ri
>>>>>>>> csHa
>>>>>>>> nd
>>>>>>>> ler.java:62)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.core.MetricsChainHandler.handleRequest
>>>>>>>> (M
>>>>>>>> et
>>>>>>>> rics
>>>>>>>> Ch
>>>>>>>> ainHandler.java:59)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.ServletInitialHandler.handleF
>>>>>>>> ir
>>>>>>>> st
>>>>>>>> Requ
>>>>>>>> es
>>>>>>>> t(ServletInitialHandler.java:274)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.ServletInitialHandler.dispatc
>>>>>>>> hR
>>>>>>>> eq
>>>>>>>> uest
>>>>>>>> (S
>>>>>>>> ervletInitialHandler.java:253)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.ServletInitialHandler.access$
>>>>>>>> 00
>>>>>>>> 0(
>>>>>>>> Serv
>>>>>>>> le
>>>>>>>> tInitialHandler.java:80)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.ServletInitialHandler$1.handl
>>>>>>>> eR
>>>>>>>> eq
>>>>>>>> uest
>>>>>>>> (S
>>>>>>>> ervletInitialHandler.java:172)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.server.Connectors.executeRootHandler(Connectors.
>>>>>>>> ja
>>>>>>>> va:1
>>>>>>>> 99
>>>>>>>> )
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.server.HttpServerExchange$1.run(HttpServerExchange.java:
>>>>>>>>
>>>>>>>> 774)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown
>>>>>>>> Source)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown
>>>>>>>> Source)
>>>>>>>>
>>>>>>>> at java.lang.Thread.run(Unknown Source)
>>>>>>>>
>>>>>>>> Caused by: org.jboss.resteasy.spi.UnhandledException:
>>>>>>>> java.lang.NullPointerException
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.ExceptionHandler.handleApplication
>>>>>>>> Ex
>>>>>>>> ce
>>>>>>>> ptio
>>>>>>>> n(
>>>>>>>> ExceptionHandler.java:76)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.ExceptionHandler.handleException(E
>>>>>>>> xc
>>>>>>>> ep
>>>>>>>> tion
>>>>>>>> Ha
>>>>>>>> ndler.java:212)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.SynchronousDispatcher.writeExcepti
>>>>>>>> on
>>>>>>>> (S
>>>>>>>> ynch
>>>>>>>> ro
>>>>>>>> nousDispatcher.java:149)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.SynchronousDispatcher.invoke(Synch
>>>>>>>> ro
>>>>>>>> no
>>>>>>>> usDi
>>>>>>>> sp
>>>>>>>> atcher.java:372)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.SynchronousDispatcher.invoke(Synch
>>>>>>>> ro
>>>>>>>> no
>>>>>>>> usDi
>>>>>>>> sp
>>>>>>>> atcher.java:179)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.plugins.server.servlet.ServletContainer
>>>>>>>> Di
>>>>>>>> sp
>>>>>>>> atch
>>>>>>>> er
>>>>>>>> .service(ServletContainerDispatcher.java:220)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.plugins.server.servlet.HttpServletDispa
>>>>>>>> tc
>>>>>>>> he
>>>>>>>> r.se
>>>>>>>> rv
>>>>>>>> ice(HttpServletDispatcher.java:56)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.plugins.server.servlet.HttpServletDispa
>>>>>>>> tc
>>>>>>>> he
>>>>>>>> r.se
>>>>>>>> rv
>>>>>>>> ice(HttpServletDispatcher.java:51)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
javax.servlet.http.HttpServlet.service(HttpServlet.java:79
>>>>>>>> 0)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.ServletHandler.handleRequest(
>>>>>>>> Se
>>>>>>>> rv
>>>>>>>> letH
>>>>>>>> an
>>>>>>>> dler.java:86)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl
>>>>>>>> .d
>>>>>>>> oF
>>>>>>>> ilte
>>>>>>>> r(
>>>>>>>> FilterHandler.java:130)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.keycloak.services.filters.ClientConnectionFilter.doFil
>>>>>>>> te
>>>>>>>> r(
>>>>>>>> Clie
>>>>>>>> nt
>>>>>>>> ConnectionFilter.java:41)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.
>>>>>>>> java
>>>>>>>> :6
>>>>>>>> 0)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl
>>>>>>>> .d
>>>>>>>> oF
>>>>>>>> ilte
>>>>>>>> r(
>>>>>>>> FilterHandler.java:132)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.keycloak.services.filters.KeycloakSessionServletFilter
>>>>>>>> .d
>>>>>>>> oF
>>>>>>>> ilte
>>>>>>>> r(
>>>>>>>> KeycloakSessionServletFilter.java:40)
>>>>>>>>
>>>>>>>> ... 31 more
>>>>>>>>
>>>>>>>> Caused by: java.lang.NullPointerException
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.keycloak.protocol.oidc.endpoints.UserInfoEndpoint.issu
>>>>>>>> eU
>>>>>>>> se
>>>>>>>> rInf
>>>>>>>> o(
>>>>>>>> UserInfoEndpoint.java:128)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.keycloak.protocol.oidc.endpoints.UserInfoEndpoint.issu
>>>>>>>> eU
>>>>>>>> se
>>>>>>>> rInf
>>>>>>>> oG
>>>>>>>> et(UserInfoEndpoint.java:101)
>>>>>>>>
>>>>>>>> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
>>>>>>>> Method)
>>>>>>>>
>>>>>>>> at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown
>>>>>>>> Source)
>>>>>>>>
>>>>>>>> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown
>>>>>>>> Source)
>>>>>>>>
>>>>>>>> at java.lang.reflect.Method.invoke(Unknown Source)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodIn
>>>>>>>> je
>>>>>>>> ct
>>>>>>>> orIm
>>>>>>>> pl
>>>>>>>> .java:137)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarg
>>>>>>>> et
>>>>>>>> (R
>>>>>>>> esou
>>>>>>>> rc
>>>>>>>> eMethodInvoker.java:296)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.ResourceMethodInvoker.invoke(Resou
>>>>>>>> rc
>>>>>>>> eM
>>>>>>>> etho
>>>>>>>> dI
>>>>>>>> nvoker.java:250)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.ResourceLocatorInvoker.invokeOnTar
>>>>>>>> ge
>>>>>>>> tO
>>>>>>>> bjec
>>>>>>>> t(
>>>>>>>> ResourceLocatorInvoker.java:140)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.ResourceLocatorInvoker.invoke(Reso
>>>>>>>> ur
>>>>>>>> ce
>>>>>>>> Loca
>>>>>>>> to
>>>>>>>> rInvoker.java:109)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.ResourceLocatorInvoker.invokeOnTar
>>>>>>>> ge
>>>>>>>> tO
>>>>>>>> bjec
>>>>>>>> t(
>>>>>>>> ResourceLocatorInvoker.java:135)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.ResourceLocatorInvoker.invoke(Reso
>>>>>>>> ur
>>>>>>>> ce
>>>>>>>> Loca
>>>>>>>> to
>>>>>>>> rInvoker.java:103)
>>>>>>>>
>>>>>>>> at
>>>>>>>>
org.jboss.resteasy.core.SynchronousDispatcher.invoke(Synch
>>>>>>>> ro
>>>>>>>> no
>>>>>>>> usDi
>>>>>>>> sp
>>>>>>>> atcher.java:356)
>>>>>>>>
>>>>>>>> ... 42 more
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> The user guide says –
>>>>>>>>
>>>>>>>> If you need to prevent node failures from requiring users
to
>>>>>>>> log in again, set the owners attribute to 2 or more for
the
>>>>>>>> sessions cache
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Questions -
>>>>>>>>
>>>>>>>> 1. Have we configured Infinispan incorrectly? We don’t
want
>>>>>>>> the users to login again if any of the nodes in the
cluster go
>>>>>>>> down.
>>>>>>>>
>>>>>>>> 2. Will changing distributed-cache to replicated-cache
help in
>>>>>>>> this scenario?
>>>>>>>>
>>>>>>>> 3. Any way we can see the contents of the cache?
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> -- Rajat
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> _______________________________________________
>>>>>>>> keycloak-user mailing list keycloak-user(a)lists.jboss.org
>>>>>>>>
https://lists.jboss.org/mailman/listinfo/keycloak-user
>>>>>>> _______________________________________________
>>>>>>> keycloak-user mailing list
>>>>>>> keycloak-user(a)lists.jboss.org
>>>>>>>
https://lists.jboss.org/mailman/listinfo/keycloak-user