Latest post Mon, Sep 26 2016 10:32 AM by olenad. 8 replies.
Page 1 of 1 (9 items)
Sort Posts: Previous Next
  • Wed, Sep 14 2016 9:03 PM

    httpd error 500

    TV Globo is having some problems with webservices.
    They report httpd error 500 when running an application. 
    They using webservices1.6.0.5 in iNews 3.6.2.1.
    They are wondering if it is worth upgrading to 1.6.1 and
     if the webservices generates a specific log file in tomcat server
    that can help identify what is causing these errors,
    Attached part of iNews and tomcat logs.
     
    iNews.log

    Sep 1 12:07:35 RIO-A a1901: [21947 3.6.2.1 RH5] gnews 1901 a - 1.6.0.5 Hot-to-go
    Sep 1 12:08:13 RIO-A a1901: Exit: Error communicating with Client (16:Recv) poctrl4 10.4.172.122 1.6.0.5/3.6.2.1 RH5
    Sep 1 12:08:13 RIO-A a1905: Exit: Error communicating with Client (16:Recv) poctrl4 10.4.172.122 1.6.0.5/3.6.2.1 RH5
    Sep 1 12:08:13 RIO-A a1903: Exit: Error communicating with Client (16:Recv) poctrl4 10.4.172.122 1.6.0.5/3.6.2.1 RH5
    Sep 1 12:08:21 RIO-A a1905: [21950 3.6.2.1 RH5] gnews 1905 a - 1.6.0.5 Hot-to-go
    Sep 1 12:08:21 RIO-A a1903: [21951 3.6.2.1 RH5] gnews 1903 a - 1.6.0.5 Hot-to-go
    Sep 1 12:08:21 RIO-A a1901: [21952 3.6.2.1 RH5] gnews 1901 a - 1.6.0.5 Hot-to-go
    Sep 1 12:08:52 RIO-A a1901: [21958 3.6.2.1 RH5] gnews 1901 a - 1.6.0.5 Hot-to-go
    Sep 1 12:09:05 RIO-A a1901: [21960 3.6.2.1 RH5] gnews 1901 a - 1.6.0.5 Hot-to-go
    Sep 1 12:30:19 RIO-A a1901: [22124 3.6.2.1 RH5] gnews 1901 a - 1.6.0.5 Hot-to-go
    Sep 2 11:44:12 RIO-A a1901: [18663 3.6.2.1 RH5] gnews 1901 a - 1.6.0.5 Hot-to-go
    Sep 2 12:05:50 RIO-A a1901: RETRYING 208519214 6010547,0 316425,-1 -3 (5078103<->6556037) x1
    Sep 2 12:15:53 RIO-A a1901: RETRYING 831823100 5949698,1 316425,-1 -3 (6590415<->6556037) x1
    Sep 2 12:44:52 RIO-A a1901: Exit: Error communicating with Client (16:Recv) poctrl4 10.4.172.122 1.6.0.5/3.6.2.1 RH5
    Sep 2 12:44:52 RIO-A a1905: Exit: Error communicating with Client (16:Recv) poctrl4 10.4.172.122 1.6.0.5/3.6.2.1 RH5
    Sep 2 12:44:52 RIO-A a1903: Exit: Error communicating with Client (16:Recv) poctrl4 10.4.172.122 1.6.0.5/3.6.2.1 RH5
    Sep 2 12:45:03 RIO-A a1905: [20183 3.6.2.1 RH5] gnews 1905 a - 1.6.0.5 Hot-to-go
    Sep 2 12:45:03 RIO-A a1903: [20184 3.6.2.1 RH5] gnews 1903 a - 1.6.0.5 Hot-to-go
    Sep 2 12:45:11 RIO-A a1905: Exit: Error communicating with Client (16:Recv) poctrl4 10.4.172.122 1.6.0.5/3.6.2.1 RH5


    tomcat.log

    10.4.172.117 - - [02/Sep/2016:12:12:01 -0300] "POST /inewswebservice/services/inewssystem?soap HTTP/1.1" 500 241
    10.4.172.118 - - [02/Sep/2016:12:12:01 -0300] "POST /inewswebservice/services/inewsqueue?soap HTTP/1.1" 200 200771
    10.4.172.117 - - [02/Sep/2016:12:12:02 -0300] "POST /inewswebservice/services/inewssystem?soap HTTP/1.1" 200 271
    10.4.172.117 - - [02/Sep/2016:12:12:02 -0300] "POST /inewswebservice/services/inewssystem?soap HTTP/1.1" 500 241
    10.4.172.118 - - [02/Sep/2016:12:12:02 -0300] "POST /inewswebservice/services/inewssystem?soap HTTP/1.1" 200 270
    10.4.172.118 - - [02/Sep/2016:12:12:02 -0300] "POST /inewswebservice/services/inewsqueue?soap HTTP/1.1" 200 200771
    10.4.172.117 - - [02/Sep/2016:12:12:03 -0300] "POST /inewswebservice/services/inewssystem?soap HTTP/1.1" 200 271
    10.4.172.117 - - [02/Sep/2016:12:12:03 -0300] "POST /inewswebservice/services/inewssystem?soap HTTP/1.1" 500 241
    10.4.172.118 - - [02/Sep/2016:12:12:03 -0300] "POST /inewswebservice/services/inewssystem?soap HTTP/1.1" 200 270

    Tks
    Filed under:
  • Thu, Sep 15 2016 11:32 AM In reply to

    • olenad
    • Not Ranked
    • Joined on Thu, Nov 6 2014
    • Posts 28
    • Points 305

    Re: httpd error 500

    hi, 

     

    could you add to description tomcat log please?

    /opt/tomcat/apache-tomcat-x.x.xx/logs

     

    thanks,

    Olena

  • Thu, Sep 15 2016 5:44 PM In reply to

    Hi Olena,

    Atached the logs

    Tks

  • Thu, Sep 15 2016 5:46 PM In reply to

    And,

     

    The other file.

     

    Andre

     

     

  • Fri, Sep 16 2016 8:38 AM In reply to

    • olenad
    • Not Ranked
    • Joined on Thu, Nov 6 2014
    • Posts 28
    • Points 305

    Re: httpd error 500

    Hi Andre,

     

    it's something weird happend with tomcat 

    May I ask you about one more file please?

     

    It's inews specifig log that should be created next to tomcat catalina log in folder

    /opt/tomcat/apache-tomcat-x.x.xx/logs/iNEWS_WS

     

    Thanks,

    Olena

  • Tue, Sep 20 2016 3:53 PM In reply to

    Hi

    Attach the file.

    Tks,

    André

  • Tue, Sep 20 2016 4:02 PM In reply to

    • olenad
    • Not Ranked
    • Joined on Thu, Nov 6 2014
    • Posts 28
    • Points 305

    Re: httpd error 500

    Hi Andre, 

     

    from log you have just attached - there is no connection to iNEWS server message is the reason:

    02-Sep-2016 14:13:24.198 WARNING [http-nio-8080-exec-8] com.avid.inews.gnews.GNEWSSession.logStatus Server connection attempt status list: 10.15.193.101:5
    02-Sep-2016 14:13:24.199 INFO [http-nio-8080-exec-8] com.avid.inewswebservice.soap.INEWSSystemPortTypeImpl.log [poctrl4:1905] 87ECF2FDF2B47415F1AFF49D7964CE62 Unable to find server: 10.15.193.101
    02-Sep-2016 14:13:24.207 INFO [http-nio-8080-exec-8] org.apache.cxf.phase.PhaseInterceptorChain.doDefaultLogging Application {http://avid.com/inewssystem}INEWSSystem#{http://avid.com/inewssystem}Connect has thrown exception, unwinding now: com.avid.inewswebservice.soap.ConnectionFault: Unable to connect to iNEWS, tried all servers.
    
    
    This address 10.15.193.101 - is this iNEWS server IP?
    are you able to login to it with inews client while using the same username and password that you do when try to login with WSAPI?
    
    
    
    
    also, could you clarify please, is this fresh install? or did it work in past and just stop working?
    
    
    thanks,
    Olena
    
    
  • Thu, Sep 22 2016 7:00 PM In reply to

    Re: httpd error 500

    Hi Olena,

     

    >>> This address 10.15.193.101 - is this iNEWS server IP?

    Yes 10.15.193.101 is iNews-A

    >>>Are you able to login to it with inews client while using the same username and password ?

    I will ask them to do this test.

    >>> also, could you clarify please, is this fresh install? or did it work in past and just stop working?

    No, they report is not a fresh install, and the problem started this month.

    May I ask you if there is a way to make the aplication check the connection ?
    So i can suggest the client to implement that in their app, and if some net problem occur the aplication reconnect without crash.

    Tks again

  • Mon, Sep 26 2016 10:32 AM In reply to

    • olenad
    • Not Ranked
    • Joined on Thu, Nov 6 2014
    • Posts 28
    • Points 305

    Re: httpd error 500

    Hi, 

    we have tried different workflows to repeat logs

    here are few things to mention:

    1) the reason for the error "Sep  2 12:44:52 RIO-A a1901: Exit: Error communicating with Client (16:Recv) poctrl4 10.4.172.122 1.6.0.5/3.6.2.1 RH5" is no connection between tomcat and inews server (tomcat service stopped of network issue occurs)

    2) from logs it seems that there are many "alive" sessions at once so there would be situation when no free sessions left on the inews server and new connection could not be established

    to verify total amount of sessions available by licensing you may run in inews console "status l"

    to verify total amount of configured sessions you may run in inews console "cat /site/config | grep api"

    to verify current number of alive sessions you may run in inews console "list s" on every inews server - A and B 

    3) note: every "connect" from WSAPI should be complete with "diconnect" in order to release session 

    4) one more advice could be to use inews system name instead of IP address - "Yes 10.15.193.101 is iNews-A"

    so it's better to connect to "iNews" instead of connecting to "10.15.193.101" and be sure that both iNews-A and iNews-B reply on ping successfully

    WSAPI will choose available inews server to connect to - A or B

    5) "May I ask you if there is a way to make the aplication check the connection ?" - this could not be a solution because session is created on inews server side when WSAPI verifies connection, so you use one license from list until session is destroyed

     

    Thanks,

    Olena

     

Page 1 of 1 (9 items)

© Copyright 2011 Avid Technology, Inc.  Terms of Use |  Privacy Policy |  Site Map |  Find a Reseller