Layer 7 Access Management

Expand all | Collapse all

Useful Wildfly/JBOSS CLI Monitoring Scripts

  • 1.  Useful Wildfly/JBOSS CLI Monitoring Scripts

    Posted 03-29-2018 06:37 PM

    Team,

     

    There is a nice feature set within the J2EE server of Wildfly/RHEL JBOSS to assist with monitoring the health of the solution.   I would like to bring these scripts & processes back to awareness, as part of any initial heath check of a solution, that may not have a formal or robust commercial monitor tool set.

    -  These tools may be used for query and updates as needed.

     

     

    To access the full features of the J2EE tier at the command line, it may be necessary to create a local management accounts.

     

    I will use the CA Identity Suite vApp as an example, as it is locked down with regards to select service IDs.

     

    Step 1:    Create a local management account for IM, IG, IP Wildfly Server.   [NOTE:  J2EE must be running]

     

    a.  sudo /opt/CA/wildfly-idm/bin/add-user.sh 

          [sudo /opt/CA/wildfly-ig/bin/add-user.sh  / sudo /opt/CA/wildfly-portal/bin/add-user.sh]
    b.  Answer with:    a  [Management User]
    c.  Answer with a userID & password:   l: jboss-admin  p: Password01!
    d.  For vApp only, answer with the following group:  IAMAdmin    [may be null for other deployments]
    e.   Answer yes to use this new configuration:   yes
    f.   Answer no, to use these credential in a domain mode:   no

     

     

    2.   Execute a list of any scripts via the  JBOSS_HOME/bin/jboss-cli.sh   process.    [NOTE:  J2EE must be running]

     

    a.   Take a snapshot (backup) of the standalone-full-ha.xml file.

     

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command=:take-snapshot
    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command=:take-snapshot
    /opt/CA/wildfly-portal/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command=:take-snapshot

     

     

     

    b.   View the JVM Heap Memory Usage

     

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/core-service=platform-mbean/type=memory :read-attribute(name=heap-memory-usage)"
    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/core-service=platform-mbean/type=memory :read-attribute(name=heap-memory-usage)"
    /opt/CA/wildfly-portal/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/core-service=platform-mbean/type=memory :read-attribute(name=heap-memory-usage)"

     

     

    c.   View J2EE datasource connection pools and active use.

     

    [IM 6 databases]

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/subsystem=datasources/data-source=iam_im-imobjectstoredb-ds/statistics=pool:read-resource(recursive=true, include-runtime=true)"
    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/subsystem=datasources/data-source=iam_im-imtaskpersistencedb-ds/statistics=pool:read-resource(recursive=true, include-runtime=true)"
    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/subsystem=datasources/data-source=iam_im-imarchivedb-ds/statistics=pool:read-resource(recursive=true, include-runtime=true)"
    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/subsystem=datasources/data-source=iam_im-imauditdb-ds/statistics=pool:read-resource(recursive=true, include-runtime=true)"
    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/subsystem=datasources/data-source=iam_im-imreportsnapshotdb-ds/statistics=pool:read-resource(recursive=true, include-runtime=true)"
    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command="/subsystem=datasources/data-source=iam_im-imworkflowdb-ds/statistics=pool:read-resource(recursive=true, include-runtime=true)"

     

     

    [IG 4 databases]

     

    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command=" /subsystem=datasources/data-source=eurekifyDS/statistics=pool:read-resource(recursive=true, include-runtime=true)"
    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command=" /subsystem=datasources/data-source=eurekifyTmsDS/statistics=pool:read-resource(recursive=true, include-runtime=true)"
    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command=" /subsystem=datasources/data-source=eurekifyReportdbDS/statistics=pool:read-resource(recursive=true, include-runtime=true)"
    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command=" /subsystem=datasources/xa-data-source=WPDS/statistics=pool:read-resource(recursive=true, include-runtime=true)"

     

     

     

    [IP 1 database]

     

    /opt/CA/wildfly-portal/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --command=" /subsystem=datasources/data-source=sigma-ds/statistics=pool:read-resource(recursive=true, include-runtime=true)"

     

     

     

    d.    A reload of the J2EE (without shutting down the full service)

     

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":reload"
    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":reload"
    /opt/CA/wildfly-portal/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":reload"

    e.   Shutdown and Restart of the J2EE

     

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":shutdown(restart=true)"
    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":shutdown(restart=true)"
    /opt/CA/wildfly-portal/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":shutdown(restart=true)"

     

     

    f.  Check on the J2EE server status (started/starting/other)

     

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":read-attribute(name=server-state)"
    /opt/CA/wildfly-ig/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":read-attribute(name=server-state)"
    /opt/CA/wildfly-portal/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=":read-attribute(name=server-state)"

     

     

    Step 3:   Bonus round.     X11 GUI of jboss-cli

    - Assumptions:   X11 libraries are installed (rpm/yum) or copied & access via CLASSPATH  [for vApp]

    - Environmental variable:  DISPLAY & CLASSPATH 

         -   For putty + XMING  DISPLAY=<IP_Address:0.0>      [XMING uses TCP 6000;  ensure this port is open on workstation F/W]

         -   For MobaTerm     DISPLAY=<IP_Address:1.0>         [MobaTerm uses TCP 6001; ensure this port is open on workstation F/W]

     

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01!  --gui

     

     

     

     

    X11 Libraries required:  

    yum install xorg-x11-xauth xorg-x11-fonts-* xorg-x11-font-utils xorg-x11-fonts-Type1

    yum install libXrender.x86_64

    yum install libXtst.i686  libXtst.x86_64    [Required both x86 and x64 version due to dependencies on vApp]

     

     

    OS Workstation Firewall Ports to allow:

     

    Cheers,

     

    Alan.

     

     

    Edit:  3/30/2018   Addition notes on GUI configuration client tools

     

    Use of MobaTerm for local Linux Host & remote AWS Linux Host (using a private key for authentication)

     

    A view for Putty to enable X11.

     

    Enable X11 forwarding

     

    If using AWS then enable these three (3) additional parameters:

    Set the initial login ID to AWS format:    ec2-user

     

    Change translation from default UTF-8 to "Use font encoding"

     

    Lastly, certificate authentication via a private key (PPK).

    - AWS will provide a PEM file when setting up the Instances with a security group.

    - Do NOT lose this file, or you will need to re-generate a new one.

     

    To generate the PPK from the PEM file, use the Putty KeyGen Tool.  Load in the PEM file, then save the PPK file.

    Use the PPK for Putty or MobaTerm tools.



  • 2.  Re: Useful Wildfly/JBOSS CLI Monitoring Scripts

    Posted 03-30-2018 12:16 PM

    I've used Xming with PuTTY X11 Forwarding but I am not familiar with MobaXterm. I'll run through these steps on a local VA install to see if I can repeat the steps and collect the detail.



  • 3.  Re: Useful Wildfly/JBOSS CLI Monitoring Scripts

    Posted 05-25-2018 09:41 AM

    Excellent.

     

     

    I found these examples useful:

    CLI Recipes - JBoss AS 7.1 - Project Documentation Editor 

     

     

    As a discovery methodology:   /system-property=*:read-resource

    configuration - JBoss AS 7 update system property via cli - Stack Overflow 



  • 4.  Re: Useful Wildfly/JBOSS CLI Monitoring Scripts

     
    Posted 05-24-2018 07:19 PM

    A few more commands courtesy Alan_Baugher:

     

    (this is to enable/disable shared-store in the hornetq-server)

     

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01  --command=:take-snapshot

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01  --command='/subsystem=messaging/hornetq-server=backup:read-attribute(name=shared-store)'

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01  --command='/subsystem=messaging/hornetq-server=default:read-attribute(name=shared-store)'

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01  --command='/subsystem=messaging/hornetq-server=default:write-attribute(name=shared-store,value=false)'

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01  --command='/subsystem=messaging/hornetq-server=backup:write-attribute(name=shared-store,value=false)'

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01 --command=":reload"



  • 5.  Re: Useful Wildfly/JBOSS CLI Monitoring Scripts

    Posted 07-25-2018 07:42 PM

    And a few more to monitor the activity between startup STEPS of the IM solution using jboss-spy

     

     

     

    Step 1:  Write the following to a new file:  jboss-spy.cli

    connect
    :take-snapshot
    batch
    /subsystem=logging/logger=jboss.jdbc.spy/:add(level=TRACE)
    /subsystem=datasources/data-source=iam_im-imtaskpersistencedb-ds/:write-attribute(name=spy,value=true)
    /subsystem=jca/cached-connection-manager=cached-connection-manager/:write-attribute(name=error,value=true)
    run-batch
    :reload
    :take-snapshot

     

     

    Step 2:  Execute the following line (with or without credentials)

     

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --file=jboss-spy.cli

     

     

     

    Otherwise, line by line:  (including both TP and OS for CA IM solution)

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command="/subsystem=logging/logger=jboss.jdbc.spy/:add(level=TRACE)"
    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command="/subsystem=datasources/data-source=iam_im-imtaskpersistencedb-ds/:write-attribute(name=spy,value=true)"

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command=" /subsystem=datasources/data-source=iam_im-imobjectstoredb-ds/:write-attribute(name=spy,value=true)“

    /opt/CA/wildfly-idm/bin/jboss-cli.sh --connect --user=jboss-admin --password=Password01! --command="/subsystem=jca/cached-connection-manager=cached-connection-manager/:write-attribute(name=error,value=true)"

     

     

     

     

     

    Select example of TP jdbc sessions captured during startup of IM (Step 1 - Step 30/31 + Workflow)

    -  TP is described in standalone-full-ha.xml as /iam/im/jdbc/jdbc/idm

    -  Steps have been color coded.

     

    2018-07-25 18:19:49,858 INFO [ims.Main] (MSC service thread 1-4) CA IAM Framework Server
    2018-07-25 18:19:49,859 INFO [ims.Main] (MSC service thread 1-4) Copyright 2000 - 2013 CA. All Rights Reserved
    2018-07-25 18:19:49,863 INFO [ims.Main] (MSC service thread 1-4) ################################################
    2018-07-25 18:19:49,863 INFO [ims.Main] (MSC service thread 1-4) # IAM Framework 400.1.0.0.369
    2018-07-25 18:19:49,863 INFO [ims.Main] (MSC service thread 1-4) ################################################
    2018-07-25 18:19:49,863 INFO [ims.Main] (MSC service thread 1-4) ################################################
    2018-07-25 18:19:49,863 INFO [ims.Main] (MSC service thread 1-4) # CA Identity Manager 14.1.0.0.347
    2018-07-25 18:19:49,863 INFO [ims.Main] (MSC service thread 1-4) ################################################
    2018-07-25 18:19:49,863 INFO [ims.Main] (MSC service thread 1-4) ---- CA IAM FW Startup Sequence Initiated. ----
    2018-07-25 18:19:49,868 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 1 : Attempting to start ServiceLocator.
    2018-07-25 18:19:50,046 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:19:50,070 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,070 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,072 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT TP_VALUE FROM TP_VERSION WHERE TP_KEY LIKE 'version')
    2018-07-25 18:19:50,074 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:19:50,075 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:19:50,075 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getString(1)
    2018-07-25 18:19:50,075 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:19:50,075 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:19:50,075 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:19:50,075 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:19:50,076 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:19:50,078 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,079 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,079 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,081 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT TP_VALUE FROM TP_VERSION WHERE TP_KEY LIKE 'version')
    2018-07-25 18:19:50,081 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:19:50,082 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:19:50,082 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getString(1)
    2018-07-25 18:19:50,082 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:19:50,082 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:19:50,082 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:19:50,082 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,082 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,083 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,083 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,083 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,084 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,084 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:19:50,085 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:20:33,653 WARN [org.jgroups.protocols.TP$ProtocolAdapter] (INT-1,shared=tcp) JGRP000031: iamnode1/live: dropping unicast message to wrong destination 67fe56cf-b64a-1f59-0581-9b1b5fecb744
    2018-07-25 18:20:33,739 WARN [org.jgroups.protocols.TP$ProtocolAdapter] (INT-1,shared=tcp) JGRP000031: iamnode1/node1_live_to_node2_backup: dropping unicast message to wrong destination dd096260-7339-50d2-3981-fc1a3f89420c
    2018-07-25 18:20:47,496 INFO [com.workpoint.server.ServerProperties] (Thread-8 (HornetQ-client-global-threads-1685966595)) Loaded server properties from /opt/CA/wildfly-idm/standalone/deployments/iam_im.ear/config/workpoint-server.properties
    2018-07-25 18:20:47,505 INFO [com.workpoint.server.ServerProperties] (Thread-8 (HornetQ-client-global-threads-1685966595)) PRODUCT = Workpoint; VERSION = 3.5.2; BUILD = 20140214.P004; BUILD DATE = June 20, 2015
    2018-07-25 18:20:47,579 INFO [com.workpoint.server.ServerProperties] (Thread-8 (HornetQ-client-global-threads-1685966595)) No event configuration File specified in the server properties, so no event subscribers will be configured.
    2018-07-25 18:21:47,471 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 2 : Attempting to start PolicyServerService
    2018-07-25 18:21:47,497 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 3 : Attempting to start ServerCommandService
    2018-07-25 18:21:47,515 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 4 : Attempting to start EnvironmentService
    2018-07-25 18:21:58,205 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:21:58,206 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:21:58,206 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT COUNT(*) FROM taskSessionSequenceEnv WHERE envid=?)
    2018-07-25 18:21:58,207 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setObject(1, 0)
    2018-07-25 18:21:58,207 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:58,207 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:58,207 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:21:58,208 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,208 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:21:58,208 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:21:58,208 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 5 : Attempting to start SecretKeyStore
    2018-07-25 18:21:58,286 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 6 : Attempting to start CacheManagerService
    2018-07-25 18:21:58,287 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 7 : Attempting to load global plugins.
    2018-07-25 18:21:58,288 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 8 : Attempting to start AdaptersConfigService
    2018-07-25 18:21:58,290 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 9 : Attempting to start EmailProviderService
    2018-07-25 18:21:58,293 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 10 : Attempting to start AuditProviderService
    2018-07-25 18:21:58,299 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 11 : Attempting to start RuntimeStatusDetailService
    2018-07-25 18:21:58,307 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 12 : Attempting to start PasswordService
    2018-07-25 18:21:58,307 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 13 : Attempting to start LogicalAttributeService
    2018-07-25 18:21:58,308 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 14 : Attempting to start BLTHService
    2018-07-25 18:21:58,308 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 15 : Attempting to start ParticipantResolverService
    2018-07-25 18:21:58,310 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 16 : Attempting to start NotificationRuleService
    2018-07-25 18:21:58,310 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 17 : Attempting to start EventAdapterService
    2018-07-25 18:21:58,310 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 18 : Attempting to start TaskService
    2018-07-25 18:21:58,316 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 19 : Attempting to start WorkflowCallbackService
    2018-07-25 18:21:58,317 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 20 : Attempting to start WorkflowService
    2018-07-25 18:21:58,320 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 21 : Attempting to start TaskStatusNotifyService
    2018-07-25 18:21:58,321 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 22 : Attempting to start EventService
    2018-07-25 18:21:58,350 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 23 : Attempting to start AdminService
    2018-07-25 18:21:58,351 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 24 : Attempting to start GeneralMonitorAdmin
    2018-07-25 18:21:58,351 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 25 : Attempting to start StatusNotificationService
    2018-07-25 18:21:58,361 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 26 : Attempting to start GlobalInitializer plug-ins
    2018-07-25 18:21:58,588 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 27 : Attempting to start SchedulerService
    2018-07-25 18:21:58,658 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:21:58,665 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:21:58,665 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(false)
    2018-07-25 18:21:58,665 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(UPDATE QRTZ_LOCKS SET LOCK_NAME = LOCK_NAME WHERE LOCK_NAME = ? )
    2018-07-25 18:21:58,665 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TRIGGER_ACCESS)
    2018-07-25 18:21:58,665 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeUpdate()
    2018-07-25 18:21:58,666 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,670 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT TRIGGER_NAME, TRIGGER_GROUP FROM QRTZ_TRIGGERS WHERE IS_VOLATILE = ?)
    2018-07-25 18:21:58,670 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBoolean(1, true)
    2018-07-25 18:21:58,670 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:58,671 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:58,672 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:21:58,672 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,672 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT JOB_NAME, JOB_GROUP FROM QRTZ_JOB_DETAILS WHERE IS_VOLATILE = ?)
    2018-07-25 18:21:58,672 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBoolean(1, true)
    2018-07-25 18:21:58,672 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:58,673 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:58,673 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:21:58,673 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,673 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(DELETE FROM QRTZ_FIRED_TRIGGERS WHERE IS_VOLATILE = ?)
    2018-07-25 18:21:58,673 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBoolean(1, true)
    2018-07-25 18:21:58,673 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeUpdate()
    2018-07-25 18:21:58,673 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,673 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] commit()
    2018-07-25 18:21:58,675 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(true)
    2018-07-25 18:21:58,675 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:21:58,675 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:21:58,676 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:21:58,676 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(false)
    2018-07-25 18:21:58,677 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(UPDATE QRTZ_LOCKS SET LOCK_NAME = LOCK_NAME WHERE LOCK_NAME = ? )
    2018-07-25 18:21:58,677 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TRIGGER_ACCESS)
    2018-07-25 18:21:58,677 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeUpdate()
    2018-07-25 18:21:58,678 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,678 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(UPDATE QRTZ_TRIGGERS SET TRIGGER_STATE = ? WHERE TRIGGER_STATE = ? OR TRIGGER_STATE = ?)
    2018-07-25 18:21:58,678 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, WAITING)
    2018-07-25 18:21:58,679 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, ACQUIRED)
    2018-07-25 18:21:58,679 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(3, BLOCKED)
    2018-07-25 18:21:58,679 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeUpdate()
    2018-07-25 18:21:58,679 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,679 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(UPDATE QRTZ_TRIGGERS SET TRIGGER_STATE = ? WHERE TRIGGER_STATE = ? OR TRIGGER_STATE = ?)
    2018-07-25 18:21:58,679 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, PAUSED)
    2018-07-25 18:21:58,679 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, PAUSED_BLOCKED)
    2018-07-25 18:21:58,679 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(3, PAUSED_BLOCKED)
    2018-07-25 18:21:58,680 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeUpdate()
    2018-07-25 18:21:58,680 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,680 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT TRIGGER_NAME, TRIGGER_GROUP FROM QRTZ_TRIGGERS WHERE NEXT_FIRE_TIME < ? AND ((TRIGGER_STATE = ?) OR (TRIGGER_STATE = ?)) ORDER BY NEXT_FIRE_TIME ASC)
    2018-07-25 18:21:58,680 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBigDecimal(1, 1532560858680)
    2018-07-25 18:21:58,680 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, MISFIRED)
    2018-07-25 18:21:58,680 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(3, WAITING)
    2018-07-25 18:21:58,680 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:58,681 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:58,681 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:21:58,681 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,681 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT * FROM QRTZ_FIRED_TRIGGERS WHERE INSTANCE_NAME = ? AND REQUESTS_RECOVERY = ?)
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, NON_CLUSTERED)
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBoolean(2, true)
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT TRIGGER_NAME, TRIGGER_GROUP FROM QRTZ_TRIGGERS WHERE TRIGGER_STATE = ?)
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, COMPLETE)
    2018-07-25 18:21:58,682 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:58,683 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:58,683 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:21:58,683 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,683 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(DELETE FROM QRTZ_FIRED_TRIGGERS)
    2018-07-25 18:21:58,683 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeUpdate()
    2018-07-25 18:21:58,683 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,684 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] commit()
    2018-07-25 18:21:58,685 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(true)
    2018-07-25 18:21:58,685 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:21:58,689 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 28 : Attempting to start NIMSMIntegrationService
    2018-07-25 18:21:58,691 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:21:58,690 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:21:58,692 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:21:58,692 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(false)
    2018-07-25 18:21:58,692 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:21:58,693 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT COUNT(TRIGGER_NAME) FROM QRTZ_TRIGGERS WHERE NEXT_FIRE_TIME < ? AND ((TRIGGER_STATE = ?) OR (TRIGGER_STATE = ?)))
    2018-07-25 18:21:58,693 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(false)
    2018-07-25 18:21:58,693 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBigDecimal(1, 1532560858692)
    2018-07-25 18:21:58,693 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, MISFIRED)
    2018-07-25 18:21:58,693 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(3, WAITING)
    2018-07-25 18:21:58,693 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:58,697 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT TRIGGER_NAME, TRIGGER_GROUP, NEXT_FIRE_TIME, PRIORITY FROM QRTZ_TRIGGERS WHERE TRIGGER_STATE = ? AND NEXT_FIRE_TIME < ? AND (NEXT_FIRE_TIME >= ?) ORDER BY NEXT_FIRE_TIME ASC, PRIORITY DESC)
    2018-07-25 18:21:58,698 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] setFetchSize(5)
    2018-07-25 18:21:58,698 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] setMaxRows(5)
    2018-07-25 18:21:58,698 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, WAITING)
    2018-07-25 18:21:58,698 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBigDecimal(2, 1532560948689)
    2018-07-25 18:21:58,698 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBigDecimal(3, 1532560858693)
    2018-07-25 18:21:58,698 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:58,699 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 29 : Attempting to start environments
    2018-07-25 18:21:58,700 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:58,700 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:21:58,700 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,700 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] commit()
    2018-07-25 18:21:58,700 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(true)
    2018-07-25 18:21:58,700 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:21:58,702 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:58,702 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:21:58,702 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:21:58,702 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:58,702 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [Connection] commit()
    2018-07-25 18:21:58,702 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(true)
    2018-07-25 18:21:58,702 DEBUG [jboss.jdbc.spy] (QuartzScheduler_iam_imDefaultQuartzScheduler-NON_CLUSTERED_MisfireHandler) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:21:58,793 INFO [ims.Main] (MSC service thread 1-4) * Starting environment: identityEnv
    2018-07-25 18:21:59,199 INFO [com.workpoint.client.ClientContext] (Thread-168) Loaded client properties from URL: vfs:/opt/CA/wildfly-idm/standalone/deployments/iam_im.ear/config/workpoint-client.properties
    2018-07-25 18:21:59,202 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:21:59,202 INFO [com.workpoint.client.ClientContext] (Thread-168) Connected to server at: localhost
    2018-07-25 18:21:59,202 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:21:59,203 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:21:59,203 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:21:59,203 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:21:59,206 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:21:59,207 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:21:59,208 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:21:59,208 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT COUNT(*) FROM taskSessionSequenceEnv WHERE envid=?)
    2018-07-25 18:21:59,208 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setObject(1, 1)
    2018-07-25 18:21:59,208 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:21:59,209 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:21:59,209 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:21:59,209 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:21:59,209 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:21:59,209 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:21:59,239 WARN [ims.llsdk.etrustadmindirectory] (MSC service thread 1-4) Not setting tenant key for environment identityEnv
    2018-07-25 18:22:00,758 INFO [ims.Main] (MSC service thread 1-4) * Started environment: identityEnv
    2018-07-25 18:22:00,771 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:22:00,771 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:22:00,778 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:22:00,780 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,780 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, EVENT12_5)
    2018-07-25 18:22:00,781 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, EVENTID)
    2018-07-25 18:22:00,781 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,781 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,781 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,782 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,782 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,782 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,782 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, EVENT12_5)
    2018-07-25 18:22:00,782 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, TASKSESSIONID)
    2018-07-25 18:22:00,783 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,783 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,783 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,783 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,783 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,784 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,784 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, EVENT12_5)
    2018-07-25 18:22:00,784 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, NAME)
    2018-07-25 18:22:00,784 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,784 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,784 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,785 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,785 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,785 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,785 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, EVENT12_5)
    2018-07-25 18:22:00,785 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, DESCRIPTION)
    2018-07-25 18:22:00,785 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,786 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,786 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,786 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,786 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,786 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:22:00,787 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,787 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TASKSESSION12_5)
    2018-07-25 18:22:00,788 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, TASKSESSIONID)
    2018-07-25 18:22:00,788 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,788 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,788 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,788 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,788 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,789 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,789 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TASKSESSION12_5)
    2018-07-25 18:22:00,789 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, USER_DN)
    2018-07-25 18:22:00,789 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,790 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,790 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,790 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,790 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,790 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,790 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TASKSESSION12_5)
    2018-07-25 18:22:00,791 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, ORG_DN)
    2018-07-25 18:22:00,791 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,791 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,791 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,791 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,791 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,792 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,792 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TASKSESSION12_5)
    2018-07-25 18:22:00,792 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, ENVIRONMENTID)
    2018-07-25 18:22:00,792 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,792 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,792 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,793 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,793 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,793 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,793 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TASKSESSION12_5)
    2018-07-25 18:22:00,793 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, NAME)
    2018-07-25 18:22:00,793 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,794 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,794 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,794 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,794 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,794 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,794 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TASKSESSION12_5)
    2018-07-25 18:22:00,795 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, DESCRIPTION)
    2018-07-25 18:22:00,795 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,795 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,795 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,795 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,795 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,796 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,796 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TASKSESSION12_5)
    2018-07-25 18:22:00,796 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, PARENT_OF_WF_ID)
    2018-07-25 18:22:00,796 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,796 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,796 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,797 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,797 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,797 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,797 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, TASKSESSION12_5)
    2018-07-25 18:22:00,797 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, INITIATORID)
    2018-07-25 18:22:00,798 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,798 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,798 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,798 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,798 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,799 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:22:00,799 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,800 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, EVENT_OBJECT12_5)
    2018-07-25 18:22:00,800 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, TASKSESSIONID)
    2018-07-25 18:22:00,800 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,800 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,800 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,800 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,801 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,801 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,801 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, EVENT_OBJECT12_5)
    2018-07-25 18:22:00,801 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, EVENTID)
    2018-07-25 18:22:00,801 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,802 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,802 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,802 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,802 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,802 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,802 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, EVENT_OBJECT12_5)
    2018-07-25 18:22:00,802 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, OBJECT_TYPE)
    2018-07-25 18:22:00,803 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,803 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,803 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,803 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,803 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,804 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,804 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, EVENT_OBJECT12_5)
    2018-07-25 18:22:00,804 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, OBJECT_UNIQUENAME)
    2018-07-25 18:22:00,804 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,804 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,805 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,805 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,805 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,806 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getMetaData()
    2018-07-25 18:22:00,807 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,807 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, LOCK12_5)
    2018-07-25 18:22:00,807 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, LOCKID)
    2018-07-25 18:22:00,807 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,807 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,808 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,808 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,808 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,808 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select CHAR_LENGTH from user_tab_columns atc where table_name=? and column_name=?)
    2018-07-25 18:22:00,808 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, LOCK12_5)
    2018-07-25 18:22:00,808 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(2, LOCKINFO)
    2018-07-25 18:22:00,808 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,809 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,810 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] getInt(1)
    2018-07-25 18:22:00,810 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,810 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,810 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:22:00,811 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:22:00,811 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:22:00,814 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(select eventid from event12_5 where state=8 and type in (34, 36) and (tasksessionid in (select tasksessionid from tasksession12_5 where environmentid=? )))
    2018-07-25 18:22:00,814 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, 1)
    2018-07-25 18:22:00,814 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:00,815 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:00,816 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:00,816 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:00,816 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:22:00,816 DEBUG [jboss.jdbc.spy] (MSC service thread 1-4) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:22:00,817 INFO [ims.Main] (MSC service thread 1-4) ** FIPS mode enabled : false
    2018-07-25 18:22:00,881 INFO [ims.Main] (MSC service thread 1-4) * Startup Step 30 : Attempting to start ApplicationContextInitializer plug-ins
    2018-07-25 18:22:00,889 INFO [ims.Main] (MSC service thread 1-4) ---- CA IAM FW Startup Sequence Complete. ----
    2018-07-25 18:22:01,020 WARN [org.apache.myfaces.shared_impl.util.LocaleUtils] (MSC service thread 1-4) Locale name in faces-config.xml null or empty, setting locale to default locale : en_US
    2018-07-25 18:22:04,343 INFO [com.workpoint.server.ServerProperties] (Timer-4) ServerProperties.setProperty() invoked for property= calculated.db.offset.millis, value=0
    2018-07-25 18:22:25,675 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(false)
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT TRIGGER_NAME, TRIGGER_GROUP, NEXT_FIRE_TIME, PRIORITY FROM QRTZ_TRIGGERS WHERE TRIGGER_STATE = ? AND NEXT_FIRE_TIME < ? AND (NEXT_FIRE_TIME >= ?) ORDER BY NEXT_FIRE_TIME ASC, PRIORITY DESC)
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] setFetchSize(5)
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] setMaxRows(5)
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, WAITING)
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBigDecimal(2, 1532560975675)
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBigDecimal(3, 1532560885677)
    2018-07-25 18:22:25,677 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:25,678 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:25,679 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:25,679 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:25,679 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] commit()
    2018-07-25 18:22:25,679 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(true)
    2018-07-25 18:22:25,679 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] close()
    2018-07-25 18:22:28,094 INFO [com.workpoint.servlet.client.WpClientServlet] (default task-22) Loaded properties from vfs:/opt/CA/wildfly-idm/standalone/deployments/iam_im.ear/config/workpoint-server.properties
    2018-07-25 18:22:28,094 INFO [com.workpoint.servlet.client.WpClientServlet] (default task-22) PRODUCT = Workpoint; VERSION = 3.5.2; BUILD = 20140214.P004; BUILD DATE = June 20, 2015
    2018-07-25 18:22:50,028 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [DataSource] getConnection()
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] getAutoCommit()
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(false)
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] prepareStatement(SELECT TRIGGER_NAME, TRIGGER_GROUP, NEXT_FIRE_TIME, PRIORITY FROM QRTZ_TRIGGERS WHERE TRIGGER_STATE = ? AND NEXT_FIRE_TIME < ? AND (NEXT_FIRE_TIME >= ?) ORDER BY NEXT_FIRE_TIME ASC, PRIORITY DESC)
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] setFetchSize(5)
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] setMaxRows(5)
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setString(1, WAITING)
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBigDecimal(2, 1532561000028)
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] setBigDecimal(3, 1532560910030)
    2018-07-25 18:22:50,030 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [PreparedStatement] executeQuery()
    2018-07-25 18:22:50,031 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [ResultSet] next()
    2018-07-25 18:22:50,031 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [ResultSet] close()
    2018-07-25 18:22:50,031 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Statement] close()
    2018-07-25 18:22:50,031 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] commit()
    2018-07-25 18:22:50,031 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] setAutoCommit(true)
    2018-07-25 18:22:50,031 DEBUG [jboss.jdbc.spy] (iam_imDefaultQuartzScheduler_QuartzSchedulerThread) java:/iam/im/jdbc/jdbc/idm [Connection] close()