Service Virtualization

Expand all | Collapse all

DevTest 9.5.1 Registry crash

Jump to Best Answer
  • 1.  DevTest 9.5.1 Registry crash

    Posted 11-22-2016 08:30 AM

    I just installed DevTest 9.5.1 and run the DevTest servers in docker containers: dradis, registry, broker and vse. It seems by the logs that the registry keeps restarting all the time. The previous version of DevTest 9.1 worked just fine in docker compose, but the recent version keeps failing all the time. Because of this any of the DevTest services will not work!

     

    Below you can see docker-compose logs from registry instance: 

     

    registry_1     | [DevTest AGENT:B][ERROR][9086][1][main][Nov 22, 2016 1:16:28 PM] Failed to configure DB sink.

    registry_1     | java.lang.StringIndexOutOfBoundsException: String index out of range: 79

    registry_1     | at java.lang.String.charAt(String.java:658)

    registry_1     | at com.itko.lisa.remote.AgentSM.fromHex(AgentSM.java:1141)

    registry_1     | at com.itko.lisa.remote.AgentSM.lisaDecrypt(AgentSM.java:1121)

    registry_1     | at com.itko.lisa.remote.broker.Main.startBroker(Main.java:168)

    registry_1     | at com.itko.lisa.remote.broker.Main.main(Main.java:91)

    registry_1     | at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

    registry_1     | at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)

    registry_1     | at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

    registry_1     | at java.lang.reflect.Method.invoke(Method.java:497)

    registry_1     | at com.exe4j.runtime.LauncherEngine.launch(Unknown Source)

    registry_1     | at com.install4j.runtime.launcher.UnixLauncher.main(Unknown Source)

    registry_1     |

    registry_1     |

    registry_1     | [DevTest AGENT:B][INFO][9086][1][main][Nov 22, 2016 1:16:29 PM] Starting pathfinder broker on tcp://0.0.0.0:2009

    registry_1     | Nov 22, 2016 1:16:29 PM com.itko.activemq.broker.BrokerService start

    registry_1     | INFO: Using Persistence Adapter: MemoryPersistenceAdapter

    registry_1     | Nov 22, 2016 1:16:29 PM com.itko.activemq.broker.BrokerService getBroker

    registry_1     | INFO: ActiveMQ null JMS Message Broker (localhost) is starting

    registry_1     | Nov 22, 2016 1:16:29 PM com.itko.activemq.broker.BrokerService getBroker

    registry_1     | INFO: For help or more information please see: http://activemq.apache.org/

    registry_1     | Nov 22, 2016 1:16:29 PM com.itko.activemq.transport.TransportServerThreadSupport doStart

    registry_1     | INFO: Listening for connections at: tcp://5225f93732ae:2009?daemon=true

    registry_1     | Nov 22, 2016 1:16:29 PM com.itko.activemq.broker.TransportConnector start

    registry_1     | INFO: Connector tcp://5225f93732ae:2009?daemon=true Started

    registry_1     | Nov 22, 2016 1:16:29 PM com.itko.activemq.broker.TransportConnector start

    registry_1     | INFO: Connector vm://localhost Started

    registry_1     | Nov 22, 2016 1:16:29 PM com.itko.activemq.broker.BrokerService start

    registry_1     | INFO: ActiveMQ JMS Message Broker (localhost, ID:5225f93732ae-38073-1479820588884-2:1) started

    registry_1     | [DevTest AGENT:B][INFO][9086][1][main][Nov 22, 2016 1:16:29 PM] Started Broker tcp://0.0.0.0:2009?daemon=true

    registry_1     | [DevTest AGENT:B][INFO][9086][1][main][Nov 22, 2016 1:16:29 PM] Persistence Directory is /opt/devtest

    registry_1     | [DevTest AGENT:B][INFO][9086][1][main][Nov 22, 2016 1:16:29 PM] Version: 10.0.0.33

    registry_1     | [DevTest AGENT:B][INFO][9086][1][main][Nov 22, 2016 1:16:29 PM] DevConsole server is listening on port 2099

    registry_1     | [DevTest AGENT:BC][INFO][9086][1][main][Nov 22, 2016 1:16:29 PM] Connection to tcp://0.0.0.0:2009?daemon=true established...

    registry_1     | [DevTest AGENT:BC][INFO][9086][57][ActiveMQ Session: ID:5225f93732ae-38073-1479820588884-0:2:1][Nov 22, 2016 1:16:29 PM] Agent online: [ID: 1603045495][NAME: Broker:root@5225f93732ae][IP: 172.23.0.4][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 9086]

    registry_1     | [DevTest AGENT:BC][INFO][9086][57][ActiveMQ Session: ID:5225f93732ae-38073-1479820588884-0:2:1][Nov 22, 2016 1:16:29 PM] TransactionCleaner: enabled=true strategy=age frequency=10 age=10080

    registry_1     | [DevTest AGENT:BC][INFO][9086][57][ActiveMQ Session: ID:5225f93732ae-38073-1479820588884-0:2:1][Nov 22, 2016 1:16:29 PM] Checking DevTest Agent schema

    registry_1     | [DevTest AGENT:BC][INFO][9086][57][ActiveMQ Session: ID:5225f93732ae-38073-1479820588884-0:2:1][Nov 22, 2016 1:16:35 PM] Schema matches expected version (v9)

    registry_1     | [DevTest AGENT:BC][INFO][9086][60][ActiveMQ Session Task][Nov 22, 2016 1:16:35 PM] Agent online: [ID: -430129386][NAME: VSE:root@845647eef583][IP: 172.23.0.5][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 16]

    registry_1     | 2016-11-22 13:16:39,166 INFO exited: Registry (terminated by SIGKILL; not expected)

    registry_1     | 2016-11-22 13:16:40,198 INFO spawned: 'Registry' with pid 9642

    registry_1     | DevTest Web Consoles will take a few additional moments to start up.



  • 2.  Re: DevTest 9.5.1 Registry crash

    Broadcom Employee
    Posted 11-22-2016 08:53 AM
    As far as I remember there was no change in the docker implementation for the registry image post 9.1. I have successfully started all the components individually in their own containers for 9.5.1 in multiple envs without any issues. 


    Can you copy/paste the dashboard and registry container startup commands here?


    Thanks.

     

     




  • 3.  Re: DevTest 9.5.1 Registry crash

    Posted 11-22-2016 09:25 AM

    Hi,

     

    I’m running devtest from docker-compose file, that also builds the the containers and sets the configuration files to each container. There is created containers for each service: dradis, registry, broker and vse. My wild guess is, that there might be some ports missing from the compose file between the services?

     

    Below is the port configurations for each service:

     

     

    dradis:

      ports:

        - "1506:1506"

      expose:

        - "2003"

        - "1506"

        - "2009"

     

    registry:

      ports:

        - "1505:1505"

        - "2010:2010"

      expose:

        - "2009"

        - "1505"

        - "2010"

        - "1508"

     

    broker:

      ports:

        - "2009:2009"

      expose:

        - "2009"

     

    vse:

      ports:

        - "8001:8001"

        - "2013:2013"

      expose:

        - "2013"

        - "2009"

     

     

     

    Best Regards,

     

    Ilpo Paju, Lead Test Engineer

     

    Tieto

     

     

     

    Koustubh.Warty <communityadmin@communities-mail.ca.com<mailto:communityadmin@communities-mail.ca.com>> kirjoitti 22.11.2016 kello 15.54:

     

    CA Communities<https://communities.ca.com/?et=watches.email.thread>

     

    Re: DevTest 9.5.1 Registry crash

     

    reply from KOUSTUBH WARTY<https://communities.ca.com/people/Koustubh.Warty?et=watches.email.thread> in DevTest Community - View the full discussion<https://communities.ca.com/message/241940062?commentID=241940062&et=watches.email.thread#comment-241940062>



  • 4.  Re: DevTest 9.5.1 Registry crash

    Posted 11-22-2016 09:41 AM

    Here is some log from the devtest_broker.log:

     

    [DevTest AGENT:B][ERROR][17471][1][main][Nov 22, 2016 2:29:38 PM] Failed to configure DB sink.

    java.lang.StringIndexOutOfBoundsException: String index out of range: 79

    at java.lang.String.charAt(String.java:658)

    at com.itko.lisa.remote.AgentSM.fromHex(AgentSM.java:1141)

    at com.itko.lisa.remote.AgentSM.lisaDecrypt(AgentSM.java:1121)

    at com.itko.lisa.remote.broker.Main.startBroker(Main.java:168)

    at com.itko.lisa.remote.broker.Main.main(Main.java:91)

    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)

    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

    at java.lang.reflect.Method.invoke(Method.java:497)

    at com.exe4j.runtime.LauncherEngine.launch(Unknown Source)

    at com.install4j.runtime.launcher.UnixLauncher.main(Unknown Source)

     

    [DevTest AGENT:B][INFO][17471][1][main][Nov 22, 2016 2:29:39 PM] Starting pathfinder broker on tcp://0.0.0.0:2009

    [DevTest AGENT:B][INFO][17471][1][main][Nov 22, 2016 2:29:39 PM] Started Broker tcp://0.0.0.0:2009?daemon=true

    [DevTest AGENT:B][INFO][17471][1][main][Nov 22, 2016 2:29:39 PM] Persistence Directory is /opt/devtest

    [DevTest AGENT:B][INFO][17471][1][main][Nov 22, 2016 2:29:39 PM] Version: 10.0.0.33

    [DevTest AGENT:B][INFO][17471][1][main][Nov 22, 2016 2:29:39 PM] DevConsole server is listening on port 2099

    [DevTest AGENT:BC][INFO][17471][1][main][Nov 22, 2016 2:29:39 PM] Connection to tcp://0.0.0.0:2009?daemon=true established...

    [DevTest AGENT:BC][INFO][17471][60][ActiveMQ Session Task][Nov 22, 2016 2:29:39 PM] Agent online: [ID: 1603045495][NAME: Broker:root@5225f93732ae][IP: 172.23.0.4][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 17471]

    [DevTest AGENT:BC][INFO][17471][60][ActiveMQ Session Task][Nov 22, 2016 2:29:39 PM] TransactionCleaner: enabled=true strategy=age frequency=10 age=10080

    [DevTest AGENT:BC][INFO][17471][60][ActiveMQ Session Task][Nov 22, 2016 2:29:39 PM] Checking DevTest Agent schema

    [DevTest AGENT:BC][INFO][17471][60][ActiveMQ Session Task][Nov 22, 2016 2:29:45 PM] Schema matches expected version (v9)

    [DevTest AGENT:BC][INFO][17471][62][ActiveMQ Session: ID:5225f93732ae-33288-1479824979208-0:2:1][Nov 22, 2016 2:29:45 PM] Agent online: [ID: -430129386][NAME: VSE:root@845647eef583][IP: 172.23.0.5][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 16]

    [DevTest AGENT:BC][INFO][17471][41][Timer-1][Nov 22, 2016 2:30:43 PM] Agent offline: [ID: 1603045495][NAME: Broker:root@5225f93732ae][IP: 172.23.0.4][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 17471]

    [DevTest AGENT:BC][INFO][17471][67][ActiveMQ Session Task][Nov 22, 2016 2:30:47 PM] Agent online: [ID: 1603045495][NAME: Broker:root@5225f93732ae][PID: 17471]

    [DevTest AGENT:BC][INFO][17471][41][Timer-1][Nov 22, 2016 2:32:14 PM] Agent offline: [ID: -430129386][NAME: VSE:root@845647eef583][IP: 172.23.0.5][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 16]

    [DevTest AGENT:BC][INFO][17471][41][Timer-1][Nov 22, 2016 2:32:14 PM] Agent offline: [ID: 1603045495][NAME: Broker:root@5225f93732ae][IP: 172.23.0.4][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 17471]

    [DevTest AGENT:BC][INFO][17471][67][ActiveMQ Session Task][Nov 22, 2016 2:32:14 PM] Agent online: [ID: 1603045495][NAME: Broker:root@5225f93732ae][PID: 17471]

    [DevTest AGENT:BC][INFO][17471][67][ActiveMQ Session Task][Nov 22, 2016 2:32:14 PM] Agent online: [ID: -430129386][NAME: VSE:root@845647eef583][PID: 16]

    [DevTest AGENT:BC][INFO][17471][41][Timer-1][Nov 22, 2016 2:33:45 PM] Agent offline: [ID: -430129386][NAME: VSE:root@845647eef583][IP: 172.23.0.5][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 16]

    [DevTest AGENT:BC][INFO][17471][41][Timer-1][Nov 22, 2016 2:33:46 PM] Agent offline: [ID: 1603045495][NAME: Broker:root@5225f93732ae][IP: 172.23.0.4][MC: com.install4j.runtime.launcher.UnixLauncher][PID: 17471]

    [DevTest AGENT:BC][INFO][17471][95][ActiveMQ Session Task][Nov 22, 2016 2:33:49 PM] Agent online: [ID: -430129386][NAME: VSE:root@845647eef583][PID: 16]



  • 5.  Re: DevTest 9.5.1 Registry crash

    Broadcom Employee
    Posted 11-22-2016 10:54 AM

    You have 1508 in the registry expose. What is that for? Also you are missing 1528 port  in the registry expose. 

    There is no need for the broker container as a broker is not required unless you are using CAI. 



  • 6.  Re: DevTest 9.5.1 Registry crash

    Posted 11-22-2016 01:18 PM

    Hi,

    still no change, the registry keeps on restarting every minute. There is some exception in the registry log that maybe is the cause (??):

     

    registry_1     | [DevTest AGENT:B][ERROR][3667][1][main][Nov 22, 2016 3:24:52 PM] Failed to configure DB sink.

    registry_1     | java.lang.StringIndexOutOfBoundsException: String index out of range: 79

    registry_1     | at java.lang.String.charAt(String.java:658)

    registry_1     | at com.itko.lisa.remote.AgentSM.fromHex(AgentSM.java:1141)

    registry_1     | at com.itko.lisa.remote.AgentSM.lisaDecrypt(AgentSM.java:1121)

    registry_1     | at com.itko.lisa.remote.broker.Main.startBroker(Main.java:168)

    registry_1     | at com.itko.lisa.remote.broker.Main.main(Main.java:91)

    registry_1     | at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

    registry_1     | at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)

    registry_1     | at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

    registry_1     | at java.lang.reflect.Method.invoke(Method.java:497)

    registry_1     | at com.exe4j.runtime.LauncherEngine.launch(Unknown Source)

    registry_1     | at com.install4j.runtime.launcher.UnixLauncher.main(Unknown Source)

     

     

     

    Is there some changes in the between the 9.1 and 9.5.1 images, because I don't recall that in the previous registry startup the supervisor process that starts the Broker and the Registry processes?



  • 7.  Re: DevTest 9.5.1 Registry crash
    Best Answer

    Broadcom Employee
    Posted 11-24-2016 12:49 AM

    Just to be clear - the registry process used to auto-start the broker internally prior to 8.x. Since 8.x onwards the broker is its own process and needs to be started separately if required. Having said that as I mentioned yesterday, if you are only using VSE there is no need of the broker process to be started.



  • 8.  Re: DevTest 9.5.1 Registry crash

    Broadcom Employee
    Posted 11-24-2016 12:51 AM

    Also what database are you using here - default Derby or something else?