Uploaded image for project: 'OpenAM'
  1. OpenAM
  2. OPENAM-9842

Mobile Push Authentication test no longer working with 14.0.0

    Details

    • Type: Bug
    • Status: Open
    • Priority: Critical
    • Resolution: Unresolved
    • Affects Version/s: 14.0.0
    • Fix Version/s: None
    • Component/s: Mobile Authenticators
    • Labels:
    • Environment:
      OpenAM 14.0.0-SNAPSHOT Build 7a21cdc199 (2016-October-11 12:13)
    • Rank:
      1|hzsbi7:

      Description

      Mobile Push Authentication perf test no longer working with 14.0.0, even if we specify resource API version = 1.0

      The following requests get Internal error:

       
      >>>>>>>>>>>>>>>>>>>>>>>>>>
      Request:
      MPA login stage 2: KO status.find.is(200), but actually found 500
      =========================
      Session:
      Session(Mobile push authentication performance test,1,Map(gatling.http.cache.dns -> io.gatling.http.resolver.ShuffleJdkNameResolver@71ce9ac9, username -> user.4, bodyStage2 -> , authId -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdXRoSW5kZXhWYWx1ZSI6ImF1dGgiLCJvdGsiOiJtcDNudWNoZmt0azRraTc5NWI4dGI1YjZlMyIsImF1dGhJbmRleFR5cGUiOiJzZXJ2aWNlIiwicmVhbG0iOiJkYz1vcGVuYW0sZGM9Zm9yZ2Vyb2NrLGRjPW9yZyIsInNlc3Npb25JZCI6IkFRSUM1d00yTFk0U2Zjem1WWHA1cGY2MDUwSFc1LXRvSkNYcFBZNW5rQ2lUYlYwLipBQUpUU1FBQ01ERUFBbE5MQUJNek5qVTBNamt3TkRRek56VTVPRGt6TmpNMEFBSlRNUUFBKiJ9.3uUyRQ5yOOBqLbXKVssJiYTz-fHg-xCk6LMwSTSWP3U, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,internal.forgerock.com,/) -> StoredCookie(amlbcookie=01; domain=.internal.forgerock.com; path=/,false,false,1476446945935))), password -> password),1476446945765,84,KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$203/738174829@cd6ef55)
      =========================
      HTTP request:
      POST http://bigmac.internal.forgerock.com:8082/openam/json/authenticate?authIndexType=service&authIndexValue=auth
      headers=
      Accept: application/json
      Content-Type: application/json
      Accept-Language: en-US,en;q=0.5
      Accept-API-Version: protocol=1.0,resource=1.0
      Accept-Encoding: gzip, deflate
      User-Agent: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:44.0) Gecko/20100101 Firefox/44.0
      Cookie: amlbcookie=01
      Content-Length: 638
      Host: bigmac.internal.forgerock.com:8082
      compositeByteData={"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdXRoSW5kZXhWYWx1ZSI6ImF1dGgiLCJvdGsiOiJtcDNudWNoZmt0azRraTc5NWI4dGI1YjZlMyIsImF1dGhJbmRleFR5cGUiOiJzZXJ2aWNlIiwicmVhbG0iOiJkYz1vcGVuYW0sZGM9Zm9yZ2Vyb2NrLGRjPW9yZyIsInNlc3Npb25JZCI6IkFRSUM1d00yTFk0U2Zjem1WWHA1cGY2MDUwSFc1LXRvSkNYcFBZNW5rQ2lUYlYwLipBQUpUU1FBQ01ERUFBbE5MQUJNek5qVTBNamt3TkRRek56VTVPRGt6TmpNMEFBSlRNUUFBKiJ9.3uUyRQ5yOOBqLbXKVssJiYTz-fHg-xCk6LMwSTSWP3U","template":"","stage":"AuthenticatorPush2","header":"ForgeRock Authenticator (Push)","callbacks":[{"type":"NameCallback","output":[{"name":"prompt","value":"User Name:"}],"input":[{"name":"IDToken1","value":"user.4"}]}]}
      =========================
      HTTP response:
      status=
      500 Internal Server Error
      headers=
      Server: Apache-Coyote/1.1
      Content-API-Version: resource=1.2
      Transfer-Encoding: chunked
      Date: Fri, 14 Oct 2016 12:09:05 GMT
      Connection: close
      
      
      <<<<<<<<<<<<<<<<<<<<<<<<<
      14:09:07.788 [WARN ] i.g.h.a.ResponseProcessor - Request 'MPA login stage 2' failed: status.find.is(200), but actually found 500
      14:09:07.789 [DEBUG] i.g.h.a.ResponseProcessor -
      >>>>>>>>>>>>>>>>>>>>>>>>>>
      Request:
      MPA login stage 2: KO status.find.is(200), but actually found 500
      =========================
      Session:
      Session(Mobile push authentication performance test,2,Map(gatling.http.cache.dns -> io.gatling.http.resolver.ShuffleJdkNameResolver@56ca89e3, username -> user.9, bodyStage2 -> , authId -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdXRoSW5kZXhWYWx1ZSI6ImF1dGgiLCJvdGsiOiJtOGVvMjJxM3EzcDIyZW9uOWQ1MDM2Nmg5ZSIsImF1dGhJbmRleFR5cGUiOiJzZXJ2aWNlIiwicmVhbG0iOiJkYz1vcGVuYW0sZGM9Zm9yZ2Vyb2NrLGRjPW9yZyIsInNlc3Npb25JZCI6IkFRSUM1d00yTFk0U2Zjd09hX1lpNHgtcHJoYksyejN3c2JLN2FPZ25fX013WDZvLipBQUpUU1FBQ01ERUFBbE5MQUJNM05qQXhPRGswTURRM056STJOVFF6TnpFNUFBSlRNUUFBKiJ9.7SIAm5ud4ybvhDqQZVX60bNAUFV3eqgcP_KY-xyTsAs, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,internal.forgerock.com,/) -> StoredCookie(amlbcookie=01; domain=.internal.forgerock.com; path=/,false,false,1476446947780))), password -> password),1476446947763,1,KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$203/738174829@cd6ef55)
      =========================
      HTTP request:
      POST http://bigmac.internal.forgerock.com:8082/openam/json/authenticate?authIndexType=service&authIndexValue=auth
      headers=
      Accept: application/json
      Content-Type: application/json
      Accept-Language: en-US,en;q=0.5
      Accept-API-Version: protocol=1.0,resource=1.0
      Accept-Encoding: gzip, deflate
      User-Agent: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:44.0) Gecko/20100101 Firefox/44.0
      Cookie: amlbcookie=01
      Content-Length: 638
      Host: bigmac.internal.forgerock.com:8082
      compositeByteData={"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdXRoSW5kZXhWYWx1ZSI6ImF1dGgiLCJvdGsiOiJtOGVvMjJxM3EzcDIyZW9uOWQ1MDM2Nmg5ZSIsImF1dGhJbmRleFR5cGUiOiJzZXJ2aWNlIiwicmVhbG0iOiJkYz1vcGVuYW0sZGM9Zm9yZ2Vyb2NrLGRjPW9yZyIsInNlc3Npb25JZCI6IkFRSUM1d00yTFk0U2Zjd09hX1lpNHgtcHJoYksyejN3c2JLN2FPZ25fX013WDZvLipBQUpUU1FBQ01ERUFBbE5MQUJNM05qQXhPRGswTURRM056STJOVFF6TnpFNUFBSlRNUUFBKiJ9.7SIAm5ud4ybvhDqQZVX60bNAUFV3eqgcP_KY-xyTsAs","template":"","stage":"AuthenticatorPush2","header":"ForgeRock Authenticator (Push)","callbacks":[{"type":"NameCallback","output":[{"name":"prompt","value":"User Name:"}],"input":[{"name":"IDToken1","value":"user.9"}]}]}
      =========================
      HTTP response:
      status=
      500 Internal Server Error
      headers=
      Server: Apache-Coyote/1.1
      Content-API-Version: resource=1.2
      Transfer-Encoding: chunked
      Date: Fri, 14 Oct 2016 12:09:07 GMT
      Connection: close
      
      
      <<<<<<<<<<<<<<<<<<<<<<<<<
      14:09:08.790 [WARN ] i.g.h.a.ResponseProcessor - Request 'MPA login stage 2' failed: status.find.is(200), but actually found 500
      14:09:08.790 [DEBUG] i.g.h.a.ResponseProcessor -
      >>>>>>>>>>>>>>>>>>>>>>>>>>
      Request:
      MPA login stage 2: KO status.find.is(200), but actually found 500
      =========================
      Session:
      Session(Mobile push authentication performance test,3,Map(gatling.http.cache.dns -> io.gatling.http.resolver.ShuffleJdkNameResolver@7826b905, username -> user.0, bodyStage2 -> , authId -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdXRoSW5kZXhWYWx1ZSI6ImF1dGgiLCJvdGsiOiI2c2hnb2I4YmI0azJ2ZTNybWNxYjc2ODg3OCIsImF1dGhJbmRleFR5cGUiOiJzZXJ2aWNlIiwicmVhbG0iOiJkYz1vcGVuYW0sZGM9Zm9yZ2Vyb2NrLGRjPW9yZyIsInNlc3Npb25JZCI6IkFRSUM1d00yTFk0U2ZjejhtSWFERGFiMU55WFlfTUQwcDg1LWd1VlA4N1lpNWVZLipBQUpUU1FBQ01ERUFBbE5MQUJRdE56RTJOVGcxTVRRMU1UYzFPRE13T0RJMk1nQUNVekVBQUEuLioifQ.xVgnZ1HdN4AvsojSbEivpVZ2qjymRLWF8X-cPjlVAwA, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,internal.forgerock.com,/) -> StoredCookie(amlbcookie=01; domain=.internal.forgerock.com; path=/,false,false,1476446948781))), password -> password),1476446948763,1,KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$203/738174829@cd6ef55)
      =========================
      HTTP request:
      POST http://bigmac.internal.forgerock.com:8082/openam/json/authenticate?authIndexType=service&authIndexValue=auth
      headers=
      Accept: application/json
      Content-Type: application/json
      Accept-Language: en-US,en;q=0.5
      Accept-API-Version: protocol=1.0,resource=1.0
      Accept-Encoding: gzip, deflate
      User-Agent: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:44.0) Gecko/20100101 Firefox/44.0
      Cookie: amlbcookie=01
      Content-Length: 644
      Host: bigmac.internal.forgerock.com:8082
      compositeByteData={"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJhdXRoSW5kZXhWYWx1ZSI6ImF1dGgiLCJvdGsiOiI2c2hnb2I4YmI0azJ2ZTNybWNxYjc2ODg3OCIsImF1dGhJbmRleFR5cGUiOiJzZXJ2aWNlIiwicmVhbG0iOiJkYz1vcGVuYW0sZGM9Zm9yZ2Vyb2NrLGRjPW9yZyIsInNlc3Npb25JZCI6IkFRSUM1d00yTFk0U2ZjejhtSWFERGFiMU55WFlfTUQwcDg1LWd1VlA4N1lpNWVZLipBQUpUU1FBQ01ERUFBbE5MQUJRdE56RTJOVGcxTVRRMU1UYzFPRE13T0RJMk1nQUNVekVBQUEuLioifQ.xVgnZ1HdN4AvsojSbEivpVZ2qjymRLWF8X-cPjlVAwA","template":"","stage":"AuthenticatorPush2","header":"ForgeRock Authenticator (Push)","callbacks":[{"type":"NameCallback","output":[{"name":"prompt","value":"User Name:"}],"input":[{"name":"IDToken1","value":"user.0"}]}]}
      =========================
      HTTP response:
      status=
      500 Internal Server Error
      headers=
      Server: Apache-Coyote/1.1
      Content-API-Version: resource=1.2
      Transfer-Encoding: chunked
      Date: Fri, 14 Oct 2016 12:09:08 GMT
      Connection: close
      
      
      <<<<<<<<<<<<<<<<<<<<<<<<<
      

      From debug log

      bigmac $ more Push
      frPush:10/14/2016 02:07:32:969 PM CEST: Thread[smIdmThreadPool,5,main]: TransactionId[5e2349a0-31b9-4e35-9966-c057db30f9bb-219]
      ERROR: Unable to update preferences for organization dc=openam,dc=forgerock,dc=org
      org.forgerock.openam.services.push.PushNotificationException: Attempted to construct a PushNotificationServiceConfig in an invalid state.
              at org.forgerock.openam.services.push.PushNotificationServiceConfig$Builder.build(PushNotificationServiceConfig.java:308)
              at org.forgerock.openam.services.push.PushNotificationServiceConfigHelper.getConfig(PushNotificationServiceConfigHelper.java:78)
              at org.forgerock.openam.services.push.PushNotificationService.updatePreferences(PushNotificationService.java:205)
              at org.forgerock.openam.services.push.PushNotificationService.access$300(PushNotificationService.java:62)
              at org.forgerock.openam.services.push.PushNotificationService$PushNotificationServiceListener.organizationConfigChanged(PushNotificationService.java:325)
              at com.sun.identity.sm.ServiceConfigManagerImpl.notifyOrgConfigChange(ServiceConfigManagerImpl.java:505)
              at com.sun.identity.sm.ServiceConfigManagerImpl.objectChanged(ServiceConfigManagerImpl.java:465)
              at com.sun.identity.sm.SMSNotificationManager.sendNotifications(SMSNotificationManager.java:294)
              at com.sun.identity.sm.SMSNotificationManager$LocalChangeNotifcationTask.run(SMSNotificationManager.java:370)
              at org.forgerock.openam.audit.context.AuditRequestContextPropagatingRunnable.run(AuditRequestContextPropagatingRunnable.java:42)
              at com.iplanet.am.util.ThreadPool$WorkerThread.run(ThreadPool.java:314)
      
      frPush:10/14/2016 02:07:32:972 PM CEST: Thread[smIdmThreadPool,5,main]: TransactionId[5e2349a0-31b9-4e35-9966-c057db30f9bb-221]
      ERROR: Unable to update preferences for organization dc=openam,dc=forgerock,dc=org
      org.forgerock.openam.services.push.PushNotificationException: Attempted to construct a PushNotificationServiceConfig in an invalid state.
              at org.forgerock.openam.services.push.PushNotificationServiceConfig$Builder.build(PushNotificationServiceConfig.java:308)
              at org.forgerock.openam.services.push.PushNotificationServiceConfigHelper.getConfig(PushNotificationServiceConfigHelper.java:78)
              at org.forgerock.openam.services.push.PushNotificationService.updatePreferences(PushNotificationService.java:205)
              at org.forgerock.openam.services.push.PushNotificationService.access$300(PushNotificationService.java:62)
              at org.forgerock.openam.services.push.PushNotificationService$PushNotificationServiceListener.organizationConfigChanged(PushNotificationService.java:325)
              at com.sun.identity.sm.ServiceConfigManagerImpl.notifyOrgConfigChange(ServiceConfigManagerImpl.java:505)
              at com.sun.identity.sm.ServiceConfigManagerImpl.objectChanged(ServiceConfigManagerImpl.java:465)
              at com.sun.identity.sm.SMSNotificationManager.sendNotifications(SMSNotificationManager.java:294)
              at com.sun.identity.sm.SMSNotificationManager$LocalChangeNotifcationTask.run(SMSNotificationManager.java:370)
              at org.forgerock.openam.audit.context.AuditRequestContextPropagatingRunnable.run(AuditRequestContextPropagatingRunnable.java:42)
              at com.iplanet.am.util.ThreadPool$WorkerThread.run(ThreadPool.java:314)
      
      frPush:10/14/2016 02:07:32:974 PM CEST: Thread[smIdmThreadPool,5,main]: TransactionId[5e2349a0-31b9-4e35-9966-c057db30f9bb-222]
      ERROR: Unable to update preferences for organization dc=openam,dc=forgerock,dc=org
      org.forgerock.openam.services.push.PushNotificationException: Attempted to construct a PushNotificationServiceConfig in an invalid state.
              at org.forgerock.openam.services.push.PushNotificationServiceConfig$Builder.build(PushNotificationServiceConfig.java:308)
              at org.forgerock.openam.services.push.PushNotificationServiceConfigHelper.getConfig(PushNotificationServiceConfigHelper.java:78)
              at org.forgerock.openam.services.push.PushNotificationService.updatePreferences(PushNotificationService.java:205)
              at org.forgerock.openam.services.push.PushNotificationService.access$300(PushNotificationService.java:62)
              at org.forgerock.openam.services.push.PushNotificationService$PushNotificationServiceListener.organizationConfigChanged(PushNotificationService.java:325)
              at com.sun.identity.sm.ServiceConfigManagerImpl.notifyOrgConfigChange(ServiceConfigManagerImpl.java:505)
              at com.sun.identity.sm.ServiceConfigManagerImpl.objectChanged(ServiceConfigManagerImpl.java:465)
              at com.sun.identity.sm.SMSNotificationManager.sendNotifications(SMSNotificationManager.java:294)
              at com.sun.identity.sm.SMSNotificationManager$LocalChangeNotifcationTask.run(SMSNotificationManager.java:370)
              at org.forgerock.openam.audit.context.AuditRequestContextPropagatingRunnable.run(AuditRequestContextPropagatingRunnable.java:42)
              at com.iplanet.am.util.ThreadPool$WorkerThread.run(ThreadPool.java:314)
      

        Attachments

          Issue Links

            Activity

              People

              • Assignee:
                Unassigned
                Reporter:
                sberthol Sebastien Bertholet [X] (Inactive)
              • Votes:
                0 Vote for this issue
                Watchers:
                3 Start watching this issue

                Dates

                • Created:
                  Updated: